{"level":"warn","ts":"2026-05-26T13:48:41.484594Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-05-26T13:48:41.484681Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.89:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.89:2380","--initial-cluster=instance=https://199.204.45.89:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.89:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.89: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-05-26T13:48:41.48477Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-05-26T13:48:41.484785Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.89:2380"]}
{"level":"info","ts":"2026-05-26T13:48:41.484803Z","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-05-26T13:48:41.485468Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.89:2379"]}
{"level":"info","ts":"2026-05-26T13:48:41.485551Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.89:2380"],"listen-peer-urls":["https://199.204.45.89:2380"],"advertise-client-urls":["https://199.204.45.89:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.89:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.89: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-05-26T13:48:41.490024Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.24965ms"}
{"level":"info","ts":"2026-05-26T13:48:41.49882Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"c3b8446219deb8c1","cluster-id":"fe02a46d8aa9751f"}
{"level":"info","ts":"2026-05-26T13:48:41.498958Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 switched to configuration voters=()"}
{"level":"info","ts":"2026-05-26T13:48:41.498994Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 became follower at term 0"}
{"level":"info","ts":"2026-05-26T13:48:41.499015Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft c3b8446219deb8c1 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-05-26T13:48:41.499032Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 became follower at term 1"}
{"level":"info","ts":"2026-05-26T13:48:41.499116Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 switched to configuration voters=(14103097421242218689)"}
{"level":"warn","ts":"2026-05-26T13:48:41.506392Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-05-26T13:48:41.508087Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-05-26T13:48:41.50922Z","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-05-26T13:48:41.511671Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"c3b8446219deb8c1","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-05-26T13:48:41.511875Z","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-05-26T13:48:41.512097Z","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-05-26T13:48:41.512148Z","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-05-26T13:48:41.512318Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"c3b8446219deb8c1","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-05-26T13:48:41.513561Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 switched to configuration voters=(14103097421242218689)"}
{"level":"info","ts":"2026-05-26T13:48:41.514174Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"fe02a46d8aa9751f","local-member-id":"c3b8446219deb8c1","added-peer-id":"c3b8446219deb8c1","added-peer-peer-urls":["https://199.204.45.89:2380"]}
{"level":"info","ts":"2026-05-26T13:48:41.515942Z","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-05-26T13:48:41.516031Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.89:2380"}
{"level":"info","ts":"2026-05-26T13:48:41.516103Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.89:2380"}
{"level":"info","ts":"2026-05-26T13:48:41.51618Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"c3b8446219deb8c1","initial-advertise-peer-urls":["https://199.204.45.89:2380"],"listen-peer-urls":["https://199.204.45.89:2380"],"advertise-client-urls":["https://199.204.45.89:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.89:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-05-26T13:48:41.516212Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-05-26T13:48:42.00019Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 is starting a new election at term 1"}
{"level":"info","ts":"2026-05-26T13:48:42.00032Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 became pre-candidate at term 1"}
{"level":"info","ts":"2026-05-26T13:48:42.000354Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 received MsgPreVoteResp from c3b8446219deb8c1 at term 1"}
{"level":"info","ts":"2026-05-26T13:48:42.00038Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 became candidate at term 2"}
{"level":"info","ts":"2026-05-26T13:48:42.000487Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 received MsgVoteResp from c3b8446219deb8c1 at term 2"}
{"level":"info","ts":"2026-05-26T13:48:42.000511Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 became leader at term 2"}
{"level":"info","ts":"2026-05-26T13:48:42.000529Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: c3b8446219deb8c1 elected leader c3b8446219deb8c1 at term 2"}
{"level":"info","ts":"2026-05-26T13:48:42.00168Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"c3b8446219deb8c1","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.89:2379]}","request-path":"/0/members/c3b8446219deb8c1/attributes","cluster-id":"fe02a46d8aa9751f","publish-timeout":"7s"}
{"level":"info","ts":"2026-05-26T13:48:42.002017Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-26T13:48:42.002981Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-05-26T13:48:42.003466Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-05-26T13:48:42.003491Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"fe02a46d8aa9751f","local-member-id":"c3b8446219deb8c1","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-26T13:48:42.003595Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-05-26T13:48:42.003615Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-26T13:48:42.00363Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-05-26T13:48:42.003653Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-26T13:48:42.005094Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.89:2379"}
{"level":"info","ts":"2026-05-26T13:48:42.006555Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-05-26T13:49:01.469954Z","caller":"traceutil/trace.go:171","msg":"trace[138204674] transaction","detail":"{read_only:false; response_revision:380; number_of_response:1; }","duration":"111.558051ms","start":"2026-05-26T13:49:01.358368Z","end":"2026-05-26T13:49:01.469927Z","steps":["trace[138204674] 'process raft request'  (duration: 111.372956ms)"],"step_count":1}
{"level":"info","ts":"2026-05-26T13:49:19.633846Z","caller":"traceutil/trace.go:171","msg":"trace[242770658] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"244.69471ms","start":"2026-05-26T13:49:19.38913Z","end":"2026-05-26T13:49:19.633825Z","steps":["trace[242770658] 'process raft request'  (duration: 240.241196ms)"],"step_count":1}
{"level":"info","ts":"2026-05-26T13:49:19.633954Z","caller":"traceutil/trace.go:171","msg":"trace[120605691] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"232.783185ms","start":"2026-05-26T13:49:19.401152Z","end":"2026-05-26T13:49:19.633935Z","steps":["trace[120605691] 'process raft request'  (duration: 232.669462ms)"],"step_count":1}
{"level":"info","ts":"2026-05-26T13:49:19.633993Z","caller":"traceutil/trace.go:171","msg":"trace[1702461909] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"244.819644ms","start":"2026-05-26T13:49:19.389149Z","end":"2026-05-26T13:49:19.633969Z","steps":["trace[1702461909] 'process raft request'  (duration: 244.621419ms)"],"step_count":1}
{"level":"info","ts":"2026-05-26T13:49:19.635155Z","caller":"traceutil/trace.go:171","msg":"trace[1751436213] transaction","detail":"{read_only:false; number_of_response:1; response_revision:497; }","duration":"227.090486ms","start":"2026-05-26T13:49:19.408014Z","end":"2026-05-26T13:49:19.635104Z","steps":["trace[1751436213] 'process raft request'  (duration: 225.920383ms)"],"step_count":1}
{"level":"info","ts":"2026-05-26T13:49:19.635762Z","caller":"traceutil/trace.go:171","msg":"trace[958262861] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"232.849158ms","start":"2026-05-26T13:49:19.4012Z","end":"2026-05-26T13:49:19.634049Z","steps":["trace[958262861] 'process raft request'  (duration: 232.698544ms)"],"step_count":1}
{"level":"info","ts":"2026-05-26T13:49:19.637379Z","caller":"traceutil/trace.go:171","msg":"trace[2074823666] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"219.815171ms","start":"2026-05-26T13:49:19.417395Z","end":"2026-05-26T13:49:19.63721Z","steps":["trace[2074823666] 'process raft request'  (duration: 217.25499ms)"],"step_count":1}
{"level":"info","ts":"2026-05-26T13:49:19.638633Z","caller":"traceutil/trace.go:171","msg":"trace[1507022744] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"221.101707ms","start":"2026-05-26T13:49:19.417488Z","end":"2026-05-26T13:49:19.638589Z","steps":["trace[1507022744] 'process raft request'  (duration: 219.602685ms)"],"step_count":1}
{"level":"info","ts":"2026-05-26T13:49:19.638802Z","caller":"traceutil/trace.go:171","msg":"trace[2031767535] transaction","detail":"{read_only:false; response_revision:501; number_of_response:1; }","duration":"161.518632ms","start":"2026-05-26T13:49:19.47727Z","end":"2026-05-26T13:49:19.638789Z","steps":["trace[2031767535] 'process raft request'  (duration: 161.290626ms)"],"step_count":1}
{"level":"info","ts":"2026-05-26T13:49:19.639001Z","caller":"traceutil/trace.go:171","msg":"trace[2063114473] transaction","detail":"{read_only:false; response_revision:502; number_of_response:1; }","duration":"157.477288ms","start":"2026-05-26T13:49:19.481508Z","end":"2026-05-26T13:49:19.638986Z","steps":["trace[2063114473] 'process raft request'  (duration: 157.103277ms)"],"step_count":1}
{"level":"info","ts":"2026-05-26T13:49:19.639024Z","caller":"traceutil/trace.go:171","msg":"trace[81049706] transaction","detail":"{read_only:false; response_revision:500; number_of_response:1; }","duration":"204.907992ms","start":"2026-05-26T13:49:19.434101Z","end":"2026-05-26T13:49:19.639009Z","steps":["trace[81049706] 'process raft request'  (duration: 204.392947ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-26T13:49:20.912102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.926834ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/udproutes.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:31126"}
{"level":"info","ts":"2026-05-26T13:49:20.912238Z","caller":"traceutil/trace.go:171","msg":"trace[1582808260] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/udproutes.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:561; }","duration":"141.097637ms","start":"2026-05-26T13:49:20.77111Z","end":"2026-05-26T13:49:20.912208Z","steps":["trace[1582808260] 'range keys from in-memory index tree'  (duration: 140.752128ms)"],"step_count":1}
{"level":"info","ts":"2026-05-26T13:49:20.920235Z","caller":"traceutil/trace.go:171","msg":"trace[1831210078] transaction","detail":"{read_only:false; response_revision:562; number_of_response:1; }","duration":"124.890522ms","start":"2026-05-26T13:49:20.795319Z","end":"2026-05-26T13:49:20.920209Z","steps":["trace[1831210078] 'process raft request'  (duration: 124.697976ms)"],"step_count":1}
{"level":"info","ts":"2026-05-26T13:49:25.764872Z","caller":"traceutil/trace.go:171","msg":"trace[1960334913] linearizableReadLoop","detail":"{readStateIndex:615; appliedIndex:614; }","duration":"118.646526ms","start":"2026-05-26T13:49:25.646167Z","end":"2026-05-26T13:49:25.764814Z","steps":["trace[1960334913] 'read index received'  (duration: 113.635705ms)","trace[1960334913] 'applied index is now lower than readState.Index'  (duration: 5.00971ms)"],"step_count":2}
{"level":"info","ts":"2026-05-26T13:49:25.765006Z","caller":"traceutil/trace.go:171","msg":"trace[1079213248] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"148.714302ms","start":"2026-05-26T13:49:25.616261Z","end":"2026-05-26T13:49:25.764975Z","steps":["trace[1079213248] 'process raft request'  (duration: 144.421971ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-26T13:49:25.765036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.861942ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-26T13:49:25.76507Z","caller":"traceutil/trace.go:171","msg":"trace[666077036] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:591; }","duration":"118.951295ms","start":"2026-05-26T13:49:25.646108Z","end":"2026-05-26T13:49:25.765059Z","steps":["trace[666077036] 'agreement among raft nodes before linearized reading'  (duration: 118.876663ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-26T13:49:27.230563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"831.670117ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13313096128157491272 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:579 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-26T13:49:27.230828Z","caller":"traceutil/trace.go:171","msg":"trace[1161858864] linearizableReadLoop","detail":"{readStateIndex:620; appliedIndex:619; }","duration":"1.056851599s","start":"2026-05-26T13:49:26.173943Z","end":"2026-05-26T13:49:27.230794Z","steps":["trace[1161858864] 'read index received'  (duration: 224.39604ms)","trace[1161858864] 'applied index is now lower than readState.Index'  (duration: 832.452719ms)"],"step_count":2}
{"level":"info","ts":"2026-05-26T13:49:27.230849Z","caller":"traceutil/trace.go:171","msg":"trace[1411945895] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"1.261230896s","start":"2026-05-26T13:49:25.969459Z","end":"2026-05-26T13:49:27.23069Z","steps":["trace[1411945895] 'process raft request'  (duration: 428.711405ms)","trace[1411945895] 'compare'  (duration: 831.558474ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-26T13:49:27.231076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.057109796s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-qwzpw\" ","response":"range_response_count:1 size:16961"}
{"level":"info","ts":"2026-05-26T13:49:27.231142Z","caller":"traceutil/trace.go:171","msg":"trace[732079613] range","detail":"{range_begin:/registry/pods/kube-system/cilium-qwzpw; range_end:; response_count:1; response_revision:596; }","duration":"1.057219548s","start":"2026-05-26T13:49:26.173905Z","end":"2026-05-26T13:49:27.231124Z","steps":["trace[732079613] 'agreement among raft nodes before linearized reading'  (duration: 1.056979271s)"],"step_count":1}
{"level":"warn","ts":"2026-05-26T13:49:27.231189Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T13:49:26.173887Z","time spent":"1.05729302s","remote":"127.0.0.1:45766","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16985,"request content":"key:\"/registry/pods/kube-system/cilium-qwzpw\" "}
{"level":"warn","ts":"2026-05-26T13:49:27.231128Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T13:49:25.969437Z","time spent":"1.261620816s","remote":"127.0.0.1:45840","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:579 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-05-26T13:49:27.231639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"585.228716ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-26T13:49:27.231693Z","caller":"traceutil/trace.go:171","msg":"trace[775578941] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"875.365225ms","start":"2026-05-26T13:49:26.356314Z","end":"2026-05-26T13:49:27.231679Z","steps":["trace[775578941] 'process raft request'  (duration: 874.563121ms)"],"step_count":1}
{"level":"info","ts":"2026-05-26T13:49:27.231703Z","caller":"traceutil/trace.go:171","msg":"trace[525264782] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:597; }","duration":"585.298629ms","start":"2026-05-26T13:49:26.646387Z","end":"2026-05-26T13:49:27.231685Z","steps":["trace[525264782] 'agreement among raft nodes before linearized reading'  (duration: 585.167805ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-26T13:49:27.231746Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T13:49:26.646323Z","time spent":"585.414341ms","remote":"127.0.0.1:45582","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-05-26T13:49:27.231788Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T13:49:26.356286Z","time spent":"875.441176ms","remote":"127.0.0.1:45668","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036305,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" mod_revision:591 > success:<request_put:<key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" value_size:1036221 >> failure:<request_range:<key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" > >"}
{"level":"info","ts":"2026-05-26T13:49:27.501632Z","caller":"traceutil/trace.go:171","msg":"trace[1861367190] transaction","detail":"{read_only:false; response_revision:598; number_of_response:1; }","duration":"254.722693ms","start":"2026-05-26T13:49:27.246883Z","end":"2026-05-26T13:49:27.501606Z","steps":["trace[1861367190] 'process raft request'  (duration: 254.603139ms)"],"step_count":1}
{"level":"info","ts":"2026-05-26T13:49:27.504242Z","caller":"traceutil/trace.go:171","msg":"trace[1357825849] transaction","detail":"{read_only:false; response_revision:599; number_of_response:1; }","duration":"208.977806ms","start":"2026-05-26T13:49:27.29523Z","end":"2026-05-26T13:49:27.504207Z","steps":["trace[1357825849] 'process raft request'  (duration: 208.859012ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-26T13:49:45.218364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"630.190721ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-05-26T13:49:45.218487Z","caller":"traceutil/trace.go:171","msg":"trace[932286289] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:763; }","duration":"630.371646ms","start":"2026-05-26T13:49:44.588089Z","end":"2026-05-26T13:49:45.218461Z","steps":["trace[932286289] 'count revisions from in-memory index tree'  (duration: 630.026716ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-26T13:49:45.218549Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T13:49:44.588068Z","time spent":"630.460829ms","remote":"127.0.0.1:46032","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":8,"response size":31,"request content":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true "}
{"level":"warn","ts":"2026-05-26T13:49:45.218767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"402.362374ms","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-05-26T13:49:45.218871Z","caller":"traceutil/trace.go:171","msg":"trace[1905505604] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:763; }","duration":"402.511629ms","start":"2026-05-26T13:49:44.816336Z","end":"2026-05-26T13:49:45.218848Z","steps":["trace[1905505604] 'range keys from in-memory index tree'  (duration: 402.129688ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-26T13:49:45.218938Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T13:49:44.816318Z","time spent":"402.605321ms","remote":"127.0.0.1:45840","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-05-26T13:49:45.340904Z","caller":"traceutil/trace.go:171","msg":"trace[1490476696] transaction","detail":"{read_only:false; response_revision:764; number_of_response:1; }","duration":"117.186695ms","start":"2026-05-26T13:49:45.223667Z","end":"2026-05-26T13:49:45.340854Z","steps":["trace[1490476696] 'process raft request'  (duration: 116.830965ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-26T13:50:19.197248Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.323112ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ttl-after-finished-controller\" ","response":"range_response_count:1 size:224"}
{"level":"info","ts":"2026-05-26T13:50:19.19736Z","caller":"traceutil/trace.go:171","msg":"trace[634962363] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-after-finished-controller; range_end:; response_count:1; response_revision:1180; }","duration":"195.479697ms","start":"2026-05-26T13:50:19.001858Z","end":"2026-05-26T13:50:19.197337Z","steps":["trace[634962363] 'range keys from in-memory index tree'  (duration: 195.203039ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-26T13:50:19.197295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"550.834199ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-26T13:50:19.197526Z","caller":"traceutil/trace.go:171","msg":"trace[1328804305] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1180; }","duration":"551.076946ms","start":"2026-05-26T13:50:18.646409Z","end":"2026-05-26T13:50:19.197486Z","steps":["trace[1328804305] 'range keys from in-memory index tree'  (duration: 550.727396ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-26T13:50:19.197819Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T13:50:18.646383Z","time spent":"551.403805ms","remote":"127.0.0.1:45582","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-05-26T13:51:07.137968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"470.018677ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-10b7e35a-c054-400c-9c90-732299b38372\" ","response":"range_response_count:1 size:3626"}
{"level":"info","ts":"2026-05-26T13:51:07.138083Z","caller":"traceutil/trace.go:171","msg":"trace[280655396] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-10b7e35a-c054-400c-9c90-732299b38372; range_end:; response_count:1; response_revision:1862; }","duration":"470.162002ms","start":"2026-05-26T13:51:06.667897Z","end":"2026-05-26T13:51:07.138059Z","steps":["trace[280655396] 'range keys from in-memory index tree'  (duration: 469.809942ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-26T13:51:07.138131Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T13:51:06.667872Z","time spent":"470.247574ms","remote":"127.0.0.1:45766","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3650,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-10b7e35a-c054-400c-9c90-732299b38372\" "}
{"level":"warn","ts":"2026-05-26T13:51:07.138418Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"573.021858ms","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-05-26T13:51:07.138459Z","caller":"traceutil/trace.go:171","msg":"trace[1575228202] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1862; }","duration":"573.096439ms","start":"2026-05-26T13:51:06.565352Z","end":"2026-05-26T13:51:07.138449Z","steps":["trace[1575228202] 'range keys from in-memory index tree'  (duration: 572.906903ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-26T13:51:07.138427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"746.785044ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"warn","ts":"2026-05-26T13:51:07.138493Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T13:51:06.565341Z","time spent":"573.145342ms","remote":"127.0.0.1:45840","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-05-26T13:51:07.138454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"574.377795ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"info","ts":"2026-05-26T13:51:07.138541Z","caller":"traceutil/trace.go:171","msg":"trace[2140439213] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1862; }","duration":"746.950488ms","start":"2026-05-26T13:51:06.39156Z","end":"2026-05-26T13:51:07.13851Z","steps":["trace[2140439213] 'range keys from in-memory index tree'  (duration: 746.463044ms)"],"step_count":1}
{"level":"info","ts":"2026-05-26T13:51:07.138559Z","caller":"traceutil/trace.go:171","msg":"trace[354761422] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1862; }","duration":"574.529771ms","start":"2026-05-26T13:51:06.564003Z","end":"2026-05-26T13:51:07.138532Z","steps":["trace[354761422] 'range keys from in-memory index tree'  (duration: 574.080888ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-26T13:51:07.138642Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T13:51:06.563978Z","time spent":"574.654534ms","remote":"127.0.0.1:45840","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-05-26T13:51:07.13869Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T13:51:06.391528Z","time spent":"747.147293ms","remote":"127.0.0.1:45840","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-05-26T13:51:07.138748Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"639.086291ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/datadir-percona-xtradb-pxc-0.18b321d20ffad92c\" ","response":"range_response_count:1 size:982"}
{"level":"info","ts":"2026-05-26T13:51:07.138836Z","caller":"traceutil/trace.go:171","msg":"trace[336021201] range","detail":"{range_begin:/registry/events/openstack/datadir-percona-xtradb-pxc-0.18b321d20ffad92c; range_end:; response_count:1; response_revision:1862; }","duration":"639.292927ms","start":"2026-05-26T13:51:06.499525Z","end":"2026-05-26T13:51:07.138818Z","steps":["trace[336021201] 'range keys from in-memory index tree'  (duration: 638.749472ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-26T13:51:07.138873Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T13:51:06.499497Z","time spent":"639.366799ms","remote":"127.0.0.1:45652","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":1006,"request content":"key:\"/registry/events/openstack/datadir-percona-xtradb-pxc-0.18b321d20ffad92c\" "}
{"level":"info","ts":"2026-05-26T13:51:07.183618Z","caller":"traceutil/trace.go:171","msg":"trace[538012810] transaction","detail":"{read_only:false; response_revision:1863; number_of_response:1; }","duration":"330.05749ms","start":"2026-05-26T13:51:06.853526Z","end":"2026-05-26T13:51:07.183583Z","steps":["trace[538012810] 'process raft request'  (duration: 329.869726ms)"],"step_count":1}
{"level":"info","ts":"2026-05-26T13:51:07.183668Z","caller":"traceutil/trace.go:171","msg":"trace[1886960630] linearizableReadLoop","detail":"{readStateIndex:1938; appliedIndex:1938; }","duration":"299.135354ms","start":"2026-05-26T13:51:06.884481Z","end":"2026-05-26T13:51:07.183617Z","steps":["trace[1886960630] 'read index received'  (duration: 299.115213ms)","trace[1886960630] 'applied index is now lower than readState.Index'  (duration: 17.331µs)"],"step_count":2}
{"level":"warn","ts":"2026-05-26T13:51:07.183982Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.482893ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-10b7e35a-c054-400c-9c90-732299b38372\" ","response":"range_response_count:1 size:3626"}
{"level":"warn","ts":"2026-05-26T13:51:07.183954Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T13:51:06.853491Z","time spent":"330.240836ms","remote":"127.0.0.1:45840","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:1843 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:459 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"info","ts":"2026-05-26T13:51:07.184032Z","caller":"traceutil/trace.go:171","msg":"trace[16573028] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-10b7e35a-c054-400c-9c90-732299b38372; range_end:; response_count:1; response_revision:1863; }","duration":"299.604957ms","start":"2026-05-26T13:51:06.884413Z","end":"2026-05-26T13:51:07.184018Z","steps":["trace[16573028] 'agreement among raft nodes before linearized reading'  (duration: 299.37766ms)"],"step_count":1}
{"level":"info","ts":"2026-05-26T13:51:07.293994Z","caller":"traceutil/trace.go:171","msg":"trace[1196248413] transaction","detail":"{read_only:false; response_revision:1865; number_of_response:1; }","duration":"152.235011ms","start":"2026-05-26T13:51:07.141715Z","end":"2026-05-26T13:51:07.29395Z","steps":["trace[1196248413] 'process raft request'  (duration: 152.094648ms)"],"step_count":1}
{"level":"info","ts":"2026-05-26T13:51:07.294085Z","caller":"traceutil/trace.go:171","msg":"trace[1428518121] transaction","detail":"{read_only:false; response_revision:1868; number_of_response:1; }","duration":"139.097393ms","start":"2026-05-26T13:51:07.154956Z","end":"2026-05-26T13:51:07.294053Z","steps":["trace[1428518121] 'process raft request'  (duration: 139.012951ms)"],"step_count":1}
{"level":"info","ts":"2026-05-26T13:51:07.294167Z","caller":"traceutil/trace.go:171","msg":"trace[1934947268] transaction","detail":"{read_only:false; response_revision:1867; number_of_response:1; }","duration":"146.798099ms","start":"2026-05-26T13:51:07.147348Z","end":"2026-05-26T13:51:07.294146Z","steps":["trace[1934947268] 'process raft request'  (duration: 146.573183ms)"],"step_count":1}
{"level":"info","ts":"2026-05-26T13:51:07.294187Z","caller":"traceutil/trace.go:171","msg":"trace[1249100263] transaction","detail":"{read_only:false; response_revision:1866; number_of_response:1; }","duration":"149.30867ms","start":"2026-05-26T13:51:07.144809Z","end":"2026-05-26T13:51:07.294117Z","steps":["trace[1249100263] 'process raft request'  (duration: 149.076874ms)"],"step_count":1}
{"level":"info","ts":"2026-05-26T13:51:07.294357Z","caller":"traceutil/trace.go:171","msg":"trace[1105755241] linearizableReadLoop","detail":"{readStateIndex:1944; appliedIndex:1938; }","duration":"110.560061ms","start":"2026-05-26T13:51:07.183752Z","end":"2026-05-26T13:51:07.294312Z","steps":["trace[1105755241] 'read index received'  (duration: 54.036326ms)","trace[1105755241] 'applied index is now lower than readState.Index'  (duration: 56.520695ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-26T13:51:07.294651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.303449ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"}
{"level":"info","ts":"2026-05-26T13:51:07.294694Z","caller":"traceutil/trace.go:171","msg":"trace[2015244392] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1869; }","duration":"324.396052ms","start":"2026-05-26T13:51:06.970282Z","end":"2026-05-26T13:51:07.294678Z","steps":["trace[2015244392] 'agreement among raft nodes before linearized reading'  (duration: 324.165916ms)"],"step_count":1}
{"level":"info","ts":"2026-05-26T13:51:07.294681Z","caller":"traceutil/trace.go:171","msg":"trace[1574043653] transaction","detail":"{read_only:false; response_revision:1869; number_of_response:1; }","duration":"138.773095ms","start":"2026-05-26T13:51:07.15589Z","end":"2026-05-26T13:51:07.294663Z","steps":["trace[1574043653] 'process raft request'  (duration: 138.115756ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-26T13:51:07.294733Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T13:51:06.970263Z","time spent":"324.461353ms","remote":"127.0.0.1:35748","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5436,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "}
{"level":"info","ts":"2026-05-26T13:51:07.294739Z","caller":"traceutil/trace.go:171","msg":"trace[674669791] transaction","detail":"{read_only:false; response_revision:1864; number_of_response:1; }","duration":"380.621929ms","start":"2026-05-26T13:51:06.914052Z","end":"2026-05-26T13:51:07.294674Z","steps":["trace[674669791] 'process raft request'  (duration: 323.817684ms)","trace[674669791] 'compare'  (duration: 55.796076ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-26T13:51:07.295132Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T13:51:06.914016Z","time spent":"380.845967ms","remote":"127.0.0.1:45840","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:1733 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"warn","ts":"2026-05-26T13:51:07.931537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.876513ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-26T13:51:07.931645Z","caller":"traceutil/trace.go:171","msg":"trace[1973024943] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1870; }","duration":"285.10048ms","start":"2026-05-26T13:51:07.646525Z","end":"2026-05-26T13:51:07.931626Z","steps":["trace[1973024943] 'range keys from in-memory index tree'  (duration: 284.78287ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-26T13:51:07.932048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.169174ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:559"}
{"level":"info","ts":"2026-05-26T13:51:07.932183Z","caller":"traceutil/trace.go:171","msg":"trace[307553789] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:1870; }","duration":"232.38093ms","start":"2026-05-26T13:51:07.699766Z","end":"2026-05-26T13:51:07.932147Z","steps":["trace[307553789] 'range keys from in-memory index tree'  (duration: 231.922278ms)"],"step_count":1}
{"level":"info","ts":"2026-05-26T13:51:07.93247Z","caller":"traceutil/trace.go:171","msg":"trace[1796217956] transaction","detail":"{read_only:false; response_revision:1871; number_of_response:1; }","duration":"229.721725ms","start":"2026-05-26T13:51:07.702693Z","end":"2026-05-26T13:51:07.932414Z","steps":["trace[1796217956] 'process raft request'  (duration: 207.586054ms)","trace[1796217956] 'compare'  (duration: 21.116722ms)"],"step_count":2}
{"level":"info","ts":"2026-05-26T13:51:07.941924Z","caller":"traceutil/trace.go:171","msg":"trace[180864525] transaction","detail":"{read_only:false; response_revision:1872; number_of_response:1; }","duration":"235.479617ms","start":"2026-05-26T13:51:07.706412Z","end":"2026-05-26T13:51:07.941891Z","steps":["trace[180864525] 'process raft request'  (duration: 235.328033ms)"],"step_count":1}
{"level":"info","ts":"2026-05-26T13:51:19.464594Z","caller":"traceutil/trace.go:171","msg":"trace[2061617990] transaction","detail":"{read_only:false; response_revision:1967; number_of_response:1; }","duration":"101.95377ms","start":"2026-05-26T13:51:19.362611Z","end":"2026-05-26T13:51:19.464565Z","steps":["trace[2061617990] 'process raft request'  (duration: 101.804256ms)"],"step_count":1}
{"level":"info","ts":"2026-05-26T13:51:19.465025Z","caller":"traceutil/trace.go:171","msg":"trace[2002855355] transaction","detail":"{read_only:false; response_revision:1968; number_of_response:1; }","duration":"102.240228ms","start":"2026-05-26T13:51:19.362751Z","end":"2026-05-26T13:51:19.464991Z","steps":["trace[2002855355] 'process raft request'  (duration: 101.772645ms)"],"step_count":1}
{"level":"info","ts":"2026-05-26T13:51:20.345278Z","caller":"traceutil/trace.go:171","msg":"trace[1171805142] transaction","detail":"{read_only:false; response_revision:1972; number_of_response:1; }","duration":"368.213581ms","start":"2026-05-26T13:51:19.97703Z","end":"2026-05-26T13:51:20.345244Z","steps":["trace[1171805142] 'process raft request'  (duration: 367.82919ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-26T13:51:20.345675Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T13:51:19.976998Z","time spent":"368.369326ms","remote":"127.0.0.1:46096","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5636,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/replicasets/openstack/rabbitmq-cluster-operator-54f767cff8\" mod_revision:1614 > success:<request_put:<key:\"/registry/replicasets/openstack/rabbitmq-cluster-operator-54f767cff8\" value_size:5560 >> failure:<request_range:<key:\"/registry/replicasets/openstack/rabbitmq-cluster-operator-54f767cff8\" > >"}
{"level":"info","ts":"2026-05-26T13:51:20.345675Z","caller":"traceutil/trace.go:171","msg":"trace[2039755674] transaction","detail":"{read_only:false; response_revision:1973; number_of_response:1; }","duration":"368.212882ms","start":"2026-05-26T13:51:19.977417Z","end":"2026-05-26T13:51:20.34563Z","steps":["trace[2039755674] 'process raft request'  (duration: 367.763089ms)"],"step_count":1}
{"level":"info","ts":"2026-05-26T13:51:20.345761Z","caller":"traceutil/trace.go:171","msg":"trace[944324322] linearizableReadLoop","detail":"{readStateIndex:2052; appliedIndex:2049; }","duration":"350.390142ms","start":"2026-05-26T13:51:19.99536Z","end":"2026-05-26T13:51:20.34575Z","steps":["trace[944324322] 'read index received'  (duration: 349.507246ms)","trace[944324322] 'applied index is now lower than readState.Index'  (duration: 881.885µs)"],"step_count":2}
{"level":"info","ts":"2026-05-26T13:51:20.345682Z","caller":"traceutil/trace.go:171","msg":"trace[369582336] transaction","detail":"{read_only:false; response_revision:1974; number_of_response:1; }","duration":"361.220766ms","start":"2026-05-26T13:51:19.984432Z","end":"2026-05-26T13:51:20.345653Z","steps":["trace[369582336] 'process raft request'  (duration: 361.035671ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-26T13:51:20.345953Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T13:51:19.977386Z","time spent":"368.393436ms","remote":"127.0.0.1:45840","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:1961 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:478 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-05-26T13:51:20.345999Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T13:51:19.984408Z","time spent":"361.496043ms","remote":"127.0.0.1:45840","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:1962 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:465 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-05-26T13:51:20.357169Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"361.79193ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-05-26T13:51:20.357258Z","caller":"traceutil/trace.go:171","msg":"trace[1023583357] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1974; }","duration":"361.941065ms","start":"2026-05-26T13:51:19.9953Z","end":"2026-05-26T13:51:20.357242Z","steps":["trace[1023583357] 'agreement among raft nodes before linearized reading'  (duration: 350.550456ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-26T13:51:20.357178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"358.922961ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"warn","ts":"2026-05-26T13:51:20.357342Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T13:51:19.995274Z","time spent":"362.058548ms","remote":"127.0.0.1:45840","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-05-26T13:51:20.357366Z","caller":"traceutil/trace.go:171","msg":"trace[1089585584] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1974; }","duration":"359.155807ms","start":"2026-05-26T13:51:19.998191Z","end":"2026-05-26T13:51:20.357347Z","steps":["trace[1089585584] 'agreement among raft nodes before linearized reading'  (duration: 358.812388ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-26T13:51:20.357451Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T13:51:19.998178Z","time spent":"359.26274ms","remote":"127.0.0.1:45840","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-05-26T13:51:23.927512Z","caller":"traceutil/trace.go:171","msg":"trace[138160400] transaction","detail":"{read_only:false; response_revision:1999; number_of_response:1; }","duration":"975.737208ms","start":"2026-05-26T13:51:22.951748Z","end":"2026-05-26T13:51:23.927485Z","steps":["trace[138160400] 'process raft request'  (duration: 975.567063ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-26T13:51:23.927681Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T13:51:22.951723Z","time spent":"975.875102ms","remote":"127.0.0.1:45840","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":544,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" mod_revision:1873 > success:<request_put:<key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" value_size:467 >> failure:<request_range:<key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" > >"}
{"level":"info","ts":"2026-05-26T13:51:23.929462Z","caller":"traceutil/trace.go:171","msg":"trace[1107990670] linearizableReadLoop","detail":"{readStateIndex:2079; appliedIndex:2077; }","duration":"494.497546ms","start":"2026-05-26T13:51:23.434936Z","end":"2026-05-26T13:51:23.929434Z","steps":["trace[1107990670] 'read index received'  (duration: 492.420077ms)","trace[1107990670] 'applied index is now lower than readState.Index'  (duration: 2.076529ms)"],"step_count":2}
{"level":"info","ts":"2026-05-26T13:51:23.929503Z","caller":"traceutil/trace.go:171","msg":"trace[1423882814] transaction","detail":"{read_only:false; response_revision:2000; number_of_response:1; }","duration":"651.996264ms","start":"2026-05-26T13:51:23.277472Z","end":"2026-05-26T13:51:23.929469Z","steps":["trace[1423882814] 'process raft request'  (duration: 651.770698ms)"],"step_count":1}
{"level":"info","ts":"2026-05-26T13:51:23.929574Z","caller":"traceutil/trace.go:171","msg":"trace[1416252916] transaction","detail":"{read_only:false; response_revision:2001; number_of_response:1; }","duration":"452.60162ms","start":"2026-05-26T13:51:23.47695Z","end":"2026-05-26T13:51:23.929551Z","steps":["trace[1416252916] 'process raft request'  (duration: 452.440685ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-26T13:51:23.929684Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.95463ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-05-26T13:51:23.929694Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.458899ms","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":"warn","ts":"2026-05-26T13:51:23.929703Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T13:51:23.476918Z","time spent":"452.731224ms","remote":"127.0.0.1:45840","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:1992 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"info","ts":"2026-05-26T13:51:23.929734Z","caller":"traceutil/trace.go:171","msg":"trace[1808429183] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:2001; }","duration":"218.543632ms","start":"2026-05-26T13:51:23.711178Z","end":"2026-05-26T13:51:23.929722Z","steps":["trace[1808429183] 'agreement among raft nodes before linearized reading'  (duration: 218.482401ms)"],"step_count":1}
{"level":"info","ts":"2026-05-26T13:51:23.929732Z","caller":"traceutil/trace.go:171","msg":"trace[1590585377] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2001; }","duration":"283.016071ms","start":"2026-05-26T13:51:23.646704Z","end":"2026-05-26T13:51:23.92972Z","steps":["trace[1590585377] 'agreement among raft nodes before linearized reading'  (duration: 282.919719ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-26T13:51:23.929812Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"494.849315ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"warn","ts":"2026-05-26T13:51:23.929889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.20752ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"}
{"level":"warn","ts":"2026-05-26T13:51:23.929878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"450.098629ms","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-05-26T13:51:23.929909Z","caller":"traceutil/trace.go:171","msg":"trace[1092111495] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2001; }","duration":"495.009659ms","start":"2026-05-26T13:51:23.434879Z","end":"2026-05-26T13:51:23.929888Z","steps":["trace[1092111495] 'agreement among raft nodes before linearized reading'  (duration: 494.717141ms)"],"step_count":1}
{"level":"info","ts":"2026-05-26T13:51:23.929943Z","caller":"traceutil/trace.go:171","msg":"trace[1084429146] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2001; }","duration":"369.347593ms","start":"2026-05-26T13:51:23.560577Z","end":"2026-05-26T13:51:23.929925Z","steps":["trace[1084429146] 'agreement among raft nodes before linearized reading'  (duration: 369.127147ms)"],"step_count":1}
{"level":"info","ts":"2026-05-26T13:51:23.929957Z","caller":"traceutil/trace.go:171","msg":"trace[383123919] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2001; }","duration":"450.241692ms","start":"2026-05-26T13:51:23.479698Z","end":"2026-05-26T13:51:23.92994Z","steps":["trace[383123919] 'agreement among raft nodes before linearized reading'  (duration: 450.004686ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-26T13:51:23.929965Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T13:51:23.434856Z","time spent":"495.100212ms","remote":"127.0.0.1:45840","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-05-26T13:51:23.92999Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T13:51:23.47968Z","time spent":"450.304675ms","remote":"127.0.0.1:45840","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-05-26T13:51:23.929985Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T13:51:23.560556Z","time spent":"369.419755ms","remote":"127.0.0.1:35748","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5436,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "}
{"level":"warn","ts":"2026-05-26T13:51:23.930114Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T13:51:23.277448Z","time spent":"652.126367ms","remote":"127.0.0.1:45840","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:1990 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:459 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"warn","ts":"2026-05-26T13:51:23.930695Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"453.34081ms","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-05-26T13:51:23.930741Z","caller":"traceutil/trace.go:171","msg":"trace[958460424] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2001; }","duration":"453.455804ms","start":"2026-05-26T13:51:23.477274Z","end":"2026-05-26T13:51:23.93073Z","steps":["trace[958460424] 'agreement among raft nodes before linearized reading'  (duration: 452.324232ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-26T13:51:23.930794Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T13:51:23.477254Z","time spent":"453.532235ms","remote":"127.0.0.1:45840","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-05-26T13:51:56.23241Z","caller":"traceutil/trace.go:171","msg":"trace[1544929897] transaction","detail":"{read_only:false; response_revision:2179; number_of_response:1; }","duration":"108.879154ms","start":"2026-05-26T13:51:56.123492Z","end":"2026-05-26T13:51:56.232371Z","steps":["trace[1544929897] 'process raft request'  (duration: 47.815972ms)","trace[1544929897] 'compare'  (duration: 60.891708ms)"],"step_count":2}
{"level":"info","ts":"2026-05-26T13:51:56.309968Z","caller":"traceutil/trace.go:171","msg":"trace[320345205] linearizableReadLoop","detail":"{readStateIndex:2268; appliedIndex:2265; }","duration":"149.802161ms","start":"2026-05-26T13:51:56.160117Z","end":"2026-05-26T13:51:56.309919Z","steps":["trace[320345205] 'read index received'  (duration: 11.312118ms)","trace[320345205] 'applied index is now lower than readState.Index'  (duration: 138.488703ms)"],"step_count":2}
{"level":"info","ts":"2026-05-26T13:51:56.31017Z","caller":"traceutil/trace.go:171","msg":"trace[1441738417] transaction","detail":"{read_only:false; response_revision:2180; number_of_response:1; }","duration":"186.260654ms","start":"2026-05-26T13:51:56.123857Z","end":"2026-05-26T13:51:56.310118Z","steps":["trace[1441738417] 'process raft request'  (duration: 185.76334ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-26T13:51:56.310249Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.111619ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"}
{"level":"info","ts":"2026-05-26T13:51:56.310306Z","caller":"traceutil/trace.go:171","msg":"trace[767452413] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2181; }","duration":"150.238084ms","start":"2026-05-26T13:51:56.160049Z","end":"2026-05-26T13:51:56.310287Z","steps":["trace[767452413] 'agreement among raft nodes before linearized reading'  (duration: 150.011197ms)"],"step_count":1}
{"level":"info","ts":"2026-05-26T13:51:56.310364Z","caller":"traceutil/trace.go:171","msg":"trace[565149559] transaction","detail":"{read_only:false; response_revision:2181; number_of_response:1; }","duration":"186.213972ms","start":"2026-05-26T13:51:56.123921Z","end":"2026-05-26T13:51:56.310135Z","steps":["trace[565149559] 'process raft request'  (duration: 185.916824ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-26T13:52:02.851916Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13313096128157494562,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-05-26T13:52:02.942954Z","caller":"traceutil/trace.go:171","msg":"trace[327909702] transaction","detail":"{read_only:false; response_revision:2211; number_of_response:1; }","duration":"600.866331ms","start":"2026-05-26T13:52:02.342057Z","end":"2026-05-26T13:52:02.942924Z","steps":["trace[327909702] 'process raft request'  (duration: 600.569652ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-26T13:52:02.94314Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T13:52:02.342037Z","time spent":"601.000855ms","remote":"127.0.0.1:45840","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:2202 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-05-26T13:52:02.942942Z","caller":"traceutil/trace.go:171","msg":"trace[156823456] transaction","detail":"{read_only:false; response_revision:2212; number_of_response:1; }","duration":"600.851651ms","start":"2026-05-26T13:52:02.342057Z","end":"2026-05-26T13:52:02.942909Z","steps":["trace[156823456] 'process raft request'  (duration: 600.777588ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-26T13:52:02.943391Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T13:52:02.342031Z","time spent":"601.278663ms","remote":"127.0.0.1:45840","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:2201 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-05-26T13:52:02.946244Z","caller":"traceutil/trace.go:171","msg":"trace[995394817] transaction","detail":"{read_only:false; response_revision:2214; number_of_response:1; }","duration":"361.592282ms","start":"2026-05-26T13:52:02.584625Z","end":"2026-05-26T13:52:02.946218Z","steps":["trace[995394817] 'process raft request'  (duration: 361.52361ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-26T13:52:02.946314Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T13:52:02.58461Z","time spent":"361.669713ms","remote":"127.0.0.1:45840","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:2204 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:478 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"info","ts":"2026-05-26T13:52:02.946268Z","caller":"traceutil/trace.go:171","msg":"trace[1569270362] linearizableReadLoop","detail":"{readStateIndex:2302; appliedIndex:2298; }","duration":"595.065699ms","start":"2026-05-26T13:52:02.351131Z","end":"2026-05-26T13:52:02.946197Z","steps":["trace[1569270362] 'read index received'  (duration: 591.471788ms)","trace[1569270362] 'applied index is now lower than readState.Index'  (duration: 3.592611ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-26T13:52:02.946456Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.86118ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-05-26T13:52:02.94651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.346754ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-05-26T13:52:02.94654Z","caller":"traceutil/trace.go:171","msg":"trace[295629301] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2214; }","duration":"325.378046ms","start":"2026-05-26T13:52:02.621155Z","end":"2026-05-26T13:52:02.946533Z","steps":["trace[295629301] 'agreement among raft nodes before linearized reading'  (duration: 325.255322ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-26T13:52:02.94657Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T13:52:02.621055Z","time spent":"325.508939ms","remote":"127.0.0.1:45840","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-05-26T13:52:02.946574Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.695463ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/issuers/\" range_end:\"/registry/cert-manager.io/issuers0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-05-26T13:52:02.946618Z","caller":"traceutil/trace.go:171","msg":"trace[1283619811] range","detail":"{range_begin:/registry/cert-manager.io/issuers/; range_end:/registry/cert-manager.io/issuers0; response_count:0; response_revision:2214; }","duration":"162.779995ms","start":"2026-05-26T13:52:02.783826Z","end":"2026-05-26T13:52:02.946606Z","steps":["trace[1283619811] 'agreement among raft nodes before linearized reading'  (duration: 162.707124ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-26T13:52:02.946675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.074206ms","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-05-26T13:52:02.946703Z","caller":"traceutil/trace.go:171","msg":"trace[208322507] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2214; }","duration":"310.149679ms","start":"2026-05-26T13:52:02.636547Z","end":"2026-05-26T13:52:02.946697Z","steps":["trace[208322507] 'agreement among raft nodes before linearized reading'  (duration: 310.083968ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-26T13:52:02.946771Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T13:52:02.636526Z","time spent":"310.237081ms","remote":"127.0.0.1:45840","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-05-26T13:52:02.946509Z","caller":"traceutil/trace.go:171","msg":"trace[452927126] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2214; }","duration":"299.956592ms","start":"2026-05-26T13:52:02.646537Z","end":"2026-05-26T13:52:02.946494Z","steps":["trace[452927126] 'agreement among raft nodes before linearized reading'  (duration: 299.884301ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-26T13:52:02.946844Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T13:52:02.64652Z","time spent":"300.318553ms","remote":"127.0.0.1:45582","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-05-26T13:52:02.94682Z","caller":"traceutil/trace.go:171","msg":"trace[87391415] transaction","detail":"{read_only:false; response_revision:2213; number_of_response:1; }","duration":"365.315766ms","start":"2026-05-26T13:52:02.580874Z","end":"2026-05-26T13:52:02.94619Z","steps":["trace[87391415] 'process raft request'  (duration: 365.124441ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-26T13:52:02.947101Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T13:52:02.580846Z","time spent":"366.111329ms","remote":"127.0.0.1:45840","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:2203 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:465 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-05-26T13:52:02.946542Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"595.380007ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"}
{"level":"info","ts":"2026-05-26T13:52:02.947467Z","caller":"traceutil/trace.go:171","msg":"trace[1134230890] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2214; }","duration":"596.355215ms","start":"2026-05-26T13:52:02.351073Z","end":"2026-05-26T13:52:02.947428Z","steps":["trace[1134230890] 'agreement among raft nodes before linearized reading'  (duration: 595.266094ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-26T13:52:02.947517Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T13:52:02.351055Z","time spent":"596.448769ms","remote":"127.0.0.1:35748","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5436,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "}
{"level":"warn","ts":"2026-05-26T13:52:03.585022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"359.958035ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13313096128157494570 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:2205 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-26T13:52:03.58537Z","caller":"traceutil/trace.go:171","msg":"trace[1251361369] transaction","detail":"{read_only:false; response_revision:2215; number_of_response:1; }","duration":"634.380491ms","start":"2026-05-26T13:52:02.950948Z","end":"2026-05-26T13:52:03.585328Z","steps":["trace[1251361369] 'process raft request'  (duration: 274.003844ms)","trace[1251361369] 'compare'  (duration: 359.559305ms)"],"step_count":2}
{"level":"info","ts":"2026-05-26T13:52:03.585419Z","caller":"traceutil/trace.go:171","msg":"trace[28155943] linearizableReadLoop","detail":"{readStateIndex:2304; appliedIndex:2302; }","duration":"431.487692ms","start":"2026-05-26T13:52:03.153909Z","end":"2026-05-26T13:52:03.585397Z","steps":["trace[28155943] 'read index received'  (duration: 71.056083ms)","trace[28155943] 'applied index is now lower than readState.Index'  (duration: 360.430549ms)"],"step_count":2}
{"level":"info","ts":"2026-05-26T13:52:03.585464Z","caller":"traceutil/trace.go:171","msg":"trace[1217957416] transaction","detail":"{read_only:false; response_revision:2216; number_of_response:1; }","duration":"633.664842ms","start":"2026-05-26T13:52:02.951761Z","end":"2026-05-26T13:52:03.585426Z","steps":["trace[1217957416] 'process raft request'  (duration: 633.400515ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-26T13:52:03.585578Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T13:52:02.950928Z","time spent":"634.539187ms","remote":"127.0.0.1:45840","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:2205 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-05-26T13:52:03.585632Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"431.718418ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"warn","ts":"2026-05-26T13:52:03.585634Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T13:52:02.95173Z","time spent":"633.817946ms","remote":"127.0.0.1:45840","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:2206 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-05-26T13:52:03.58567Z","caller":"traceutil/trace.go:171","msg":"trace[1576601361] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:2216; }","duration":"431.79429ms","start":"2026-05-26T13:52:03.153865Z","end":"2026-05-26T13:52:03.585659Z","steps":["trace[1576601361] 'agreement among raft nodes before linearized reading'  (duration: 431.588444ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-26T13:52:03.585713Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T13:52:03.153846Z","time spent":"431.857762ms","remote":"127.0.0.1:46134","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":253,"response size":32,"request content":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true "}
{"level":"warn","ts":"2026-05-26T13:52:03.58571Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.026931ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-05-26T13:52:03.585778Z","caller":"traceutil/trace.go:171","msg":"trace[1538305022] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:2216; }","duration":"271.155365ms","start":"2026-05-26T13:52:03.314602Z","end":"2026-05-26T13:52:03.585758Z","steps":["trace[1538305022] 'agreement among raft nodes before linearized reading'  (duration: 271.039802ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-26T13:52:03.585804Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.215407ms","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-05-26T13:52:03.585877Z","caller":"traceutil/trace.go:171","msg":"trace[1194393402] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:2216; }","duration":"102.294819ms","start":"2026-05-26T13:52:03.483569Z","end":"2026-05-26T13:52:03.585864Z","steps":["trace[1194393402] 'agreement among raft nodes before linearized reading'  (duration: 102.132035ms)"],"step_count":1}
{"level":"info","ts":"2026-05-26T13:52:46.428589Z","caller":"traceutil/trace.go:171","msg":"trace[2061983497] transaction","detail":"{read_only:false; response_revision:2621; number_of_response:1; }","duration":"100.636774ms","start":"2026-05-26T13:52:46.327918Z","end":"2026-05-26T13:52:46.428555Z","steps":["trace[2061983497] 'process raft request'  (duration: 100.430629ms)"],"step_count":1}
{"level":"info","ts":"2026-05-26T13:53:20.183773Z","caller":"traceutil/trace.go:171","msg":"trace[408695241] transaction","detail":"{read_only:false; response_revision:2823; number_of_response:1; }","duration":"196.408163ms","start":"2026-05-26T13:53:19.987334Z","end":"2026-05-26T13:53:20.183742Z","steps":["trace[408695241] 'process raft request'  (duration: 196.216737ms)"],"step_count":1}
{"level":"info","ts":"2026-05-26T13:53:20.566251Z","caller":"traceutil/trace.go:171","msg":"trace[1944376107] transaction","detail":"{read_only:false; response_revision:2824; number_of_response:1; }","duration":"578.264644ms","start":"2026-05-26T13:53:19.987959Z","end":"2026-05-26T13:53:20.566224Z","steps":["trace[1944376107] 'process raft request'  (duration: 567.405021ms)","trace[1944376107] 'compare'  (duration: 10.563645ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-26T13:53:20.566402Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T13:53:19.987947Z","time spent":"578.378317ms","remote":"127.0.0.1:45840","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:2814 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-05-26T13:53:20.609892Z","caller":"traceutil/trace.go:171","msg":"trace[1084398995] transaction","detail":"{read_only:false; response_revision:2825; number_of_response:1; }","duration":"146.783ms","start":"2026-05-26T13:53:20.463091Z","end":"2026-05-26T13:53:20.609874Z","steps":["trace[1084398995] 'process raft request'  (duration: 146.619916ms)"],"step_count":1}
{"level":"info","ts":"2026-05-26T13:53:20.610242Z","caller":"traceutil/trace.go:171","msg":"trace[583578385] linearizableReadLoop","detail":"{readStateIndex:2937; appliedIndex:2935; }","duration":"190.564599ms","start":"2026-05-26T13:53:20.419649Z","end":"2026-05-26T13:53:20.610213Z","steps":["trace[583578385] 'read index received'  (duration: 135.799304ms)","trace[583578385] 'applied index is now lower than readState.Index'  (duration: 54.763935ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-26T13:53:20.610574Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.901448ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"}
{"level":"info","ts":"2026-05-26T13:53:20.610701Z","caller":"traceutil/trace.go:171","msg":"trace[303005876] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2827; }","duration":"191.065795ms","start":"2026-05-26T13:53:20.419616Z","end":"2026-05-26T13:53:20.610682Z","steps":["trace[303005876] 'agreement among raft nodes before linearized reading'  (duration: 190.787977ms)"],"step_count":1}
{"level":"info","ts":"2026-05-26T13:53:31.382024Z","caller":"traceutil/trace.go:171","msg":"trace[2048914367] transaction","detail":"{read_only:false; response_revision:2889; number_of_response:1; }","duration":"127.232516ms","start":"2026-05-26T13:53:31.254767Z","end":"2026-05-26T13:53:31.381999Z","steps":["trace[2048914367] 'process raft request'  (duration: 127.088071ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-26T13:55:51.131021Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.211895ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-05-26T13:55:51.131128Z","caller":"traceutil/trace.go:171","msg":"trace[1132421463] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:3820; }","duration":"143.38164ms","start":"2026-05-26T13:55:50.987727Z","end":"2026-05-26T13:55:51.131109Z","steps":["trace[1132421463] 'count revisions from in-memory index tree'  (duration: 143.110322ms)"],"step_count":1}
{"level":"info","ts":"2026-05-26T13:55:51.273958Z","caller":"traceutil/trace.go:171","msg":"trace[1773305383] linearizableReadLoop","detail":"{readStateIndex:3971; appliedIndex:3970; }","duration":"136.422106ms","start":"2026-05-26T13:55:51.137514Z","end":"2026-05-26T13:55:51.273936Z","steps":["trace[1773305383] 'read index received'  (duration: 136.276252ms)","trace[1773305383] 'applied index is now lower than readState.Index'  (duration: 144.774µs)"],"step_count":2}
{"level":"info","ts":"2026-05-26T13:55:51.274067Z","caller":"traceutil/trace.go:171","msg":"trace[67327463] transaction","detail":"{read_only:false; response_revision:3821; number_of_response:1; }","duration":"136.709385ms","start":"2026-05-26T13:55:51.137319Z","end":"2026-05-26T13:55:51.274029Z","steps":["trace[67327463] 'process raft request'  (duration: 136.476929ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-26T13:55:51.27415Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.629443ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-prometheus-client-secret\" ","response":"range_response_count:1 size:692"}
{"level":"info","ts":"2026-05-26T13:55:51.274184Z","caller":"traceutil/trace.go:171","msg":"trace[394094296] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-prometheus-client-secret; range_end:; response_count:1; response_revision:3821; }","duration":"136.729125ms","start":"2026-05-26T13:55:51.137442Z","end":"2026-05-26T13:55:51.274171Z","steps":["trace[394094296] 'agreement among raft nodes before linearized reading'  (duration: 136.593711ms)"],"step_count":1}
{"level":"info","ts":"2026-05-26T13:55:51.327138Z","caller":"traceutil/trace.go:171","msg":"trace[1743067919] transaction","detail":"{read_only:false; response_revision:3822; number_of_response:1; }","duration":"187.894976ms","start":"2026-05-26T13:55:51.139213Z","end":"2026-05-26T13:55:51.327108Z","steps":["trace[1743067919] 'process raft request'  (duration: 187.718801ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-26T13:55:51.327204Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.143631ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-7ml7x\" ","response":"range_response_count:1 size:6520"}
{"level":"info","ts":"2026-05-26T13:55:51.327264Z","caller":"traceutil/trace.go:171","msg":"trace[120006502] range","detail":"{range_begin:/registry/pods/openstack/keepalived-7ml7x; range_end:; response_count:1; response_revision:3822; }","duration":"180.258053ms","start":"2026-05-26T13:55:51.146992Z","end":"2026-05-26T13:55:51.32725Z","steps":["trace[120006502] 'agreement among raft nodes before linearized reading'  (duration: 180.094739ms)"],"step_count":1}
{"level":"info","ts":"2026-05-26T13:57:15.863472Z","caller":"traceutil/trace.go:171","msg":"trace[377038910] linearizableReadLoop","detail":"{readStateIndex:4955; appliedIndex:4948; }","duration":"102.020176ms","start":"2026-05-26T13:57:15.76143Z","end":"2026-05-26T13:57:15.86345Z","steps":["trace[377038910] 'read index received'  (duration: 34.869026ms)","trace[377038910] 'applied index is now lower than readState.Index'  (duration: 67.14994ms)"],"step_count":2}
{"level":"info","ts":"2026-05-26T13:57:15.865075Z","caller":"traceutil/trace.go:171","msg":"trace[1751299940] transaction","detail":"{read_only:false; response_revision:4762; number_of_response:1; }","duration":"105.479432ms","start":"2026-05-26T13:57:15.759571Z","end":"2026-05-26T13:57:15.865051Z","steps":["trace[1751299940] 'process raft request'  (duration: 103.520847ms)"],"step_count":1}
{"level":"info","ts":"2026-05-26T13:57:15.865255Z","caller":"traceutil/trace.go:171","msg":"trace[581563473] transaction","detail":"{read_only:false; response_revision:4763; number_of_response:1; }","duration":"105.504381ms","start":"2026-05-26T13:57:15.759743Z","end":"2026-05-26T13:57:15.865247Z","steps":["trace[581563473] 'process raft request'  (duration: 103.481386ms)"],"step_count":1}
{"level":"info","ts":"2026-05-26T13:57:15.865356Z","caller":"traceutil/trace.go:171","msg":"trace[2010957202] transaction","detail":"{read_only:false; response_revision:4764; number_of_response:1; }","duration":"105.548103ms","start":"2026-05-26T13:57:15.759802Z","end":"2026-05-26T13:57:15.86535Z","steps":["trace[2010957202] 'process raft request'  (duration: 103.483286ms)"],"step_count":1}
{"level":"info","ts":"2026-05-26T13:57:15.865436Z","caller":"traceutil/trace.go:171","msg":"trace[760209614] transaction","detail":"{read_only:false; response_revision:4765; number_of_response:1; }","duration":"105.565574ms","start":"2026-05-26T13:57:15.759863Z","end":"2026-05-26T13:57:15.865429Z","steps":["trace[760209614] 'process raft request'  (duration: 103.453085ms)"],"step_count":1}
{"level":"info","ts":"2026-05-26T13:57:15.866131Z","caller":"traceutil/trace.go:171","msg":"trace[871322445] transaction","detail":"{read_only:false; response_revision:4766; number_of_response:1; }","duration":"106.105219ms","start":"2026-05-26T13:57:15.760016Z","end":"2026-05-26T13:57:15.866121Z","steps":["trace[871322445] 'process raft request'  (duration: 103.323882ms)"],"step_count":1}
{"level":"info","ts":"2026-05-26T13:57:15.866227Z","caller":"traceutil/trace.go:171","msg":"trace[1956268412] transaction","detail":"{read_only:false; response_revision:4767; number_of_response:1; }","duration":"106.090208ms","start":"2026-05-26T13:57:15.760129Z","end":"2026-05-26T13:57:15.866219Z","steps":["trace[1956268412] 'process raft request'  (duration: 103.23988ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-26T13:57:15.866898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.459941ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:7 size:62970"}
{"level":"info","ts":"2026-05-26T13:57:15.866929Z","caller":"traceutil/trace.go:171","msg":"trace[1112896242] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:7; response_revision:4768; }","duration":"105.543583ms","start":"2026-05-26T13:57:15.761376Z","end":"2026-05-26T13:57:15.86692Z","steps":["trace[1112896242] 'agreement among raft nodes before linearized reading'  (duration: 105.356618ms)"],"step_count":1}
{"level":"info","ts":"2026-05-26T13:57:18.576984Z","caller":"traceutil/trace.go:171","msg":"trace[1187208910] transaction","detail":"{read_only:false; response_revision:4962; number_of_response:1; }","duration":"109.315037ms","start":"2026-05-26T13:57:18.467619Z","end":"2026-05-26T13:57:18.576934Z","steps":["trace[1187208910] 'process raft request'  (duration: 109.014999ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-26T13:57:20.878025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.396777ms","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-05-26T13:57:20.878088Z","caller":"traceutil/trace.go:171","msg":"trace[1919347689] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5005; }","duration":"271.463939ms","start":"2026-05-26T13:57:20.606606Z","end":"2026-05-26T13:57:20.87807Z","steps":["trace[1919347689] 'range keys from in-memory index tree'  (duration: 271.242561ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-26T13:57:20.87811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.841689ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-05-26T13:57:20.87827Z","caller":"traceutil/trace.go:171","msg":"trace[354535143] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5005; }","duration":"255.066664ms","start":"2026-05-26T13:57:20.623168Z","end":"2026-05-26T13:57:20.878234Z","steps":["trace[354535143] 'range keys from in-memory index tree'  (duration: 254.597522ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-26T13:57:20.899177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.787626ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13313096128157501119 > lease_revoke:<id:38c19e648b74c256>","response":"size:29"}
{"level":"info","ts":"2026-05-26T13:57:20.899426Z","caller":"traceutil/trace.go:171","msg":"trace[2009507078] linearizableReadLoop","detail":"{readStateIndex:5199; appliedIndex:5198; }","duration":"252.793921ms","start":"2026-05-26T13:57:20.646597Z","end":"2026-05-26T13:57:20.899391Z","steps":["trace[2009507078] 'read index received'  (duration: 75.725947ms)","trace[2009507078] 'applied index is now lower than readState.Index'  (duration: 177.065474ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-26T13:57:20.899608Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.986838ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-26T13:57:20.899672Z","caller":"traceutil/trace.go:171","msg":"trace[1722432786] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5006; }","duration":"253.11271ms","start":"2026-05-26T13:57:20.646545Z","end":"2026-05-26T13:57:20.899658Z","steps":["trace[1722432786] 'agreement among raft nodes before linearized reading'  (duration: 252.931085ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-26T13:57:20.902681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.713006ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-79690844-488f-470b-a329-40899878c96c\" ","response":"range_response_count:1 size:4052"}
{"level":"info","ts":"2026-05-26T13:57:20.902731Z","caller":"traceutil/trace.go:171","msg":"trace[1290384876] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-79690844-488f-470b-a329-40899878c96c; range_end:; response_count:1; response_revision:5007; }","duration":"214.80979ms","start":"2026-05-26T13:57:20.687909Z","end":"2026-05-26T13:57:20.902719Z","steps":["trace[1290384876] 'agreement among raft nodes before linearized reading'  (duration: 214.237614ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-26T13:57:20.903063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.995268ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:530"}
{"level":"info","ts":"2026-05-26T13:57:20.903104Z","caller":"traceutil/trace.go:171","msg":"trace[816183078] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:5007; }","duration":"118.07494ms","start":"2026-05-26T13:57:20.785018Z","end":"2026-05-26T13:57:20.903093Z","steps":["trace[816183078] 'agreement among raft nodes before linearized reading'  (duration: 117.934496ms)"],"step_count":1}
{"level":"info","ts":"2026-05-26T13:57:32.747531Z","caller":"traceutil/trace.go:171","msg":"trace[224103135] linearizableReadLoop","detail":"{readStateIndex:5440; appliedIndex:5439; }","duration":"196.022899ms","start":"2026-05-26T13:57:32.551481Z","end":"2026-05-26T13:57:32.747504Z","steps":["trace[224103135] 'read index received'  (duration: 195.749282ms)","trace[224103135] 'applied index is now lower than readState.Index'  (duration: 272.667µs)"],"step_count":2}
{"level":"info","ts":"2026-05-26T13:57:32.747569Z","caller":"traceutil/trace.go:171","msg":"trace[1581853816] transaction","detail":"{read_only:false; response_revision:5237; number_of_response:1; }","duration":"197.788279ms","start":"2026-05-26T13:57:32.549758Z","end":"2026-05-26T13:57:32.747546Z","steps":["trace[1581853816] 'process raft request'  (duration: 197.571443ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-26T13:57:32.747776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.276146ms","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-05-26T13:57:32.747818Z","caller":"traceutil/trace.go:171","msg":"trace[1108266664] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5237; }","duration":"196.362757ms","start":"2026-05-26T13:57:32.551443Z","end":"2026-05-26T13:57:32.747806Z","steps":["trace[1108266664] 'agreement among raft nodes before linearized reading'  (duration: 196.193863ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-26T13:57:32.747823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.276217ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-26T13:57:32.747942Z","caller":"traceutil/trace.go:171","msg":"trace[93946273] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5237; }","duration":"100.433091ms","start":"2026-05-26T13:57:32.647491Z","end":"2026-05-26T13:57:32.747924Z","steps":["trace[93946273] 'agreement among raft nodes before linearized reading'  (duration: 100.241496ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-26T13:57:32.747982Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.601931ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/vector-rpp6f\" ","response":"range_response_count:1 size:5851"}
{"level":"info","ts":"2026-05-26T13:57:32.748607Z","caller":"traceutil/trace.go:171","msg":"trace[1458598073] range","detail":"{range_begin:/registry/pods/monitoring/vector-rpp6f; range_end:; response_count:1; response_revision:5237; }","duration":"128.742155ms","start":"2026-05-26T13:57:32.61935Z","end":"2026-05-26T13:57:32.748092Z","steps":["trace[1458598073] 'agreement among raft nodes before linearized reading'  (duration: 128.349334ms)"],"step_count":1}
{"level":"info","ts":"2026-05-26T13:57:32.860405Z","caller":"traceutil/trace.go:171","msg":"trace[1604928529] transaction","detail":"{read_only:false; response_revision:5239; number_of_response:1; }","duration":"102.683864ms","start":"2026-05-26T13:57:32.757696Z","end":"2026-05-26T13:57:32.86038Z","steps":["trace[1604928529] 'process raft request'  (duration: 57.734529ms)","trace[1604928529] 'compare'  (duration: 44.836472ms)"],"step_count":2}
{"level":"info","ts":"2026-05-26T13:57:32.86045Z","caller":"traceutil/trace.go:171","msg":"trace[302250648] linearizableReadLoop","detail":"{readStateIndex:5442; appliedIndex:5440; }","duration":"102.673343ms","start":"2026-05-26T13:57:32.757746Z","end":"2026-05-26T13:57:32.860419Z","steps":["trace[302250648] 'read index received'  (duration: 6.656673ms)","trace[302250648] 'applied index is now lower than readState.Index'  (duration: 96.01481ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-26T13:57:32.86064Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.87878ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5651"}
{"level":"info","ts":"2026-05-26T13:57:32.860677Z","caller":"traceutil/trace.go:171","msg":"trace[1457797883] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:5240; }","duration":"102.936511ms","start":"2026-05-26T13:57:32.757727Z","end":"2026-05-26T13:57:32.860663Z","steps":["trace[1457797883] 'agreement among raft nodes before linearized reading'  (duration: 102.769127ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-26T13:57:33.721143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.295808ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-26T13:57:33.721275Z","caller":"traceutil/trace.go:171","msg":"trace[794965496] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:5252; }","duration":"195.434792ms","start":"2026-05-26T13:57:33.52582Z","end":"2026-05-26T13:57:33.721254Z","steps":["trace[794965496] 'range keys from in-memory index tree'  (duration: 195.279808ms)"],"step_count":1}
{"level":"info","ts":"2026-05-26T13:57:33.738666Z","caller":"traceutil/trace.go:171","msg":"trace[1932772961] transaction","detail":"{read_only:false; response_revision:5253; number_of_response:1; }","duration":"123.338587ms","start":"2026-05-26T13:57:33.615307Z","end":"2026-05-26T13:57:33.738646Z","steps":["trace[1932772961] 'process raft request'  (duration: 123.198452ms)"],"step_count":1}
{"level":"info","ts":"2026-05-26T13:57:36.013743Z","caller":"traceutil/trace.go:171","msg":"trace[999337863] transaction","detail":"{read_only:false; response_revision:5292; number_of_response:1; }","duration":"269.506405ms","start":"2026-05-26T13:57:35.74421Z","end":"2026-05-26T13:57:36.013716Z","steps":["trace[999337863] 'process raft request'  (duration: 195.036522ms)","trace[999337863] 'compare'  (duration: 74.263447ms)"],"step_count":2}
{"level":"info","ts":"2026-05-26T13:57:36.01784Z","caller":"traceutil/trace.go:171","msg":"trace[184338271] linearizableReadLoop","detail":"{readStateIndex:5497; appliedIndex:5495; }","duration":"101.096791ms","start":"2026-05-26T13:57:35.9167Z","end":"2026-05-26T13:57:36.01782Z","steps":["trace[184338271] 'read index received'  (duration: 22.539165ms)","trace[184338271] 'applied index is now lower than readState.Index'  (duration: 78.556346ms)"],"step_count":2}
{"level":"info","ts":"2026-05-26T13:57:36.017911Z","caller":"traceutil/trace.go:171","msg":"trace[1440650360] transaction","detail":"{read_only:false; response_revision:5293; number_of_response:1; }","duration":"263.420846ms","start":"2026-05-26T13:57:35.754458Z","end":"2026-05-26T13:57:36.017879Z","steps":["trace[1440650360] 'process raft request'  (duration: 263.174668ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-26T13:57:36.018033Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.324236ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:530"}
{"level":"info","ts":"2026-05-26T13:57:36.01808Z","caller":"traceutil/trace.go:171","msg":"trace[1826448246] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:5293; }","duration":"101.419408ms","start":"2026-05-26T13:57:35.916649Z","end":"2026-05-26T13:57:36.018068Z","steps":["trace[1826448246] 'agreement among raft nodes before linearized reading'  (duration: 101.254974ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-26T13:57:40.810602Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.62166ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-26T13:57:40.810713Z","caller":"traceutil/trace.go:171","msg":"trace[868048848] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5425; }","duration":"164.787514ms","start":"2026-05-26T13:57:40.645901Z","end":"2026-05-26T13:57:40.810688Z","steps":["trace[868048848] 'range keys from in-memory index tree'  (duration: 164.516237ms)"],"step_count":1}
{"level":"info","ts":"2026-05-26T13:57:43.211873Z","caller":"traceutil/trace.go:171","msg":"trace[283588648] linearizableReadLoop","detail":"{readStateIndex:5658; appliedIndex:5657; }","duration":"113.900084ms","start":"2026-05-26T13:57:43.097951Z","end":"2026-05-26T13:57:43.211851Z","steps":["trace[283588648] 'read index received'  (duration: 113.72975ms)","trace[283588648] 'applied index is now lower than readState.Index'  (duration: 169.434µs)"],"step_count":2}
{"level":"warn","ts":"2026-05-26T13:57:43.212062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.09202ms","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-05-26T13:57:43.212095Z","caller":"traceutil/trace.go:171","msg":"trace[122526921] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5453; }","duration":"114.169132ms","start":"2026-05-26T13:57:43.097916Z","end":"2026-05-26T13:57:43.212086Z","steps":["trace[122526921] 'agreement among raft nodes before linearized reading'  (duration: 114.025928ms)"],"step_count":1}
{"level":"info","ts":"2026-05-26T13:57:43.212071Z","caller":"traceutil/trace.go:171","msg":"trace[866115534] transaction","detail":"{read_only:false; response_revision:5453; number_of_response:1; }","duration":"123.884341ms","start":"2026-05-26T13:57:43.088153Z","end":"2026-05-26T13:57:43.212038Z","steps":["trace[866115534] 'process raft request'  (duration: 123.570222ms)"],"step_count":1}
{"level":"info","ts":"2026-05-26T13:57:48.247605Z","caller":"traceutil/trace.go:171","msg":"trace[1628043800] transaction","detail":"{read_only:false; response_revision:5560; number_of_response:1; }","duration":"109.815571ms","start":"2026-05-26T13:57:48.137766Z","end":"2026-05-26T13:57:48.247581Z","steps":["trace[1628043800] 'process raft request'  (duration: 109.536733ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-26T13:57:48.247853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.907584ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:9 size:81597"}
{"level":"info","ts":"2026-05-26T13:57:48.247939Z","caller":"traceutil/trace.go:171","msg":"trace[1066483097] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:9; response_revision:5560; }","duration":"110.063839ms","start":"2026-05-26T13:57:48.137862Z","end":"2026-05-26T13:57:48.247926Z","steps":["trace[1066483097] 'agreement among raft nodes before linearized reading'  (duration: 109.75894ms)"],"step_count":1}
{"level":"info","ts":"2026-05-26T13:57:53.130418Z","caller":"traceutil/trace.go:171","msg":"trace[811089213] linearizableReadLoop","detail":"{readStateIndex:5806; appliedIndex:5805; }","duration":"104.407232ms","start":"2026-05-26T13:57:53.025991Z","end":"2026-05-26T13:57:53.130398Z","steps":["trace[811089213] 'read index received'  (duration: 104.222586ms)","trace[811089213] 'applied index is now lower than readState.Index'  (duration: 184.016µs)"],"step_count":2}
{"level":"info","ts":"2026-05-26T13:57:53.130525Z","caller":"traceutil/trace.go:171","msg":"trace[545526622] transaction","detail":"{read_only:false; response_revision:5596; number_of_response:1; }","duration":"138.64295ms","start":"2026-05-26T13:57:52.991844Z","end":"2026-05-26T13:57:53.130487Z","steps":["trace[545526622] 'process raft request'  (duration: 138.419003ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-26T13:57:53.130575Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.562637ms","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-05-26T13:57:53.130757Z","caller":"traceutil/trace.go:171","msg":"trace[1576812085] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5596; }","duration":"104.778702ms","start":"2026-05-26T13:57:53.025944Z","end":"2026-05-26T13:57:53.130723Z","steps":["trace[1576812085] 'agreement among raft nodes before linearized reading'  (duration: 104.528374ms)"],"step_count":1}
{"level":"info","ts":"2026-05-26T13:57:53.308182Z","caller":"traceutil/trace.go:171","msg":"trace[2077942853] transaction","detail":"{read_only:false; response_revision:5597; number_of_response:1; }","duration":"165.201546ms","start":"2026-05-26T13:57:53.142957Z","end":"2026-05-26T13:57:53.308158Z","steps":["trace[2077942853] 'process raft request'  (duration: 123.135741ms)","trace[2077942853] 'compare'  (duration: 41.910761ms)"],"step_count":2}
{"level":"info","ts":"2026-05-26T13:57:53.493187Z","caller":"traceutil/trace.go:171","msg":"trace[1268540694] transaction","detail":"{read_only:false; response_revision:5599; number_of_response:1; }","duration":"178.770831ms","start":"2026-05-26T13:57:53.314386Z","end":"2026-05-26T13:57:53.493157Z","steps":["trace[1268540694] 'process raft request'  (duration: 172.072966ms)"],"step_count":1}
{"level":"info","ts":"2026-05-26T13:57:53.493569Z","caller":"traceutil/trace.go:171","msg":"trace[62101514] transaction","detail":"{read_only:false; response_revision:5600; number_of_response:1; }","duration":"178.243866ms","start":"2026-05-26T13:57:53.315296Z","end":"2026-05-26T13:57:53.49354Z","steps":["trace[62101514] 'process raft request'  (duration: 177.766183ms)"],"step_count":1}
{"level":"info","ts":"2026-05-26T13:57:53.493666Z","caller":"traceutil/trace.go:171","msg":"trace[1011491663] transaction","detail":"{read_only:false; response_revision:5601; number_of_response:1; }","duration":"177.484795ms","start":"2026-05-26T13:57:53.31615Z","end":"2026-05-26T13:57:53.493635Z","steps":["trace[1011491663] 'process raft request'  (duration: 177.214067ms)"],"step_count":1}
{"level":"info","ts":"2026-05-26T13:57:53.493684Z","caller":"traceutil/trace.go:171","msg":"trace[945356330] transaction","detail":"{read_only:false; response_revision:5602; number_of_response:1; }","duration":"177.385663ms","start":"2026-05-26T13:57:53.316278Z","end":"2026-05-26T13:57:53.493664Z","steps":["trace[945356330] 'process raft request'  (duration: 177.206317ms)"],"step_count":1}
{"level":"info","ts":"2026-05-26T13:57:53.493729Z","caller":"traceutil/trace.go:171","msg":"trace[1562961536] linearizableReadLoop","detail":"{readStateIndex:5813; appliedIndex:5808; }","duration":"119.565012ms","start":"2026-05-26T13:57:53.374149Z","end":"2026-05-26T13:57:53.493714Z","steps":["trace[1562961536] 'read index received'  (duration: 112.414994ms)","trace[1562961536] 'applied index is now lower than readState.Index'  (duration: 7.149218ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-26T13:57:53.493816Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.656834ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-26T13:57:53.493843Z","caller":"traceutil/trace.go:171","msg":"trace[736491501] transaction","detail":"{read_only:false; response_revision:5603; number_of_response:1; }","duration":"177.402273ms","start":"2026-05-26T13:57:53.316427Z","end":"2026-05-26T13:57:53.493829Z","steps":["trace[736491501] 'process raft request'  (duration: 177.172947ms)"],"step_count":1}
{"level":"info","ts":"2026-05-26T13:57:53.493852Z","caller":"traceutil/trace.go:171","msg":"trace[1840936015] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:5603; }","duration":"119.736395ms","start":"2026-05-26T13:57:53.374105Z","end":"2026-05-26T13:57:53.493842Z","steps":["trace[1840936015] 'agreement among raft nodes before linearized reading'  (duration: 119.664914ms)"],"step_count":1}
{"level":"info","ts":"2026-05-26T13:57:54.122314Z","caller":"traceutil/trace.go:171","msg":"trace[373898454] transaction","detail":"{read_only:false; response_revision:5605; number_of_response:1; }","duration":"113.054048ms","start":"2026-05-26T13:57:54.009223Z","end":"2026-05-26T13:57:54.122277Z","steps":["trace[373898454] 'process raft request'  (duration: 112.708888ms)"],"step_count":1}
{"level":"info","ts":"2026-05-26T13:57:54.218905Z","caller":"traceutil/trace.go:171","msg":"trace[1241014072] transaction","detail":"{read_only:false; response_revision:5606; number_of_response:1; }","duration":"139.145048ms","start":"2026-05-26T13:57:54.079738Z","end":"2026-05-26T13:57:54.218883Z","steps":["trace[1241014072] 'process raft request'  (duration: 99.21877ms)","trace[1241014072] 'compare'  (duration: 39.768243ms)"],"step_count":2}
{"level":"info","ts":"2026-05-26T13:57:54.219063Z","caller":"traceutil/trace.go:171","msg":"trace[1931762786] transaction","detail":"{read_only:false; response_revision:5607; number_of_response:1; }","duration":"139.213379ms","start":"2026-05-26T13:57:54.079841Z","end":"2026-05-26T13:57:54.219054Z","steps":["trace[1931762786] 'process raft request'  (duration: 139.001843ms)"],"step_count":1}
{"level":"info","ts":"2026-05-26T13:57:54.279504Z","caller":"traceutil/trace.go:171","msg":"trace[1783079265] transaction","detail":"{read_only:false; response_revision:5608; number_of_response:1; }","duration":"151.191271ms","start":"2026-05-26T13:57:54.12829Z","end":"2026-05-26T13:57:54.279482Z","steps":["trace[1783079265] 'process raft request'  (duration: 151.028306ms)"],"step_count":1}
{"level":"info","ts":"2026-05-26T13:57:54.279535Z","caller":"traceutil/trace.go:171","msg":"trace[804106727] transaction","detail":"{read_only:false; response_revision:5609; number_of_response:1; }","duration":"150.754759ms","start":"2026-05-26T13:57:54.12876Z","end":"2026-05-26T13:57:54.279515Z","steps":["trace[804106727] 'process raft request'  (duration: 150.650676ms)"],"step_count":1}
{"level":"info","ts":"2026-05-26T13:57:54.279778Z","caller":"traceutil/trace.go:171","msg":"trace[135852872] transaction","detail":"{read_only:false; response_revision:5610; number_of_response:1; }","duration":"150.584673ms","start":"2026-05-26T13:57:54.129172Z","end":"2026-05-26T13:57:54.279757Z","steps":["trace[135852872] 'process raft request'  (duration: 150.275694ms)"],"step_count":1}
{"level":"info","ts":"2026-05-26T13:57:54.279789Z","caller":"traceutil/trace.go:171","msg":"trace[1429873573] transaction","detail":"{read_only:false; response_revision:5611; number_of_response:1; }","duration":"150.304745ms","start":"2026-05-26T13:57:54.129467Z","end":"2026-05-26T13:57:54.279772Z","steps":["trace[1429873573] 'process raft request'  (duration: 150.190992ms)"],"step_count":1}
{"level":"info","ts":"2026-05-26T13:57:54.279837Z","caller":"traceutil/trace.go:171","msg":"trace[321493122] transaction","detail":"{read_only:false; response_revision:5612; number_of_response:1; }","duration":"143.227058ms","start":"2026-05-26T13:57:54.136588Z","end":"2026-05-26T13:57:54.279815Z","steps":["trace[321493122] 'process raft request'  (duration: 143.139576ms)"],"step_count":1}
{"level":"info","ts":"2026-05-26T13:57:54.402422Z","caller":"traceutil/trace.go:171","msg":"trace[401461167] transaction","detail":"{read_only:false; response_revision:5615; number_of_response:1; }","duration":"116.916432ms","start":"2026-05-26T13:57:54.28548Z","end":"2026-05-26T13:57:54.402397Z","steps":["trace[401461167] 'process raft request'  (duration: 58.640792ms)","trace[401461167] 'compare'  (duration: 58.104485ms)"],"step_count":2}
{"level":"info","ts":"2026-05-26T13:57:54.402711Z","caller":"traceutil/trace.go:171","msg":"trace[1526313268] transaction","detail":"{read_only:false; response_revision:5616; number_of_response:1; }","duration":"116.386147ms","start":"2026-05-26T13:57:54.286314Z","end":"2026-05-26T13:57:54.4027Z","steps":["trace[1526313268] 'process raft request'  (duration: 116.041627ms)"],"step_count":1}
{"level":"info","ts":"2026-05-26T13:57:54.402763Z","caller":"traceutil/trace.go:171","msg":"trace[1813893076] transaction","detail":"{read_only:false; response_revision:5617; number_of_response:1; }","duration":"105.709648ms","start":"2026-05-26T13:57:54.297035Z","end":"2026-05-26T13:57:54.402745Z","steps":["trace[1813893076] 'process raft request'  (duration: 105.625295ms)"],"step_count":1}
{"level":"info","ts":"2026-05-26T13:57:54.402779Z","caller":"traceutil/trace.go:171","msg":"trace[1539593943] linearizableReadLoop","detail":"{readStateIndex:5826; appliedIndex:5824; }","duration":"109.34531ms","start":"2026-05-26T13:57:54.293395Z","end":"2026-05-26T13:57:54.40274Z","steps":["trace[1539593943] 'read index received'  (duration: 50.72243ms)","trace[1539593943] 'applied index is now lower than readState.Index'  (duration: 58.62125ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-26T13:57:54.403058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.533649ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/\" range_end:\"/registry/pods/monitoring0\" ","response":"range_response_count:16 size:112288"}
{"level":"warn","ts":"2026-05-26T13:57:54.40306Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.742566ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-79690844-488f-470b-a329-40899878c96c\" ","response":"range_response_count:1 size:1435"}
{"level":"info","ts":"2026-05-26T13:57:54.40309Z","caller":"traceutil/trace.go:171","msg":"trace[146769119] range","detail":"{range_begin:/registry/pods/monitoring/; range_end:/registry/pods/monitoring0; response_count:16; response_revision:5617; }","duration":"112.60132ms","start":"2026-05-26T13:57:54.290481Z","end":"2026-05-26T13:57:54.403083Z","steps":["trace[146769119] 'agreement among raft nodes before linearized reading'  (duration: 112.407065ms)"],"step_count":1}
{"level":"info","ts":"2026-05-26T13:57:54.403109Z","caller":"traceutil/trace.go:171","msg":"trace[1152232328] range","detail":"{range_begin:/registry/persistentvolumes/pvc-79690844-488f-470b-a329-40899878c96c; range_end:; response_count:1; response_revision:5617; }","duration":"106.822429ms","start":"2026-05-26T13:57:54.296268Z","end":"2026-05-26T13:57:54.403091Z","steps":["trace[1152232328] 'agreement among raft nodes before linearized reading'  (duration: 106.641275ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-26T13:57:54.403151Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.342176ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:9 size:81887"}
{"level":"info","ts":"2026-05-26T13:57:54.403216Z","caller":"traceutil/trace.go:171","msg":"trace[1694088019] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:9; response_revision:5617; }","duration":"106.427557ms","start":"2026-05-26T13:57:54.296774Z","end":"2026-05-26T13:57:54.403202Z","steps":["trace[1694088019] 'agreement among raft nodes before linearized reading'  (duration: 106.15288ms)"],"step_count":1}
{"level":"info","ts":"2026-05-26T13:58:42.067745Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2947}
{"level":"info","ts":"2026-05-26T13:58:42.144083Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2947,"took":"75.01998ms","hash":758003525,"current-db-size-bytes":57622528,"current-db-size":"58 MB","current-db-size-in-use-bytes":33906688,"current-db-size-in-use":"34 MB"}
{"level":"info","ts":"2026-05-26T13:58:42.144212Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":758003525,"revision":2947,"compact-revision":-1}
{"level":"info","ts":"2026-05-26T14:03:42.073598Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6023}
{"level":"info","ts":"2026-05-26T14:03:42.167438Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6023,"took":"92.497435ms","hash":2518341743,"current-db-size-bytes":57622528,"current-db-size":"58 MB","current-db-size-in-use-bytes":21344256,"current-db-size-in-use":"21 MB"}
{"level":"info","ts":"2026-05-26T14:03:42.167508Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2518341743,"revision":6023,"compact-revision":2947}
{"level":"warn","ts":"2026-05-26T14:03:55.284522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"448.913949ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephfilesystemmirrors/\" range_end:\"/registry/ceph.rook.io/cephfilesystemmirrors0\" limit:10000 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-26T14:03:55.284632Z","caller":"traceutil/trace.go:171","msg":"trace[213858758] range","detail":"{range_begin:/registry/ceph.rook.io/cephfilesystemmirrors/; range_end:/registry/ceph.rook.io/cephfilesystemmirrors0; response_count:0; response_revision:8316; }","duration":"449.053194ms","start":"2026-05-26T14:03:54.835559Z","end":"2026-05-26T14:03:55.284613Z","steps":["trace[213858758] 'range keys from in-memory index tree'  (duration: 448.765546ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-26T14:03:55.284597Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"507.333585ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephcosidrivers/\" range_end:\"/registry/ceph.rook.io/cephcosidrivers0\" limit:10000 ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-05-26T14:03:55.284681Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:03:54.835489Z","time spent":"449.179357ms","remote":"127.0.0.1:57306","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":29,"request content":"key:\"/registry/ceph.rook.io/cephfilesystemmirrors/\" range_end:\"/registry/ceph.rook.io/cephfilesystemmirrors0\" limit:10000 "}
{"level":"warn","ts":"2026-05-26T14:03:55.284652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"528.13223ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephblockpools/\" range_end:\"/registry/ceph.rook.io/cephblockpools0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-26T14:03:55.284745Z","caller":"traceutil/trace.go:171","msg":"trace[1062167255] range","detail":"{range_begin:/registry/ceph.rook.io/cephcosidrivers/; range_end:/registry/ceph.rook.io/cephcosidrivers0; response_count:0; response_revision:8316; }","duration":"507.483468ms","start":"2026-05-26T14:03:54.777209Z","end":"2026-05-26T14:03:55.284693Z","steps":["trace[1062167255] 'range keys from in-memory index tree'  (duration: 507.271492ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-26T14:03:55.284795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"426.074006ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephblockpoolradosnamespaces/\" range_end:\"/registry/ceph.rook.io/cephblockpoolradosnamespaces0\" limit:500 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-26T14:03:55.284785Z","caller":"traceutil/trace.go:171","msg":"trace[1764039240] range","detail":"{range_begin:/registry/ceph.rook.io/cephblockpools/; range_end:/registry/ceph.rook.io/cephblockpools0; response_count:0; response_revision:8316; }","duration":"528.320596ms","start":"2026-05-26T14:03:54.756444Z","end":"2026-05-26T14:03:55.284764Z","steps":["trace[1764039240] 'count revisions from in-memory index tree'  (duration: 528.030037ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-26T14:03:55.284825Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:03:54.777182Z","time spent":"507.624812ms","remote":"127.0.0.1:57278","response type":"/etcdserverpb.KV/Range","request count":0,"request size":85,"response count":0,"response size":29,"request content":"key:\"/registry/ceph.rook.io/cephcosidrivers/\" range_end:\"/registry/ceph.rook.io/cephcosidrivers0\" limit:10000 "}
{"level":"warn","ts":"2026-05-26T14:03:55.284852Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:03:54.756422Z","time spent":"528.417658ms","remote":"127.0.0.1:57262","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":29,"request content":"key:\"/registry/ceph.rook.io/cephblockpools/\" range_end:\"/registry/ceph.rook.io/cephblockpools0\" count_only:true "}
{"level":"warn","ts":"2026-05-26T14:03:55.284873Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"411.034684ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/objectbucket.io/objectbuckets/\" range_end:\"/registry/objectbucket.io/objectbuckets0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-26T14:03:55.2849Z","caller":"traceutil/trace.go:171","msg":"trace[43950633] range","detail":"{range_begin:/registry/objectbucket.io/objectbuckets/; range_end:/registry/objectbucket.io/objectbuckets0; response_count:0; response_revision:8316; }","duration":"411.074144ms","start":"2026-05-26T14:03:54.873818Z","end":"2026-05-26T14:03:55.284892Z","steps":["trace[43950633] 'count revisions from in-memory index tree'  (duration: 411.003582ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-26T14:03:55.284937Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:03:54.873813Z","time spent":"411.116506ms","remote":"127.0.0.1:57332","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":0,"response size":29,"request content":"key:\"/registry/objectbucket.io/objectbuckets/\" range_end:\"/registry/objectbucket.io/objectbuckets0\" count_only:true "}
{"level":"warn","ts":"2026-05-26T14:03:55.285127Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"411.353221ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/objectbucket.io/objectbuckets/\" range_end:\"/registry/objectbucket.io/objectbuckets0\" limit:10000 ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-05-26T14:03:55.285133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"544.575302ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephbuckettopics/\" range_end:\"/registry/ceph.rook.io/cephbuckettopics0\" limit:10000 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-26T14:03:55.285162Z","caller":"traceutil/trace.go:171","msg":"trace[737594253] range","detail":"{range_begin:/registry/objectbucket.io/objectbuckets/; range_end:/registry/objectbucket.io/objectbuckets0; response_count:0; response_revision:8316; }","duration":"411.409823ms","start":"2026-05-26T14:03:54.873744Z","end":"2026-05-26T14:03:55.285154Z","steps":["trace[737594253] 'range keys from in-memory index tree'  (duration: 411.237328ms)"],"step_count":1}
{"level":"info","ts":"2026-05-26T14:03:55.285174Z","caller":"traceutil/trace.go:171","msg":"trace[367400748] range","detail":"{range_begin:/registry/ceph.rook.io/cephbuckettopics/; range_end:/registry/ceph.rook.io/cephbuckettopics0; response_count:0; response_revision:8316; }","duration":"544.648586ms","start":"2026-05-26T14:03:54.740513Z","end":"2026-05-26T14:03:55.285161Z","steps":["trace[367400748] 'range keys from in-memory index tree'  (duration: 544.473359ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-26T14:03:55.285195Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:03:54.873734Z","time spent":"411.453366ms","remote":"127.0.0.1:57332","response type":"/etcdserverpb.KV/Range","request count":0,"request size":87,"response count":0,"response size":29,"request content":"key:\"/registry/objectbucket.io/objectbuckets/\" range_end:\"/registry/objectbucket.io/objectbuckets0\" limit:10000 "}
{"level":"warn","ts":"2026-05-26T14:03:55.285208Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:03:54.740496Z","time spent":"544.702887ms","remote":"127.0.0.1:57252","response type":"/etcdserverpb.KV/Range","request count":0,"request size":87,"response count":0,"response size":29,"request content":"key:\"/registry/ceph.rook.io/cephbuckettopics/\" range_end:\"/registry/ceph.rook.io/cephbuckettopics0\" limit:10000 "}
{"level":"warn","ts":"2026-05-26T14:03:55.285317Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"508.503898ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephcosidrivers/\" range_end:\"/registry/ceph.rook.io/cephcosidrivers0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-05-26T14:03:55.285335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"482.131765ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephnfses/\" range_end:\"/registry/ceph.rook.io/cephnfses0\" limit:10000 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-26T14:03:55.285374Z","caller":"traceutil/trace.go:171","msg":"trace[768554779] range","detail":"{range_begin:/registry/ceph.rook.io/cephcosidrivers/; range_end:/registry/ceph.rook.io/cephcosidrivers0; response_count:0; response_revision:8316; }","duration":"508.58098ms","start":"2026-05-26T14:03:54.776777Z","end":"2026-05-26T14:03:55.285358Z","steps":["trace[768554779] 'count revisions from in-memory index tree'  (duration: 508.428455ms)"],"step_count":1}
{"level":"info","ts":"2026-05-26T14:03:55.285387Z","caller":"traceutil/trace.go:171","msg":"trace[1014755866] range","detail":"{range_begin:/registry/ceph.rook.io/cephnfses/; range_end:/registry/ceph.rook.io/cephnfses0; response_count:0; response_revision:8316; }","duration":"482.208457ms","start":"2026-05-26T14:03:54.803163Z","end":"2026-05-26T14:03:55.285371Z","steps":["trace[1014755866] 'range keys from in-memory index tree'  (duration: 482.040352ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-26T14:03:55.285398Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"544.887253ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephbuckettopics/\" range_end:\"/registry/ceph.rook.io/cephbuckettopics0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-05-26T14:03:55.285439Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:03:54.776759Z","time spent":"508.648051ms","remote":"127.0.0.1:57278","response type":"/etcdserverpb.KV/Range","request count":0,"request size":84,"response count":0,"response size":29,"request content":"key:\"/registry/ceph.rook.io/cephcosidrivers/\" range_end:\"/registry/ceph.rook.io/cephcosidrivers0\" count_only:true "}
{"level":"warn","ts":"2026-05-26T14:03:55.285461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"482.26507ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephnfses/\" range_end:\"/registry/ceph.rook.io/cephnfses0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-26T14:03:55.285466Z","caller":"traceutil/trace.go:171","msg":"trace[151281935] range","detail":"{range_begin:/registry/ceph.rook.io/cephbuckettopics/; range_end:/registry/ceph.rook.io/cephbuckettopics0; response_count:0; response_revision:8316; }","duration":"545.002955ms","start":"2026-05-26T14:03:54.740449Z","end":"2026-05-26T14:03:55.285452Z","steps":["trace[151281935] 'count revisions from in-memory index tree'  (duration: 544.735097ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-26T14:03:55.285521Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"481.508607ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephnfses/\" range_end:\"/registry/ceph.rook.io/cephnfses0\" limit:500 ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-05-26T14:03:55.285531Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:03:54.740426Z","time spent":"545.088527ms","remote":"127.0.0.1:57252","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":0,"response size":29,"request content":"key:\"/registry/ceph.rook.io/cephbuckettopics/\" range_end:\"/registry/ceph.rook.io/cephbuckettopics0\" count_only:true "}
{"level":"info","ts":"2026-05-26T14:03:55.285557Z","caller":"traceutil/trace.go:171","msg":"trace[300059285] range","detail":"{range_begin:/registry/ceph.rook.io/cephnfses/; range_end:/registry/ceph.rook.io/cephnfses0; response_count:0; response_revision:8316; }","duration":"481.545338ms","start":"2026-05-26T14:03:54.804005Z","end":"2026-05-26T14:03:55.28555Z","steps":["trace[300059285] 'range keys from in-memory index tree'  (duration: 481.430515ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-26T14:03:55.285591Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:03:54.80394Z","time spent":"481.643312ms","remote":"127.0.0.1:57292","response type":"/etcdserverpb.KV/Range","request count":0,"request size":73,"response count":0,"response size":29,"request content":"key:\"/registry/ceph.rook.io/cephnfses/\" range_end:\"/registry/ceph.rook.io/cephnfses0\" limit:500 "}
{"level":"warn","ts":"2026-05-26T14:03:55.285635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"508.461866ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephcosidrivers/\" range_end:\"/registry/ceph.rook.io/cephcosidrivers0\" limit:500 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-26T14:03:55.285687Z","caller":"traceutil/trace.go:171","msg":"trace[673312383] range","detail":"{range_begin:/registry/ceph.rook.io/cephcosidrivers/; range_end:/registry/ceph.rook.io/cephcosidrivers0; response_count:0; response_revision:8316; }","duration":"508.528868ms","start":"2026-05-26T14:03:54.777145Z","end":"2026-05-26T14:03:55.285673Z","steps":["trace[673312383] 'range keys from in-memory index tree'  (duration: 508.432036ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-26T14:03:55.285733Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:03:54.777139Z","time spent":"508.581269ms","remote":"127.0.0.1:57278","response type":"/etcdserverpb.KV/Range","request count":0,"request size":85,"response count":0,"response size":29,"request content":"key:\"/registry/ceph.rook.io/cephcosidrivers/\" range_end:\"/registry/ceph.rook.io/cephcosidrivers0\" limit:500 "}
{"level":"warn","ts":"2026-05-26T14:03:55.285745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"544.625214ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephbuckettopics/\" range_end:\"/registry/ceph.rook.io/cephbuckettopics0\" limit:500 ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-05-26T14:03:55.285767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"466.922227ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectzonegroups/\" range_end:\"/registry/ceph.rook.io/cephobjectzonegroups0\" limit:10000 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-26T14:03:55.285792Z","caller":"traceutil/trace.go:171","msg":"trace[1252531915] range","detail":"{range_begin:/registry/ceph.rook.io/cephbuckettopics/; range_end:/registry/ceph.rook.io/cephbuckettopics0; response_count:0; response_revision:8316; }","duration":"544.694867ms","start":"2026-05-26T14:03:54.741083Z","end":"2026-05-26T14:03:55.285778Z","steps":["trace[1252531915] 'range keys from in-memory index tree'  (duration: 544.531042ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-26T14:03:55.285837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"467.007239ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectzonegroups/\" range_end:\"/registry/ceph.rook.io/cephobjectzonegroups0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-05-26T14:03:55.285855Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:03:54.741073Z","time spent":"544.770998ms","remote":"127.0.0.1:57252","response type":"/etcdserverpb.KV/Range","request count":0,"request size":87,"response count":0,"response size":29,"request content":"key:\"/registry/ceph.rook.io/cephbuckettopics/\" range_end:\"/registry/ceph.rook.io/cephbuckettopics0\" limit:500 "}
{"level":"warn","ts":"2026-05-26T14:03:55.285898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"466.598018ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectzonegroups/\" range_end:\"/registry/ceph.rook.io/cephobjectzonegroups0\" limit:500 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-26T14:03:55.285922Z","caller":"traceutil/trace.go:171","msg":"trace[1895483357] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectzonegroups/; range_end:/registry/ceph.rook.io/cephobjectzonegroups0; response_count:0; response_revision:8316; }","duration":"466.641728ms","start":"2026-05-26T14:03:54.819274Z","end":"2026-05-26T14:03:55.285915Z","steps":["trace[1895483357] 'range keys from in-memory index tree'  (duration: 466.511155ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-26T14:03:55.285327Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"411.197087ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/objectbucket.io/objectbuckets/\" range_end:\"/registry/objectbucket.io/objectbuckets0\" limit:500 ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-05-26T14:03:55.285951Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:03:54.819239Z","time spent":"466.702221ms","remote":"127.0.0.1:57298","response type":"/etcdserverpb.KV/Range","request count":0,"request size":95,"response count":0,"response size":29,"request content":"key:\"/registry/ceph.rook.io/cephobjectzonegroups/\" range_end:\"/registry/ceph.rook.io/cephobjectzonegroups0\" limit:500 "}
{"level":"info","ts":"2026-05-26T14:03:55.285966Z","caller":"traceutil/trace.go:171","msg":"trace[534884637] range","detail":"{range_begin:/registry/objectbucket.io/objectbuckets/; range_end:/registry/objectbucket.io/objectbuckets0; response_count:0; response_revision:8316; }","duration":"411.843396ms","start":"2026-05-26T14:03:54.874109Z","end":"2026-05-26T14:03:55.285952Z","steps":["trace[534884637] 'range keys from in-memory index tree'  (duration: 411.155517ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-26T14:03:55.286019Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:03:54.874102Z","time spent":"411.899048ms","remote":"127.0.0.1:57332","response type":"/etcdserverpb.KV/Range","request count":0,"request size":87,"response count":0,"response size":29,"request content":"key:\"/registry/objectbucket.io/objectbuckets/\" range_end:\"/registry/objectbucket.io/objectbuckets0\" limit:500 "}
{"level":"warn","ts":"2026-05-26T14:03:55.286054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"529.676393ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephblockpools/\" range_end:\"/registry/ceph.rook.io/cephblockpools0\" limit:10000 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-26T14:03:55.2861Z","caller":"traceutil/trace.go:171","msg":"trace[1658430106] range","detail":"{range_begin:/registry/ceph.rook.io/cephblockpools/; range_end:/registry/ceph.rook.io/cephblockpools0; response_count:0; response_revision:8316; }","duration":"529.743276ms","start":"2026-05-26T14:03:54.756346Z","end":"2026-05-26T14:03:55.28609Z","steps":["trace[1658430106] 'range keys from in-memory index tree'  (duration: 529.624313ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-26T14:03:55.286137Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:03:54.756335Z","time spent":"529.793588ms","remote":"127.0.0.1:57262","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":0,"response size":29,"request content":"key:\"/registry/ceph.rook.io/cephblockpools/\" range_end:\"/registry/ceph.rook.io/cephblockpools0\" limit:10000 "}
{"level":"warn","ts":"2026-05-26T14:03:55.286191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"450.784592ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephfilesystemmirrors/\" range_end:\"/registry/ceph.rook.io/cephfilesystemmirrors0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-26T14:03:55.286231Z","caller":"traceutil/trace.go:171","msg":"trace[1414033084] range","detail":"{range_begin:/registry/ceph.rook.io/cephfilesystemmirrors/; range_end:/registry/ceph.rook.io/cephfilesystemmirrors0; response_count:0; response_revision:8316; }","duration":"450.846885ms","start":"2026-05-26T14:03:54.835375Z","end":"2026-05-26T14:03:55.286222Z","steps":["trace[1414033084] 'count revisions from in-memory index tree'  (duration: 450.73634ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-26T14:03:55.284731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"429.200074ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephblockpoolradosnamespaces/\" range_end:\"/registry/ceph.rook.io/cephblockpoolradosnamespaces0\" limit:10000 ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-05-26T14:03:55.284766Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"429.135633ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephblockpoolradosnamespaces/\" range_end:\"/registry/ceph.rook.io/cephblockpoolradosnamespaces0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-26T14:03:55.286286Z","caller":"traceutil/trace.go:171","msg":"trace[621101791] range","detail":"{range_begin:/registry/ceph.rook.io/cephblockpoolradosnamespaces/; range_end:/registry/ceph.rook.io/cephblockpoolradosnamespaces0; response_count:0; response_revision:8316; }","duration":"430.809549ms","start":"2026-05-26T14:03:54.855462Z","end":"2026-05-26T14:03:55.286271Z","steps":["trace[621101791] 'range keys from in-memory index tree'  (duration: 429.152462ms)"],"step_count":1}
{"level":"info","ts":"2026-05-26T14:03:55.286304Z","caller":"traceutil/trace.go:171","msg":"trace[1565205605] range","detail":"{range_begin:/registry/ceph.rook.io/cephblockpoolradosnamespaces/; range_end:/registry/ceph.rook.io/cephblockpoolradosnamespaces0; response_count:0; response_revision:8316; }","duration":"430.672515ms","start":"2026-05-26T14:03:54.855612Z","end":"2026-05-26T14:03:55.286285Z","steps":["trace[1565205605] 'count revisions from in-memory index tree'  (duration: 429.112783ms)"],"step_count":1}
{"level":"info","ts":"2026-05-26T14:03:55.285868Z","caller":"traceutil/trace.go:171","msg":"trace[1757543647] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectzonegroups/; range_end:/registry/ceph.rook.io/cephobjectzonegroups0; response_count:0; response_revision:8316; }","duration":"467.06968ms","start":"2026-05-26T14:03:54.818791Z","end":"2026-05-26T14:03:55.285861Z","steps":["trace[1757543647] 'count revisions from in-memory index tree'  (duration: 466.924307ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-26T14:03:55.286357Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:03:54.818771Z","time spent":"467.577466ms","remote":"127.0.0.1:57298","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":29,"request content":"key:\"/registry/ceph.rook.io/cephobjectzonegroups/\" range_end:\"/registry/ceph.rook.io/cephobjectzonegroups0\" count_only:true "}
{"level":"warn","ts":"2026-05-26T14:03:55.28637Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:03:54.855608Z","time spent":"430.744018ms","remote":"127.0.0.1:57320","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":29,"request content":"key:\"/registry/ceph.rook.io/cephblockpoolradosnamespaces/\" range_end:\"/registry/ceph.rook.io/cephblockpoolradosnamespaces0\" count_only:true "}
{"level":"warn","ts":"2026-05-26T14:03:55.286483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.198074ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13313096128157509598 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:8127 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:472 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >>","response":"size:16"}
{"level":"warn","ts":"2026-05-26T14:03:55.28513Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"524.157568ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephblockpools/\" range_end:\"/registry/ceph.rook.io/cephblockpools0\" limit:500 ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-05-26T14:03:55.285425Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:03:54.803148Z","time spent":"482.264148ms","remote":"127.0.0.1:57292","response type":"/etcdserverpb.KV/Range","request count":0,"request size":73,"response count":0,"response size":29,"request content":"key:\"/registry/ceph.rook.io/cephnfses/\" range_end:\"/registry/ceph.rook.io/cephnfses0\" limit:10000 "}
{"level":"info","ts":"2026-05-26T14:03:55.286543Z","caller":"traceutil/trace.go:171","msg":"trace[459661441] range","detail":"{range_begin:/registry/ceph.rook.io/cephblockpools/; range_end:/registry/ceph.rook.io/cephblockpools0; response_count:0; response_revision:8316; }","duration":"525.602189ms","start":"2026-05-26T14:03:54.760931Z","end":"2026-05-26T14:03:55.286533Z","steps":["trace[459661441] 'range keys from in-memory index tree'  (duration: 524.099846ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-26T14:03:55.286577Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:03:54.760918Z","time spent":"525.64976ms","remote":"127.0.0.1:57262","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":0,"response size":29,"request content":"key:\"/registry/ceph.rook.io/cephblockpools/\" range_end:\"/registry/ceph.rook.io/cephblockpools0\" limit:500 "}
{"level":"info","ts":"2026-05-26T14:03:55.28549Z","caller":"traceutil/trace.go:171","msg":"trace[1381875178] range","detail":"{range_begin:/registry/ceph.rook.io/cephnfses/; range_end:/registry/ceph.rook.io/cephnfses0; response_count:0; response_revision:8316; }","duration":"482.29343ms","start":"2026-05-26T14:03:54.803188Z","end":"2026-05-26T14:03:55.285482Z","steps":["trace[1381875178] 'count revisions from in-memory index tree'  (duration: 482.175866ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-26T14:03:55.284645Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"448.862118ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephfilesystemmirrors/\" range_end:\"/registry/ceph.rook.io/cephfilesystemmirrors0\" limit:500 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-26T14:03:55.285806Z","caller":"traceutil/trace.go:171","msg":"trace[1634528275] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectzonegroups/; range_end:/registry/ceph.rook.io/cephobjectzonegroups0; response_count:0; response_revision:8316; }","duration":"466.963808ms","start":"2026-05-26T14:03:54.818834Z","end":"2026-05-26T14:03:55.285798Z","steps":["trace[1634528275] 'range keys from in-memory index tree'  (duration: 466.867115ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-26T14:03:55.286876Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:03:54.818791Z","time spent":"468.061278ms","remote":"127.0.0.1:57298","response type":"/etcdserverpb.KV/Range","request count":0,"request size":95,"response count":0,"response size":29,"request content":"key:\"/registry/ceph.rook.io/cephobjectzonegroups/\" range_end:\"/registry/ceph.rook.io/cephobjectzonegroups0\" limit:10000 "}
{"level":"info","ts":"2026-05-26T14:03:55.286957Z","caller":"traceutil/trace.go:171","msg":"trace[1959290757] linearizableReadLoop","detail":"{readStateIndex:8615; appliedIndex:8614; }","duration":"212.291647ms","start":"2026-05-26T14:03:55.074652Z","end":"2026-05-26T14:03:55.286943Z","steps":["trace[1959290757] 'read index received'  (duration: 4.506867ms)","trace[1959290757] 'applied index is now lower than readState.Index'  (duration: 207.78377ms)"],"step_count":2}
{"level":"info","ts":"2026-05-26T14:03:55.284834Z","caller":"traceutil/trace.go:171","msg":"trace[1813277768] range","detail":"{range_begin:/registry/ceph.rook.io/cephblockpoolradosnamespaces/; range_end:/registry/ceph.rook.io/cephblockpoolradosnamespaces0; response_count:0; response_revision:8316; }","duration":"426.119428ms","start":"2026-05-26T14:03:54.858701Z","end":"2026-05-26T14:03:55.28482Z","steps":["trace[1813277768] 'range keys from in-memory index tree'  (duration: 426.044315ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-26T14:03:55.287108Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:03:54.858694Z","time spent":"428.394362ms","remote":"127.0.0.1:57320","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":29,"request content":"key:\"/registry/ceph.rook.io/cephblockpoolradosnamespaces/\" range_end:\"/registry/ceph.rook.io/cephblockpoolradosnamespaces0\" limit:500 "}
{"level":"info","ts":"2026-05-26T14:03:55.287129Z","caller":"traceutil/trace.go:171","msg":"trace[70017137] transaction","detail":"{read_only:false; response_revision:8317; number_of_response:1; }","duration":"290.069757ms","start":"2026-05-26T14:03:54.997047Z","end":"2026-05-26T14:03:55.287117Z","steps":["trace[70017137] 'process raft request'  (duration: 82.175214ms)","trace[70017137] 'compare'  (duration: 206.539175ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-26T14:03:55.286322Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:03:54.855445Z","time spent":"430.864901ms","remote":"127.0.0.1:57320","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":29,"request content":"key:\"/registry/ceph.rook.io/cephblockpoolradosnamespaces/\" range_end:\"/registry/ceph.rook.io/cephblockpoolradosnamespaces0\" limit:10000 "}
{"level":"warn","ts":"2026-05-26T14:03:55.287341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.685038ms","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-05-26T14:03:55.287369Z","caller":"traceutil/trace.go:171","msg":"trace[1075329906] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8317; }","duration":"212.74268ms","start":"2026-05-26T14:03:55.074618Z","end":"2026-05-26T14:03:55.287361Z","steps":["trace[1075329906] 'agreement among raft nodes before linearized reading'  (duration: 212.629407ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-26T14:03:55.286259Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:03:54.835364Z","time spent":"450.887206ms","remote":"127.0.0.1:57306","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":29,"request content":"key:\"/registry/ceph.rook.io/cephfilesystemmirrors/\" range_end:\"/registry/ceph.rook.io/cephfilesystemmirrors0\" count_only:true "}
{"level":"info","ts":"2026-05-26T14:03:55.286732Z","caller":"traceutil/trace.go:171","msg":"trace[7653956] range","detail":"{range_begin:/registry/ceph.rook.io/cephfilesystemmirrors/; range_end:/registry/ceph.rook.io/cephfilesystemmirrors0; response_count:0; response_revision:8316; }","duration":"450.975898ms","start":"2026-05-26T14:03:54.835738Z","end":"2026-05-26T14:03:55.286714Z","steps":["trace[7653956] 'range keys from in-memory index tree'  (duration: 448.799867ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-26T14:03:55.287748Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:03:54.835726Z","time spent":"451.998527ms","remote":"127.0.0.1:57306","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":29,"request content":"key:\"/registry/ceph.rook.io/cephfilesystemmirrors/\" range_end:\"/registry/ceph.rook.io/cephfilesystemmirrors0\" limit:500 "}
{"level":"warn","ts":"2026-05-26T14:03:55.286674Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:03:54.803148Z","time spent":"483.510073ms","remote":"127.0.0.1:57292","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":29,"request content":"key:\"/registry/ceph.rook.io/cephnfses/\" range_end:\"/registry/ceph.rook.io/cephnfses0\" count_only:true "}
{"level":"warn","ts":"2026-05-26T14:04:06.452909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.565741ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-05-26T14:04:06.45298Z","caller":"traceutil/trace.go:171","msg":"trace[1782968532] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:8378; }","duration":"100.719416ms","start":"2026-05-26T14:04:06.352245Z","end":"2026-05-26T14:04:06.452965Z","steps":["trace[1782968532] 'count revisions from in-memory index tree'  (duration: 100.460429ms)"],"step_count":1}
{"level":"info","ts":"2026-05-26T14:04:06.937218Z","caller":"traceutil/trace.go:171","msg":"trace[1214002702] transaction","detail":"{read_only:false; response_revision:8379; number_of_response:1; }","duration":"107.289831ms","start":"2026-05-26T14:04:06.829901Z","end":"2026-05-26T14:04:06.937191Z","steps":["trace[1214002702] 'process raft request'  (duration: 107.117396ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-26T14:04:07.78329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.268901ms","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-05-26T14:04:07.78335Z","caller":"traceutil/trace.go:171","msg":"trace[1751080151] linearizableReadLoop","detail":"{readStateIndex:8684; appliedIndex:8683; }","duration":"136.651538ms","start":"2026-05-26T14:04:07.646671Z","end":"2026-05-26T14:04:07.783322Z","steps":["trace[1751080151] 'read index received'  (duration: 127.362907ms)","trace[1751080151] 'applied index is now lower than readState.Index'  (duration: 9.287651ms)"],"step_count":2}
{"level":"info","ts":"2026-05-26T14:04:07.783356Z","caller":"traceutil/trace.go:171","msg":"trace[1690807192] transaction","detail":"{read_only:false; response_revision:8383; number_of_response:1; }","duration":"238.00112ms","start":"2026-05-26T14:04:07.545337Z","end":"2026-05-26T14:04:07.783338Z","steps":["trace[1690807192] 'process raft request'  (duration: 228.585366ms)"],"step_count":1}
{"level":"info","ts":"2026-05-26T14:04:07.783371Z","caller":"traceutil/trace.go:171","msg":"trace[731177264] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8382; }","duration":"307.407676ms","start":"2026-05-26T14:04:07.47595Z","end":"2026-05-26T14:04:07.783358Z","steps":["trace[731177264] 'range keys from in-memory index tree'  (duration: 307.069585ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-26T14:04:07.783413Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:04:07.475923Z","time spent":"307.481398ms","remote":"127.0.0.1:45840","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":504,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-05-26T14:04:07.783428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.762271ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-26T14:04:07.783453Z","caller":"traceutil/trace.go:171","msg":"trace[1667979707] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8383; }","duration":"136.835562ms","start":"2026-05-26T14:04:07.64661Z","end":"2026-05-26T14:04:07.783445Z","steps":["trace[1667979707] 'agreement among raft nodes before linearized reading'  (duration: 136.781891ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-26T14:04:35.506433Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:04:35.196377Z","time spent":"310.051119ms","remote":"127.0.0.1:45614","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"warn","ts":"2026-05-26T14:04:35.770431Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.243115ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13313096128157510415 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/masterleases/199.204.45.89\" mod_revision:8481 > success:<request_put:<key:\"/registry/masterleases/199.204.45.89\" value_size:66 lease:4089724091302734604 >> failure:<request_range:<key:\"/registry/masterleases/199.204.45.89\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-26T14:04:35.770645Z","caller":"traceutil/trace.go:171","msg":"trace[662440964] linearizableReadLoop","detail":"{readStateIndex:8892; appliedIndex:8890; }","duration":"253.718404ms","start":"2026-05-26T14:04:35.51691Z","end":"2026-05-26T14:04:35.770628Z","steps":["trace[662440964] 'read index received'  (duration: 3.446587ms)","trace[662440964] 'applied index is now lower than readState.Index'  (duration: 250.270727ms)"],"step_count":2}
{"level":"info","ts":"2026-05-26T14:04:35.770784Z","caller":"traceutil/trace.go:171","msg":"trace[1116669705] transaction","detail":"{read_only:false; response_revision:8582; number_of_response:1; }","duration":"263.318263ms","start":"2026-05-26T14:04:35.507454Z","end":"2026-05-26T14:04:35.770773Z","steps":["trace[1116669705] 'process raft request'  (duration: 12.642195ms)","trace[1116669705] 'compare'  (duration: 250.109242ms)"],"step_count":2}
{"level":"info","ts":"2026-05-26T14:04:35.771096Z","caller":"traceutil/trace.go:171","msg":"trace[1961429690] transaction","detail":"{read_only:false; response_revision:8583; number_of_response:1; }","duration":"260.973427ms","start":"2026-05-26T14:04:35.510112Z","end":"2026-05-26T14:04:35.771086Z","steps":["trace[1961429690] 'process raft request'  (duration: 260.439172ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-26T14:04:35.771279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.362072ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-05-26T14:04:35.77131Z","caller":"traceutil/trace.go:171","msg":"trace[1018546470] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8583; }","duration":"254.407692ms","start":"2026-05-26T14:04:35.516895Z","end":"2026-05-26T14:04:35.771302Z","steps":["trace[1018546470] 'agreement among raft nodes before linearized reading'  (duration: 254.30462ms)"],"step_count":1}
{"level":"info","ts":"2026-05-26T14:04:39.849514Z","caller":"traceutil/trace.go:171","msg":"trace[407992476] transaction","detail":"{read_only:false; response_revision:8605; number_of_response:1; }","duration":"170.292484ms","start":"2026-05-26T14:04:39.679184Z","end":"2026-05-26T14:04:39.849477Z","steps":["trace[407992476] 'process raft request'  (duration: 169.896364ms)"],"step_count":1}
{"level":"info","ts":"2026-05-26T14:04:49.673658Z","caller":"traceutil/trace.go:171","msg":"trace[1310415935] transaction","detail":"{read_only:false; response_revision:8700; number_of_response:1; }","duration":"354.850491ms","start":"2026-05-26T14:04:49.318783Z","end":"2026-05-26T14:04:49.673633Z","steps":["trace[1310415935] 'process raft request'  (duration: 354.684667ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-26T14:04:49.673803Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:04:49.318766Z","time spent":"354.980194ms","remote":"127.0.0.1:45652","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":746,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/events/openstack/rook-ceph-detect-version-tcmm6.18b322924269ce5e\" mod_revision:0 > success:<request_put:<key:\"/registry/events/openstack/rook-ceph-detect-version-tcmm6.18b322924269ce5e\" value_size:654 lease:4089724091302734646 >> failure:<>"}
{"level":"info","ts":"2026-05-26T14:04:49.796996Z","caller":"traceutil/trace.go:171","msg":"trace[1286440222] linearizableReadLoop","detail":"{readStateIndex:9016; appliedIndex:9014; }","duration":"150.251751ms","start":"2026-05-26T14:04:49.646725Z","end":"2026-05-26T14:04:49.796976Z","steps":["trace[1286440222] 'read index received'  (duration: 26.733313ms)","trace[1286440222] 'applied index is now lower than readState.Index'  (duration: 123.517588ms)"],"step_count":2}
{"level":"info","ts":"2026-05-26T14:04:49.79708Z","caller":"traceutil/trace.go:171","msg":"trace[171906612] transaction","detail":"{read_only:false; response_revision:8701; number_of_response:1; }","duration":"470.283892ms","start":"2026-05-26T14:04:49.326754Z","end":"2026-05-26T14:04:49.797038Z","steps":["trace[171906612] 'process raft request'  (duration: 470.083556ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-26T14:04:49.797159Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.407894ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-26T14:04:49.79724Z","caller":"traceutil/trace.go:171","msg":"trace[1727966703] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8701; }","duration":"150.538449ms","start":"2026-05-26T14:04:49.646679Z","end":"2026-05-26T14:04:49.797217Z","steps":["trace[1727966703] 'agreement among raft nodes before linearized reading'  (duration: 150.386595ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-26T14:04:49.797329Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:04:49.32673Z","time spent":"470.483697ms","remote":"127.0.0.1:45822","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3037,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/jobs/openstack/rook-ceph-detect-version\" mod_revision:8694 > success:<request_put:<key:\"/registry/jobs/openstack/rook-ceph-detect-version\" value_size:2980 >> failure:<request_range:<key:\"/registry/jobs/openstack/rook-ceph-detect-version\" > >"}
{"level":"info","ts":"2026-05-26T14:05:02.615909Z","caller":"traceutil/trace.go:171","msg":"trace[1665368438] linearizableReadLoop","detail":"{readStateIndex:9126; appliedIndex:9125; }","duration":"152.620587ms","start":"2026-05-26T14:05:02.463254Z","end":"2026-05-26T14:05:02.615874Z","steps":["trace[1665368438] 'read index received'  (duration: 152.172644ms)","trace[1665368438] 'applied index is now lower than readState.Index'  (duration: 446.302µs)"],"step_count":2}
{"level":"info","ts":"2026-05-26T14:05:02.616046Z","caller":"traceutil/trace.go:171","msg":"trace[647921287] transaction","detail":"{read_only:false; response_revision:8808; number_of_response:1; }","duration":"171.364996ms","start":"2026-05-26T14:05:02.444632Z","end":"2026-05-26T14:05:02.615997Z","steps":["trace[647921287] 'process raft request'  (duration: 170.874312ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-26T14:05:02.616601Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.325437ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-05-26T14:05:02.616653Z","caller":"traceutil/trace.go:171","msg":"trace[1085424639] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:8808; }","duration":"153.40795ms","start":"2026-05-26T14:05:02.463234Z","end":"2026-05-26T14:05:02.616641Z","steps":["trace[1085424639] 'agreement among raft nodes before linearized reading'  (duration: 152.762702ms)"],"step_count":1}
{"level":"info","ts":"2026-05-26T14:05:17.20263Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-000000000000246b.wal"}
{"level":"info","ts":"2026-05-26T14:06:34.495177Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"c3b8446219deb8c1","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-05-26T14:06:34.501399Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001}
{"level":"info","ts":"2026-05-26T14:06:34.501512Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001}
{"level":"info","ts":"2026-05-26T14:08:42.081367Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8110}
{"level":"info","ts":"2026-05-26T14:08:42.152503Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8110,"took":"69.056252ms","hash":1578291212,"current-db-size-bytes":57622528,"current-db-size":"58 MB","current-db-size-in-use-bytes":28254208,"current-db-size-in-use":"28 MB"}
{"level":"info","ts":"2026-05-26T14:08:42.152612Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1578291212,"revision":8110,"compact-revision":6023}
{"level":"info","ts":"2026-05-26T14:11:25.725512Z","caller":"traceutil/trace.go:171","msg":"trace[1437552746] linearizableReadLoop","detail":"{readStateIndex:12191; appliedIndex:12189; }","duration":"300.57567ms","start":"2026-05-26T14:11:25.424903Z","end":"2026-05-26T14:11:25.725479Z","steps":["trace[1437552746] 'read index received'  (duration: 59.392619ms)","trace[1437552746] 'applied index is now lower than readState.Index'  (duration: 241.181611ms)"],"step_count":2}
{"level":"info","ts":"2026-05-26T14:11:25.725695Z","caller":"traceutil/trace.go:171","msg":"trace[1985269915] transaction","detail":"{read_only:false; response_revision:11780; number_of_response:1; }","duration":"302.494434ms","start":"2026-05-26T14:11:25.423187Z","end":"2026-05-26T14:11:25.725681Z","steps":["trace[1985269915] 'process raft request'  (duration: 277.562223ms)","trace[1985269915] 'compare'  (duration: 24.491609ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-26T14:11:25.725796Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.871258ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-05-26T14:11:25.72584Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:11:25.423174Z","time spent":"302.558535ms","remote":"127.0.0.1:45840","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:11766 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"info","ts":"2026-05-26T14:11:25.725895Z","caller":"traceutil/trace.go:171","msg":"trace[879256436] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:11781; }","duration":"301.016142ms","start":"2026-05-26T14:11:25.424857Z","end":"2026-05-26T14:11:25.725873Z","steps":["trace[879256436] 'agreement among raft nodes before linearized reading'  (duration: 300.860098ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-26T14:11:25.725948Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:11:25.424844Z","time spent":"301.094405ms","remote":"127.0.0.1:45800","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":29,"request content":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true "}
{"level":"info","ts":"2026-05-26T14:11:25.726174Z","caller":"traceutil/trace.go:171","msg":"trace[1878123745] transaction","detail":"{read_only:false; response_revision:11781; number_of_response:1; }","duration":"259.706362ms","start":"2026-05-26T14:11:25.466452Z","end":"2026-05-26T14:11:25.726158Z","steps":["trace[1878123745] 'process raft request'  (duration: 258.964661ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-26T14:11:25.726226Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.409318ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-7ml7x\" ","response":"range_response_count:1 size:6520"}
{"level":"info","ts":"2026-05-26T14:11:25.726291Z","caller":"traceutil/trace.go:171","msg":"trace[2070047750] range","detail":"{range_begin:/registry/pods/openstack/keepalived-7ml7x; range_end:; response_count:1; response_revision:11781; }","duration":"215.511701ms","start":"2026-05-26T14:11:25.510766Z","end":"2026-05-26T14:11:25.726278Z","steps":["trace[2070047750] 'agreement among raft nodes before linearized reading'  (duration: 215.322997ms)"],"step_count":1}
{"level":"info","ts":"2026-05-26T14:11:42.74479Z","caller":"traceutil/trace.go:171","msg":"trace[1570430825] transaction","detail":"{read_only:false; response_revision:11873; number_of_response:1; }","duration":"107.460067ms","start":"2026-05-26T14:11:42.637297Z","end":"2026-05-26T14:11:42.744757Z","steps":["trace[1570430825] 'process raft request'  (duration: 107.22772ms)"],"step_count":1}
{"level":"info","ts":"2026-05-26T14:11:43.34179Z","caller":"traceutil/trace.go:171","msg":"trace[1955848634] transaction","detail":"{read_only:false; response_revision:11877; number_of_response:1; }","duration":"149.256511ms","start":"2026-05-26T14:11:43.192497Z","end":"2026-05-26T14:11:43.341754Z","steps":["trace[1955848634] 'process raft request'  (duration: 99.569085ms)","trace[1955848634] 'compare'  (duration: 49.431648ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-26T14:11:44.254484Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.68614ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephbuckettopics/\" range_end:\"/registry/ceph.rook.io/cephbuckettopics0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-26T14:11:44.254572Z","caller":"traceutil/trace.go:171","msg":"trace[231199819] range","detail":"{range_begin:/registry/ceph.rook.io/cephbuckettopics/; range_end:/registry/ceph.rook.io/cephbuckettopics0; response_count:0; response_revision:11883; }","duration":"198.827734ms","start":"2026-05-26T14:11:44.055725Z","end":"2026-05-26T14:11:44.254553Z","steps":["trace[231199819] 'count revisions from in-memory index tree'  (duration: 198.542885ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-26T14:11:44.255018Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.641199ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-05-26T14:11:44.255085Z","caller":"traceutil/trace.go:171","msg":"trace[952015134] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:11883; }","duration":"161.777812ms","start":"2026-05-26T14:11:44.093293Z","end":"2026-05-26T14:11:44.255071Z","steps":["trace[952015134] 'range keys from in-memory index tree'  (duration: 161.477944ms)"],"step_count":1}
{"level":"info","ts":"2026-05-26T14:13:42.087059Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10474}
{"level":"info","ts":"2026-05-26T14:13:42.166721Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10474,"took":"77.2646ms","hash":367121017,"current-db-size-bytes":57622528,"current-db-size":"58 MB","current-db-size-in-use-bytes":26300416,"current-db-size-in-use":"26 MB"}
{"level":"info","ts":"2026-05-26T14:13:42.166778Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":367121017,"revision":10474,"compact-revision":8110}
{"level":"info","ts":"2026-05-26T14:17:41.193181Z","caller":"traceutil/trace.go:171","msg":"trace[1085145485] transaction","detail":"{read_only:false; response_revision:14311; number_of_response:1; }","duration":"117.738939ms","start":"2026-05-26T14:17:41.075414Z","end":"2026-05-26T14:17:41.193153Z","steps":["trace[1085145485] 'process raft request'  (duration: 117.607826ms)"],"step_count":1}
{"level":"info","ts":"2026-05-26T14:17:41.200065Z","caller":"traceutil/trace.go:171","msg":"trace[381845916] transaction","detail":"{read_only:false; response_revision:14312; number_of_response:1; }","duration":"123.531451ms","start":"2026-05-26T14:17:41.07651Z","end":"2026-05-26T14:17:41.200042Z","steps":["trace[381845916] 'process raft request'  (duration: 123.400928ms)"],"step_count":1}
{"level":"info","ts":"2026-05-26T14:18:03.062473Z","caller":"traceutil/trace.go:171","msg":"trace[192531500] transaction","detail":"{read_only:false; response_revision:14428; number_of_response:1; }","duration":"129.273023ms","start":"2026-05-26T14:18:02.933167Z","end":"2026-05-26T14:18:03.06244Z","steps":["trace[192531500] 'process raft request'  (duration: 129.032236ms)"],"step_count":1}
{"level":"info","ts":"2026-05-26T14:18:10.937602Z","caller":"traceutil/trace.go:171","msg":"trace[1541889844] linearizableReadLoop","detail":"{readStateIndex:14973; appliedIndex:14972; }","duration":"114.363655ms","start":"2026-05-26T14:18:10.823215Z","end":"2026-05-26T14:18:10.937578Z","steps":["trace[1541889844] 'read index received'  (duration: 106.283098ms)","trace[1541889844] 'applied index is now lower than readState.Index'  (duration: 8.079637ms)"],"step_count":2}
{"level":"info","ts":"2026-05-26T14:18:10.938342Z","caller":"traceutil/trace.go:171","msg":"trace[1681377769] transaction","detail":"{read_only:false; response_revision:14468; number_of_response:1; }","duration":"125.205979ms","start":"2026-05-26T14:18:10.812621Z","end":"2026-05-26T14:18:10.937827Z","steps":["trace[1681377769] 'process raft request'  (duration: 116.844755ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-26T14:18:10.938544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.309452ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"}
{"level":"info","ts":"2026-05-26T14:18:10.938635Z","caller":"traceutil/trace.go:171","msg":"trace[231722520] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:14468; }","duration":"115.442146ms","start":"2026-05-26T14:18:10.823157Z","end":"2026-05-26T14:18:10.938599Z","steps":["trace[231722520] 'agreement among raft nodes before linearized reading'  (duration: 114.518089ms)"],"step_count":1}
{"level":"info","ts":"2026-05-26T14:18:17.943945Z","caller":"traceutil/trace.go:171","msg":"trace[2050082560] transaction","detail":"{read_only:false; response_revision:14516; number_of_response:1; }","duration":"113.85767ms","start":"2026-05-26T14:18:17.830069Z","end":"2026-05-26T14:18:17.943927Z","steps":["trace[2050082560] 'process raft request'  (duration: 113.742927ms)"],"step_count":1}
{"level":"info","ts":"2026-05-26T14:18:17.968493Z","caller":"traceutil/trace.go:171","msg":"trace[393600894] transaction","detail":"{read_only:false; response_revision:14517; number_of_response:1; }","duration":"137.294108ms","start":"2026-05-26T14:18:17.831164Z","end":"2026-05-26T14:18:17.968458Z","steps":["trace[393600894] 'process raft request'  (duration: 137.061981ms)"],"step_count":1}
{"level":"info","ts":"2026-05-26T14:18:18.973021Z","caller":"traceutil/trace.go:171","msg":"trace[48486832] transaction","detail":"{read_only:false; response_revision:14522; number_of_response:1; }","duration":"207.340341ms","start":"2026-05-26T14:18:18.765654Z","end":"2026-05-26T14:18:18.972994Z","steps":["trace[48486832] 'process raft request'  (duration: 207.185417ms)"],"step_count":1}
{"level":"info","ts":"2026-05-26T14:18:42.09379Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12687}
{"level":"info","ts":"2026-05-26T14:18:42.179474Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12687,"took":"82.829272ms","hash":2332751052,"current-db-size-bytes":57622528,"current-db-size":"58 MB","current-db-size-in-use-bytes":29331456,"current-db-size-in-use":"29 MB"}
{"level":"info","ts":"2026-05-26T14:18:42.179541Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2332751052,"revision":12687,"compact-revision":10474}
{"level":"info","ts":"2026-05-26T14:20:08.808682Z","caller":"traceutil/trace.go:171","msg":"trace[95770642] transaction","detail":"{read_only:false; response_revision:15782; number_of_response:1; }","duration":"262.492846ms","start":"2026-05-26T14:20:08.546161Z","end":"2026-05-26T14:20:08.808653Z","steps":["trace[95770642] 'process raft request'  (duration: 174.427909ms)","trace[95770642] 'compare'  (duration: 87.746928ms)"],"step_count":2}
{"level":"info","ts":"2026-05-26T14:20:08.808692Z","caller":"traceutil/trace.go:171","msg":"trace[480456977] linearizableReadLoop","detail":"{readStateIndex:16329; appliedIndex:16328; }","duration":"160.729324ms","start":"2026-05-26T14:20:08.647894Z","end":"2026-05-26T14:20:08.808623Z","steps":["trace[480456977] 'read index received'  (duration: 72.704227ms)","trace[480456977] 'applied index is now lower than readState.Index'  (duration: 88.023007ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-26T14:20:08.809048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.397434ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-user\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-05-26T14:20:08.809046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.85221ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-05-26T14:20:08.809047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.031684ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-26T14:20:08.809098Z","caller":"traceutil/trace.go:171","msg":"trace[1930811477] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-user; range_end:; response_count:0; response_revision:15782; }","duration":"120.503947ms","start":"2026-05-26T14:20:08.688582Z","end":"2026-05-26T14:20:08.809086Z","steps":["trace[1930811477] 'agreement among raft nodes before linearized reading'  (duration: 120.415616ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-26T14:20:08.809099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.539277ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5521"}
{"level":"info","ts":"2026-05-26T14:20:08.809114Z","caller":"traceutil/trace.go:171","msg":"trace[776618993] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:15782; }","duration":"123.953394ms","start":"2026-05-26T14:20:08.685143Z","end":"2026-05-26T14:20:08.809097Z","steps":["trace[776618993] 'agreement among raft nodes before linearized reading'  (duration: 123.850691ms)"],"step_count":1}
{"level":"info","ts":"2026-05-26T14:20:08.809137Z","caller":"traceutil/trace.go:171","msg":"trace[1102271345] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:15782; }","duration":"120.60895ms","start":"2026-05-26T14:20:08.688519Z","end":"2026-05-26T14:20:08.809128Z","steps":["trace[1102271345] 'agreement among raft nodes before linearized reading'  (duration: 120.473046ms)"],"step_count":1}
{"level":"info","ts":"2026-05-26T14:20:08.80913Z","caller":"traceutil/trace.go:171","msg":"trace[1538752364] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:15782; }","duration":"161.23634ms","start":"2026-05-26T14:20:08.647873Z","end":"2026-05-26T14:20:08.809109Z","steps":["trace[1538752364] 'agreement among raft nodes before linearized reading'  (duration: 160.979722ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-26T14:20:08.809281Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.467007ms","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-05-26T14:20:08.809339Z","caller":"traceutil/trace.go:171","msg":"trace[222994427] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-endpoints; range_end:; response_count:0; response_revision:15782; }","duration":"120.775835ms","start":"2026-05-26T14:20:08.688546Z","end":"2026-05-26T14:20:08.809322Z","steps":["trace[222994427] 'agreement among raft nodes before linearized reading'  (duration: 120.443875ms)"],"step_count":1}
{"level":"info","ts":"2026-05-26T14:23:42.102758Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14967}
{"level":"info","ts":"2026-05-26T14:23:42.200442Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14967,"took":"94.749596ms","hash":1304998651,"current-db-size-bytes":57622528,"current-db-size":"58 MB","current-db-size-in-use-bytes":30638080,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-05-26T14:23:42.200517Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1304998651,"revision":14967,"compact-revision":12687}
{"level":"warn","ts":"2026-05-26T14:25:52.32083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.934511ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:532"}
{"level":"info","ts":"2026-05-26T14:25:52.320947Z","caller":"traceutil/trace.go:171","msg":"trace[2121048486] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:18323; }","duration":"110.091457ms","start":"2026-05-26T14:25:52.210834Z","end":"2026-05-26T14:25:52.320925Z","steps":["trace[2121048486] 'range keys from in-memory index tree'  (duration: 109.727136ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-26T14:25:52.321076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.022953ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-cell-setup-9t97w\" ","response":"range_response_count:1 size:9791"}
{"level":"info","ts":"2026-05-26T14:25:52.321119Z","caller":"traceutil/trace.go:171","msg":"trace[58821422] range","detail":"{range_begin:/registry/pods/openstack/nova-cell-setup-9t97w; range_end:; response_count:1; response_revision:18323; }","duration":"233.101264ms","start":"2026-05-26T14:25:52.088005Z","end":"2026-05-26T14:25:52.321106Z","steps":["trace[58821422] 'range keys from in-memory index tree'  (duration: 232.875408ms)"],"step_count":1}
{"level":"info","ts":"2026-05-26T14:25:52.671599Z","caller":"traceutil/trace.go:171","msg":"trace[371345000] transaction","detail":"{read_only:false; response_revision:18325; number_of_response:1; }","duration":"346.001528ms","start":"2026-05-26T14:25:52.325558Z","end":"2026-05-26T14:25:52.671559Z","steps":["trace[371345000] 'process raft request'  (duration: 340.417193ms)"],"step_count":1}
{"level":"info","ts":"2026-05-26T14:25:52.671705Z","caller":"traceutil/trace.go:171","msg":"trace[686962553] linearizableReadLoop","detail":"{readStateIndex:18958; appliedIndex:18957; }","duration":"307.529062ms","start":"2026-05-26T14:25:52.364152Z","end":"2026-05-26T14:25:52.671681Z","steps":["trace[686962553] 'read index received'  (duration: 301.81942ms)","trace[686962553] 'applied index is now lower than readState.Index'  (duration: 5.707991ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-26T14:25:52.671789Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:25:52.325544Z","time spent":"346.142935ms","remote":"127.0.0.1:45840","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":514,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/cert-manager/cert-manager-controller\" mod_revision:18228 > success:<request_put:<key:\"/registry/leases/cert-manager/cert-manager-controller\" value_size:453 >> failure:<request_range:<key:\"/registry/leases/cert-manager/cert-manager-controller\" > >"}
{"level":"warn","ts":"2026-05-26T14:25:52.672002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.831783ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/neutron-server\" ","response":"range_response_count:1 size:702"}
{"level":"warn","ts":"2026-05-26T14:25:52.672245Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.426164ms","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-05-26T14:25:52.672294Z","caller":"traceutil/trace.go:171","msg":"trace[857525562] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:18326; }","duration":"187.507526ms","start":"2026-05-26T14:25:52.484773Z","end":"2026-05-26T14:25:52.672281Z","steps":["trace[857525562] 'agreement among raft nodes before linearized reading'  (duration: 187.336341ms)"],"step_count":1}
{"level":"info","ts":"2026-05-26T14:25:52.672104Z","caller":"traceutil/trace.go:171","msg":"trace[1225581381] range","detail":"{range_begin:/registry/services/endpoints/openstack/neutron-server; range_end:; response_count:1; response_revision:18326; }","duration":"188.986718ms","start":"2026-05-26T14:25:52.483102Z","end":"2026-05-26T14:25:52.672089Z","steps":["trace[1225581381] 'agreement among raft nodes before linearized reading'  (duration: 188.784953ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-26T14:25:52.672676Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"343.342906ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:95 size:941296"}
{"level":"info","ts":"2026-05-26T14:25:52.672759Z","caller":"traceutil/trace.go:171","msg":"trace[1255982288] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:95; response_revision:18326; }","duration":"343.449968ms","start":"2026-05-26T14:25:52.329296Z","end":"2026-05-26T14:25:52.672746Z","steps":["trace[1255982288] 'agreement among raft nodes before linearized reading'  (duration: 342.501022ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-26T14:25:52.672806Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:25:52.32929Z","time spent":"343.50414ms","remote":"127.0.0.1:45766","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":95,"response size":941320,"request content":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" "}
{"level":"warn","ts":"2026-05-26T14:25:53.091538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.510846ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13313096128157540521 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:18313 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-26T14:25:53.09167Z","caller":"traceutil/trace.go:171","msg":"trace[1617194507] transaction","detail":"{read_only:false; response_revision:18327; number_of_response:1; }","duration":"416.436094ms","start":"2026-05-26T14:25:52.675213Z","end":"2026-05-26T14:25:53.091649Z","steps":["trace[1617194507] 'process raft request'  (duration: 294.681461ms)","trace[1617194507] 'compare'  (duration: 121.29405ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-26T14:25:53.091728Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:25:52.675197Z","time spent":"416.505977ms","remote":"127.0.0.1:45840","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:18313 > 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-05-26T14:25:53.163876Z","caller":"traceutil/trace.go:171","msg":"trace[1924011005] transaction","detail":"{read_only:false; response_revision:18330; number_of_response:1; }","duration":"296.021578ms","start":"2026-05-26T14:25:52.867827Z","end":"2026-05-26T14:25:53.163848Z","steps":["trace[1924011005] 'process raft request'  (duration: 295.521794ms)"],"step_count":1}
{"level":"info","ts":"2026-05-26T14:25:53.163953Z","caller":"traceutil/trace.go:171","msg":"trace[308942936] transaction","detail":"{read_only:false; response_revision:18328; number_of_response:1; }","duration":"487.372202ms","start":"2026-05-26T14:25:52.676563Z","end":"2026-05-26T14:25:53.163935Z","steps":["trace[308942936] 'process raft request'  (duration: 486.56709ms)"],"step_count":1}
{"level":"info","ts":"2026-05-26T14:25:53.163968Z","caller":"traceutil/trace.go:171","msg":"trace[538949651] transaction","detail":"{read_only:false; response_revision:18331; number_of_response:1; }","duration":"227.816946ms","start":"2026-05-26T14:25:52.936104Z","end":"2026-05-26T14:25:53.163921Z","steps":["trace[538949651] 'process raft request'  (duration: 227.287991ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-26T14:25:53.164168Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:25:52.676544Z","time spent":"487.474395ms","remote":"127.0.0.1:45840","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:18312 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-05-26T14:25:53.163928Z","caller":"traceutil/trace.go:171","msg":"trace[579162478] transaction","detail":"{read_only:false; response_revision:18332; number_of_response:1; }","duration":"226.465449ms","start":"2026-05-26T14:25:52.937423Z","end":"2026-05-26T14:25:53.163888Z","steps":["trace[579162478] 'process raft request'  (duration: 226.006827ms)"],"step_count":1}
{"level":"info","ts":"2026-05-26T14:25:53.163892Z","caller":"traceutil/trace.go:171","msg":"trace[221155918] transaction","detail":"{read_only:false; response_revision:18329; number_of_response:1; }","duration":"474.802061ms","start":"2026-05-26T14:25:52.689053Z","end":"2026-05-26T14:25:53.163855Z","steps":["trace[221155918] 'process raft request'  (duration: 474.237294ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-26T14:25:53.164761Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:25:52.689032Z","time spent":"475.52362ms","remote":"127.0.0.1:45766","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":20962,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/pods/openstack/libvirt-libvirt-default-dd2wz\" mod_revision:18276 > success:<request_put:<key:\"/registry/pods/openstack/libvirt-libvirt-default-dd2wz\" value_size:20898 >> failure:<request_range:<key:\"/registry/pods/openstack/libvirt-libvirt-default-dd2wz\" > >"}
{"level":"info","ts":"2026-05-26T14:26:59.009455Z","caller":"traceutil/trace.go:171","msg":"trace[2117672340] linearizableReadLoop","detail":"{readStateIndex:19415; appliedIndex:19414; }","duration":"170.742756ms","start":"2026-05-26T14:26:58.838673Z","end":"2026-05-26T14:26:59.009416Z","steps":["trace[2117672340] 'read index received'  (duration: 170.227391ms)","trace[2117672340] 'applied index is now lower than readState.Index'  (duration: 513.815µs)"],"step_count":2}
{"level":"info","ts":"2026-05-26T14:26:59.009599Z","caller":"traceutil/trace.go:171","msg":"trace[393470220] transaction","detail":"{read_only:false; response_revision:18763; number_of_response:1; }","duration":"209.097711ms","start":"2026-05-26T14:26:58.800468Z","end":"2026-05-26T14:26:59.009566Z","steps":["trace[393470220] 'process raft request'  (duration: 208.471144ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-26T14:26:59.010196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.489228ms","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-05-26T14:26:59.010271Z","caller":"traceutil/trace.go:171","msg":"trace[472151094] range","detail":"{range_begin:/registry/services/endpoints/openstack/neutron-server; range_end:; response_count:1; response_revision:18763; }","duration":"171.614542ms","start":"2026-05-26T14:26:58.838637Z","end":"2026-05-26T14:26:59.010251Z","steps":["trace[472151094] 'agreement among raft nodes before linearized reading'  (duration: 170.961454ms)"],"step_count":1}
{"level":"info","ts":"2026-05-26T14:26:59.012866Z","caller":"traceutil/trace.go:171","msg":"trace[1516737643] transaction","detail":"{read_only:false; response_revision:18764; number_of_response:1; }","duration":"116.631339ms","start":"2026-05-26T14:26:58.896207Z","end":"2026-05-26T14:26:59.012838Z","steps":["trace[1516737643] 'process raft request'  (duration: 115.783565ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-26T14:27:02.147937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.159672ms","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-05-26T14:27:02.148229Z","caller":"traceutil/trace.go:171","msg":"trace[217010605] range","detail":"{range_begin:/registry/services/endpoints/openstack/neutron-server; range_end:; response_count:1; response_revision:18780; }","duration":"265.433941ms","start":"2026-05-26T14:27:01.882712Z","end":"2026-05-26T14:27:02.148146Z","steps":["trace[217010605] 'range keys from in-memory index tree'  (duration: 264.957997ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-26T14:27:02.148295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"561.225323ms","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-05-26T14:27:02.148409Z","caller":"traceutil/trace.go:171","msg":"trace[1631803162] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:18780; }","duration":"561.380927ms","start":"2026-05-26T14:27:01.587002Z","end":"2026-05-26T14:27:02.148383Z","steps":["trace[1631803162] 'range keys from in-memory index tree'  (duration: 560.979896ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-26T14:27:02.148481Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:27:01.586984Z","time spent":"561.48162ms","remote":"127.0.0.1:45840","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-05-26T14:27:02.148673Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"546.346075ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"}
{"level":"info","ts":"2026-05-26T14:27:02.148733Z","caller":"traceutil/trace.go:171","msg":"trace[599877563] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:18780; }","duration":"546.428528ms","start":"2026-05-26T14:27:01.602292Z","end":"2026-05-26T14:27:02.14872Z","steps":["trace[599877563] 'range keys from in-memory index tree'  (duration: 546.122629ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-26T14:27:02.148761Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:27:01.602277Z","time spent":"546.475369ms","remote":"127.0.0.1:45840","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":464,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-05-26T14:27:02.149003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"539.550605ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"}
{"level":"info","ts":"2026-05-26T14:27:02.149051Z","caller":"traceutil/trace.go:171","msg":"trace[624850672] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:18780; }","duration":"539.613117ms","start":"2026-05-26T14:27:01.609409Z","end":"2026-05-26T14:27:02.149022Z","steps":["trace[624850672] 'range keys from in-memory index tree'  (duration: 539.435802ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-26T14:27:02.14904Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:27:01.792626Z","time spent":"356.411081ms","remote":"127.0.0.1:44018","response type":"/etcdserverpb.Maintenance/Status","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"warn","ts":"2026-05-26T14:27:02.149078Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:27:01.60939Z","time spent":"539.681038ms","remote":"127.0.0.1:45840","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":519,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-05-26T14:27:02.149218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"505.281655ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-26T14:27:02.149244Z","caller":"traceutil/trace.go:171","msg":"trace[2016152550] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:18780; }","duration":"505.338066ms","start":"2026-05-26T14:27:01.643899Z","end":"2026-05-26T14:27:02.149237Z","steps":["trace[2016152550] 'range keys from in-memory index tree'  (duration: 505.16806ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-26T14:27:02.149264Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:27:01.643883Z","time spent":"505.375498ms","remote":"127.0.0.1:45592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":30,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-05-26T14:27:02.148065Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.050161ms","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-05-26T14:27:02.149651Z","caller":"traceutil/trace.go:171","msg":"trace[1574619155] range","detail":"{range_begin:/registry/services/endpoints/openstack/neutron-server; range_end:; response_count:1; response_revision:18780; }","duration":"266.700335ms","start":"2026-05-26T14:27:01.882907Z","end":"2026-05-26T14:27:02.149607Z","steps":["trace[1574619155] 'range keys from in-memory index tree'  (duration: 264.845784ms)"],"step_count":1}
{"level":"info","ts":"2026-05-26T14:28:42.109529Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17422}
{"level":"info","ts":"2026-05-26T14:28:42.21199Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17422,"took":"99.397246ms","hash":3442219011,"current-db-size-bytes":57622528,"current-db-size":"58 MB","current-db-size-in-use-bytes":29597696,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-05-26T14:28:42.212074Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3442219011,"revision":17422,"compact-revision":14967}
{"level":"info","ts":"2026-05-26T14:28:46.667818Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"c3b8446219deb8c1","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-05-26T14:28:46.673546Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002}
{"level":"info","ts":"2026-05-26T14:28:46.673656Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002}
{"level":"info","ts":"2026-05-26T14:33:42.115535Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19302}
{"level":"info","ts":"2026-05-26T14:33:42.206463Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19302,"took":"87.89031ms","hash":1917464090,"current-db-size-bytes":57622528,"current-db-size":"58 MB","current-db-size-in-use-bytes":24018944,"current-db-size-in-use":"24 MB"}
{"level":"info","ts":"2026-05-26T14:33:42.20652Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1917464090,"revision":19302,"compact-revision":17422}