{"level":"warn","ts":"2026-08-19T20:26:12.795655Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-08-19T20:26:12.795774Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.186:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://162.253.55.186:2380","--initial-cluster=instance=https://162.253.55.186:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.186:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.186:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]}
{"level":"warn","ts":"2026-08-19T20:26:12.795876Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-08-19T20:26:12.795893Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.186:2380"]}
{"level":"info","ts":"2026-08-19T20:26:12.795911Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-08-19T20:26:12.79665Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.186:2379"]}
{"level":"info","ts":"2026-08-19T20:26:12.796742Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://162.253.55.186:2380"],"listen-peer-urls":["https://162.253.55.186:2380"],"advertise-client-urls":["https://162.253.55.186:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.186:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.186:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"}
{"level":"info","ts":"2026-08-19T20:26:12.800032Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.92218ms"}
{"level":"info","ts":"2026-08-19T20:26:12.806357Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"612d5169b08bb96b","cluster-id":"20ec8eafba602517"}
{"level":"info","ts":"2026-08-19T20:26:12.806458Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"612d5169b08bb96b switched to configuration voters=()"}
{"level":"info","ts":"2026-08-19T20:26:12.806489Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"612d5169b08bb96b became follower at term 0"}
{"level":"info","ts":"2026-08-19T20:26:12.806508Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 612d5169b08bb96b [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-08-19T20:26:12.806521Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"612d5169b08bb96b became follower at term 1"}
{"level":"info","ts":"2026-08-19T20:26:12.806566Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"612d5169b08bb96b switched to configuration voters=(7002342510006352235)"}
{"level":"warn","ts":"2026-08-19T20:26:12.811233Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-08-19T20:26:12.812656Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-08-19T20:26:12.813989Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"}
{"level":"info","ts":"2026-08-19T20:26:12.815995Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"612d5169b08bb96b","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-08-19T20:26:12.816187Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"612d5169b08bb96b","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-08-19T20:26:12.81643Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"}
{"level":"info","ts":"2026-08-19T20:26:12.816485Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"}
{"level":"info","ts":"2026-08-19T20:26:12.816502Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"}
{"level":"info","ts":"2026-08-19T20:26:12.817722Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"612d5169b08bb96b switched to configuration voters=(7002342510006352235)"}
{"level":"info","ts":"2026-08-19T20:26:12.819809Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"20ec8eafba602517","local-member-id":"612d5169b08bb96b","added-peer-id":"612d5169b08bb96b","added-peer-peer-urls":["https://162.253.55.186:2380"]}
{"level":"info","ts":"2026-08-19T20:26:12.823546Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-08-19T20:26:12.823657Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.186:2380"}
{"level":"info","ts":"2026-08-19T20:26:12.82371Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.186:2380"}
{"level":"info","ts":"2026-08-19T20:26:12.823948Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"612d5169b08bb96b","initial-advertise-peer-urls":["https://162.253.55.186:2380"],"listen-peer-urls":["https://162.253.55.186:2380"],"advertise-client-urls":["https://162.253.55.186:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.186:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-08-19T20:26:12.824008Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-08-19T20:26:12.907238Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"612d5169b08bb96b is starting a new election at term 1"}
{"level":"info","ts":"2026-08-19T20:26:12.907324Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"612d5169b08bb96b became pre-candidate at term 1"}
{"level":"info","ts":"2026-08-19T20:26:12.907364Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"612d5169b08bb96b received MsgPreVoteResp from 612d5169b08bb96b at term 1"}
{"level":"info","ts":"2026-08-19T20:26:12.907387Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"612d5169b08bb96b became candidate at term 2"}
{"level":"info","ts":"2026-08-19T20:26:12.907399Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"612d5169b08bb96b received MsgVoteResp from 612d5169b08bb96b at term 2"}
{"level":"info","ts":"2026-08-19T20:26:12.907418Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"612d5169b08bb96b became leader at term 2"}
{"level":"info","ts":"2026-08-19T20:26:12.907432Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 612d5169b08bb96b elected leader 612d5169b08bb96b at term 2"}
{"level":"info","ts":"2026-08-19T20:26:12.908656Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"612d5169b08bb96b","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.186:2379]}","request-path":"/0/members/612d5169b08bb96b/attributes","cluster-id":"20ec8eafba602517","publish-timeout":"7s"}
{"level":"info","ts":"2026-08-19T20:26:12.908661Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-08-19T20:26:12.908684Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-08-19T20:26:12.90901Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-08-19T20:26:12.909358Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-08-19T20:26:12.909429Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-08-19T20:26:12.912478Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.186:2379"}
{"level":"info","ts":"2026-08-19T20:26:12.912486Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-08-19T20:26:12.913292Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"20ec8eafba602517","local-member-id":"612d5169b08bb96b","cluster-version":"3.5"}
{"level":"info","ts":"2026-08-19T20:26:12.913507Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-08-19T20:26:12.913561Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-08-19T20:26:56.324314Z","caller":"traceutil/trace.go:171","msg":"trace[454017973] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"134.450964ms","start":"2026-08-19T20:26:56.189794Z","end":"2026-08-19T20:26:56.324245Z","steps":["trace[454017973] 'process raft request'  (duration: 133.722536ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:26:56.552109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.104975ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13360948760368237350 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/pods/kube-system/cilium-znx26\" mod_revision:476 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-znx26\" value_size:17085 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-znx26\" > >>","response":"size:16"}
{"level":"info","ts":"2026-08-19T20:26:56.55228Z","caller":"traceutil/trace.go:171","msg":"trace[259013644] linearizableReadLoop","detail":"{readStateIndex:613; appliedIndex:612; }","duration":"188.455193ms","start":"2026-08-19T20:26:56.363806Z","end":"2026-08-19T20:26:56.552261Z","steps":["trace[259013644] 'read index received'  (duration: 25.457558ms)","trace[259013644] 'applied index is now lower than readState.Index'  (duration: 162.995785ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-19T20:26:56.552385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.572087ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:422"}
{"level":"info","ts":"2026-08-19T20:26:56.552442Z","caller":"traceutil/trace.go:171","msg":"trace[453279914] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:590; }","duration":"188.666638ms","start":"2026-08-19T20:26:56.363762Z","end":"2026-08-19T20:26:56.552429Z","steps":["trace[453279914] 'agreement among raft nodes before linearized reading'  (duration: 188.555465ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:26:56.552432Z","caller":"traceutil/trace.go:171","msg":"trace[105828758] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"195.532282ms","start":"2026-08-19T20:26:56.356862Z","end":"2026-08-19T20:26:56.552395Z","steps":["trace[105828758] 'process raft request'  (duration: 32.471636ms)","trace[105828758] 'compare'  (duration: 161.547761ms)"],"step_count":2}
{"level":"info","ts":"2026-08-19T20:26:56.773907Z","caller":"traceutil/trace.go:171","msg":"trace[2043521076] linearizableReadLoop","detail":"{readStateIndex:614; appliedIndex:613; }","duration":"219.065675ms","start":"2026-08-19T20:26:56.554803Z","end":"2026-08-19T20:26:56.773869Z","steps":["trace[2043521076] 'read index received'  (duration: 210.785917ms)","trace[2043521076] 'applied index is now lower than readState.Index'  (duration: 8.277698ms)"],"step_count":2}
{"level":"info","ts":"2026-08-19T20:26:56.773923Z","caller":"traceutil/trace.go:171","msg":"trace[829136230] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"374.645232ms","start":"2026-08-19T20:26:56.399245Z","end":"2026-08-19T20:26:56.77389Z","steps":["trace[829136230] 'process raft request'  (duration: 366.18995ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:26:56.774122Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:26:56.399218Z","time spent":"374.796026ms","remote":"127.0.0.1:55220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/clusterrolebindings/envoy-gateway-gateway-helm-certgen:envoy-gateway-system\" mod_revision:0 > success:<request_put:<key:\"/registry/clusterrolebindings/envoy-gateway-gateway-helm-certgen:envoy-gateway-system\" value_size:994 >> failure:<>"}
{"level":"warn","ts":"2026-08-19T20:26:56.774408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.537198ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/\" range_end:\"/registry/masterleases0\" ","response":"range_response_count:1 size:135"}
{"level":"info","ts":"2026-08-19T20:26:56.774697Z","caller":"traceutil/trace.go:171","msg":"trace[716499604] range","detail":"{range_begin:/registry/masterleases/; range_end:/registry/masterleases0; response_count:1; response_revision:591; }","duration":"219.937857ms","start":"2026-08-19T20:26:56.55473Z","end":"2026-08-19T20:26:56.774668Z","steps":["trace[716499604] 'agreement among raft nodes before linearized reading'  (duration: 219.245419ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:26:57.41317Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.604181ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13360948760368237357 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:576 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >>","response":"size:16"}
{"level":"info","ts":"2026-08-19T20:26:57.413373Z","caller":"traceutil/trace.go:171","msg":"trace[896806156] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"537.459094ms","start":"2026-08-19T20:26:56.875867Z","end":"2026-08-19T20:26:57.413327Z","steps":["trace[896806156] 'process raft request'  (duration: 347.589997ms)","trace[896806156] 'compare'  (duration: 189.485178ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-19T20:26:57.413548Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:26:56.875841Z","time spent":"537.615388ms","remote":"127.0.0.1:55128","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:576 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-08-19T20:26:57.413628Z","caller":"traceutil/trace.go:171","msg":"trace[208365117] linearizableReadLoop","detail":"{readStateIndex:615; appliedIndex:614; }","duration":"336.828239ms","start":"2026-08-19T20:26:57.076729Z","end":"2026-08-19T20:26:57.413557Z","steps":["trace[208365117] 'read index received'  (duration: 146.804718ms)","trace[208365117] 'applied index is now lower than readState.Index'  (duration: 190.015921ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-19T20:26:57.414425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"337.672919ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-19T20:26:57.414513Z","caller":"traceutil/trace.go:171","msg":"trace[237968312] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:592; }","duration":"337.783642ms","start":"2026-08-19T20:26:57.07671Z","end":"2026-08-19T20:26:57.414493Z","steps":["trace[237968312] 'agreement among raft nodes before linearized reading'  (duration: 337.000193ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:26:57.414568Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:26:57.076629Z","time spent":"337.926366ms","remote":"127.0.0.1:54870","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-08-19T20:26:57.414611Z","caller":"traceutil/trace.go:171","msg":"trace[177386338] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"250.183028ms","start":"2026-08-19T20:26:57.164369Z","end":"2026-08-19T20:26:57.414552Z","steps":["trace[177386338] 'process raft request'  (duration: 249.139234ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:26:57.414803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.068193ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"info","ts":"2026-08-19T20:26:57.414874Z","caller":"traceutil/trace.go:171","msg":"trace[505982421] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:593; }","duration":"303.202015ms","start":"2026-08-19T20:26:57.111653Z","end":"2026-08-19T20:26:57.414855Z","steps":["trace[505982421] 'agreement among raft nodes before linearized reading'  (duration: 302.879418ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:26:57.41496Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:26:57.111615Z","time spent":"303.332779ms","remote":"127.0.0.1:55128","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-08-19T20:26:57.417256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.680438ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-19T20:26:57.417379Z","caller":"traceutil/trace.go:171","msg":"trace[427213465] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:593; }","duration":"186.123858ms","start":"2026-08-19T20:26:57.231212Z","end":"2026-08-19T20:26:57.417336Z","steps":["trace[427213465] 'agreement among raft nodes before linearized reading'  (duration: 184.169191ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:27:12.60275Z","caller":"traceutil/trace.go:171","msg":"trace[1523264736] linearizableReadLoop","detail":"{readStateIndex:781; appliedIndex:780; }","duration":"209.118773ms","start":"2026-08-19T20:27:12.393603Z","end":"2026-08-19T20:27:12.602722Z","steps":["trace[1523264736] 'read index received'  (duration: 208.921498ms)","trace[1523264736] 'applied index is now lower than readState.Index'  (duration: 196.135µs)"],"step_count":2}
{"level":"info","ts":"2026-08-19T20:27:12.602864Z","caller":"traceutil/trace.go:171","msg":"trace[467990364] transaction","detail":"{read_only:false; response_revision:754; number_of_response:1; }","duration":"270.937881ms","start":"2026-08-19T20:27:12.331891Z","end":"2026-08-19T20:27:12.602829Z","steps":["trace[467990364] 'process raft request'  (duration: 270.661604ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:27:12.602984Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.35949ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-2hxg2\" ","response":"range_response_count:1 size:3965"}
{"level":"info","ts":"2026-08-19T20:27:12.603058Z","caller":"traceutil/trace.go:171","msg":"trace[626521618] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-2hxg2; range_end:; response_count:1; response_revision:754; }","duration":"209.495082ms","start":"2026-08-19T20:27:12.39355Z","end":"2026-08-19T20:27:12.603045Z","steps":["trace[626521618] 'agreement among raft nodes before linearized reading'  (duration: 209.280997ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:28:27.774363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.205276ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"}
{"level":"info","ts":"2026-08-19T20:28:27.77447Z","caller":"traceutil/trace.go:171","msg":"trace[1766193991] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1818; }","duration":"101.345259ms","start":"2026-08-19T20:28:27.673098Z","end":"2026-08-19T20:28:27.774443Z","steps":["trace[1766193991] 'range keys from in-memory index tree'  (duration: 100.963248ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:28:28.098806Z","caller":"traceutil/trace.go:171","msg":"trace[912879436] linearizableReadLoop","detail":"{readStateIndex:1888; appliedIndex:1887; }","duration":"217.954302ms","start":"2026-08-19T20:28:27.880826Z","end":"2026-08-19T20:28:28.09878Z","steps":["trace[912879436] 'read index received'  (duration: 217.887661ms)","trace[912879436] 'applied index is now lower than readState.Index'  (duration: 65.081µs)"],"step_count":2}
{"level":"info","ts":"2026-08-19T20:28:28.098898Z","caller":"traceutil/trace.go:171","msg":"trace[1378277329] transaction","detail":"{read_only:false; response_revision:1819; number_of_response:1; }","duration":"282.995427ms","start":"2026-08-19T20:28:27.815875Z","end":"2026-08-19T20:28:28.098871Z","steps":["trace[1378277329] 'process raft request'  (duration: 282.717311ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:28:28.099238Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.361403ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-08-19T20:28:28.099375Z","caller":"traceutil/trace.go:171","msg":"trace[1787100642] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1819; }","duration":"218.566578ms","start":"2026-08-19T20:28:27.88078Z","end":"2026-08-19T20:28:28.099346Z","steps":["trace[1787100642] 'agreement among raft nodes before linearized reading'  (duration: 218.152537ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:28:28.104355Z","caller":"traceutil/trace.go:171","msg":"trace[1781379419] transaction","detail":"{read_only:false; response_revision:1820; number_of_response:1; }","duration":"192.378946ms","start":"2026-08-19T20:28:27.911944Z","end":"2026-08-19T20:28:28.104323Z","steps":["trace[1781379419] 'process raft request'  (duration: 192.130921ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:28:28.104624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.460512ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-08-19T20:28:28.104693Z","caller":"traceutil/trace.go:171","msg":"trace[1242540856] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1821; }","duration":"222.541894ms","start":"2026-08-19T20:28:27.882131Z","end":"2026-08-19T20:28:28.104673Z","steps":["trace[1242540856] 'agreement among raft nodes before linearized reading'  (duration: 222.4194ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:28:28.506091Z","caller":"traceutil/trace.go:171","msg":"trace[1353523019] transaction","detail":"{read_only:false; response_revision:1830; number_of_response:1; }","duration":"120.688163ms","start":"2026-08-19T20:28:28.385373Z","end":"2026-08-19T20:28:28.506061Z","steps":["trace[1353523019] 'process raft request'  (duration: 120.480378ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:28:41.039271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.115367ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"}
{"level":"info","ts":"2026-08-19T20:28:41.039502Z","caller":"traceutil/trace.go:171","msg":"trace[761892707] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1929; }","duration":"159.346803ms","start":"2026-08-19T20:28:40.880085Z","end":"2026-08-19T20:28:41.039432Z","steps":["trace[761892707] 'range keys from in-memory index tree'  (duration: 158.912132ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:28:41.0395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.392376ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-19T20:28:41.039661Z","caller":"traceutil/trace.go:171","msg":"trace[1478775835] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1929; }","duration":"137.56834ms","start":"2026-08-19T20:28:40.902073Z","end":"2026-08-19T20:28:41.039641Z","steps":["trace[1478775835] 'range keys from in-memory index tree'  (duration: 137.373634ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:29:13.547051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.254396ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-08-19T20:29:13.547195Z","caller":"traceutil/trace.go:171","msg":"trace[1094427700] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2120; }","duration":"153.437751ms","start":"2026-08-19T20:29:13.393729Z","end":"2026-08-19T20:29:13.547167Z","steps":["trace[1094427700] 'range keys from in-memory index tree'  (duration: 152.989161ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:29:13.858037Z","caller":"traceutil/trace.go:171","msg":"trace[1938494304] transaction","detail":"{read_only:false; response_revision:2121; number_of_response:1; }","duration":"307.176609ms","start":"2026-08-19T20:29:13.550831Z","end":"2026-08-19T20:29:13.858008Z","steps":["trace[1938494304] 'process raft request'  (duration: 306.976004ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:29:13.858238Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:29:13.550799Z","time spent":"307.344763ms","remote":"127.0.0.1:55128","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" mod_revision:2082 > success:<request_put:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" value_size:416 >> failure:<request_range:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" > >"}
{"level":"info","ts":"2026-08-19T20:29:13.912478Z","caller":"traceutil/trace.go:171","msg":"trace[835126935] transaction","detail":"{read_only:false; response_revision:2123; number_of_response:1; }","duration":"360.361018ms","start":"2026-08-19T20:29:13.552086Z","end":"2026-08-19T20:29:13.912447Z","steps":["trace[835126935] 'process raft request'  (duration: 360.305316ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:29:13.912514Z","caller":"traceutil/trace.go:171","msg":"trace[1199182435] transaction","detail":"{read_only:false; response_revision:2122; number_of_response:1; }","duration":"361.185878ms","start":"2026-08-19T20:29:13.551293Z","end":"2026-08-19T20:29:13.912479Z","steps":["trace[1199182435] 'process raft request'  (duration: 360.922502ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:29:13.912671Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:29:13.552072Z","time spent":"360.501892ms","remote":"127.0.0.1:55128","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:2111 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-08-19T20:29:13.91307Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:29:13.55127Z","time spent":"361.564569ms","remote":"127.0.0.1:55128","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:2112 > 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":"warn","ts":"2026-08-19T20:29:14.713564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"398.2596ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13360948760368240423 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:2115 > 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\" > >>","response":"size:16"}
{"level":"info","ts":"2026-08-19T20:29:14.713676Z","caller":"traceutil/trace.go:171","msg":"trace[1618292439] linearizableReadLoop","detail":"{readStateIndex:2204; appliedIndex:2203; }","duration":"411.874028ms","start":"2026-08-19T20:29:14.301783Z","end":"2026-08-19T20:29:14.713657Z","steps":["trace[1618292439] 'read index received'  (duration: 13.374072ms)","trace[1618292439] 'applied index is now lower than readState.Index'  (duration: 398.498365ms)"],"step_count":2}
{"level":"info","ts":"2026-08-19T20:29:14.713891Z","caller":"traceutil/trace.go:171","msg":"trace[1562084356] transaction","detail":"{read_only:false; response_revision:2125; number_of_response:1; }","duration":"435.957136ms","start":"2026-08-19T20:29:14.277896Z","end":"2026-08-19T20:29:14.713853Z","steps":["trace[1562084356] 'process raft request'  (duration: 37.308557ms)","trace[1562084356] 'compare'  (duration: 397.886801ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-19T20:29:14.714011Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"403.095617ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"warn","ts":"2026-08-19T20:29:14.713988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"412.185886ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"}
{"level":"info","ts":"2026-08-19T20:29:14.714051Z","caller":"traceutil/trace.go:171","msg":"trace[696488997] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2125; }","duration":"403.166659ms","start":"2026-08-19T20:29:14.310871Z","end":"2026-08-19T20:29:14.714038Z","steps":["trace[696488997] 'agreement among raft nodes before linearized reading'  (duration: 403.029184ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:29:14.714057Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:29:14.277876Z","time spent":"436.096281ms","remote":"127.0.0.1:55128","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:2115 > 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-08-19T20:29:14.714079Z","caller":"traceutil/trace.go:171","msg":"trace[357061526] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2125; }","duration":"412.325899ms","start":"2026-08-19T20:29:14.301728Z","end":"2026-08-19T20:29:14.714054Z","steps":["trace[357061526] 'agreement among raft nodes before linearized reading'  (duration: 412.050171ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:29:14.714085Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:29:14.310854Z","time spent":"403.222849ms","remote":"127.0.0.1:55128","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-08-19T20:29:14.714097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.224433ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/servicenodeports\" ","response":"range_response_count:1 size:118"}
{"level":"warn","ts":"2026-08-19T20:29:14.714126Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:29:14.301706Z","time spent":"412.410131ms","remote":"127.0.0.1:56262","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5434,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "}
{"level":"info","ts":"2026-08-19T20:29:14.714169Z","caller":"traceutil/trace.go:171","msg":"trace[1023268240] range","detail":"{range_begin:/registry/ranges/servicenodeports; range_end:; response_count:1; response_revision:2125; }","duration":"256.312566ms","start":"2026-08-19T20:29:14.457833Z","end":"2026-08-19T20:29:14.714146Z","steps":["trace[1023268240] 'agreement among raft nodes before linearized reading'  (duration: 256.096021ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:29:14.714262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"355.389289ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"warn","ts":"2026-08-19T20:29:14.714304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.609205ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:1 size:128073"}
{"level":"info","ts":"2026-08-19T20:29:14.714426Z","caller":"traceutil/trace.go:171","msg":"trace[1802475448] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:1; response_revision:2125; }","duration":"259.745628ms","start":"2026-08-19T20:29:14.454656Z","end":"2026-08-19T20:29:14.714402Z","steps":["trace[1802475448] 'agreement among raft nodes before linearized reading'  (duration: 259.362959ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:29:14.714359Z","caller":"traceutil/trace.go:171","msg":"trace[1003724134] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2125; }","duration":"355.517052ms","start":"2026-08-19T20:29:14.358817Z","end":"2026-08-19T20:29:14.714334Z","steps":["trace[1003724134] 'agreement among raft nodes before linearized reading'  (duration: 355.210244ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:29:14.71444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"352.115631ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"warn","ts":"2026-08-19T20:29:14.714516Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:29:14.358807Z","time spent":"355.696077ms","remote":"127.0.0.1:55128","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-08-19T20:29:14.714545Z","caller":"traceutil/trace.go:171","msg":"trace[1643243463] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2125; }","duration":"352.236403ms","start":"2026-08-19T20:29:14.36229Z","end":"2026-08-19T20:29:14.714526Z","steps":["trace[1643243463] 'agreement among raft nodes before linearized reading'  (duration: 351.715951ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:29:14.714587Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:29:14.362281Z","time spent":"352.297824ms","remote":"127.0.0.1:55128","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-08-19T20:29:20.522252Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"444.82841ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-19T20:29:20.522336Z","caller":"traceutil/trace.go:171","msg":"trace[415647898] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2155; }","duration":"444.981833ms","start":"2026-08-19T20:29:20.077335Z","end":"2026-08-19T20:29:20.522317Z","steps":["trace[415647898] 'range keys from in-memory index tree'  (duration: 444.647965ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:29:20.52241Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:29:20.077295Z","time spent":"445.075045ms","remote":"127.0.0.1:54860","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-08-19T20:29:20.555844Z","caller":"traceutil/trace.go:171","msg":"trace[786031515] transaction","detail":"{read_only:false; response_revision:2156; number_of_response:1; }","duration":"237.457759ms","start":"2026-08-19T20:29:20.318348Z","end":"2026-08-19T20:29:20.555805Z","steps":["trace[786031515] 'process raft request'  (duration: 237.249554ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:29:21.170101Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.671301ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-19T20:29:21.170245Z","caller":"traceutil/trace.go:171","msg":"trace[2086906001] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:2156; }","duration":"267.838385ms","start":"2026-08-19T20:29:20.902387Z","end":"2026-08-19T20:29:21.170225Z","steps":["trace[2086906001] 'range keys from in-memory index tree'  (duration: 267.62797ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:29:21.171843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.60683ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13360948760368240503 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:2148 > 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\" > >>","response":"size:16"}
{"level":"info","ts":"2026-08-19T20:29:21.172021Z","caller":"traceutil/trace.go:171","msg":"trace[1849833118] transaction","detail":"{read_only:false; response_revision:2157; number_of_response:1; }","duration":"437.413879ms","start":"2026-08-19T20:29:20.734561Z","end":"2026-08-19T20:29:21.171974Z","steps":["trace[1849833118] 'process raft request'  (duration: 162.567743ms)","trace[1849833118] 'compare'  (duration: 272.935459ms)"],"step_count":2}
{"level":"info","ts":"2026-08-19T20:29:21.172169Z","caller":"traceutil/trace.go:171","msg":"trace[2082133008] transaction","detail":"{read_only:false; response_revision:2158; number_of_response:1; }","duration":"409.894461ms","start":"2026-08-19T20:29:20.762224Z","end":"2026-08-19T20:29:21.172118Z","steps":["trace[2082133008] 'process raft request'  (duration: 409.739448ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:29:21.172095Z","caller":"traceutil/trace.go:171","msg":"trace[2033809982] linearizableReadLoop","detail":"{readStateIndex:2237; appliedIndex:2236; }","duration":"413.620882ms","start":"2026-08-19T20:29:20.758451Z","end":"2026-08-19T20:29:21.172072Z","steps":["trace[2033809982] 'read index received'  (duration: 138.713805ms)","trace[2033809982] 'applied index is now lower than readState.Index'  (duration: 274.903557ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-19T20:29:21.172262Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:29:20.734528Z","time spent":"437.621284ms","remote":"127.0.0.1:55128","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:2148 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:478 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-08-19T20:29:21.172314Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:29:20.762191Z","time spent":"410.050725ms","remote":"127.0.0.1:55128","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:2150 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:458 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"warn","ts":"2026-08-19T20:29:21.172492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"414.041273ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-08-19T20:29:21.172561Z","caller":"traceutil/trace.go:171","msg":"trace[532779688] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2158; }","duration":"414.152576ms","start":"2026-08-19T20:29:20.758393Z","end":"2026-08-19T20:29:21.172545Z","steps":["trace[532779688] 'agreement among raft nodes before linearized reading'  (duration: 413.738746ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:29:21.172633Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"410.6067ms","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-08-19T20:29:21.172663Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.433996ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/percona-xtradb-haproxy-0.18cd4edc7b724076\" ","response":"range_response_count:1 size:846"}
{"level":"warn","ts":"2026-08-19T20:29:21.172694Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"409.539283ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-08-19T20:29:21.172714Z","caller":"traceutil/trace.go:171","msg":"trace[902462832] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2158; }","duration":"410.720012ms","start":"2026-08-19T20:29:20.761974Z","end":"2026-08-19T20:29:21.172694Z","steps":["trace[902462832] 'agreement among raft nodes before linearized reading'  (duration: 410.425075ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:29:21.172722Z","caller":"traceutil/trace.go:171","msg":"trace[598146212] range","detail":"{range_begin:/registry/events/openstack/percona-xtradb-haproxy-0.18cd4edc7b724076; range_end:; response_count:1; response_revision:2158; }","duration":"166.535388ms","start":"2026-08-19T20:29:21.006166Z","end":"2026-08-19T20:29:21.172702Z","steps":["trace[598146212] 'agreement among raft nodes before linearized reading'  (duration: 166.346254ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:29:21.172669Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:29:20.75838Z","time spent":"414.272938ms","remote":"127.0.0.1:55128","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-08-19T20:29:21.17275Z","caller":"traceutil/trace.go:171","msg":"trace[219863543] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2158; }","duration":"409.628055ms","start":"2026-08-19T20:29:20.763105Z","end":"2026-08-19T20:29:21.172733Z","steps":["trace[219863543] 'agreement among raft nodes before linearized reading'  (duration: 409.460831ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:29:21.17276Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:29:20.761963Z","time spent":"410.787094ms","remote":"127.0.0.1:56262","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5434,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "}
{"level":"warn","ts":"2026-08-19T20:29:21.172795Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:29:20.763095Z","time spent":"409.691627ms","remote":"127.0.0.1:55128","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-08-19T20:29:21.172814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"409.593654ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-08-19T20:29:21.172923Z","caller":"traceutil/trace.go:171","msg":"trace[1185952332] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2158; }","duration":"409.741228ms","start":"2026-08-19T20:29:20.763157Z","end":"2026-08-19T20:29:21.172898Z","steps":["trace[1185952332] 'agreement among raft nodes before linearized reading'  (duration: 409.39029ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:29:21.173015Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:29:20.763151Z","time spent":"409.852631ms","remote":"127.0.0.1:55128","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-08-19T20:30:12.476276Z","caller":"traceutil/trace.go:171","msg":"trace[1021257797] transaction","detail":"{read_only:false; response_revision:2608; number_of_response:1; }","duration":"164.09911ms","start":"2026-08-19T20:30:12.312149Z","end":"2026-08-19T20:30:12.476248Z","steps":["trace[1021257797] 'process raft request'  (duration: 163.909805ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:30:12.519526Z","caller":"traceutil/trace.go:171","msg":"trace[558455438] transaction","detail":"{read_only:false; response_revision:2609; number_of_response:1; }","duration":"205.275379ms","start":"2026-08-19T20:30:12.314213Z","end":"2026-08-19T20:30:12.519489Z","steps":["trace[558455438] 'process raft request'  (duration: 190.134322ms)","trace[558455438] 'compare'  (duration: 14.929711ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-19T20:30:17.034031Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13360948760368241532,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-08-19T20:30:17.535102Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13360948760368241532,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-08-19T20:30:18.036057Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13360948760368241532,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-08-19T20:30:18.537233Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13360948760368241532,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-08-19T20:30:18.82255Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.326477486s","expected-duration":"1s"}
{"level":"info","ts":"2026-08-19T20:30:18.823246Z","caller":"traceutil/trace.go:171","msg":"trace[156096426] transaction","detail":"{read_only:false; response_revision:2629; number_of_response:1; }","duration":"2.327255645s","start":"2026-08-19T20:30:16.495953Z","end":"2026-08-19T20:30:18.823208Z","steps":["trace[156096426] 'process raft request'  (duration: 2.326927057s)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:30:18.823499Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:30:16.49594Z","time spent":"2.327430609s","remote":"127.0.0.1:55128","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:2619 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-08-19T20:30:18.825908Z","caller":"traceutil/trace.go:171","msg":"trace[1578608894] transaction","detail":"{read_only:false; response_revision:2631; number_of_response:1; }","duration":"1.43650203s","start":"2026-08-19T20:30:17.389379Z","end":"2026-08-19T20:30:18.825881Z","steps":["trace[1578608894] 'process raft request'  (duration: 1.436422908s)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:30:18.825971Z","caller":"traceutil/trace.go:171","msg":"trace[28629991] transaction","detail":"{read_only:false; response_revision:2630; number_of_response:1; }","duration":"2.058772954s","start":"2026-08-19T20:30:16.767166Z","end":"2026-08-19T20:30:18.825939Z","steps":["trace[28629991] 'process raft request'  (duration: 2.058475306s)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:30:18.826079Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:30:17.389359Z","time spent":"1.436609043s","remote":"127.0.0.1:55128","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:2622 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:458 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"warn","ts":"2026-08-19T20:30:18.826108Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:30:16.767133Z","time spent":"2.058908887s","remote":"127.0.0.1:55128","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:2621 > 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":"info","ts":"2026-08-19T20:30:18.826334Z","caller":"traceutil/trace.go:171","msg":"trace[1407167517] transaction","detail":"{read_only:false; response_revision:2632; number_of_response:1; }","duration":"1.434295968s","start":"2026-08-19T20:30:17.391996Z","end":"2026-08-19T20:30:18.826292Z","steps":["trace[1407167517] 'process raft request'  (duration: 1.433839846s)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:30:18.826431Z","caller":"traceutil/trace.go:171","msg":"trace[707749984] transaction","detail":"{read_only:false; response_revision:2634; number_of_response:1; }","duration":"1.247613461s","start":"2026-08-19T20:30:17.578787Z","end":"2026-08-19T20:30:18.8264Z","steps":["trace[707749984] 'process raft request'  (duration: 1.247527548s)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:30:18.826504Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:30:17.391983Z","time spent":"1.434433831s","remote":"127.0.0.1:55128","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:2623 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:478 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-08-19T20:30:18.82661Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:30:17.578755Z","time spent":"1.247756594s","remote":"127.0.0.1:55128","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:2627 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"info","ts":"2026-08-19T20:30:18.826636Z","caller":"traceutil/trace.go:171","msg":"trace[1898503377] transaction","detail":"{read_only:false; response_revision:2633; number_of_response:1; }","duration":"1.325327535s","start":"2026-08-19T20:30:17.501298Z","end":"2026-08-19T20:30:18.826626Z","steps":["trace[1898503377] 'process raft request'  (duration: 1.324865243s)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:30:18.826677Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:30:17.501279Z","time spent":"1.325375686s","remote":"127.0.0.1:55128","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":515,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/cert-manager/cert-manager-controller\" mod_revision:2494 > success:<request_put:<key:\"/registry/leases/cert-manager/cert-manager-controller\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/cert-manager/cert-manager-controller\" > >"}
{"level":"info","ts":"2026-08-19T20:30:18.826706Z","caller":"traceutil/trace.go:171","msg":"trace[301483810] linearizableReadLoop","detail":"{readStateIndex:2735; appliedIndex:2729; }","duration":"2.293453876s","start":"2026-08-19T20:30:16.533231Z","end":"2026-08-19T20:30:18.826685Z","steps":["trace[301483810] 'read index received'  (duration: 2.289693004s)","trace[301483810] 'applied index is now lower than readState.Index'  (duration: 3.759292ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-19T20:30:18.827217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.293963508s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-08-19T20:30:18.827291Z","caller":"traceutil/trace.go:171","msg":"trace[748467834] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2635; }","duration":"2.294120902s","start":"2026-08-19T20:30:16.533153Z","end":"2026-08-19T20:30:18.827274Z","steps":["trace[748467834] 'agreement among raft nodes before linearized reading'  (duration: 2.293702892s)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:30:18.827349Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:30:16.533124Z","time spent":"2.294212124s","remote":"127.0.0.1:55128","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-08-19T20:30:18.827649Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.083013192s","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-08-19T20:30:18.827723Z","caller":"traceutil/trace.go:171","msg":"trace[1084994111] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2635; }","duration":"2.083137685s","start":"2026-08-19T20:30:16.744569Z","end":"2026-08-19T20:30:18.827707Z","steps":["trace[1084994111] 'agreement among raft nodes before linearized reading'  (duration: 2.08293789s)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:30:18.82776Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:30:16.744545Z","time spent":"2.083208427s","remote":"127.0.0.1:55052","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":1391,"request content":"key:\"/registry/services/specs/auth-system/keycloak-headless\" "}
{"level":"warn","ts":"2026-08-19T20:30:18.827785Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"750.360769ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-19T20:30:18.82787Z","caller":"traceutil/trace.go:171","msg":"trace[1847631594] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2635; }","duration":"750.499793ms","start":"2026-08-19T20:30:18.077358Z","end":"2026-08-19T20:30:18.827858Z","steps":["trace[1847631594] 'agreement among raft nodes before linearized reading'  (duration: 750.384351ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:30:18.827865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.296606098s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"warn","ts":"2026-08-19T20:30:18.827961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.596400319s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-08-19T20:30:18.827981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"714.558091ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-19T20:30:18.827999Z","caller":"traceutil/trace.go:171","msg":"trace[430560504] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2635; }","duration":"1.296808773s","start":"2026-08-19T20:30:17.531161Z","end":"2026-08-19T20:30:18.82797Z","steps":["trace[430560504] 'agreement among raft nodes before linearized reading'  (duration: 1.296413664s)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:30:18.828059Z","caller":"traceutil/trace.go:171","msg":"trace[1749418088] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:2635; }","duration":"714.673873ms","start":"2026-08-19T20:30:18.113359Z","end":"2026-08-19T20:30:18.828033Z","steps":["trace[1749418088] 'agreement among raft nodes before linearized reading'  (duration: 714.577151ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:30:18.828111Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:30:18.113336Z","time spent":"714.765186ms","remote":"127.0.0.1:54952","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":27,"request content":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true "}
{"level":"warn","ts":"2026-08-19T20:30:18.82822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"892.785663ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-19T20:30:18.828262Z","caller":"traceutil/trace.go:171","msg":"trace[1075971875] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:2635; }","duration":"892.864466ms","start":"2026-08-19T20:30:17.935387Z","end":"2026-08-19T20:30:18.828252Z","steps":["trace[1075971875] 'agreement among raft nodes before linearized reading'  (duration: 892.736983ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:30:18.828293Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:30:17.935366Z","time spent":"892.918487ms","remote":"127.0.0.1:41466","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true "}
{"level":"info","ts":"2026-08-19T20:30:18.828037Z","caller":"traceutil/trace.go:171","msg":"trace[1640108127] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2635; }","duration":"1.596525262s","start":"2026-08-19T20:30:17.231494Z","end":"2026-08-19T20:30:18.828019Z","steps":["trace[1640108127] 'agreement among raft nodes before linearized reading'  (duration: 1.596416359s)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:30:18.828099Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:30:17.531135Z","time spent":"1.296946487s","remote":"127.0.0.1:55128","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-08-19T20:30:18.828374Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:30:17.231462Z","time spent":"1.596894921s","remote":"127.0.0.1:54860","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-08-19T20:30:18.82792Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:30:18.077329Z","time spent":"750.583605ms","remote":"127.0.0.1:54870","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-08-19T20:30:18.827985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.801167396s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"}
{"level":"warn","ts":"2026-08-19T20:30:18.828693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.303253129s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"warn","ts":"2026-08-19T20:30:18.828277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.296111585s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-08-19T20:30:18.828768Z","caller":"traceutil/trace.go:171","msg":"trace[565144646] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2635; }","duration":"1.296599297s","start":"2026-08-19T20:30:17.532154Z","end":"2026-08-19T20:30:18.828753Z","steps":["trace[565144646] 'agreement among raft nodes before linearized reading'  (duration: 1.295980742s)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:30:18.828679Z","caller":"traceutil/trace.go:171","msg":"trace[650406009] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2635; }","duration":"1.801900463s","start":"2026-08-19T20:30:17.026759Z","end":"2026-08-19T20:30:18.828659Z","steps":["trace[650406009] 'agreement among raft nodes before linearized reading'  (duration: 1.801153446s)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:30:18.828849Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:30:17.532129Z","time spent":"1.296673689s","remote":"127.0.0.1:55128","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-08-19T20:30:18.828825Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:30:17.026734Z","time spent":"1.802077077s","remote":"127.0.0.1:55042","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12238,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "}
{"level":"info","ts":"2026-08-19T20:30:18.828723Z","caller":"traceutil/trace.go:171","msg":"trace[1592335621] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2635; }","duration":"1.3033022s","start":"2026-08-19T20:30:17.525414Z","end":"2026-08-19T20:30:18.828716Z","steps":["trace[1592335621] 'agreement among raft nodes before linearized reading'  (duration: 1.303231578s)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:30:18.82908Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:30:17.525403Z","time spent":"1.303638369s","remote":"127.0.0.1:55128","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-08-19T20:30:18.828619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.492104609s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-19T20:30:18.829164Z","caller":"traceutil/trace.go:171","msg":"trace[1258677738] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:2635; }","duration":"1.492670543s","start":"2026-08-19T20:30:17.336484Z","end":"2026-08-19T20:30:18.829155Z","steps":["trace[1258677738] 'agreement among raft nodes before linearized reading'  (duration: 1.492103849s)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:30:18.829192Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:30:17.336473Z","time spent":"1.492709634s","remote":"127.0.0.1:59624","response type":"/etcdserverpb.KV/Range","request count":0,"request size":112,"response count":0,"response size":27,"request content":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true "}
{"level":"info","ts":"2026-08-19T20:30:19.184733Z","caller":"traceutil/trace.go:171","msg":"trace[1838646895] linearizableReadLoop","detail":"{readStateIndex:2741; appliedIndex:2740; }","duration":"276.389123ms","start":"2026-08-19T20:30:18.908308Z","end":"2026-08-19T20:30:19.184697Z","steps":["trace[1838646895] 'read index received'  (duration: 276.196478ms)","trace[1838646895] 'applied index is now lower than readState.Index'  (duration: 191.535µs)"],"step_count":2}
{"level":"info","ts":"2026-08-19T20:30:19.184788Z","caller":"traceutil/trace.go:171","msg":"trace[24705282] transaction","detail":"{read_only:false; response_revision:2640; number_of_response:1; }","duration":"325.831853ms","start":"2026-08-19T20:30:18.858909Z","end":"2026-08-19T20:30:19.184741Z","steps":["trace[24705282] 'process raft request'  (duration: 325.613708ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:30:19.18499Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:30:18.858876Z","time spent":"326.021888ms","remote":"127.0.0.1:54942","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":779,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/events/auth-system/keycloak-0.18cd4eefc590a808\" mod_revision:0 > success:<request_put:<key:\"/registry/events/auth-system/keycloak-0.18cd4eefc590a808\" value_size:705 lease:4137576723513464699 >> failure:<>"}
{"level":"warn","ts":"2026-08-19T20:30:19.185034Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.696001ms","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-08-19T20:30:19.185098Z","caller":"traceutil/trace.go:171","msg":"trace[1234231444] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:2640; }","duration":"276.832974ms","start":"2026-08-19T20:30:18.908248Z","end":"2026-08-19T20:30:19.185081Z","steps":["trace[1234231444] 'agreement among raft nodes before linearized reading'  (duration: 276.571028ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:30:21.072748Z","caller":"traceutil/trace.go:171","msg":"trace[2027067597] transaction","detail":"{read_only:false; response_revision:2644; number_of_response:1; }","duration":"277.629653ms","start":"2026-08-19T20:30:20.795092Z","end":"2026-08-19T20:30:21.072721Z","steps":["trace[2027067597] 'process raft request'  (duration: 277.48595ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:30:21.073051Z","caller":"traceutil/trace.go:171","msg":"trace[142493043] linearizableReadLoop","detail":"{readStateIndex:2745; appliedIndex:2745; }","duration":"244.511191ms","start":"2026-08-19T20:30:20.82853Z","end":"2026-08-19T20:30:21.073041Z","steps":["trace[142493043] 'read index received'  (duration: 244.506721ms)","trace[142493043] 'applied index is now lower than readState.Index'  (duration: 3.53µs)"],"step_count":2}
{"level":"warn","ts":"2026-08-19T20:30:21.073438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.846889ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-08-19T20:30:21.073574Z","caller":"traceutil/trace.go:171","msg":"trace[1297783068] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2644; }","duration":"245.040374ms","start":"2026-08-19T20:30:20.828502Z","end":"2026-08-19T20:30:21.073543Z","steps":["trace[1297783068] 'agreement among raft nodes before linearized reading'  (duration: 244.612604ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:30:21.081191Z","caller":"traceutil/trace.go:171","msg":"trace[583460137] transaction","detail":"{read_only:false; response_revision:2648; number_of_response:1; }","duration":"248.426205ms","start":"2026-08-19T20:30:20.832743Z","end":"2026-08-19T20:30:21.081169Z","steps":["trace[583460137] 'process raft request'  (duration: 248.359964ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:30:21.081372Z","caller":"traceutil/trace.go:171","msg":"trace[13331838] transaction","detail":"{read_only:false; response_revision:2645; number_of_response:1; }","duration":"249.936583ms","start":"2026-08-19T20:30:20.831419Z","end":"2026-08-19T20:30:21.081356Z","steps":["trace[13331838] 'process raft request'  (duration: 248.337753ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:30:21.081427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.051302ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-08-19T20:30:21.081858Z","caller":"traceutil/trace.go:171","msg":"trace[361515831] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2648; }","duration":"242.500302ms","start":"2026-08-19T20:30:20.839342Z","end":"2026-08-19T20:30:21.081842Z","steps":["trace[361515831] 'agreement among raft nodes before linearized reading'  (duration: 241.990469ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:30:21.081442Z","caller":"traceutil/trace.go:171","msg":"trace[2080830267] transaction","detail":"{read_only:false; response_revision:2646; number_of_response:1; }","duration":"249.799559ms","start":"2026-08-19T20:30:20.831628Z","end":"2026-08-19T20:30:21.081428Z","steps":["trace[2080830267] 'process raft request'  (duration: 249.389979ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:30:21.081498Z","caller":"traceutil/trace.go:171","msg":"trace[1162882843] transaction","detail":"{read_only:false; response_revision:2647; number_of_response:1; }","duration":"249.244055ms","start":"2026-08-19T20:30:20.832246Z","end":"2026-08-19T20:30:21.08149Z","steps":["trace[1162882843] 'process raft request'  (duration: 248.823064ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:30:21.081492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.418307ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-08-19T20:30:21.082014Z","caller":"traceutil/trace.go:171","msg":"trace[547477612] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2648; }","duration":"241.98952ms","start":"2026-08-19T20:30:20.840008Z","end":"2026-08-19T20:30:21.081998Z","steps":["trace[547477612] 'agreement among raft nodes before linearized reading'  (duration: 241.277122ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:30:21.081589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.30003ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-08-19T20:30:21.08214Z","caller":"traceutil/trace.go:171","msg":"trace[1036479637] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2648; }","duration":"238.871143ms","start":"2026-08-19T20:30:20.843259Z","end":"2026-08-19T20:30:21.08213Z","steps":["trace[1036479637] 'agreement among raft nodes before linearized reading'  (duration: 238.264399ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:34:54.687482Z","caller":"traceutil/trace.go:171","msg":"trace[1090572339] transaction","detail":"{read_only:false; response_revision:4934; number_of_response:1; }","duration":"100.357106ms","start":"2026-08-19T20:34:54.587086Z","end":"2026-08-19T20:34:54.687443Z","steps":["trace[1090572339] 'process raft request'  (duration: 100.020468ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:34:57.928028Z","caller":"traceutil/trace.go:171","msg":"trace[1149381025] linearizableReadLoop","detail":"{readStateIndex:5243; appliedIndex:5242; }","duration":"173.419899ms","start":"2026-08-19T20:34:57.754584Z","end":"2026-08-19T20:34:57.928004Z","steps":["trace[1149381025] 'read index received'  (duration: 172.883126ms)","trace[1149381025] 'applied index is now lower than readState.Index'  (duration: 535.333µs)"],"step_count":2}
{"level":"info","ts":"2026-08-19T20:34:57.928138Z","caller":"traceutil/trace.go:171","msg":"trace[1023675682] transaction","detail":"{read_only:false; response_revision:5051; number_of_response:1; }","duration":"194.425692ms","start":"2026-08-19T20:34:57.733677Z","end":"2026-08-19T20:34:57.928103Z","steps":["trace[1023675682] 'process raft request'  (duration: 193.885819ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:34:57.928879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.258318ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:24 size:728947"}
{"level":"info","ts":"2026-08-19T20:34:57.929041Z","caller":"traceutil/trace.go:171","msg":"trace[1063213733] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:24; response_revision:5051; }","duration":"174.479214ms","start":"2026-08-19T20:34:57.754534Z","end":"2026-08-19T20:34:57.929013Z","steps":["trace[1063213733] 'agreement among raft nodes before linearized reading'  (duration: 173.608153ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:35:01.498359Z","caller":"traceutil/trace.go:171","msg":"trace[245262235] transaction","detail":"{read_only:false; response_revision:5127; number_of_response:1; }","duration":"109.357272ms","start":"2026-08-19T20:35:01.388969Z","end":"2026-08-19T20:35:01.498326Z","steps":["trace[245262235] 'process raft request'  (duration: 109.143297ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:35:11.109794Z","caller":"traceutil/trace.go:171","msg":"trace[1949546701] linearizableReadLoop","detail":"{readStateIndex:5521; appliedIndex:5520; }","duration":"115.575811ms","start":"2026-08-19T20:35:10.994195Z","end":"2026-08-19T20:35:11.109771Z","steps":["trace[1949546701] 'read index received'  (duration: 115.331036ms)","trace[1949546701] 'applied index is now lower than readState.Index'  (duration: 244.065µs)"],"step_count":2}
{"level":"info","ts":"2026-08-19T20:35:11.109893Z","caller":"traceutil/trace.go:171","msg":"trace[239023571] transaction","detail":"{read_only:false; response_revision:5320; number_of_response:1; }","duration":"116.249417ms","start":"2026-08-19T20:35:10.993634Z","end":"2026-08-19T20:35:11.109884Z","steps":["trace[239023571] 'process raft request'  (duration: 115.985601ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:35:11.110234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.028322ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:16906"}
{"level":"info","ts":"2026-08-19T20:35:11.110274Z","caller":"traceutil/trace.go:171","msg":"trace[1970385063] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:5320; }","duration":"116.113414ms","start":"2026-08-19T20:35:10.994153Z","end":"2026-08-19T20:35:11.110266Z","steps":["trace[1970385063] 'agreement among raft nodes before linearized reading'  (duration: 115.896969ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:35:11.727517Z","caller":"traceutil/trace.go:171","msg":"trace[1907117105] transaction","detail":"{read_only:false; response_revision:5324; number_of_response:1; }","duration":"219.599816ms","start":"2026-08-19T20:35:11.507892Z","end":"2026-08-19T20:35:11.727491Z","steps":["trace[1907117105] 'process raft request'  (duration: 219.422152ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:35:11.729278Z","caller":"traceutil/trace.go:171","msg":"trace[1373521297] transaction","detail":"{read_only:false; response_revision:5325; number_of_response:1; }","duration":"201.4214ms","start":"2026-08-19T20:35:11.527824Z","end":"2026-08-19T20:35:11.729246Z","steps":["trace[1373521297] 'process raft request'  (duration: 200.808216ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:35:19.786998Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.398462ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13360948760368248406 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/endpointslices/monitoring/loki-6sb7p\" mod_revision:4969 > success:<request_put:<key:\"/registry/endpointslices/monitoring/loki-6sb7p\" value_size:1340 >> failure:<request_range:<key:\"/registry/endpointslices/monitoring/loki-6sb7p\" > >>","response":"size:16"}
{"level":"info","ts":"2026-08-19T20:35:19.787204Z","caller":"traceutil/trace.go:171","msg":"trace[357863018] transaction","detail":"{read_only:false; response_revision:5496; number_of_response:1; }","duration":"179.973506ms","start":"2026-08-19T20:35:19.607205Z","end":"2026-08-19T20:35:19.787179Z","steps":["trace[357863018] 'process raft request'  (duration: 15.293087ms)","trace[357863018] 'compare'  (duration: 164.113136ms)"],"step_count":2}
{"level":"info","ts":"2026-08-19T20:35:19.787373Z","caller":"traceutil/trace.go:171","msg":"trace[153356527] transaction","detail":"{read_only:false; response_revision:5498; number_of_response:1; }","duration":"177.915167ms","start":"2026-08-19T20:35:19.609435Z","end":"2026-08-19T20:35:19.78735Z","steps":["trace[153356527] 'process raft request'  (duration: 177.827715ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:35:19.787383Z","caller":"traceutil/trace.go:171","msg":"trace[7104324] transaction","detail":"{read_only:false; response_revision:5497; number_of_response:1; }","duration":"178.003629ms","start":"2026-08-19T20:35:19.609345Z","end":"2026-08-19T20:35:19.787349Z","steps":["trace[7104324] 'process raft request'  (duration: 177.801534ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:35:19.787598Z","caller":"traceutil/trace.go:171","msg":"trace[406213316] transaction","detail":"{read_only:false; response_revision:5500; number_of_response:1; }","duration":"176.135594ms","start":"2026-08-19T20:35:19.61144Z","end":"2026-08-19T20:35:19.787575Z","steps":["trace[406213316] 'process raft request'  (duration: 176.014361ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:35:19.787667Z","caller":"traceutil/trace.go:171","msg":"trace[2001686409] transaction","detail":"{read_only:false; response_revision:5501; number_of_response:1; }","duration":"176.096073ms","start":"2026-08-19T20:35:19.611552Z","end":"2026-08-19T20:35:19.787648Z","steps":["trace[2001686409] 'process raft request'  (duration: 175.986471ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:35:19.787593Z","caller":"traceutil/trace.go:171","msg":"trace[228621220] transaction","detail":"{read_only:false; response_revision:5499; number_of_response:1; }","duration":"178.092061ms","start":"2026-08-19T20:35:19.60944Z","end":"2026-08-19T20:35:19.787532Z","steps":["trace[228621220] 'process raft request'  (duration: 177.870735ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:35:20.49627Z","caller":"traceutil/trace.go:171","msg":"trace[49521552] linearizableReadLoop","detail":"{readStateIndex:5708; appliedIndex:5707; }","duration":"191.680067ms","start":"2026-08-19T20:35:20.304561Z","end":"2026-08-19T20:35:20.496241Z","steps":["trace[49521552] 'read index received'  (duration: 191.528883ms)","trace[49521552] 'applied index is now lower than readState.Index'  (duration: 149.994µs)"],"step_count":2}
{"level":"info","ts":"2026-08-19T20:35:20.496397Z","caller":"traceutil/trace.go:171","msg":"trace[853441944] transaction","detail":"{read_only:false; response_revision:5502; number_of_response:1; }","duration":"413.143578ms","start":"2026-08-19T20:35:20.083217Z","end":"2026-08-19T20:35:20.49636Z","steps":["trace[853441944] 'process raft request'  (duration: 412.8181ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:35:20.496507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.941213ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-vctpg\" ","response":"range_response_count:1 size:6531"}
{"level":"info","ts":"2026-08-19T20:35:20.496555Z","caller":"traceutil/trace.go:171","msg":"trace[789816643] range","detail":"{range_begin:/registry/pods/openstack/keepalived-vctpg; range_end:; response_count:1; response_revision:5502; }","duration":"192.041516ms","start":"2026-08-19T20:35:20.304501Z","end":"2026-08-19T20:35:20.496543Z","steps":["trace[789816643] 'agreement among raft nodes before linearized reading'  (duration: 191.865062ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:35:20.496571Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:35:20.08318Z","time spent":"413.302662ms","remote":"127.0.0.1:55030","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":19075,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/minions/instance\" mod_revision:4811 > success:<request_put:<key:\"/registry/minions/instance\" value_size:19039 >> failure:<request_range:<key:\"/registry/minions/instance\" > >"}
{"level":"warn","ts":"2026-08-19T20:35:21.11124Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.706664ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-19T20:35:21.111378Z","caller":"traceutil/trace.go:171","msg":"trace[449474590] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:5502; }","duration":"208.862828ms","start":"2026-08-19T20:35:20.902498Z","end":"2026-08-19T20:35:21.11136Z","steps":["trace[449474590] 'range keys from in-memory index tree'  (duration: 208.687454ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:35:21.111819Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"333.359354ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13360948760368248414 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:5422 > 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\" > >>","response":"size:16"}
{"level":"info","ts":"2026-08-19T20:35:21.112029Z","caller":"traceutil/trace.go:171","msg":"trace[1927094410] linearizableReadLoop","detail":"{readStateIndex:5712; appliedIndex:5708; }","duration":"610.053128ms","start":"2026-08-19T20:35:20.501963Z","end":"2026-08-19T20:35:21.112017Z","steps":["trace[1927094410] 'read index received'  (duration: 276.411688ms)","trace[1927094410] 'applied index is now lower than readState.Index'  (duration: 333.64045ms)"],"step_count":2}
{"level":"info","ts":"2026-08-19T20:35:21.112334Z","caller":"traceutil/trace.go:171","msg":"trace[711047959] transaction","detail":"{read_only:false; response_revision:5503; number_of_response:1; }","duration":"780.582247ms","start":"2026-08-19T20:35:20.33173Z","end":"2026-08-19T20:35:21.112313Z","steps":["trace[711047959] 'process raft request'  (duration: 446.651771ms)","trace[711047959] 'compare'  (duration: 333.24177ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-19T20:35:21.112432Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:35:20.331699Z","time spent":"780.68904ms","remote":"127.0.0.1:55128","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:5422 > 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":"info","ts":"2026-08-19T20:35:21.112517Z","caller":"traceutil/trace.go:171","msg":"trace[360886602] transaction","detail":"{read_only:false; response_revision:5506; number_of_response:1; }","duration":"728.185621ms","start":"2026-08-19T20:35:20.384298Z","end":"2026-08-19T20:35:21.112483Z","steps":["trace[360886602] 'process raft request'  (duration: 727.678569ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:35:21.112556Z","caller":"traceutil/trace.go:171","msg":"trace[246934144] transaction","detail":"{read_only:false; response_revision:5504; number_of_response:1; }","duration":"763.008896ms","start":"2026-08-19T20:35:20.349515Z","end":"2026-08-19T20:35:21.112523Z","steps":["trace[246934144] 'process raft request'  (duration: 762.380072ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:35:21.112633Z","caller":"traceutil/trace.go:171","msg":"trace[1736433221] transaction","detail":"{read_only:false; response_revision:5505; number_of_response:1; }","duration":"732.437833ms","start":"2026-08-19T20:35:20.380154Z","end":"2026-08-19T20:35:21.112592Z","steps":["trace[1736433221] 'process raft request'  (duration: 731.788568ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:35:21.112667Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:35:20.384266Z","time spent":"728.315964ms","remote":"127.0.0.1:55128","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:5426 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:478 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-08-19T20:35:21.112698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.254355ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/persistence-rabbitmq-keystone-server-0.18cd4f3598c0a0db\" ","response":"range_response_count:1 size:1012"}
{"level":"warn","ts":"2026-08-19T20:35:21.112714Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:35:20.34942Z","time spent":"763.211491ms","remote":"127.0.0.1:55128","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:5423 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"warn","ts":"2026-08-19T20:35:21.112737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.480401ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"}
{"level":"warn","ts":"2026-08-19T20:35:21.112738Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.557039ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"}
{"level":"warn","ts":"2026-08-19T20:35:21.112787Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:35:20.380125Z","time spent":"732.584347ms","remote":"127.0.0.1:55128","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:5425 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:458 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"info","ts":"2026-08-19T20:35:21.112859Z","caller":"traceutil/trace.go:171","msg":"trace[1992218871] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5506; }","duration":"304.637935ms","start":"2026-08-19T20:35:20.808199Z","end":"2026-08-19T20:35:21.112837Z","steps":["trace[1992218871] 'agreement among raft nodes before linearized reading'  (duration: 304.344878ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:35:21.112576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"505.158983ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/storage-loki-0\" ","response":"range_response_count:1 size:1781"}
{"level":"info","ts":"2026-08-19T20:35:21.112863Z","caller":"traceutil/trace.go:171","msg":"trace[1970563123] range","detail":"{range_begin:/registry/events/openstack/persistence-rabbitmq-keystone-server-0.18cd4f3598c0a0db; range_end:; response_count:1; response_revision:5506; }","duration":"148.347157ms","start":"2026-08-19T20:35:20.964416Z","end":"2026-08-19T20:35:21.112763Z","steps":["trace[1970563123] 'agreement among raft nodes before linearized reading'  (duration: 148.03859ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:35:21.112873Z","caller":"traceutil/trace.go:171","msg":"trace[2089302053] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5506; }","duration":"303.719142ms","start":"2026-08-19T20:35:20.809131Z","end":"2026-08-19T20:35:21.11285Z","steps":["trace[2089302053] 'agreement among raft nodes before linearized reading'  (duration: 303.460066ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:35:21.11294Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:35:20.808177Z","time spent":"304.748098ms","remote":"127.0.0.1:55128","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-08-19T20:35:21.11295Z","caller":"traceutil/trace.go:171","msg":"trace[1329680274] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/storage-loki-0; range_end:; response_count:1; response_revision:5506; }","duration":"505.587593ms","start":"2026-08-19T20:35:20.607349Z","end":"2026-08-19T20:35:21.112936Z","steps":["trace[1329680274] 'agreement among raft nodes before linearized reading'  (duration: 505.03882ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:35:21.112959Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:35:20.809115Z","time spent":"303.834245ms","remote":"127.0.0.1:55128","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-08-19T20:35:21.11299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"471.038665ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"}
{"level":"warn","ts":"2026-08-19T20:35:21.113002Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:35:20.607329Z","time spent":"505.659694ms","remote":"127.0.0.1:55010","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":1803,"request content":"key:\"/registry/persistentvolumeclaims/monitoring/storage-loki-0\" "}
{"level":"warn","ts":"2026-08-19T20:35:21.112859Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"320.156727ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-cf0cea5d-4d2f-46b5-951d-d1f72206bef3\" ","response":"range_response_count:1 size:3763"}
{"level":"info","ts":"2026-08-19T20:35:21.113051Z","caller":"traceutil/trace.go:171","msg":"trace[1160123672] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5506; }","duration":"471.090216ms","start":"2026-08-19T20:35:20.641942Z","end":"2026-08-19T20:35:21.113032Z","steps":["trace[1160123672] 'agreement among raft nodes before linearized reading'  (duration: 470.972854ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:35:21.113078Z","caller":"traceutil/trace.go:171","msg":"trace[1580541272] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-cf0cea5d-4d2f-46b5-951d-d1f72206bef3; range_end:; response_count:1; response_revision:5506; }","duration":"320.474814ms","start":"2026-08-19T20:35:20.792583Z","end":"2026-08-19T20:35:21.113058Z","steps":["trace[1580541272] 'agreement among raft nodes before linearized reading'  (duration: 320.117186ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:35:21.113092Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:35:20.641915Z","time spent":"471.168628ms","remote":"127.0.0.1:55128","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-08-19T20:35:21.113142Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:35:20.792557Z","time spent":"320.568307ms","remote":"127.0.0.1:55042","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3785,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-cf0cea5d-4d2f-46b5-951d-d1f72206bef3\" "}
{"level":"warn","ts":"2026-08-19T20:35:21.113139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"422.243356ms","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-08-19T20:35:21.113259Z","caller":"traceutil/trace.go:171","msg":"trace[1562280719] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5506; }","duration":"422.4711ms","start":"2026-08-19T20:35:20.690762Z","end":"2026-08-19T20:35:21.113234Z","steps":["trace[1562280719] 'agreement among raft nodes before linearized reading'  (duration: 421.984089ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:35:21.113372Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:35:20.69074Z","time spent":"422.596084ms","remote":"127.0.0.1:55128","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-08-19T20:35:21.113518Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.760368ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"}
{"level":"info","ts":"2026-08-19T20:35:21.113639Z","caller":"traceutil/trace.go:171","msg":"trace[2108746435] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5506; }","duration":"304.880831ms","start":"2026-08-19T20:35:20.808737Z","end":"2026-08-19T20:35:21.113618Z","steps":["trace[2108746435] 'agreement among raft nodes before linearized reading'  (duration: 303.919679ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:35:21.114378Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:35:20.808675Z","time spent":"305.68299ms","remote":"127.0.0.1:55128","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-08-19T20:35:21.113771Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"611.804089ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:9 size:80213"}
{"level":"info","ts":"2026-08-19T20:35:21.114615Z","caller":"traceutil/trace.go:171","msg":"trace[153565450] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:9; response_revision:5506; }","duration":"612.680341ms","start":"2026-08-19T20:35:20.501916Z","end":"2026-08-19T20:35:21.114597Z","steps":["trace[153565450] 'agreement among raft nodes before linearized reading'  (duration: 610.597321ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:35:21.11469Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:35:20.501895Z","time spent":"612.778834ms","remote":"127.0.0.1:55042","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":9,"response size":80235,"request content":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" "}
{"level":"info","ts":"2026-08-19T20:35:21.239273Z","caller":"traceutil/trace.go:171","msg":"trace[3856562] transaction","detail":"{read_only:false; response_revision:5507; number_of_response:1; }","duration":"123.548673ms","start":"2026-08-19T20:35:21.115693Z","end":"2026-08-19T20:35:21.239242Z","steps":["trace[3856562] 'process raft request'  (duration: 117.043597ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:35:21.239465Z","caller":"traceutil/trace.go:171","msg":"trace[730832064] linearizableReadLoop","detail":"{readStateIndex:5713; appliedIndex:5712; }","duration":"123.685045ms","start":"2026-08-19T20:35:21.115753Z","end":"2026-08-19T20:35:21.239438Z","steps":["trace[730832064] 'read index received'  (duration: 119.362µs)","trace[730832064] 'applied index is now lower than readState.Index'  (duration: 123.563803ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-19T20:35:21.239679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.901941ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-19T20:35:21.239703Z","caller":"traceutil/trace.go:171","msg":"trace[1092949569] transaction","detail":"{read_only:false; response_revision:5509; number_of_response:1; }","duration":"121.244737ms","start":"2026-08-19T20:35:21.118441Z","end":"2026-08-19T20:35:21.239686Z","steps":["trace[1092949569] 'process raft request'  (duration: 120.96069ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:35:21.23974Z","caller":"traceutil/trace.go:171","msg":"trace[939650694] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5510; }","duration":"123.999543ms","start":"2026-08-19T20:35:21.115725Z","end":"2026-08-19T20:35:21.239725Z","steps":["trace[939650694] 'agreement among raft nodes before linearized reading'  (duration: 123.85803ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:35:21.239812Z","caller":"traceutil/trace.go:171","msg":"trace[981463851] transaction","detail":"{read_only:false; response_revision:5508; number_of_response:1; }","duration":"121.446662ms","start":"2026-08-19T20:35:21.118352Z","end":"2026-08-19T20:35:21.239799Z","steps":["trace[981463851] 'process raft request'  (duration: 120.823547ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:35:21.239911Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.691821ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-0fe9ece3-a158-4e21-be6f-9bc6595beaf0\" ","response":"range_response_count:1 size:1275"}
{"level":"info","ts":"2026-08-19T20:35:21.239982Z","caller":"traceutil/trace.go:171","msg":"trace[1715435668] range","detail":"{range_begin:/registry/persistentvolumes/pvc-0fe9ece3-a158-4e21-be6f-9bc6595beaf0; range_end:; response_count:1; response_revision:5512; }","duration":"122.794085ms","start":"2026-08-19T20:35:21.11717Z","end":"2026-08-19T20:35:21.239964Z","steps":["trace[1715435668] 'agreement among raft nodes before linearized reading'  (duration: 122.564139ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:35:21.240207Z","caller":"traceutil/trace.go:171","msg":"trace[1724664480] transaction","detail":"{read_only:false; response_revision:5511; number_of_response:1; }","duration":"121.492333ms","start":"2026-08-19T20:35:21.118684Z","end":"2026-08-19T20:35:21.240176Z","steps":["trace[1724664480] 'process raft request'  (duration: 120.9359ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:35:21.240235Z","caller":"traceutil/trace.go:171","msg":"trace[277725511] transaction","detail":"{read_only:false; response_revision:5510; number_of_response:1; }","duration":"121.761109ms","start":"2026-08-19T20:35:21.118456Z","end":"2026-08-19T20:35:21.240217Z","steps":["trace[277725511] 'process raft request'  (duration: 121.096753ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:35:21.24046Z","caller":"traceutil/trace.go:171","msg":"trace[255109488] transaction","detail":"{read_only:false; response_revision:5512; number_of_response:1; }","duration":"121.288718ms","start":"2026-08-19T20:35:21.119101Z","end":"2026-08-19T20:35:21.240389Z","steps":["trace[255109488] 'process raft request'  (duration: 120.570301ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:36:01.491415Z","caller":"traceutil/trace.go:171","msg":"trace[1346024279] transaction","detail":"{read_only:false; response_revision:5925; number_of_response:1; }","duration":"136.76505ms","start":"2026-08-19T20:36:01.354627Z","end":"2026-08-19T20:36:01.491392Z","steps":["trace[1346024279] 'process raft request'  (duration: 136.605826ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:36:01.702922Z","caller":"traceutil/trace.go:171","msg":"trace[2107360470] transaction","detail":"{read_only:false; response_revision:5926; number_of_response:1; }","duration":"326.830106ms","start":"2026-08-19T20:36:01.376059Z","end":"2026-08-19T20:36:01.702889Z","steps":["trace[2107360470] 'process raft request'  (duration: 326.518379ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:36:01.703099Z","caller":"traceutil/trace.go:171","msg":"trace[178154246] linearizableReadLoop","detail":"{readStateIndex:6144; appliedIndex:6140; }","duration":"307.827461ms","start":"2026-08-19T20:36:01.395251Z","end":"2026-08-19T20:36:01.703079Z","steps":["trace[178154246] 'read index received'  (duration: 96.092254ms)","trace[178154246] 'applied index is now lower than readState.Index'  (duration: 211.733887ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-19T20:36:01.703126Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:36:01.376024Z","time spent":"326.999581ms","remote":"127.0.0.1:55128","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:5881 > 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-08-19T20:36:01.703232Z","caller":"traceutil/trace.go:171","msg":"trace[1140821701] transaction","detail":"{read_only:false; response_revision:5928; number_of_response:1; }","duration":"319.146403ms","start":"2026-08-19T20:36:01.384057Z","end":"2026-08-19T20:36:01.703203Z","steps":["trace[1140821701] 'process raft request'  (duration: 318.935608ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:36:01.703346Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.049628ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"}
{"level":"warn","ts":"2026-08-19T20:36:01.703396Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:36:01.384043Z","time spent":"319.262735ms","remote":"127.0.0.1:55128","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:5885 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:458 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"info","ts":"2026-08-19T20:36:01.703431Z","caller":"traceutil/trace.go:171","msg":"trace[1692714688] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5928; }","duration":"238.14608ms","start":"2026-08-19T20:36:01.465248Z","end":"2026-08-19T20:36:01.703394Z","steps":["trace[1692714688] 'agreement among raft nodes before linearized reading'  (duration: 237.966886ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:36:01.70354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.263412ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-vctpg\" ","response":"range_response_count:1 size:6531"}
{"level":"warn","ts":"2026-08-19T20:36:01.703604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.023009ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"}
{"level":"info","ts":"2026-08-19T20:36:01.703632Z","caller":"traceutil/trace.go:171","msg":"trace[205307892] transaction","detail":"{read_only:false; response_revision:5927; number_of_response:1; }","duration":"319.507522ms","start":"2026-08-19T20:36:01.384051Z","end":"2026-08-19T20:36:01.703558Z","steps":["trace[205307892] 'process raft request'  (duration: 318.752533ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:36:01.703756Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.477194ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"}
{"level":"info","ts":"2026-08-19T20:36:01.703702Z","caller":"traceutil/trace.go:171","msg":"trace[1078115960] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5928; }","duration":"228.173182ms","start":"2026-08-19T20:36:01.475505Z","end":"2026-08-19T20:36:01.703679Z","steps":["trace[1078115960] 'agreement among raft nodes before linearized reading'  (duration: 227.900475ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:36:01.703823Z","caller":"traceutil/trace.go:171","msg":"trace[1839197122] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5928; }","duration":"237.584877ms","start":"2026-08-19T20:36:01.466222Z","end":"2026-08-19T20:36:01.703807Z","steps":["trace[1839197122] 'agreement among raft nodes before linearized reading'  (duration: 237.414473ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:36:01.703633Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.261553ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"}
{"level":"warn","ts":"2026-08-19T20:36:01.703886Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:36:01.384028Z","time spent":"319.738727ms","remote":"127.0.0.1:55128","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:5883 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"info","ts":"2026-08-19T20:36:01.703727Z","caller":"traceutil/trace.go:171","msg":"trace[512933258] range","detail":"{range_begin:/registry/pods/openstack/keepalived-vctpg; range_end:; response_count:1; response_revision:5928; }","duration":"308.433636ms","start":"2026-08-19T20:36:01.395209Z","end":"2026-08-19T20:36:01.703643Z","steps":["trace[512933258] 'agreement among raft nodes before linearized reading'  (duration: 307.990605ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:36:01.70395Z","caller":"traceutil/trace.go:171","msg":"trace[1893808102] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5928; }","duration":"225.609571ms","start":"2026-08-19T20:36:01.478306Z","end":"2026-08-19T20:36:01.703916Z","steps":["trace[1893808102] 'agreement among raft nodes before linearized reading'  (duration: 225.226142ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:36:01.704037Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:36:01.395192Z","time spent":"308.829516ms","remote":"127.0.0.1:55042","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6553,"request content":"key:\"/registry/pods/openstack/keepalived-vctpg\" "}
{"level":"warn","ts":"2026-08-19T20:36:01.703634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.264938ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"}
{"level":"info","ts":"2026-08-19T20:36:01.704687Z","caller":"traceutil/trace.go:171","msg":"trace[1398442250] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5928; }","duration":"230.24334ms","start":"2026-08-19T20:36:01.474338Z","end":"2026-08-19T20:36:01.704581Z","steps":["trace[1398442250] 'agreement among raft nodes before linearized reading'  (duration: 229.214456ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:36:11.638383Z","caller":"traceutil/trace.go:171","msg":"trace[48247786] transaction","detail":"{read_only:false; response_revision:5983; number_of_response:1; }","duration":"114.397703ms","start":"2026-08-19T20:36:11.523957Z","end":"2026-08-19T20:36:11.638355Z","steps":["trace[48247786] 'process raft request'  (duration: 114.211209ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:36:11.841045Z","caller":"traceutil/trace.go:171","msg":"trace[1863389305] transaction","detail":"{read_only:false; response_revision:5984; number_of_response:1; }","duration":"103.439811ms","start":"2026-08-19T20:36:11.737587Z","end":"2026-08-19T20:36:11.841027Z","steps":["trace[1863389305] 'process raft request'  (duration: 103.124654ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:36:13.221576Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2948}
{"level":"info","ts":"2026-08-19T20:36:13.295836Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2948,"took":"72.377646ms","hash":2577675374,"current-db-size-bytes":57729024,"current-db-size":"58 MB","current-db-size-in-use-bytes":33722368,"current-db-size-in-use":"34 MB"}
{"level":"info","ts":"2026-08-19T20:36:13.295904Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2577675374,"revision":2948,"compact-revision":-1}
{"level":"info","ts":"2026-08-19T20:36:20.019489Z","caller":"traceutil/trace.go:171","msg":"trace[2121341403] transaction","detail":"{read_only:false; response_revision:6063; number_of_response:1; }","duration":"102.230952ms","start":"2026-08-19T20:36:19.917227Z","end":"2026-08-19T20:36:20.019458Z","steps":["trace[2121341403] 'process raft request'  (duration: 77.823697ms)","trace[2121341403] 'compare'  (duration: 24.18607ms)"],"step_count":2}
{"level":"info","ts":"2026-08-19T20:36:20.019786Z","caller":"traceutil/trace.go:171","msg":"trace[1106905452] transaction","detail":"{read_only:false; response_revision:6064; number_of_response:1; }","duration":"101.73798ms","start":"2026-08-19T20:36:19.918029Z","end":"2026-08-19T20:36:20.019767Z","steps":["trace[1106905452] 'process raft request'  (duration: 101.353451ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:36:20.019868Z","caller":"traceutil/trace.go:171","msg":"trace[760131994] transaction","detail":"{read_only:false; response_revision:6065; number_of_response:1; }","duration":"101.266068ms","start":"2026-08-19T20:36:19.918583Z","end":"2026-08-19T20:36:20.019849Z","steps":["trace[760131994] 'process raft request'  (duration: 101.092154ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:41:13.227661Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6002}
{"level":"info","ts":"2026-08-19T20:41:13.330791Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6002,"took":"100.625156ms","hash":2081494063,"current-db-size-bytes":57729024,"current-db-size":"58 MB","current-db-size-in-use-bytes":21778432,"current-db-size-in-use":"22 MB"}
{"level":"info","ts":"2026-08-19T20:41:13.330886Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2081494063,"revision":6002,"compact-revision":2948}
{"level":"info","ts":"2026-08-19T20:41:57.689293Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002255.wal"}
{"level":"info","ts":"2026-08-19T20:42:28.290959Z","caller":"traceutil/trace.go:171","msg":"trace[1240228598] transaction","detail":"{read_only:false; response_revision:8705; number_of_response:1; }","duration":"134.615709ms","start":"2026-08-19T20:42:28.156311Z","end":"2026-08-19T20:42:28.290927Z","steps":["trace[1240228598] 'process raft request'  (duration: 134.253639ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:42:28.291149Z","caller":"traceutil/trace.go:171","msg":"trace[1426337947] transaction","detail":"{read_only:false; response_revision:8704; number_of_response:1; }","duration":"135.215564ms","start":"2026-08-19T20:42:28.155922Z","end":"2026-08-19T20:42:28.291137Z","steps":["trace[1426337947] 'process raft request'  (duration: 126.456742ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:42:38.606008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.494693ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:26 size:228772"}
{"level":"info","ts":"2026-08-19T20:42:38.606104Z","caller":"traceutil/trace.go:171","msg":"trace[1953649512] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:26; response_revision:8804; }","duration":"150.605486ms","start":"2026-08-19T20:42:38.455479Z","end":"2026-08-19T20:42:38.606085Z","steps":["trace[1953649512] 'range keys from in-memory index tree'  (duration: 150.077354ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:42:39.87663Z","caller":"traceutil/trace.go:171","msg":"trace[12465357] transaction","detail":"{read_only:false; response_revision:8807; number_of_response:1; }","duration":"466.482651ms","start":"2026-08-19T20:42:39.410115Z","end":"2026-08-19T20:42:39.876598Z","steps":["trace[12465357] 'process raft request'  (duration: 466.305807ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:42:39.8768Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:42:39.410097Z","time spent":"466.616064ms","remote":"127.0.0.1:55128","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:8788 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"info","ts":"2026-08-19T20:42:40.009729Z","caller":"traceutil/trace.go:171","msg":"trace[2111300000] transaction","detail":"{read_only:false; response_revision:8808; number_of_response:1; }","duration":"597.121064ms","start":"2026-08-19T20:42:39.412583Z","end":"2026-08-19T20:42:40.009704Z","steps":["trace[2111300000] 'process raft request'  (duration: 596.92188ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:42:40.009905Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:42:39.412561Z","time spent":"597.253358ms","remote":"127.0.0.1:55128","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:8789 > 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-08-19T20:42:40.010105Z","caller":"traceutil/trace.go:171","msg":"trace[872878384] transaction","detail":"{read_only:false; response_revision:8809; number_of_response:1; }","duration":"578.433293ms","start":"2026-08-19T20:42:39.43164Z","end":"2026-08-19T20:42:40.010073Z","steps":["trace[872878384] 'process raft request'  (duration: 578.021243ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:42:40.010128Z","caller":"traceutil/trace.go:171","msg":"trace[1668426831] linearizableReadLoop","detail":"{readStateIndex:9123; appliedIndex:9122; }","duration":"597.184676ms","start":"2026-08-19T20:42:39.412917Z","end":"2026-08-19T20:42:40.010102Z","steps":["trace[1668426831] 'read index received'  (duration: 463.717204ms)","trace[1668426831] 'applied index is now lower than readState.Index'  (duration: 133.466322ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-19T20:42:40.010281Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:42:39.431624Z","time spent":"578.570156ms","remote":"127.0.0.1:55128","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:8792 > 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":"info","ts":"2026-08-19T20:42:40.010334Z","caller":"traceutil/trace.go:171","msg":"trace[588280100] transaction","detail":"{read_only:false; response_revision:8810; number_of_response:1; }","duration":"571.254829ms","start":"2026-08-19T20:42:39.438901Z","end":"2026-08-19T20:42:40.010156Z","steps":["trace[588280100] 'process raft request'  (duration: 571.056694ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:42:40.010684Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:42:39.438891Z","time spent":"571.603697ms","remote":"127.0.0.1:55128","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:8793 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:458 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"warn","ts":"2026-08-19T20:42:40.011308Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"598.400935ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:57 size:2225408"}
{"level":"info","ts":"2026-08-19T20:42:40.011385Z","caller":"traceutil/trace.go:171","msg":"trace[148420182] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:57; response_revision:8810; }","duration":"598.555769ms","start":"2026-08-19T20:42:39.412814Z","end":"2026-08-19T20:42:40.011369Z","steps":["trace[148420182] 'agreement among raft nodes before linearized reading'  (duration: 597.424052ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:42:40.01143Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:42:39.412785Z","time spent":"598.6338ms","remote":"127.0.0.1:54960","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":57,"response size":2225430,"request content":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" "}
{"level":"info","ts":"2026-08-19T20:43:58.644174Z","caller":"traceutil/trace.go:171","msg":"trace[286752666] transaction","detail":"{read_only:false; response_revision:9566; number_of_response:1; }","duration":"324.911421ms","start":"2026-08-19T20:43:58.319228Z","end":"2026-08-19T20:43:58.644139Z","steps":["trace[286752666] 'process raft request'  (duration: 324.696176ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:43:58.644393Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:43:58.3192Z","time spent":"325.088236ms","remote":"127.0.0.1:55128","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:9554 > 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":"info","ts":"2026-08-19T20:43:58.653242Z","caller":"traceutil/trace.go:171","msg":"trace[2137698593] linearizableReadLoop","detail":"{readStateIndex:9902; appliedIndex:9899; }","duration":"129.860306ms","start":"2026-08-19T20:43:58.523351Z","end":"2026-08-19T20:43:58.653211Z","steps":["trace[2137698593] 'read index received'  (duration: 120.720908ms)","trace[2137698593] 'applied index is now lower than readState.Index'  (duration: 9.137688ms)"],"step_count":2}
{"level":"info","ts":"2026-08-19T20:43:58.653525Z","caller":"traceutil/trace.go:171","msg":"trace[83474188] transaction","detail":"{read_only:false; response_revision:9567; number_of_response:1; }","duration":"332.026638ms","start":"2026-08-19T20:43:58.321489Z","end":"2026-08-19T20:43:58.653516Z","steps":["trace[83474188] 'process raft request'  (duration: 331.521466ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:43:58.653611Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:43:58.321467Z","time spent":"332.07791ms","remote":"127.0.0.1:55128","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:9555 > 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-08-19T20:43:58.653743Z","caller":"traceutil/trace.go:171","msg":"trace[390926179] transaction","detail":"{read_only:false; response_revision:9568; number_of_response:1; }","duration":"329.921627ms","start":"2026-08-19T20:43:58.323772Z","end":"2026-08-19T20:43:58.653693Z","steps":["trace[390926179] 'process raft request'  (duration: 329.378973ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:43:58.653879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.518912ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"}
{"level":"info","ts":"2026-08-19T20:43:58.653954Z","caller":"traceutil/trace.go:171","msg":"trace[1244983016] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:9568; }","duration":"130.653605ms","start":"2026-08-19T20:43:58.523283Z","end":"2026-08-19T20:43:58.653937Z","steps":["trace[1244983016] 'agreement among raft nodes before linearized reading'  (duration: 130.430869ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:43:58.653964Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:43:58.323746Z","time spent":"330.101452ms","remote":"127.0.0.1:55128","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:9556 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:458 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"info","ts":"2026-08-19T20:43:58.84796Z","caller":"traceutil/trace.go:171","msg":"trace[362484739] transaction","detail":"{read_only:false; response_revision:9570; number_of_response:1; }","duration":"149.469935ms","start":"2026-08-19T20:43:58.698457Z","end":"2026-08-19T20:43:58.847927Z","steps":["trace[362484739] 'process raft request'  (duration: 82.571444ms)","trace[362484739] 'compare'  (duration: 66.634815ms)"],"step_count":2}
{"level":"info","ts":"2026-08-19T20:43:58.848128Z","caller":"traceutil/trace.go:171","msg":"trace[2070787745] transaction","detail":"{read_only:false; response_revision:9571; number_of_response:1; }","duration":"148.385889ms","start":"2026-08-19T20:43:58.699706Z","end":"2026-08-19T20:43:58.848091Z","steps":["trace[2070787745] 'process raft request'  (duration: 148.159003ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:43:58.974791Z","caller":"traceutil/trace.go:171","msg":"trace[34959888] transaction","detail":"{read_only:false; response_revision:9572; number_of_response:1; }","duration":"121.393025ms","start":"2026-08-19T20:43:58.853374Z","end":"2026-08-19T20:43:58.974767Z","steps":["trace[34959888] 'process raft request'  (duration: 104.681908ms)","trace[34959888] 'compare'  (duration: 16.595304ms)"],"step_count":2}
{"level":"info","ts":"2026-08-19T20:43:58.976714Z","caller":"traceutil/trace.go:171","msg":"trace[1279728453] transaction","detail":"{read_only:false; response_revision:9573; number_of_response:1; }","duration":"123.310372ms","start":"2026-08-19T20:43:58.853378Z","end":"2026-08-19T20:43:58.976688Z","steps":["trace[1279728453] 'process raft request'  (duration: 123.171949ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:44:10.919325Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"612d5169b08bb96b","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-08-19T20:44:10.925205Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001}
{"level":"info","ts":"2026-08-19T20:44:10.925329Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001}
{"level":"info","ts":"2026-08-19T20:46:13.235381Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8071}
{"level":"info","ts":"2026-08-19T20:46:13.303181Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8071,"took":"64.841791ms","hash":328854920,"current-db-size-bytes":57729024,"current-db-size":"58 MB","current-db-size-in-use-bytes":27226112,"current-db-size-in-use":"27 MB"}
{"level":"info","ts":"2026-08-19T20:46:13.303252Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":328854920,"revision":8071,"compact-revision":6002}
{"level":"info","ts":"2026-08-19T20:49:36.513263Z","caller":"traceutil/trace.go:171","msg":"trace[1535354587] transaction","detail":"{read_only:false; response_revision:12000; number_of_response:1; }","duration":"118.570654ms","start":"2026-08-19T20:49:36.394654Z","end":"2026-08-19T20:49:36.513225Z","steps":["trace[1535354587] 'process raft request'  (duration: 89.76256ms)","trace[1535354587] 'compare'  (duration: 28.547788ms)"],"step_count":2}
{"level":"info","ts":"2026-08-19T20:49:36.691365Z","caller":"traceutil/trace.go:171","msg":"trace[1164136562] transaction","detail":"{read_only:false; response_revision:12001; number_of_response:1; }","duration":"172.85754ms","start":"2026-08-19T20:49:36.51848Z","end":"2026-08-19T20:49:36.691337Z","steps":["trace[1164136562] 'process raft request'  (duration: 123.416941ms)","trace[1164136562] 'compare'  (duration: 48.989778ms)"],"step_count":2}
{"level":"info","ts":"2026-08-19T20:49:36.843413Z","caller":"traceutil/trace.go:171","msg":"trace[1935829302] transaction","detail":"{read_only:false; response_revision:12003; number_of_response:1; }","duration":"124.675201ms","start":"2026-08-19T20:49:36.718685Z","end":"2026-08-19T20:49:36.84336Z","steps":["trace[1935829302] 'process raft request'  (duration: 73.218382ms)","trace[1935829302] 'compare'  (duration: 51.207184ms)"],"step_count":2}
{"level":"info","ts":"2026-08-19T20:51:13.254769Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10480}
{"level":"info","ts":"2026-08-19T20:51:13.339251Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10480,"took":"81.37164ms","hash":1456860961,"current-db-size-bytes":57729024,"current-db-size":"58 MB","current-db-size-in-use-bytes":25735168,"current-db-size-in-use":"26 MB"}
{"level":"info","ts":"2026-08-19T20:51:13.339326Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1456860961,"revision":10480,"compact-revision":8071}
{"level":"info","ts":"2026-08-19T20:54:17.889584Z","caller":"traceutil/trace.go:171","msg":"trace[196299606] transaction","detail":"{read_only:false; response_revision:13911; number_of_response:1; }","duration":"158.064188ms","start":"2026-08-19T20:54:17.731486Z","end":"2026-08-19T20:54:17.88955Z","steps":["trace[196299606] 'process raft request'  (duration: 157.841303ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:54:20.57409Z","caller":"traceutil/trace.go:171","msg":"trace[789352872] transaction","detail":"{read_only:false; response_revision:13925; number_of_response:1; }","duration":"473.727295ms","start":"2026-08-19T20:54:20.100329Z","end":"2026-08-19T20:54:20.574056Z","steps":["trace[789352872] 'process raft request'  (duration: 473.529771ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:54:20.574303Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:54:20.100293Z","time spent":"473.893319ms","remote":"127.0.0.1:55128","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:13862 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:599 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"info","ts":"2026-08-19T20:54:20.577259Z","caller":"traceutil/trace.go:171","msg":"trace[321959410] linearizableReadLoop","detail":"{readStateIndex:14405; appliedIndex:14403; }","duration":"296.393161ms","start":"2026-08-19T20:54:20.280827Z","end":"2026-08-19T20:54:20.57722Z","steps":["trace[321959410] 'read index received'  (duration: 293.089492ms)","trace[321959410] 'applied index is now lower than readState.Index'  (duration: 3.302099ms)"],"step_count":2}
{"level":"info","ts":"2026-08-19T20:54:20.57738Z","caller":"traceutil/trace.go:171","msg":"trace[912783366] transaction","detail":"{read_only:false; response_revision:13926; number_of_response:1; }","duration":"339.969123ms","start":"2026-08-19T20:54:20.23738Z","end":"2026-08-19T20:54:20.577349Z","steps":["trace[912783366] 'process raft request'  (duration: 339.667784ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:54:20.577448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.488905ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/placement-ks-user\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-19T20:54:20.577485Z","caller":"traceutil/trace.go:171","msg":"trace[43446003] range","detail":"{range_begin:/registry/jobs/openstack/placement-ks-user; range_end:; response_count:0; response_revision:13926; }","duration":"296.602867ms","start":"2026-08-19T20:54:20.280871Z","end":"2026-08-19T20:54:20.577474Z","steps":["trace[43446003] 'agreement among raft nodes before linearized reading'  (duration: 296.513435ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:54:20.577531Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:54:20.237355Z","time spent":"340.087166ms","remote":"127.0.0.1:55104","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5240,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/jobs/openstack/placement-db-sync\" mod_revision:13911 > success:<request_put:<key:\"/registry/jobs/openstack/placement-db-sync\" value_size:5190 >> failure:<request_range:<key:\"/registry/jobs/openstack/placement-db-sync\" > >"}
{"level":"warn","ts":"2026-08-19T20:54:20.577691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.744573ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-vctpg\" ","response":"range_response_count:1 size:6531"}
{"level":"info","ts":"2026-08-19T20:54:20.577741Z","caller":"traceutil/trace.go:171","msg":"trace[1904131381] range","detail":"{range_begin:/registry/pods/openstack/keepalived-vctpg; range_end:; response_count:1; response_revision:13926; }","duration":"294.812194ms","start":"2026-08-19T20:54:20.282912Z","end":"2026-08-19T20:54:20.577725Z","steps":["trace[1904131381] 'agreement among raft nodes before linearized reading'  (duration: 294.64648ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:54:20.577624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.544146ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/placement-ks-service\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-08-19T20:54:20.577736Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.141257ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"}
{"level":"info","ts":"2026-08-19T20:54:20.577785Z","caller":"traceutil/trace.go:171","msg":"trace[1162872687] range","detail":"{range_begin:/registry/jobs/openstack/placement-ks-service; range_end:; response_count:0; response_revision:13926; }","duration":"296.72143ms","start":"2026-08-19T20:54:20.281054Z","end":"2026-08-19T20:54:20.577776Z","steps":["trace[1162872687] 'agreement among raft nodes before linearized reading'  (duration: 296.517195ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:54:20.577806Z","caller":"traceutil/trace.go:171","msg":"trace[196015423] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:13926; }","duration":"162.25727ms","start":"2026-08-19T20:54:20.415532Z","end":"2026-08-19T20:54:20.57779Z","steps":["trace[196015423] 'agreement among raft nodes before linearized reading'  (duration: 161.998804ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:54:20.577632Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.023228ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/placement-db-sync\" ","response":"range_response_count:1 size:5255"}
{"level":"info","ts":"2026-08-19T20:54:20.577855Z","caller":"traceutil/trace.go:171","msg":"trace[113623525] range","detail":"{range_begin:/registry/jobs/openstack/placement-db-sync; range_end:; response_count:1; response_revision:13926; }","duration":"292.291224ms","start":"2026-08-19T20:54:20.285557Z","end":"2026-08-19T20:54:20.577848Z","steps":["trace[113623525] 'agreement among raft nodes before linearized reading'  (duration: 292.005828ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:54:20.577814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.692316ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"}
{"level":"info","ts":"2026-08-19T20:54:20.577948Z","caller":"traceutil/trace.go:171","msg":"trace[1216341634] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:13926; }","duration":"122.882661ms","start":"2026-08-19T20:54:20.455031Z","end":"2026-08-19T20:54:20.577914Z","steps":["trace[1216341634] 'agreement among raft nodes before linearized reading'  (duration: 122.463771ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:54:20.578206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.015003ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"}
{"level":"warn","ts":"2026-08-19T20:54:20.578219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.386276ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/placement-ks-endpoints\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-19T20:54:20.578248Z","caller":"traceutil/trace.go:171","msg":"trace[901335042] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:13926; }","duration":"230.098995ms","start":"2026-08-19T20:54:20.348139Z","end":"2026-08-19T20:54:20.578238Z","steps":["trace[901335042] 'agreement among raft nodes before linearized reading'  (duration: 229.304976ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:54:20.578271Z","caller":"traceutil/trace.go:171","msg":"trace[759838012] range","detail":"{range_begin:/registry/jobs/openstack/placement-ks-endpoints; range_end:; response_count:0; response_revision:13926; }","duration":"297.475088ms","start":"2026-08-19T20:54:20.28078Z","end":"2026-08-19T20:54:20.578255Z","steps":["trace[759838012] 'agreement among raft nodes before linearized reading'  (duration: 296.596437ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:55:50.355415Z","caller":"traceutil/trace.go:171","msg":"trace[982617167] linearizableReadLoop","detail":"{readStateIndex:15013; appliedIndex:15012; }","duration":"162.172808ms","start":"2026-08-19T20:55:50.193211Z","end":"2026-08-19T20:55:50.355384Z","steps":["trace[982617167] 'read index received'  (duration: 59.509974ms)","trace[982617167] 'applied index is now lower than readState.Index'  (duration: 102.661214ms)"],"step_count":2}
{"level":"info","ts":"2026-08-19T20:55:50.355505Z","caller":"traceutil/trace.go:171","msg":"trace[812653918] transaction","detail":"{read_only:false; response_revision:14511; number_of_response:1; }","duration":"176.568095ms","start":"2026-08-19T20:55:50.178871Z","end":"2026-08-19T20:55:50.355439Z","steps":["trace[812653918] 'process raft request'  (duration: 154.825582ms)","trace[812653918] 'compare'  (duration: 21.426176ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-19T20:55:50.355662Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.370739ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectzones/\" range_end:\"/registry/ceph.rook.io/cephobjectzones0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-19T20:55:50.355512Z","caller":"traceutil/trace.go:171","msg":"trace[1911610897] transaction","detail":"{read_only:false; response_revision:14512; number_of_response:1; }","duration":"125.874634ms","start":"2026-08-19T20:55:50.2296Z","end":"2026-08-19T20:55:50.355474Z","steps":["trace[1911610897] 'process raft request'  (duration: 125.71759ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:55:50.355709Z","caller":"traceutil/trace.go:171","msg":"trace[853744950] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectzones/; range_end:/registry/ceph.rook.io/cephobjectzones0; response_count:0; response_revision:14512; }","duration":"142.507373ms","start":"2026-08-19T20:55:50.213189Z","end":"2026-08-19T20:55:50.355696Z","steps":["trace[853744950] 'agreement among raft nodes before linearized reading'  (duration: 142.38923ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:55:50.355783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.550287ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-08-19T20:55:50.355906Z","caller":"traceutil/trace.go:171","msg":"trace[1769376214] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:14512; }","duration":"162.717092ms","start":"2026-08-19T20:55:50.193134Z","end":"2026-08-19T20:55:50.355851Z","steps":["trace[1769376214] 'agreement among raft nodes before linearized reading'  (duration: 162.417454ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:56:13.262197Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12636}
{"level":"info","ts":"2026-08-19T20:56:13.340798Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12636,"took":"75.909779ms","hash":447834607,"current-db-size-bytes":57729024,"current-db-size":"58 MB","current-db-size-in-use-bytes":27635712,"current-db-size-in-use":"28 MB"}
{"level":"info","ts":"2026-08-19T20:56:13.340865Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":447834607,"revision":12636,"compact-revision":10480}
{"level":"info","ts":"2026-08-19T20:56:15.556553Z","caller":"traceutil/trace.go:171","msg":"trace[294797641] linearizableReadLoop","detail":"{readStateIndex:15157; appliedIndex:15156; }","duration":"172.492706ms","start":"2026-08-19T20:56:15.384037Z","end":"2026-08-19T20:56:15.55653Z","steps":["trace[294797641] 'read index received'  (duration: 171.607605ms)","trace[294797641] 'applied index is now lower than readState.Index'  (duration: 884.051µs)"],"step_count":2}
{"level":"info","ts":"2026-08-19T20:56:15.556631Z","caller":"traceutil/trace.go:171","msg":"trace[524311847] transaction","detail":"{read_only:false; response_revision:14649; number_of_response:1; }","duration":"191.310169ms","start":"2026-08-19T20:56:15.365285Z","end":"2026-08-19T20:56:15.556596Z","steps":["trace[524311847] 'process raft request'  (duration: 190.282575ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:56:15.556766Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.712821ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"}
{"level":"info","ts":"2026-08-19T20:56:15.556795Z","caller":"traceutil/trace.go:171","msg":"trace[182418668] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:14649; }","duration":"172.787983ms","start":"2026-08-19T20:56:15.383999Z","end":"2026-08-19T20:56:15.556787Z","steps":["trace[182418668] 'agreement among raft nodes before linearized reading'  (duration: 172.618369ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:56:15.72395Z","caller":"traceutil/trace.go:171","msg":"trace[856152798] transaction","detail":"{read_only:false; response_revision:14650; number_of_response:1; }","duration":"162.385963ms","start":"2026-08-19T20:56:15.56151Z","end":"2026-08-19T20:56:15.723896Z","steps":["trace[856152798] 'process raft request'  (duration: 149.612976ms)","trace[856152798] 'compare'  (duration: 12.565062ms)"],"step_count":2}
{"level":"info","ts":"2026-08-19T20:56:55.714837Z","caller":"traceutil/trace.go:171","msg":"trace[584134132] transaction","detail":"{read_only:false; response_revision:15062; number_of_response:1; }","duration":"161.472731ms","start":"2026-08-19T20:56:55.553335Z","end":"2026-08-19T20:56:55.714808Z","steps":["trace[584134132] 'process raft request'  (duration: 161.266005ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:56:55.772391Z","caller":"traceutil/trace.go:171","msg":"trace[1657831531] transaction","detail":"{read_only:false; response_revision:15063; number_of_response:1; }","duration":"215.987055ms","start":"2026-08-19T20:56:55.556346Z","end":"2026-08-19T20:56:55.772333Z","steps":["trace[1657831531] 'process raft request'  (duration: 215.727489ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:56:55.911838Z","caller":"traceutil/trace.go:171","msg":"trace[2009745376] transaction","detail":"{read_only:false; response_revision:15064; number_of_response:1; }","duration":"111.485087ms","start":"2026-08-19T20:56:55.800312Z","end":"2026-08-19T20:56:55.911797Z","steps":["trace[2009745376] 'process raft request'  (duration: 39.903951ms)","trace[2009745376] 'compare'  (duration: 71.194336ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-19T20:58:32.001854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.74318ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13360948760368277394 > lease_revoke:<id:396ba01bb3f265ba>","response":"size:27"}
{"level":"info","ts":"2026-08-19T20:58:32.001982Z","caller":"traceutil/trace.go:171","msg":"trace[658934326] linearizableReadLoop","detail":"{readStateIndex:16471; appliedIndex:16470; }","duration":"223.701456ms","start":"2026-08-19T20:58:31.77826Z","end":"2026-08-19T20:58:32.001961Z","steps":["trace[658934326] 'read index received'  (duration: 76.725461ms)","trace[658934326] 'applied index is now lower than readState.Index'  (duration: 146.973995ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-19T20:58:32.002241Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.981454ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/glance-api-797b8949d7-t2pw5.18cd4fe50c4e0bbe\" ","response":"range_response_count:1 size:2106"}
{"level":"info","ts":"2026-08-19T20:58:32.002292Z","caller":"traceutil/trace.go:171","msg":"trace[1989964699] range","detail":"{range_begin:/registry/events/openstack/glance-api-797b8949d7-t2pw5.18cd4fe50c4e0bbe; range_end:; response_count:1; response_revision:15920; }","duration":"224.098246ms","start":"2026-08-19T20:58:31.778177Z","end":"2026-08-19T20:58:32.002275Z","steps":["trace[1989964699] 'agreement among raft nodes before linearized reading'  (duration: 223.907411ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:58:32.110918Z","caller":"traceutil/trace.go:171","msg":"trace[572708528] transaction","detail":"{read_only:false; response_revision:15921; number_of_response:1; }","duration":"105.96543ms","start":"2026-08-19T20:58:32.004907Z","end":"2026-08-19T20:58:32.110872Z","steps":["trace[572708528] 'process raft request'  (duration: 105.563011ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:58:32.734416Z","caller":"traceutil/trace.go:171","msg":"trace[1070876143] transaction","detail":"{read_only:false; response_revision:15925; number_of_response:1; }","duration":"206.9558ms","start":"2026-08-19T20:58:32.527433Z","end":"2026-08-19T20:58:32.734389Z","steps":["trace[1070876143] 'process raft request'  (duration: 206.767675ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:58:32.792598Z","caller":"traceutil/trace.go:171","msg":"trace[1753145591] transaction","detail":"{read_only:false; response_revision:15926; number_of_response:1; }","duration":"264.025104ms","start":"2026-08-19T20:58:32.528508Z","end":"2026-08-19T20:58:32.792533Z","steps":["trace[1753145591] 'process raft request'  (duration: 242.448901ms)","trace[1753145591] 'compare'  (duration: 21.41631ms)"],"step_count":2}
{"level":"info","ts":"2026-08-19T21:01:13.268758Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14635}
{"level":"info","ts":"2026-08-19T21:01:13.3492Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14635,"took":"76.393274ms","hash":2430232606,"current-db-size-bytes":57729024,"current-db-size":"58 MB","current-db-size-in-use-bytes":31842304,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-08-19T21:01:13.349286Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2430232606,"revision":14635,"compact-revision":12636}
{"level":"info","ts":"2026-08-19T21:02:16.441445Z","caller":"traceutil/trace.go:171","msg":"trace[851856847] transaction","detail":"{read_only:false; response_revision:17682; number_of_response:1; }","duration":"391.920017ms","start":"2026-08-19T21:02:16.049486Z","end":"2026-08-19T21:02:16.441406Z","steps":["trace[851856847] 'process raft request'  (duration: 391.768573ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T21:02:16.441639Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T21:02:16.049474Z","time spent":"392.064291ms","remote":"127.0.0.1:55128","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:17673 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-08-19T21:02:16.441897Z","caller":"traceutil/trace.go:171","msg":"trace[2035524138] linearizableReadLoop","detail":"{readStateIndex:18287; appliedIndex:18287; }","duration":"379.114988ms","start":"2026-08-19T21:02:16.06272Z","end":"2026-08-19T21:02:16.441835Z","steps":["trace[2035524138] 'read index received'  (duration: 379.107018ms)","trace[2035524138] 'applied index is now lower than readState.Index'  (duration: 5.95µs)"],"step_count":2}
{"level":"warn","ts":"2026-08-19T21:02:16.442488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"379.59602ms","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-08-19T21:02:16.444463Z","caller":"traceutil/trace.go:171","msg":"trace[301953492] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:17682; }","duration":"381.723261ms","start":"2026-08-19T21:02:16.062694Z","end":"2026-08-19T21:02:16.444417Z","steps":["trace[301953492] 'agreement among raft nodes before linearized reading'  (duration: 379.283822ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T21:02:16.444595Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T21:02:16.062682Z","time spent":"381.876295ms","remote":"127.0.0.1:55128","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-08-19T21:02:16.445793Z","caller":"traceutil/trace.go:171","msg":"trace[2008389836] transaction","detail":"{read_only:false; response_revision:17683; number_of_response:1; }","duration":"382.951681ms","start":"2026-08-19T21:02:16.06279Z","end":"2026-08-19T21:02:16.445742Z","steps":["trace[2008389836] 'process raft request'  (duration: 382.740286ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T21:02:16.445819Z","caller":"traceutil/trace.go:171","msg":"trace[680754369] transaction","detail":"{read_only:false; response_revision:17684; number_of_response:1; }","duration":"380.182313ms","start":"2026-08-19T21:02:16.065588Z","end":"2026-08-19T21:02:16.445771Z","steps":["trace[680754369] 'process raft request'  (duration: 380.071411ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T21:02:16.445956Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T21:02:16.062778Z","time spent":"383.083394ms","remote":"127.0.0.1:55128","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:17675 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:457 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"warn","ts":"2026-08-19T21:02:16.445979Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T21:02:16.065557Z","time spent":"380.333607ms","remote":"127.0.0.1:55128","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:17676 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:464 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-08-19T21:02:16.44669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.074637ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/neutron-server\" ","response":"range_response_count:1 size:701"}
{"level":"info","ts":"2026-08-19T21:02:16.446782Z","caller":"traceutil/trace.go:171","msg":"trace[1282897946] range","detail":"{range_begin:/registry/services/endpoints/openstack/neutron-server; range_end:; response_count:1; response_revision:17685; }","duration":"154.165469ms","start":"2026-08-19T21:02:16.292602Z","end":"2026-08-19T21:02:16.446767Z","steps":["trace[1282897946] 'agreement among raft nodes before linearized reading'  (duration: 153.974745ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T21:02:16.447273Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.062961ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/neutron-server\" ","response":"range_response_count:1 size:701"}
{"level":"info","ts":"2026-08-19T21:02:16.452965Z","caller":"traceutil/trace.go:171","msg":"trace[2018555438] range","detail":"{range_begin:/registry/services/endpoints/openstack/neutron-server; range_end:; response_count:1; response_revision:17685; }","duration":"160.75789ms","start":"2026-08-19T21:02:16.292183Z","end":"2026-08-19T21:02:16.452941Z","steps":["trace[2018555438] 'agreement among raft nodes before linearized reading'  (duration: 155.035171ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T21:02:16.44772Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.296691ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/neutron-rabbit-init\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-19T21:02:16.453084Z","caller":"traceutil/trace.go:171","msg":"trace[4917979] range","detail":"{range_begin:/registry/jobs/openstack/neutron-rabbit-init; range_end:; response_count:0; response_revision:17685; }","duration":"161.743013ms","start":"2026-08-19T21:02:16.291332Z","end":"2026-08-19T21:02:16.453075Z","steps":["trace[4917979] 'agreement among raft nodes before linearized reading'  (duration: 156.332912ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T21:02:16.900357Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.162717ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/neutron-metadata-agent-default-8ptjq\" ","response":"range_response_count:1 size:14278"}
{"level":"info","ts":"2026-08-19T21:02:16.900546Z","caller":"traceutil/trace.go:171","msg":"trace[1762748403] range","detail":"{range_begin:/registry/pods/openstack/neutron-metadata-agent-default-8ptjq; range_end:; response_count:1; response_revision:17689; }","duration":"123.426243ms","start":"2026-08-19T21:02:16.777097Z","end":"2026-08-19T21:02:16.900523Z","steps":["trace[1762748403] 'range keys from in-memory index tree'  (duration: 122.928992ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T21:02:16.900361Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.451423ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/neutron-dhcp-agent-default-wn6k5\" ","response":"range_response_count:1 size:18647"}
{"level":"info","ts":"2026-08-19T21:02:16.901273Z","caller":"traceutil/trace.go:171","msg":"trace[1166860416] range","detail":"{range_begin:/registry/pods/openstack/neutron-dhcp-agent-default-wn6k5; range_end:; response_count:1; response_revision:17689; }","duration":"133.350355ms","start":"2026-08-19T21:02:16.767792Z","end":"2026-08-19T21:02:16.901143Z","steps":["trace[1166860416] 'range keys from in-memory index tree'  (duration: 132.109285ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T21:02:16.900401Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.706208ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/neutron-l3-agent-default-7sxzc\" ","response":"range_response_count:1 size:18672"}
{"level":"info","ts":"2026-08-19T21:02:16.901601Z","caller":"traceutil/trace.go:171","msg":"trace[876709464] range","detail":"{range_begin:/registry/pods/openstack/neutron-l3-agent-default-7sxzc; range_end:; response_count:1; response_revision:17689; }","duration":"222.973939ms","start":"2026-08-19T21:02:16.678613Z","end":"2026-08-19T21:02:16.901587Z","steps":["trace[876709464] 'range keys from in-memory index tree'  (duration: 221.493312ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T21:05:01.905068Z","caller":"traceutil/trace.go:171","msg":"trace[751885754] transaction","detail":"{read_only:false; response_revision:18783; number_of_response:1; }","duration":"105.243094ms","start":"2026-08-19T21:05:01.799795Z","end":"2026-08-19T21:05:01.905038Z","steps":["trace[751885754] 'process raft request'  (duration: 104.660249ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T21:05:03.701655Z","caller":"traceutil/trace.go:171","msg":"trace[95460337] transaction","detail":"{read_only:false; response_revision:18787; number_of_response:1; }","duration":"488.149499ms","start":"2026-08-19T21:05:03.213477Z","end":"2026-08-19T21:05:03.701626Z","steps":["trace[95460337] 'process raft request'  (duration: 487.942014ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T21:05:03.701827Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T21:05:03.213443Z","time spent":"488.295583ms","remote":"127.0.0.1:55128","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:18773 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:477 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"info","ts":"2026-08-19T21:05:03.78705Z","caller":"traceutil/trace.go:171","msg":"trace[203183833] transaction","detail":"{read_only:false; response_revision:18788; number_of_response:1; }","duration":"570.326385ms","start":"2026-08-19T21:05:03.216695Z","end":"2026-08-19T21:05:03.787021Z","steps":["trace[203183833] 'process raft request'  (duration: 553.970531ms)","trace[203183833] 'compare'  (duration: 16.18532ms)"],"step_count":2}
{"level":"info","ts":"2026-08-19T21:05:03.787163Z","caller":"traceutil/trace.go:171","msg":"trace[1964173540] linearizableReadLoop","detail":"{readStateIndex:19433; appliedIndex:19430; }","duration":"437.461734ms","start":"2026-08-19T21:05:03.349683Z","end":"2026-08-19T21:05:03.787144Z","steps":["trace[1964173540] 'read index received'  (duration: 351.763294ms)","trace[1964173540] 'applied index is now lower than readState.Index'  (duration: 85.69606ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-19T21:05:03.787211Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T21:05:03.216649Z","time spent":"570.479209ms","remote":"127.0.0.1:55128","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:18774 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:457 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"info","ts":"2026-08-19T21:05:03.787252Z","caller":"traceutil/trace.go:171","msg":"trace[1264842043] transaction","detail":"{read_only:false; response_revision:18789; number_of_response:1; }","duration":"570.024219ms","start":"2026-08-19T21:05:03.217219Z","end":"2026-08-19T21:05:03.787243Z","steps":["trace[1264842043] 'process raft request'  (duration: 569.759602ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T21:05:03.787298Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T21:05:03.21719Z","time spent":"570.076879ms","remote":"127.0.0.1:55128","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:18775 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:464 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-08-19T21:05:03.787393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.126284ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"}
{"level":"info","ts":"2026-08-19T21:05:03.787433Z","caller":"traceutil/trace.go:171","msg":"trace[744402402] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:18789; }","duration":"283.216657ms","start":"2026-08-19T21:05:03.50421Z","end":"2026-08-19T21:05:03.787426Z","steps":["trace[744402402] 'agreement among raft nodes before linearized reading'  (duration: 283.104333ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T21:05:03.787431Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"437.418154ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"}
{"level":"info","ts":"2026-08-19T21:05:03.787492Z","caller":"traceutil/trace.go:171","msg":"trace[254177666] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:18789; }","duration":"437.535847ms","start":"2026-08-19T21:05:03.349941Z","end":"2026-08-19T21:05:03.787477Z","steps":["trace[254177666] 'agreement among raft nodes before linearized reading'  (duration: 437.368752ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T21:05:03.787517Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T21:05:03.349916Z","time spent":"437.596948ms","remote":"127.0.0.1:55128","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":463,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-08-19T21:05:03.787454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"421.632723ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-stvk6\" ","response":"range_response_count:1 size:22101"}
{"level":"warn","ts":"2026-08-19T21:05:03.787547Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"437.869385ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-08-19T21:05:03.787561Z","caller":"traceutil/trace.go:171","msg":"trace[1542637134] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-stvk6; range_end:; response_count:1; response_revision:18789; }","duration":"421.787366ms","start":"2026-08-19T21:05:03.365766Z","end":"2026-08-19T21:05:03.787554Z","steps":["trace[1542637134] 'agreement among raft nodes before linearized reading'  (duration: 421.609201ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T21:05:03.787566Z","caller":"traceutil/trace.go:171","msg":"trace[146903605] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:18789; }","duration":"437.934136ms","start":"2026-08-19T21:05:03.349626Z","end":"2026-08-19T21:05:03.787561Z","steps":["trace[146903605] 'agreement among raft nodes before linearized reading'  (duration: 437.861735ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T21:05:03.787583Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T21:05:03.365731Z","time spent":"421.846848ms","remote":"127.0.0.1:55042","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":1,"response size":22123,"request content":"key:\"/registry/pods/openstack/nova-compute-default-stvk6\" "}
{"level":"warn","ts":"2026-08-19T21:05:03.787584Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T21:05:03.34961Z","time spent":"437.970608ms","remote":"127.0.0.1:55128","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-08-19T21:05:45.027182Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"612d5169b08bb96b","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-08-19T21:05:45.033257Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002}
{"level":"info","ts":"2026-08-19T21:05:45.033384Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002}
{"level":"info","ts":"2026-08-19T21:06:13.27686Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17119}
{"level":"info","ts":"2026-08-19T21:06:13.380219Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17119,"took":"99.123367ms","hash":3130467200,"current-db-size-bytes":57729024,"current-db-size":"58 MB","current-db-size-in-use-bytes":33447936,"current-db-size-in-use":"33 MB"}
{"level":"info","ts":"2026-08-19T21:06:13.380286Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3130467200,"revision":17119,"compact-revision":14635}
{"level":"info","ts":"2026-08-19T21:11:13.285621Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19591}
{"level":"info","ts":"2026-08-19T21:11:13.41096Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19591,"took":"120.876291ms","hash":3501770358,"current-db-size-bytes":57729024,"current-db-size":"58 MB","current-db-size-in-use-bytes":30179328,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-08-19T21:11:13.411026Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3501770358,"revision":19591,"compact-revision":17119}
{"level":"info","ts":"2026-08-19T21:11:26.125936Z","caller":"traceutil/trace.go:171","msg":"trace[1547747432] linearizableReadLoop","detail":"{readStateIndex:22437; appliedIndex:22436; }","duration":"164.639946ms","start":"2026-08-19T21:11:25.96127Z","end":"2026-08-19T21:11:26.12591Z","steps":["trace[1547747432] 'read index received'  (duration: 164.349609ms)","trace[1547747432] 'applied index is now lower than readState.Index'  (duration: 289.507µs)"],"step_count":2}
{"level":"info","ts":"2026-08-19T21:11:26.126009Z","caller":"traceutil/trace.go:171","msg":"trace[1659089565] transaction","detail":"{read_only:false; response_revision:21698; number_of_response:1; }","duration":"173.574822ms","start":"2026-08-19T21:11:25.952389Z","end":"2026-08-19T21:11:26.125963Z","steps":["trace[1659089565] 'process raft request'  (duration: 173.295446ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T21:11:26.126361Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.085227ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"}
{"level":"warn","ts":"2026-08-19T21:11:26.126466Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.30345ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-08-19T21:11:26.12647Z","caller":"traceutil/trace.go:171","msg":"trace[394515782] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:21698; }","duration":"165.248421ms","start":"2026-08-19T21:11:25.961193Z","end":"2026-08-19T21:11:26.126442Z","steps":["trace[394515782] 'agreement among raft nodes before linearized reading'  (duration: 164.876042ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T21:11:26.126522Z","caller":"traceutil/trace.go:171","msg":"trace[2042488576] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:21698; }","duration":"136.424193ms","start":"2026-08-19T21:11:25.990084Z","end":"2026-08-19T21:11:26.126508Z","steps":["trace[2042488576] 'agreement among raft nodes before linearized reading'  (duration: 136.003083ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T21:11:26.410694Z","caller":"traceutil/trace.go:171","msg":"trace[117902870] transaction","detail":"{read_only:false; response_revision:21700; number_of_response:1; }","duration":"277.820816ms","start":"2026-08-19T21:11:26.13282Z","end":"2026-08-19T21:11:26.410641Z","steps":["trace[117902870] 'process raft request'  (duration: 277.390246ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T21:11:26.410749Z","caller":"traceutil/trace.go:171","msg":"trace[834198719] transaction","detail":"{read_only:false; response_revision:21701; number_of_response:1; }","duration":"275.690115ms","start":"2026-08-19T21:11:26.135015Z","end":"2026-08-19T21:11:26.410705Z","steps":["trace[834198719] 'process raft request'  (duration: 275.492349ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T21:11:26.699146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.79099ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.186\" ","response":"range_response_count:1 size:140"}
{"level":"info","ts":"2026-08-19T21:11:26.699232Z","caller":"traceutil/trace.go:171","msg":"trace[1254167883] range","detail":"{range_begin:/registry/masterleases/162.253.55.186; range_end:; response_count:1; response_revision:21701; }","duration":"221.936363ms","start":"2026-08-19T21:11:26.477276Z","end":"2026-08-19T21:11:26.699213Z","steps":["trace[1254167883] 'range keys from in-memory index tree'  (duration: 221.557365ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T21:11:26.881433Z","caller":"traceutil/trace.go:171","msg":"trace[824507668] transaction","detail":"{read_only:false; response_revision:21702; number_of_response:1; }","duration":"165.560869ms","start":"2026-08-19T21:11:26.715825Z","end":"2026-08-19T21:11:26.881386Z","steps":["trace[824507668] 'process raft request'  (duration: 162.629007ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T21:11:27.192855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.105962ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13360948760368297317 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:21692 > 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-08-19T21:11:27.193008Z","caller":"traceutil/trace.go:171","msg":"trace[2146123488] transaction","detail":"{read_only:false; response_revision:21703; number_of_response:1; }","duration":"305.683441ms","start":"2026-08-19T21:11:26.8873Z","end":"2026-08-19T21:11:27.192984Z","steps":["trace[2146123488] 'process raft request'  (duration: 203.344623ms)","trace[2146123488] 'compare'  (duration: 101.932859ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-19T21:11:27.193309Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T21:11:26.887283Z","time spent":"305.985438ms","remote":"127.0.0.1:55128","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:21692 > 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-08-19T21:11:27.198088Z","caller":"traceutil/trace.go:171","msg":"trace[442594551] transaction","detail":"{read_only:false; response_revision:21704; number_of_response:1; }","duration":"310.068828ms","start":"2026-08-19T21:11:26.88797Z","end":"2026-08-19T21:11:27.198039Z","steps":["trace[442594551] 'process raft request'  (duration: 309.849652ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T21:11:27.197973Z","caller":"traceutil/trace.go:171","msg":"trace[1022245246] linearizableReadLoop","detail":"{readStateIndex:22444; appliedIndex:22442; }","duration":"308.838539ms","start":"2026-08-19T21:11:26.889115Z","end":"2026-08-19T21:11:27.197954Z","steps":["trace[1022245246] 'read index received'  (duration: 201.601092ms)","trace[1022245246] 'applied index is now lower than readState.Index'  (duration: 107.236327ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-19T21:11:27.198285Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T21:11:26.88794Z","time spent":"310.228912ms","remote":"127.0.0.1:55128","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:21693 > 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":"warn","ts":"2026-08-19T21:11:27.198397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.255118ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:482"}
{"level":"info","ts":"2026-08-19T21:11:27.198538Z","caller":"traceutil/trace.go:171","msg":"trace[951704793] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:21704; }","duration":"309.467623ms","start":"2026-08-19T21:11:26.889045Z","end":"2026-08-19T21:11:27.198513Z","steps":["trace[951704793] 'agreement among raft nodes before linearized reading'  (duration: 309.125125ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T21:11:27.19859Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T21:11:26.889013Z","time spent":"309.567426ms","remote":"127.0.0.1:55142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":504,"request content":"key:\"/registry/endpointslices/default/kubernetes\" "}
{"level":"warn","ts":"2026-08-19T21:11:27.198749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.898667ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-19T21:11:27.198804Z","caller":"traceutil/trace.go:171","msg":"trace[586297519] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:21704; }","duration":"120.99549ms","start":"2026-08-19T21:11:27.077794Z","end":"2026-08-19T21:11:27.19879Z","steps":["trace[586297519] 'agreement among raft nodes before linearized reading'  (duration: 120.913728ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T21:11:27.549615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.267754ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13360948760368297322 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:21694 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:458 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >>","response":"size:18"}
{"level":"info","ts":"2026-08-19T21:11:27.549834Z","caller":"traceutil/trace.go:171","msg":"trace[2064844129] linearizableReadLoop","detail":"{readStateIndex:22447; appliedIndex:22444; }","duration":"162.668288ms","start":"2026-08-19T21:11:27.38715Z","end":"2026-08-19T21:11:27.549819Z","steps":["trace[2064844129] 'read index received'  (duration: 148.554117ms)","trace[2064844129] 'applied index is now lower than readState.Index'  (duration: 14.113211ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-19T21:11:27.549943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.796422ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephfilesystemsubvolumegroups/\" range_end:\"/registry/ceph.rook.io/cephfilesystemsubvolumegroups0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-19T21:11:27.54999Z","caller":"traceutil/trace.go:171","msg":"trace[673330584] range","detail":"{range_begin:/registry/ceph.rook.io/cephfilesystemsubvolumegroups/; range_end:/registry/ceph.rook.io/cephfilesystemsubvolumegroups0; response_count:0; response_revision:21707; }","duration":"162.895164ms","start":"2026-08-19T21:11:27.387081Z","end":"2026-08-19T21:11:27.549976Z","steps":["trace[673330584] 'agreement among raft nodes before linearized reading'  (duration: 162.786522ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T21:11:27.549948Z","caller":"traceutil/trace.go:171","msg":"trace[1807225518] transaction","detail":"{read_only:false; response_revision:21707; number_of_response:1; }","duration":"201.12776ms","start":"2026-08-19T21:11:27.348776Z","end":"2026-08-19T21:11:27.549904Z","steps":["trace[1807225518] 'process raft request'  (duration: 200.997257ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T21:11:27.549986Z","caller":"traceutil/trace.go:171","msg":"trace[1324844350] transaction","detail":"{read_only:false; response_revision:21705; number_of_response:1; }","duration":"219.077124ms","start":"2026-08-19T21:11:27.330895Z","end":"2026-08-19T21:11:27.549972Z","steps":["trace[1324844350] 'process raft request'  (duration: 38.354419ms)","trace[1324844350] 'compare'  (duration: 180.165612ms)"],"step_count":2}
{"level":"info","ts":"2026-08-19T21:11:27.549914Z","caller":"traceutil/trace.go:171","msg":"trace[1627965766] transaction","detail":"{read_only:false; response_revision:21706; number_of_response:1; }","duration":"216.779758ms","start":"2026-08-19T21:11:27.333099Z","end":"2026-08-19T21:11:27.549879Z","steps":["trace[1627965766] 'process raft request'  (duration: 216.612714ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T21:11:27.913011Z","caller":"traceutil/trace.go:171","msg":"trace[754162650] transaction","detail":"{read_only:false; response_revision:21708; number_of_response:1; }","duration":"319.534756ms","start":"2026-08-19T21:11:27.59247Z","end":"2026-08-19T21:11:27.912005Z","steps":["trace[754162650] 'process raft request'  (duration: 319.072905ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T21:11:27.913231Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T21:11:27.592437Z","time spent":"320.674045ms","remote":"127.0.0.1:55128","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:21697 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"info","ts":"2026-08-19T21:15:38.709055Z","caller":"traceutil/trace.go:171","msg":"trace[682716641] transaction","detail":"{read_only:false; response_revision:24075; number_of_response:1; }","duration":"101.427876ms","start":"2026-08-19T21:15:38.607595Z","end":"2026-08-19T21:15:38.709023Z","steps":["trace[682716641] 'process raft request'  (duration: 96.190599ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T21:15:47.249982Z","caller":"traceutil/trace.go:171","msg":"trace[409360260] linearizableReadLoop","detail":"{readStateIndex:25126; appliedIndex:25125; }","duration":"173.847239ms","start":"2026-08-19T21:15:47.076104Z","end":"2026-08-19T21:15:47.249951Z","steps":["trace[409360260] 'read index received'  (duration: 173.430528ms)","trace[409360260] 'applied index is now lower than readState.Index'  (duration: 415.131µs)"],"step_count":2}
{"level":"warn","ts":"2026-08-19T21:15:47.250257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.140416ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-19T21:15:47.250294Z","caller":"traceutil/trace.go:171","msg":"trace[987675761] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24310; }","duration":"174.238128ms","start":"2026-08-19T21:15:47.076044Z","end":"2026-08-19T21:15:47.250283Z","steps":["trace[987675761] 'agreement among raft nodes before linearized reading'  (duration: 174.139106ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T21:15:47.250298Z","caller":"traceutil/trace.go:171","msg":"trace[610935111] transaction","detail":"{read_only:false; response_revision:24310; number_of_response:1; }","duration":"225.403368ms","start":"2026-08-19T21:15:47.02487Z","end":"2026-08-19T21:15:47.250273Z","steps":["trace[610935111] 'process raft request'  (duration: 224.765032ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T21:15:47.861372Z","caller":"traceutil/trace.go:171","msg":"trace[1288759658] transaction","detail":"{read_only:false; response_revision:24311; number_of_response:1; }","duration":"487.684707ms","start":"2026-08-19T21:15:47.373642Z","end":"2026-08-19T21:15:47.861327Z","steps":["trace[1288759658] 'process raft request'  (duration: 397.75258ms)","trace[1288759658] 'compare'  (duration: 89.713292ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-19T21:15:47.86156Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T21:15:47.373608Z","time spent":"487.855792ms","remote":"127.0.0.1:55128","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" mod_revision:24143 > success:<request_put:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" value_size:416 >> failure:<request_range:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" > >"}
{"level":"info","ts":"2026-08-19T21:15:47.922922Z","caller":"traceutil/trace.go:171","msg":"trace[880545642] linearizableReadLoop","detail":"{readStateIndex:25128; appliedIndex:25126; }","duration":"320.974752ms","start":"2026-08-19T21:15:47.601911Z","end":"2026-08-19T21:15:47.922886Z","steps":["trace[880545642] 'read index received'  (duration: 169.578306ms)","trace[880545642] 'applied index is now lower than readState.Index'  (duration: 151.394546ms)"],"step_count":2}
{"level":"info","ts":"2026-08-19T21:15:47.923062Z","caller":"traceutil/trace.go:171","msg":"trace[1014410789] transaction","detail":"{read_only:false; response_revision:24312; number_of_response:1; }","duration":"382.446531ms","start":"2026-08-19T21:15:47.540603Z","end":"2026-08-19T21:15:47.923049Z","steps":["trace[1014410789] 'process raft request'  (duration: 382.111803ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T21:15:47.923187Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T21:15:47.540564Z","time spent":"382.523982ms","remote":"127.0.0.1:55128","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":498,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" mod_revision:24275 > success:<request_put:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" value_size:442 >> failure:<request_range:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" > >"}
{"level":"warn","ts":"2026-08-19T21:15:47.923421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"321.471533ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"}
{"level":"info","ts":"2026-08-19T21:15:47.923575Z","caller":"traceutil/trace.go:171","msg":"trace[628361462] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:24312; }","duration":"321.674478ms","start":"2026-08-19T21:15:47.601859Z","end":"2026-08-19T21:15:47.923533Z","steps":["trace[628361462] 'agreement among raft nodes before linearized reading'  (duration: 321.207857ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T21:15:47.923648Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T21:15:47.601844Z","time spent":"321.788041ms","remote":"127.0.0.1:55128","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":531,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-08-19T21:15:47.987581Z","caller":"traceutil/trace.go:171","msg":"trace[2477753] transaction","detail":"{read_only:false; response_revision:24314; number_of_response:1; }","duration":"119.464263ms","start":"2026-08-19T21:15:47.868089Z","end":"2026-08-19T21:15:47.987553Z","steps":["trace[2477753] 'process raft request'  (duration: 119.36375ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T21:15:47.987695Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"379.381005ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"}
{"level":"info","ts":"2026-08-19T21:15:47.987763Z","caller":"traceutil/trace.go:171","msg":"trace[771676124] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:24314; }","duration":"379.503119ms","start":"2026-08-19T21:15:47.608243Z","end":"2026-08-19T21:15:47.987746Z","steps":["trace[771676124] 'agreement among raft nodes before linearized reading'  (duration: 379.289714ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T21:15:47.987802Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T21:15:47.608215Z","time spent":"379.576421ms","remote":"127.0.0.1:55128","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":463,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-08-19T21:15:47.987866Z","caller":"traceutil/trace.go:171","msg":"trace[1941364430] transaction","detail":"{read_only:false; response_revision:24313; number_of_response:1; }","duration":"191.828963ms","start":"2026-08-19T21:15:47.796013Z","end":"2026-08-19T21:15:47.987842Z","steps":["trace[1941364430] 'process raft request'  (duration: 191.222339ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T21:15:47.989663Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.579553ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:9"}
{"level":"info","ts":"2026-08-19T21:15:47.989786Z","caller":"traceutil/trace.go:171","msg":"trace[1682642559] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:24314; }","duration":"318.788958ms","start":"2026-08-19T21:15:47.670974Z","end":"2026-08-19T21:15:47.989763Z","steps":["trace[1682642559] 'agreement among raft nodes before linearized reading'  (duration: 316.632436ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T21:15:47.989852Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T21:15:47.670938Z","time spent":"318.898501ms","remote":"127.0.0.1:54942","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":2463,"response size":31,"request content":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true "}
{"level":"info","ts":"2026-08-19T21:16:13.299799Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":21632}
{"level":"info","ts":"2026-08-19T21:16:13.406167Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":21632,"took":"102.01455ms","hash":2825306605,"current-db-size-bytes":57729024,"current-db-size":"58 MB","current-db-size-in-use-bytes":42430464,"current-db-size-in-use":"42 MB"}
{"level":"info","ts":"2026-08-19T21:16:13.406233Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2825306605,"revision":21632,"compact-revision":19591}
{"level":"info","ts":"2026-08-19T21:16:33.29996Z","caller":"traceutil/trace.go:171","msg":"trace[372467662] transaction","detail":"{read_only:false; response_revision:24750; number_of_response:1; }","duration":"318.149314ms","start":"2026-08-19T21:16:32.981773Z","end":"2026-08-19T21:16:33.299923Z","steps":["trace[372467662] 'process raft request'  (duration: 316.483203ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T21:16:33.300066Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.708631ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-19T21:16:33.300099Z","caller":"traceutil/trace.go:171","msg":"trace[147422822] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24751; }","duration":"224.757992ms","start":"2026-08-19T21:16:33.075334Z","end":"2026-08-19T21:16:33.300092Z","steps":["trace[147422822] 'agreement among raft nodes before linearized reading'  (duration: 224.68811ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T21:16:33.299977Z","caller":"traceutil/trace.go:171","msg":"trace[200472780] linearizableReadLoop","detail":"{readStateIndex:25579; appliedIndex:25577; }","duration":"224.592717ms","start":"2026-08-19T21:16:33.07535Z","end":"2026-08-19T21:16:33.299943Z","steps":["trace[200472780] 'read index received'  (duration: 222.994038ms)","trace[200472780] 'applied index is now lower than readState.Index'  (duration: 1.590729ms)"],"step_count":2}
{"level":"info","ts":"2026-08-19T21:16:33.300095Z","caller":"traceutil/trace.go:171","msg":"trace[1224757577] transaction","detail":"{read_only:false; response_revision:24751; number_of_response:1; }","duration":"312.554018ms","start":"2026-08-19T21:16:32.987482Z","end":"2026-08-19T21:16:33.300036Z","steps":["trace[1224757577] 'process raft request'  (duration: 312.368083ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T21:16:33.300157Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T21:16:32.981739Z","time spent":"318.317768ms","remote":"127.0.0.1:55128","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:24722 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:478 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-08-19T21:16:33.300345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.005107ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"}
{"level":"info","ts":"2026-08-19T21:16:33.300407Z","caller":"traceutil/trace.go:171","msg":"trace[63083442] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:24751; }","duration":"213.09796ms","start":"2026-08-19T21:16:33.087293Z","end":"2026-08-19T21:16:33.300391Z","steps":["trace[63083442] 'agreement among raft nodes before linearized reading'  (duration: 212.913346ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T21:16:33.30043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.322237ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/capo-system/capo-controller-manager-8c5df4f-6cglh\" ","response":"range_response_count:1 size:2901"}
{"level":"info","ts":"2026-08-19T21:16:33.300455Z","caller":"traceutil/trace.go:171","msg":"trace[161182343] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/capo-system/capo-controller-manager-8c5df4f-6cglh; range_end:; response_count:1; response_revision:24751; }","duration":"154.390538ms","start":"2026-08-19T21:16:33.146056Z","end":"2026-08-19T21:16:33.300447Z","steps":["trace[161182343] 'agreement among raft nodes before linearized reading'  (duration: 154.311756ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T21:16:33.300451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.834827ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" ","response":"range_response_count:1 size:644"}
{"level":"info","ts":"2026-08-19T21:16:33.300547Z","caller":"traceutil/trace.go:171","msg":"trace[1551405694] range","detail":"{range_begin:/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi; range_end:; response_count:1; response_revision:24751; }","duration":"137.96902ms","start":"2026-08-19T21:16:33.162553Z","end":"2026-08-19T21:16:33.300522Z","steps":["trace[1551405694] 'agreement among raft nodes before linearized reading'  (duration: 137.690003ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T21:16:33.300476Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T21:16:32.987468Z","time spent":"312.804604ms","remote":"127.0.0.1:55128","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:24723 > 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-08-19T21:16:33.300578Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.593447ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"}
{"level":"info","ts":"2026-08-19T21:16:33.300622Z","caller":"traceutil/trace.go:171","msg":"trace[2141989841] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:24751; }","duration":"205.653739ms","start":"2026-08-19T21:16:33.094953Z","end":"2026-08-19T21:16:33.300607Z","steps":["trace[2141989841] 'agreement among raft nodes before linearized reading'  (duration: 205.560247ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T21:17:10.584032Z","caller":"traceutil/trace.go:171","msg":"trace[764046346] linearizableReadLoop","detail":"{readStateIndex:26034; appliedIndex:26032; }","duration":"113.006825ms","start":"2026-08-19T21:17:10.470998Z","end":"2026-08-19T21:17:10.584005Z","steps":["trace[764046346] 'read index received'  (duration: 32.438815ms)","trace[764046346] 'applied index is now lower than readState.Index'  (duration: 80.56659ms)"],"step_count":2}
{"level":"info","ts":"2026-08-19T21:17:10.584175Z","caller":"traceutil/trace.go:171","msg":"trace[603567523] transaction","detail":"{read_only:false; response_revision:25196; number_of_response:1; }","duration":"132.803654ms","start":"2026-08-19T21:17:10.451327Z","end":"2026-08-19T21:17:10.58413Z","steps":["trace[603567523] 'process raft request'  (duration: 132.436026ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T21:17:10.58422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.199381ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/magnum-ks-user\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-19T21:17:10.584286Z","caller":"traceutil/trace.go:171","msg":"trace[426884705] range","detail":"{range_begin:/registry/jobs/openstack/magnum-ks-user; range_end:; response_count:0; response_revision:25196; }","duration":"113.411046ms","start":"2026-08-19T21:17:10.470859Z","end":"2026-08-19T21:17:10.58427Z","steps":["trace[426884705] 'agreement among raft nodes before linearized reading'  (duration: 113.281423ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T21:17:10.584308Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.31613ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/magnum-db-sync\" ","response":"range_response_count:1 size:5080"}
{"level":"info","ts":"2026-08-19T21:17:10.584351Z","caller":"traceutil/trace.go:171","msg":"trace[112599516] range","detail":"{range_begin:/registry/jobs/openstack/magnum-db-sync; range_end:; response_count:1; response_revision:25196; }","duration":"110.370262ms","start":"2026-08-19T21:17:10.473955Z","end":"2026-08-19T21:17:10.584326Z","steps":["trace[112599516] 'agreement among raft nodes before linearized reading'  (duration: 110.222588ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T21:17:10.584358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.673227ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/magnum-db-sync-b2mx9\" ","response":"range_response_count:1 size:6611"}
{"level":"info","ts":"2026-08-19T21:17:10.584421Z","caller":"traceutil/trace.go:171","msg":"trace[1876074388] range","detail":"{range_begin:/registry/pods/openstack/magnum-db-sync-b2mx9; range_end:; response_count:1; response_revision:25196; }","duration":"100.756929ms","start":"2026-08-19T21:17:10.483649Z","end":"2026-08-19T21:17:10.584406Z","steps":["trace[1876074388] 'agreement among raft nodes before linearized reading'  (duration: 100.579955ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T21:17:10.584505Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.30277ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/magnum-domain-ks-user\" ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-08-19T21:17:10.584446Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.28428ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/magnum-ks-endpoints\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-19T21:17:10.584534Z","caller":"traceutil/trace.go:171","msg":"trace[571517950] range","detail":"{range_begin:/registry/jobs/openstack/magnum-domain-ks-user; range_end:; response_count:0; response_revision:25196; }","duration":"110.348391ms","start":"2026-08-19T21:17:10.474179Z","end":"2026-08-19T21:17:10.584527Z","steps":["trace[571517950] 'agreement among raft nodes before linearized reading'  (duration: 110.30327ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T21:17:10.584573Z","caller":"traceutil/trace.go:171","msg":"trace[2061403498] range","detail":"{range_begin:/registry/jobs/openstack/magnum-ks-endpoints; range_end:; response_count:0; response_revision:25196; }","duration":"110.465774ms","start":"2026-08-19T21:17:10.474078Z","end":"2026-08-19T21:17:10.584544Z","steps":["trace[2061403498] 'agreement among raft nodes before linearized reading'  (duration: 110.259599ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T21:17:10.584457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.408863ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/magnum-rabbit-init\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-19T21:17:10.584721Z","caller":"traceutil/trace.go:171","msg":"trace[1819912099] range","detail":"{range_begin:/registry/jobs/openstack/magnum-rabbit-init; range_end:; response_count:0; response_revision:25196; }","duration":"110.676899ms","start":"2026-08-19T21:17:10.474024Z","end":"2026-08-19T21:17:10.584701Z","steps":["trace[1819912099] 'agreement among raft nodes before linearized reading'  (duration: 110.407713ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T21:17:19.210025Z","caller":"traceutil/trace.go:171","msg":"trace[1381521137] linearizableReadLoop","detail":"{readStateIndex:26105; appliedIndex:26104; }","duration":"132.886028ms","start":"2026-08-19T21:17:19.077116Z","end":"2026-08-19T21:17:19.210002Z","steps":["trace[1381521137] 'read index received'  (duration: 132.683063ms)","trace[1381521137] 'applied index is now lower than readState.Index'  (duration: 201.795µs)"],"step_count":2}
{"level":"info","ts":"2026-08-19T21:17:19.210354Z","caller":"traceutil/trace.go:171","msg":"trace[1941992866] transaction","detail":"{read_only:false; response_revision:25265; number_of_response:1; }","duration":"171.036021ms","start":"2026-08-19T21:17:19.039306Z","end":"2026-08-19T21:17:19.210342Z","steps":["trace[1941992866] 'process raft request'  (duration: 170.455267ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T21:17:19.210678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.547504ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-19T21:17:19.210729Z","caller":"traceutil/trace.go:171","msg":"trace[356899055] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25265; }","duration":"133.646497ms","start":"2026-08-19T21:17:19.077068Z","end":"2026-08-19T21:17:19.210715Z","steps":["trace[356899055] 'agreement among raft nodes before linearized reading'  (duration: 133.556294ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T21:17:19.871422Z","caller":"traceutil/trace.go:171","msg":"trace[15726289] transaction","detail":"{read_only:false; response_revision:25272; number_of_response:1; }","duration":"129.069705ms","start":"2026-08-19T21:17:19.742326Z","end":"2026-08-19T21:17:19.871396Z","steps":["trace[15726289] 'process raft request'  (duration: 128.701046ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T21:17:19.871592Z","caller":"traceutil/trace.go:171","msg":"trace[1747096222] transaction","detail":"{read_only:false; response_revision:25273; number_of_response:1; }","duration":"120.856956ms","start":"2026-08-19T21:17:19.750698Z","end":"2026-08-19T21:17:19.871555Z","steps":["trace[1747096222] 'process raft request'  (duration: 120.520108ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T21:17:29.717675Z","caller":"traceutil/trace.go:171","msg":"trace[1743734448] transaction","detail":"{read_only:false; response_revision:25352; number_of_response:1; }","duration":"126.334949ms","start":"2026-08-19T21:17:29.591304Z","end":"2026-08-19T21:17:29.717639Z","steps":["trace[1743734448] 'process raft request'  (duration: 101.769354ms)","trace[1743734448] 'compare'  (duration: 24.34967ms)"],"step_count":2}
{"level":"info","ts":"2026-08-19T21:17:29.752471Z","caller":"traceutil/trace.go:171","msg":"trace[544418455] transaction","detail":"{read_only:false; response_revision:25353; number_of_response:1; }","duration":"153.721462ms","start":"2026-08-19T21:17:29.598709Z","end":"2026-08-19T21:17:29.752431Z","steps":["trace[544418455] 'process raft request'  (duration: 153.443095ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T21:17:29.953939Z","caller":"traceutil/trace.go:171","msg":"trace[189027162] transaction","detail":"{read_only:false; response_revision:25356; number_of_response:1; }","duration":"167.615188ms","start":"2026-08-19T21:17:29.786294Z","end":"2026-08-19T21:17:29.953909Z","steps":["trace[189027162] 'process raft request'  (duration: 167.545096ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T21:17:29.954279Z","caller":"traceutil/trace.go:171","msg":"trace[200583803] transaction","detail":"{read_only:false; response_revision:25355; number_of_response:1; }","duration":"194.229663ms","start":"2026-08-19T21:17:29.760023Z","end":"2026-08-19T21:17:29.954253Z","steps":["trace[200583803] 'process raft request'  (duration: 186.153848ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T21:17:30.39838Z","caller":"traceutil/trace.go:171","msg":"trace[206759879] linearizableReadLoop","detail":"{readStateIndex:26202; appliedIndex:26201; }","duration":"204.47717ms","start":"2026-08-19T21:17:30.193879Z","end":"2026-08-19T21:17:30.398356Z","steps":["trace[206759879] 'read index received'  (duration: 204.308426ms)","trace[206759879] 'applied index is now lower than readState.Index'  (duration: 167.814µs)"],"step_count":2}
{"level":"warn","ts":"2026-08-19T21:17:30.398563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.663596ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-cinder-server-0\" ","response":"range_response_count:1 size:1858"}
{"level":"info","ts":"2026-08-19T21:17:30.398591Z","caller":"traceutil/trace.go:171","msg":"trace[1127566861] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-cinder-server-0; range_end:; response_count:1; response_revision:25360; }","duration":"204.709727ms","start":"2026-08-19T21:17:30.19387Z","end":"2026-08-19T21:17:30.39858Z","steps":["trace[1127566861] 'agreement among raft nodes before linearized reading'  (duration: 204.575104ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T21:17:30.398746Z","caller":"traceutil/trace.go:171","msg":"trace[1414274709] transaction","detail":"{read_only:false; response_revision:25360; number_of_response:1; }","duration":"262.674599ms","start":"2026-08-19T21:17:30.136044Z","end":"2026-08-19T21:17:30.398719Z","steps":["trace[1414274709] 'process raft request'  (duration: 262.148997ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T21:17:31.026099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.655735ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-19T21:17:31.026229Z","caller":"traceutil/trace.go:171","msg":"trace[114767945] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:25363; }","duration":"121.797959ms","start":"2026-08-19T21:17:30.904416Z","end":"2026-08-19T21:17:31.026214Z","steps":["trace[114767945] 'range keys from in-memory index tree'  (duration: 121.638855ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T21:17:31.026536Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.371831ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13360948760368307267 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:25348 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >>","response":"size:18"}
{"level":"info","ts":"2026-08-19T21:17:31.026588Z","caller":"traceutil/trace.go:171","msg":"trace[702591028] linearizableReadLoop","detail":"{readStateIndex:26206; appliedIndex:26205; }","duration":"250.259219ms","start":"2026-08-19T21:17:30.776321Z","end":"2026-08-19T21:17:31.02658Z","steps":["trace[702591028] 'read index received'  (duration: 82.53767ms)","trace[702591028] 'applied index is now lower than readState.Index'  (duration: 167.720599ms)"],"step_count":2}
{"level":"info","ts":"2026-08-19T21:17:31.026776Z","caller":"traceutil/trace.go:171","msg":"trace[885939706] transaction","detail":"{read_only:false; response_revision:25364; number_of_response:1; }","duration":"258.340646ms","start":"2026-08-19T21:17:30.768427Z","end":"2026-08-19T21:17:31.026768Z","steps":["trace[885939706] 'process raft request'  (duration: 90.654416ms)","trace[885939706] 'compare'  (duration: 167.069384ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-19T21:17:31.026954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.54118ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/magnum-ks-endpoints\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-19T21:17:31.027042Z","caller":"traceutil/trace.go:171","msg":"trace[628763251] range","detail":"{range_begin:/registry/jobs/openstack/magnum-ks-endpoints; range_end:; response_count:0; response_revision:25364; }","duration":"232.668353ms","start":"2026-08-19T21:17:30.794354Z","end":"2026-08-19T21:17:31.027023Z","steps":["trace[628763251] 'agreement among raft nodes before linearized reading'  (duration: 232.476358ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T21:17:31.026986Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.643032ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/magnum-rabbit-init\" ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-08-19T21:17:31.026883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.533597ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-08-19T21:17:31.027133Z","caller":"traceutil/trace.go:171","msg":"trace[660359149] range","detail":"{range_begin:/registry/jobs/openstack/magnum-rabbit-init; range_end:; response_count:0; response_revision:25364; }","duration":"232.833927ms","start":"2026-08-19T21:17:30.794278Z","end":"2026-08-19T21:17:31.027112Z","steps":["trace[660359149] 'agreement among raft nodes before linearized reading'  (duration: 232.590141ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T21:17:31.027242Z","caller":"traceutil/trace.go:171","msg":"trace[2072229043] range","detail":"{range_begin:/registry/ingress/; range_end:/registry/ingress0; response_count:0; response_revision:25364; }","duration":"250.955197ms","start":"2026-08-19T21:17:30.776271Z","end":"2026-08-19T21:17:31.027226Z","steps":["trace[2072229043] 'agreement among raft nodes before linearized reading'  (duration: 250.508926ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T21:17:31.027284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.519752ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/magnum-ks-user\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-19T21:17:31.027358Z","caller":"traceutil/trace.go:171","msg":"trace[289152784] range","detail":"{range_begin:/registry/jobs/openstack/magnum-ks-user; range_end:; response_count:0; response_revision:25364; }","duration":"235.613185ms","start":"2026-08-19T21:17:30.791727Z","end":"2026-08-19T21:17:31.02734Z","steps":["trace[289152784] 'agreement among raft nodes before linearized reading'  (duration: 235.509832ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T21:17:31.027684Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.471786ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/magnum-domain-ks-user\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-19T21:17:31.027806Z","caller":"traceutil/trace.go:171","msg":"trace[468511306] range","detail":"{range_begin:/registry/jobs/openstack/magnum-domain-ks-user; range_end:; response_count:0; response_revision:25364; }","duration":"236.689371ms","start":"2026-08-19T21:17:30.791086Z","end":"2026-08-19T21:17:31.027776Z","steps":["trace[468511306] 'agreement among raft nodes before linearized reading'  (duration: 235.733318ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T21:17:31.027881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.523373ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/magnum-db-sync\" ","response":"range_response_count:1 size:5080"}
{"level":"info","ts":"2026-08-19T21:17:31.027936Z","caller":"traceutil/trace.go:171","msg":"trace[379692129] range","detail":"{range_begin:/registry/jobs/openstack/magnum-db-sync; range_end:; response_count:1; response_revision:25364; }","duration":"233.594706ms","start":"2026-08-19T21:17:30.794328Z","end":"2026-08-19T21:17:31.027922Z","steps":["trace[379692129] 'agreement among raft nodes before linearized reading'  (duration: 232.486399ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T21:17:57.986138Z","caller":"traceutil/trace.go:171","msg":"trace[1897343067] transaction","detail":"{read_only:false; response_revision:25565; number_of_response:1; }","duration":"103.581728ms","start":"2026-08-19T21:17:57.882525Z","end":"2026-08-19T21:17:57.986107Z","steps":["trace[1897343067] 'process raft request'  (duration: 103.154438ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T21:18:32.382355Z","caller":"traceutil/trace.go:171","msg":"trace[395236509] transaction","detail":"{read_only:false; response_revision:25824; number_of_response:1; }","duration":"106.821756ms","start":"2026-08-19T21:18:32.275478Z","end":"2026-08-19T21:18:32.3823Z","steps":["trace[395236509] 'process raft request'  (duration: 106.636092ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T21:18:50.624061Z","caller":"traceutil/trace.go:171","msg":"trace[1282740630] transaction","detail":"{read_only:false; response_revision:25958; number_of_response:1; }","duration":"121.712536ms","start":"2026-08-19T21:18:50.50231Z","end":"2026-08-19T21:18:50.624022Z","steps":["trace[1282740630] 'process raft request'  (duration: 117.947965ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T21:18:51.825719Z","caller":"traceutil/trace.go:171","msg":"trace[1634168832] transaction","detail":"{read_only:false; response_revision:25970; number_of_response:1; }","duration":"112.427503ms","start":"2026-08-19T21:18:51.71325Z","end":"2026-08-19T21:18:51.825678Z","steps":["trace[1634168832] 'process raft request'  (duration: 103.814034ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T21:19:33.121009Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-0000000000006a05.wal"}
{"level":"info","ts":"2026-08-19T21:19:33.121663Z","caller":"traceutil/trace.go:171","msg":"trace[1404150530] transaction","detail":"{read_only:false; response_revision:26271; number_of_response:1; }","duration":"185.843349ms","start":"2026-08-19T21:19:32.93577Z","end":"2026-08-19T21:19:33.121613Z","steps":["trace[1404150530] 'process raft request'  (duration: 185.629934ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T21:19:33.135884Z","caller":"traceutil/trace.go:171","msg":"trace[1117703531] transaction","detail":"{read_only:false; response_revision:26272; number_of_response:1; }","duration":"199.379237ms","start":"2026-08-19T21:19:32.936484Z","end":"2026-08-19T21:19:33.135863Z","steps":["trace[1117703531] 'process raft request'  (duration: 199.207633ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T21:19:33.136329Z","caller":"traceutil/trace.go:171","msg":"trace[1340654532] transaction","detail":"{read_only:false; response_revision:26273; number_of_response:1; }","duration":"101.331495ms","start":"2026-08-19T21:19:33.034935Z","end":"2026-08-19T21:19:33.136266Z","steps":["trace[1340654532] 'process raft request'  (duration: 100.867073ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T21:20:04.96684Z","caller":"traceutil/trace.go:171","msg":"trace[1390705223] transaction","detail":"{read_only:false; response_revision:26523; number_of_response:1; }","duration":"316.344432ms","start":"2026-08-19T21:20:04.650455Z","end":"2026-08-19T21:20:04.9668Z","steps":["trace[1390705223] 'process raft request'  (duration: 257.734276ms)","trace[1390705223] 'compare'  (duration: 58.458002ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-19T21:20:04.967071Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T21:20:04.650444Z","time spent":"316.507196ms","remote":"127.0.0.1:55128","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:26502 > 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":"info","ts":"2026-08-19T21:20:05.17766Z","caller":"traceutil/trace.go:171","msg":"trace[1634056331] transaction","detail":"{read_only:false; response_revision:26526; number_of_response:1; }","duration":"109.385312ms","start":"2026-08-19T21:20:05.06825Z","end":"2026-08-19T21:20:05.177636Z","steps":["trace[1634056331] 'process raft request'  (duration: 109.202668ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T21:20:05.178123Z","caller":"traceutil/trace.go:171","msg":"trace[457718812] transaction","detail":"{read_only:false; response_revision:26527; number_of_response:1; }","duration":"107.509557ms","start":"2026-08-19T21:20:05.07059Z","end":"2026-08-19T21:20:05.1781Z","steps":["trace[457718812] 'process raft request'  (duration: 107.001794ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T21:20:07.700942Z","caller":"traceutil/trace.go:171","msg":"trace[974833537] transaction","detail":"{read_only:false; response_revision:26548; number_of_response:1; }","duration":"106.541024ms","start":"2026-08-19T21:20:07.594364Z","end":"2026-08-19T21:20:07.700905Z","steps":["trace[974833537] 'process raft request'  (duration: 106.304578ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T21:20:10.355503Z","caller":"traceutil/trace.go:171","msg":"trace[1247935035] linearizableReadLoop","detail":"{readStateIndex:27440; appliedIndex:27439; }","duration":"306.261489ms","start":"2026-08-19T21:20:10.049212Z","end":"2026-08-19T21:20:10.355473Z","steps":["trace[1247935035] 'read index received'  (duration: 306.044994ms)","trace[1247935035] 'applied index is now lower than readState.Index'  (duration: 214.715µs)"],"step_count":2}
{"level":"info","ts":"2026-08-19T21:20:10.355654Z","caller":"traceutil/trace.go:171","msg":"trace[2100651168] transaction","detail":"{read_only:false; response_revision:26564; number_of_response:1; }","duration":"306.620547ms","start":"2026-08-19T21:20:10.048973Z","end":"2026-08-19T21:20:10.355593Z","steps":["trace[2100651168] 'process raft request'  (duration: 306.30629ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T21:20:10.355761Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.531025ms","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-08-19T21:20:10.355801Z","caller":"traceutil/trace.go:171","msg":"trace[694474284] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26564; }","duration":"306.621828ms","start":"2026-08-19T21:20:10.049169Z","end":"2026-08-19T21:20:10.355791Z","steps":["trace[694474284] 'agreement among raft nodes before linearized reading'  (duration: 306.443504ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T21:20:10.355841Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T21:20:10.049152Z","time spent":"306.680359ms","remote":"127.0.0.1:55128","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-08-19T21:20:10.355932Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T21:20:10.048925Z","time spent":"306.862984ms","remote":"127.0.0.1:55104","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5597,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/jobs/openstack/heat-engine-cleaner-29786240\" mod_revision:26536 > success:<request_put:<key:\"/registry/jobs/openstack/heat-engine-cleaner-29786240\" value_size:5536 >> failure:<request_range:<key:\"/registry/jobs/openstack/heat-engine-cleaner-29786240\" > >"}
{"level":"warn","ts":"2026-08-19T21:20:10.383157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.336396ms","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-08-19T21:20:10.383603Z","caller":"traceutil/trace.go:171","msg":"trace[1623054578] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:26565; }","duration":"329.51632ms","start":"2026-08-19T21:20:10.053733Z","end":"2026-08-19T21:20:10.38325Z","steps":["trace[1623054578] 'agreement among raft nodes before linearized reading'  (duration: 329.167881ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T21:20:10.383677Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T21:20:10.053719Z","time spent":"329.94257ms","remote":"127.0.0.1:55128","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-08-19T21:20:10.550674Z","caller":"traceutil/trace.go:171","msg":"trace[853824657] transaction","detail":"{read_only:false; response_revision:26568; number_of_response:1; }","duration":"158.030597ms","start":"2026-08-19T21:20:10.392599Z","end":"2026-08-19T21:20:10.55063Z","steps":["trace[853824657] 'process raft request'  (duration: 157.878663ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T21:20:10.550937Z","caller":"traceutil/trace.go:171","msg":"trace[1050696031] transaction","detail":"{read_only:false; response_revision:26567; number_of_response:1; }","duration":"161.077081ms","start":"2026-08-19T21:20:10.389815Z","end":"2026-08-19T21:20:10.550892Z","steps":["trace[1050696031] 'process raft request'  (duration: 160.252541ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T21:20:11.515211Z","caller":"traceutil/trace.go:171","msg":"trace[1705231874] transaction","detail":"{read_only:false; response_revision:26578; number_of_response:1; }","duration":"149.374369ms","start":"2026-08-19T21:20:11.365809Z","end":"2026-08-19T21:20:11.515184Z","steps":["trace[1705231874] 'process raft request'  (duration: 117.535609ms)","trace[1705231874] 'compare'  (duration: 31.704357ms)"],"step_count":2}
{"level":"info","ts":"2026-08-19T21:20:11.628615Z","caller":"traceutil/trace.go:171","msg":"trace[867332435] transaction","detail":"{read_only:false; response_revision:26579; number_of_response:1; }","duration":"159.328439ms","start":"2026-08-19T21:20:11.46925Z","end":"2026-08-19T21:20:11.628578Z","steps":["trace[867332435] 'process raft request'  (duration: 154.01703ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T21:20:11.820492Z","caller":"traceutil/trace.go:171","msg":"trace[1114945453] linearizableReadLoop","detail":"{readStateIndex:27456; appliedIndex:27454; }","duration":"283.102318ms","start":"2026-08-19T21:20:11.537359Z","end":"2026-08-19T21:20:11.820461Z","steps":["trace[1114945453] 'read index received'  (duration: 85.946705ms)","trace[1114945453] 'applied index is now lower than readState.Index'  (duration: 197.154323ms)"],"step_count":2}
{"level":"info","ts":"2026-08-19T21:20:11.82057Z","caller":"traceutil/trace.go:171","msg":"trace[885130083] transaction","detail":"{read_only:false; response_revision:26580; number_of_response:1; }","duration":"293.027199ms","start":"2026-08-19T21:20:11.527497Z","end":"2026-08-19T21:20:11.820524Z","steps":["trace[885130083] 'process raft request'  (duration: 211.873778ms)","trace[885130083] 'compare'  (duration: 80.920995ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-19T21:20:11.820772Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.391796ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/magnum-ks-user\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-19T21:20:11.82085Z","caller":"traceutil/trace.go:171","msg":"trace[1039340165] range","detail":"{range_begin:/registry/jobs/openstack/magnum-ks-user; range_end:; response_count:0; response_revision:26580; }","duration":"283.534359ms","start":"2026-08-19T21:20:11.537301Z","end":"2026-08-19T21:20:11.820836Z","steps":["trace[1039340165] 'agreement among raft nodes before linearized reading'  (duration: 283.336294ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T21:20:11.820867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.06361ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"}
{"level":"info","ts":"2026-08-19T21:20:11.820956Z","caller":"traceutil/trace.go:171","msg":"trace[1598326618] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:26580; }","duration":"281.197393ms","start":"2026-08-19T21:20:11.539743Z","end":"2026-08-19T21:20:11.820941Z","steps":["trace[1598326618] 'agreement among raft nodes before linearized reading'  (duration: 280.927906ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T21:20:11.821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.962097ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/magnum-rabbit-init\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-19T21:20:11.821057Z","caller":"traceutil/trace.go:171","msg":"trace[2032867694] range","detail":"{range_begin:/registry/jobs/openstack/magnum-rabbit-init; range_end:; response_count:0; response_revision:26580; }","duration":"264.050768ms","start":"2026-08-19T21:20:11.556993Z","end":"2026-08-19T21:20:11.821043Z","steps":["trace[2032867694] 'agreement among raft nodes before linearized reading'  (duration: 263.951756ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T21:20:11.821238Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.064722ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"}
{"level":"info","ts":"2026-08-19T21:20:11.821281Z","caller":"traceutil/trace.go:171","msg":"trace[125942384] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26580; }","duration":"101.167274ms","start":"2026-08-19T21:20:11.720101Z","end":"2026-08-19T21:20:11.821268Z","steps":["trace[125942384] 'agreement among raft nodes before linearized reading'  (duration: 101.040931ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T21:20:11.821222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.91576ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/magnum-domain-ks-user\" ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-08-19T21:20:11.821361Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.920948ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/magnum-db-sync\" ","response":"range_response_count:1 size:5080"}
{"level":"warn","ts":"2026-08-19T21:20:11.821388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.191586ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/magnum-ks-endpoints\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-19T21:20:11.821463Z","caller":"traceutil/trace.go:171","msg":"trace[953691331] range","detail":"{range_begin:/registry/jobs/openstack/magnum-db-sync; range_end:; response_count:1; response_revision:26580; }","duration":"262.064891ms","start":"2026-08-19T21:20:11.559378Z","end":"2026-08-19T21:20:11.821442Z","steps":["trace[953691331] 'agreement among raft nodes before linearized reading'  (duration: 261.672361ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T21:20:11.82139Z","caller":"traceutil/trace.go:171","msg":"trace[38206013] range","detail":"{range_begin:/registry/jobs/openstack/magnum-domain-ks-user; range_end:; response_count:0; response_revision:26580; }","duration":"265.165466ms","start":"2026-08-19T21:20:11.556193Z","end":"2026-08-19T21:20:11.821359Z","steps":["trace[38206013] 'agreement among raft nodes before linearized reading'  (duration: 264.821797ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T21:20:11.821491Z","caller":"traceutil/trace.go:171","msg":"trace[150353353] range","detail":"{range_begin:/registry/jobs/openstack/magnum-ks-endpoints; range_end:; response_count:0; response_revision:26580; }","duration":"265.34061ms","start":"2026-08-19T21:20:11.556126Z","end":"2026-08-19T21:20:11.821467Z","steps":["trace[150353353] 'agreement among raft nodes before linearized reading'  (duration: 265.083384ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T21:20:11.822078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.659823ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/alertmanagerconfigs/\" range_end:\"/registry/monitoring.coreos.com/alertmanagerconfigs0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-19T21:20:11.822264Z","caller":"traceutil/trace.go:171","msg":"trace[1569134354] range","detail":"{range_begin:/registry/monitoring.coreos.com/alertmanagerconfigs/; range_end:/registry/monitoring.coreos.com/alertmanagerconfigs0; response_count:0; response_revision:26580; }","duration":"172.151778ms","start":"2026-08-19T21:20:11.650091Z","end":"2026-08-19T21:20:11.822243Z","steps":["trace[1569134354] 'agreement among raft nodes before linearized reading'  (duration: 170.672022ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T21:20:12.086172Z","caller":"traceutil/trace.go:171","msg":"trace[1652439937] transaction","detail":"{read_only:false; response_revision:26581; number_of_response:1; }","duration":"256.469625ms","start":"2026-08-19T21:20:11.829669Z","end":"2026-08-19T21:20:12.086138Z","steps":["trace[1652439937] 'process raft request'  (duration: 256.26099ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T21:20:12.239305Z","caller":"traceutil/trace.go:171","msg":"trace[806510572] transaction","detail":"{read_only:false; response_revision:26582; number_of_response:1; }","duration":"408.850637ms","start":"2026-08-19T21:20:11.830412Z","end":"2026-08-19T21:20:12.239262Z","steps":["trace[806510572] 'process raft request'  (duration: 408.620271ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T21:20:12.239393Z","caller":"traceutil/trace.go:171","msg":"trace[1408343183] transaction","detail":"{read_only:false; response_revision:26583; number_of_response:1; }","duration":"403.21183ms","start":"2026-08-19T21:20:11.836148Z","end":"2026-08-19T21:20:12.23936Z","steps":["trace[1408343183] 'process raft request'  (duration: 403.058346ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T21:20:12.239512Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T21:20:11.830324Z","time spent":"409.076292ms","remote":"127.0.0.1:55104","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5694,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/jobs/openstack/heat-engine-cleaner-29786240\" mod_revision:26578 > success:<request_put:<key:\"/registry/jobs/openstack/heat-engine-cleaner-29786240\" value_size:5633 >> failure:<request_range:<key:\"/registry/jobs/openstack/heat-engine-cleaner-29786240\" > >"}
{"level":"warn","ts":"2026-08-19T21:20:12.239801Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T21:20:11.836114Z","time spent":"403.544058ms","remote":"127.0.0.1:55128","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:26563 > 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-08-19T21:20:12.242638Z","caller":"traceutil/trace.go:171","msg":"trace[520426379] linearizableReadLoop","detail":"{readStateIndex:27459; appliedIndex:27456; }","duration":"398.754852ms","start":"2026-08-19T21:20:11.843862Z","end":"2026-08-19T21:20:12.242617Z","steps":["trace[520426379] 'read index received'  (duration: 242.117199ms)","trace[520426379] 'applied index is now lower than readState.Index'  (duration: 156.636403ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-19T21:20:12.242845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"398.974207ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/machinehealthchecks/\" range_end:\"/registry/cluster.x-k8s.io/machinehealthchecks0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-19T21:20:12.242895Z","caller":"traceutil/trace.go:171","msg":"trace[223115124] range","detail":"{range_begin:/registry/cluster.x-k8s.io/machinehealthchecks/; range_end:/registry/cluster.x-k8s.io/machinehealthchecks0; response_count:0; response_revision:26583; }","duration":"399.06495ms","start":"2026-08-19T21:20:11.843817Z","end":"2026-08-19T21:20:12.242882Z","steps":["trace[223115124] 'agreement among raft nodes before linearized reading'  (duration: 398.946497ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T21:20:12.242913Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.624191ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-08-19T21:20:12.24295Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T21:20:11.843805Z","time spent":"399.128131ms","remote":"127.0.0.1:59266","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":28,"request content":"key:\"/registry/cluster.x-k8s.io/machinehealthchecks/\" range_end:\"/registry/cluster.x-k8s.io/machinehealthchecks0\" count_only:true "}
{"level":"info","ts":"2026-08-19T21:20:12.24299Z","caller":"traceutil/trace.go:171","msg":"trace[1200412067] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26583; }","duration":"165.750334ms","start":"2026-08-19T21:20:12.077221Z","end":"2026-08-19T21:20:12.242972Z","steps":["trace[1200412067] 'agreement among raft nodes before linearized reading'  (duration: 165.626221ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T21:20:35.352021Z","caller":"traceutil/trace.go:171","msg":"trace[622074025] transaction","detail":"{read_only:false; response_revision:26757; number_of_response:1; }","duration":"111.896883ms","start":"2026-08-19T21:20:35.240094Z","end":"2026-08-19T21:20:35.351991Z","steps":["trace[622074025] 'process raft request'  (duration: 110.765955ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T21:21:13.321643Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":24563}
{"level":"info","ts":"2026-08-19T21:21:13.516186Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":24563,"took":"189.365605ms","hash":1940860626,"current-db-size-bytes":57729024,"current-db-size":"58 MB","current-db-size-in-use-bytes":33267712,"current-db-size-in-use":"33 MB"}
{"level":"info","ts":"2026-08-19T21:21:13.516341Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1940860626,"revision":24563,"compact-revision":21632}
{"level":"warn","ts":"2026-08-19T21:22:14.141165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.231577ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13360948760368313304 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:27468 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >>","response":"size:18"}
{"level":"info","ts":"2026-08-19T21:22:14.141316Z","caller":"traceutil/trace.go:171","msg":"trace[1328976046] transaction","detail":"{read_only:false; response_revision:27482; number_of_response:1; }","duration":"197.707266ms","start":"2026-08-19T21:22:13.943585Z","end":"2026-08-19T21:22:14.141292Z","steps":["trace[1328976046] 'process raft request'  (duration: 86.215362ms)","trace[1328976046] 'compare'  (duration: 111.069764ms)"],"step_count":2}
{"level":"info","ts":"2026-08-19T21:22:14.148855Z","caller":"traceutil/trace.go:171","msg":"trace[71036303] linearizableReadLoop","detail":"{readStateIndex:28387; appliedIndex:28385; }","duration":"183.582845ms","start":"2026-08-19T21:22:13.965241Z","end":"2026-08-19T21:22:14.148823Z","steps":["trace[71036303] 'read index received'  (duration: 64.57675ms)","trace[71036303] 'applied index is now lower than readState.Index'  (duration: 119.005025ms)"],"step_count":2}
{"level":"info","ts":"2026-08-19T21:22:14.148958Z","caller":"traceutil/trace.go:171","msg":"trace[941019501] transaction","detail":"{read_only:false; response_revision:27483; number_of_response:1; }","duration":"197.530032ms","start":"2026-08-19T21:22:13.95137Z","end":"2026-08-19T21:22:14.1489Z","steps":["trace[941019501] 'process raft request'  (duration: 197.219054ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T21:22:14.148994Z","caller":"traceutil/trace.go:171","msg":"trace[689816805] transaction","detail":"{read_only:false; response_revision:27484; number_of_response:1; }","duration":"181.579676ms","start":"2026-08-19T21:22:13.96734Z","end":"2026-08-19T21:22:14.148919Z","steps":["trace[689816805] 'process raft request'  (duration: 181.432763ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T21:22:14.149462Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.176669ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/cert-manager/\" range_end:\"/registry/secrets/cert-manager0\" ","response":"range_response_count:4 size:293679"}
{"level":"info","ts":"2026-08-19T21:22:14.149609Z","caller":"traceutil/trace.go:171","msg":"trace[1420488979] range","detail":"{range_begin:/registry/secrets/cert-manager/; range_end:/registry/secrets/cert-manager0; response_count:4; response_revision:27484; }","duration":"184.370514ms","start":"2026-08-19T21:22:13.965206Z","end":"2026-08-19T21:22:14.149576Z","steps":["trace[1420488979] 'agreement among raft nodes before linearized reading'  (duration: 183.847321ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T21:22:29.887835Z","caller":"traceutil/trace.go:171","msg":"trace[1021209928] transaction","detail":"{read_only:false; response_revision:27599; number_of_response:1; }","duration":"115.428918ms","start":"2026-08-19T21:22:29.772341Z","end":"2026-08-19T21:22:29.88777Z","steps":["trace[1021209928] 'process raft request'  (duration: 113.715208ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T21:23:05.623569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.133496ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/ingress-nginx/ingress-nginx-tcp\" ","response":"range_response_count:1 size:1043"}
{"level":"info","ts":"2026-08-19T21:23:05.623657Z","caller":"traceutil/trace.go:171","msg":"trace[1107891058] range","detail":"{range_begin:/registry/configmaps/ingress-nginx/ingress-nginx-tcp; range_end:; response_count:1; response_revision:27854; }","duration":"104.27298ms","start":"2026-08-19T21:23:05.519366Z","end":"2026-08-19T21:23:05.623639Z","steps":["trace[1107891058] 'range keys from in-memory index tree'  (duration: 103.913811ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T21:25:44.717986Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"612d5169b08bb96b","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-08-19T21:25:44.770803Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003}
{"level":"info","ts":"2026-08-19T21:25:44.77094Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003}