{"level":"warn","ts":"2026-04-20T04:53:57.784117Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-04-20T04:53:57.784278Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.116:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.116:2380","--initial-cluster=instance=https://199.204.45.116:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.116:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.116:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]}
{"level":"warn","ts":"2026-04-20T04:53:57.784367Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-04-20T04:53:57.784387Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.116:2380"]}
{"level":"info","ts":"2026-04-20T04:53:57.784662Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-04-20T04:53:57.786423Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.116:2379"]}
{"level":"info","ts":"2026-04-20T04:53:57.786572Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.116:2380"],"listen-peer-urls":["https://199.204.45.116:2380"],"advertise-client-urls":["https://199.204.45.116:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.116:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.116:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"}
{"level":"info","ts":"2026-04-20T04:53:57.79047Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.589234ms"}
{"level":"info","ts":"2026-04-20T04:53:57.796507Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"5caa70ef1dd6dc04","cluster-id":"45afccab143d2c82"}
{"level":"info","ts":"2026-04-20T04:53:57.796579Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 switched to configuration voters=()"}
{"level":"info","ts":"2026-04-20T04:53:57.796609Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 became follower at term 0"}
{"level":"info","ts":"2026-04-20T04:53:57.796621Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 5caa70ef1dd6dc04 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-04-20T04:53:57.796639Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 became follower at term 1"}
{"level":"info","ts":"2026-04-20T04:53:57.79668Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 switched to configuration voters=(6677273569830296580)"}
{"level":"warn","ts":"2026-04-20T04:53:57.808027Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-04-20T04:53:57.811113Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-04-20T04:53:57.812772Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"}
{"level":"info","ts":"2026-04-20T04:53:57.816152Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"5caa70ef1dd6dc04","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-04-20T04:53:57.816391Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"5caa70ef1dd6dc04","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-04-20T04:53:57.816454Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"}
{"level":"info","ts":"2026-04-20T04:53:57.816555Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"}
{"level":"info","ts":"2026-04-20T04:53:57.816569Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"}
{"level":"info","ts":"2026-04-20T04:53:57.817438Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 switched to configuration voters=(6677273569830296580)"}
{"level":"info","ts":"2026-04-20T04:53:57.817621Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"45afccab143d2c82","local-member-id":"5caa70ef1dd6dc04","added-peer-id":"5caa70ef1dd6dc04","added-peer-peer-urls":["https://199.204.45.116:2380"]}
{"level":"info","ts":"2026-04-20T04:53:57.820529Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-04-20T04:53:57.820821Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"5caa70ef1dd6dc04","initial-advertise-peer-urls":["https://199.204.45.116:2380"],"listen-peer-urls":["https://199.204.45.116:2380"],"advertise-client-urls":["https://199.204.45.116:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.116:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-04-20T04:53:57.820872Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-04-20T04:53:57.821024Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.116:2380"}
{"level":"info","ts":"2026-04-20T04:53:57.821043Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.116:2380"}
{"level":"info","ts":"2026-04-20T04:53:57.897107Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 is starting a new election at term 1"}
{"level":"info","ts":"2026-04-20T04:53:57.897195Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 became pre-candidate at term 1"}
{"level":"info","ts":"2026-04-20T04:53:57.89726Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 received MsgPreVoteResp from 5caa70ef1dd6dc04 at term 1"}
{"level":"info","ts":"2026-04-20T04:53:57.897287Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 became candidate at term 2"}
{"level":"info","ts":"2026-04-20T04:53:57.8973Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 received MsgVoteResp from 5caa70ef1dd6dc04 at term 2"}
{"level":"info","ts":"2026-04-20T04:53:57.897332Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 became leader at term 2"}
{"level":"info","ts":"2026-04-20T04:53:57.897402Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 5caa70ef1dd6dc04 elected leader 5caa70ef1dd6dc04 at term 2"}
{"level":"info","ts":"2026-04-20T04:53:57.898493Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"5caa70ef1dd6dc04","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.116:2379]}","request-path":"/0/members/5caa70ef1dd6dc04/attributes","cluster-id":"45afccab143d2c82","publish-timeout":"7s"}
{"level":"info","ts":"2026-04-20T04:53:57.898504Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-20T04:53:57.898558Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-04-20T04:53:57.898617Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-04-20T04:53:57.898743Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-04-20T04:53:57.898781Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-04-20T04:53:57.899292Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"45afccab143d2c82","local-member-id":"5caa70ef1dd6dc04","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-20T04:53:57.899428Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-20T04:53:57.899463Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-20T04:53:57.90197Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.116:2379"}
{"level":"info","ts":"2026-04-20T04:53:57.902027Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-04-20T04:54:12.200616Z","caller":"traceutil/trace.go:171","msg":"trace[1911368729] transaction","detail":"{read_only:false; response_revision:361; number_of_response:1; }","duration":"160.426262ms","start":"2026-04-20T04:54:12.040163Z","end":"2026-04-20T04:54:12.200589Z","steps":["trace[1911368729] 'process raft request'  (duration: 160.267378ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T04:54:12.589149Z","caller":"traceutil/trace.go:171","msg":"trace[1819180135] linearizableReadLoop","detail":"{readStateIndex:374; appliedIndex:373; }","duration":"117.485018ms","start":"2026-04-20T04:54:12.471634Z","end":"2026-04-20T04:54:12.589119Z","steps":["trace[1819180135] 'read index received'  (duration: 117.274813ms)","trace[1819180135] 'applied index is now lower than readState.Index'  (duration: 208.755µs)"],"step_count":2}
{"level":"warn","ts":"2026-04-20T04:54:12.589315Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.654572ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-04-20T04:54:12.589407Z","caller":"traceutil/trace.go:171","msg":"trace[1792682224] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:362; }","duration":"117.801895ms","start":"2026-04-20T04:54:12.471583Z","end":"2026-04-20T04:54:12.589385Z","steps":["trace[1792682224] 'agreement among raft nodes before linearized reading'  (duration: 117.646171ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T04:54:12.589485Z","caller":"traceutil/trace.go:171","msg":"trace[1251112191] transaction","detail":"{read_only:false; response_revision:362; number_of_response:1; }","duration":"207.722538ms","start":"2026-04-20T04:54:12.381736Z","end":"2026-04-20T04:54:12.589459Z","steps":["trace[1251112191] 'process raft request'  (duration: 207.204186ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T04:54:28.991749Z","caller":"traceutil/trace.go:171","msg":"trace[1662518155] linearizableReadLoop","detail":"{readStateIndex:536; appliedIndex:535; }","duration":"246.68104ms","start":"2026-04-20T04:54:28.745031Z","end":"2026-04-20T04:54:28.991712Z","steps":["trace[1662518155] 'read index received'  (duration: 240.400223ms)","trace[1662518155] 'applied index is now lower than readState.Index'  (duration: 6.279547ms)"],"step_count":2}
{"level":"info","ts":"2026-04-20T04:54:28.991887Z","caller":"traceutil/trace.go:171","msg":"trace[316325978] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"263.093973ms","start":"2026-04-20T04:54:28.728759Z","end":"2026-04-20T04:54:28.991853Z","steps":["trace[316325978] 'process raft request'  (duration: 256.721364ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T04:54:28.992095Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.044958ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/httproutes.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:150495"}
{"level":"info","ts":"2026-04-20T04:54:28.992167Z","caller":"traceutil/trace.go:171","msg":"trace[1313335370] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/httproutes.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:519; }","duration":"247.181131ms","start":"2026-04-20T04:54:28.744966Z","end":"2026-04-20T04:54:28.992147Z","steps":["trace[1313335370] 'agreement among raft nodes before linearized reading'  (duration: 246.911885ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T04:54:29.001339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.013893ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-20T04:54:29.001476Z","caller":"traceutil/trace.go:171","msg":"trace[685789086] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:520; }","duration":"166.192796ms","start":"2026-04-20T04:54:28.835254Z","end":"2026-04-20T04:54:29.001447Z","steps":["trace[685789086] 'agreement among raft nodes before linearized reading'  (duration: 165.982031ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T04:54:29.00169Z","caller":"traceutil/trace.go:171","msg":"trace[1661887623] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"237.361881ms","start":"2026-04-20T04:54:28.764299Z","end":"2026-04-20T04:54:29.001661Z","steps":["trace[1661887623] 'process raft request'  (duration: 236.750647ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T04:54:30.887324Z","caller":"traceutil/trace.go:171","msg":"trace[284108227] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"171.748906ms","start":"2026-04-20T04:54:30.715545Z","end":"2026-04-20T04:54:30.887294Z","steps":["trace[284108227] 'process raft request'  (duration: 170.759543ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T04:54:35.047552Z","caller":"traceutil/trace.go:171","msg":"trace[1694464177] transaction","detail":"{read_only:false; response_revision:578; number_of_response:1; }","duration":"144.323935ms","start":"2026-04-20T04:54:34.903206Z","end":"2026-04-20T04:54:35.04753Z","steps":["trace[1694464177] 'process raft request'  (duration: 143.962687ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T04:54:35.285556Z","caller":"traceutil/trace.go:171","msg":"trace[1282817336] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"225.800214ms","start":"2026-04-20T04:54:35.059726Z","end":"2026-04-20T04:54:35.285526Z","steps":["trace[1282817336] 'process raft request'  (duration: 225.526087ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T04:54:35.419018Z","caller":"traceutil/trace.go:171","msg":"trace[1497033497] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"332.51791ms","start":"2026-04-20T04:54:35.086455Z","end":"2026-04-20T04:54:35.418973Z","steps":["trace[1497033497] 'process raft request'  (duration: 331.917286ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T04:54:35.418974Z","caller":"traceutil/trace.go:171","msg":"trace[932095931] linearizableReadLoop","detail":"{readStateIndex:598; appliedIndex:597; }","duration":"114.212293ms","start":"2026-04-20T04:54:35.304713Z","end":"2026-04-20T04:54:35.418926Z","steps":["trace[932095931] 'read index received'  (duration: 113.386483ms)","trace[932095931] 'applied index is now lower than readState.Index'  (duration: 824.5µs)"],"step_count":2}
{"level":"warn","ts":"2026-04-20T04:54:35.419376Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.654244ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"info","ts":"2026-04-20T04:54:35.419444Z","caller":"traceutil/trace.go:171","msg":"trace[1002613755] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:580; }","duration":"114.793607ms","start":"2026-04-20T04:54:35.304633Z","end":"2026-04-20T04:54:35.419427Z","steps":["trace[1002613755] 'agreement among raft nodes before linearized reading'  (duration: 114.428338ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T04:54:35.419565Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T04:54:35.086424Z","time spent":"332.660333ms","remote":"127.0.0.1:35710","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036305,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" mod_revision:573 > success:<request_put:<key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" value_size:1036221 >> failure:<request_range:<key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" > >"}
{"level":"warn","ts":"2026-04-20T04:54:36.056299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"558.101708ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15853969938448754891 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:566 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >>","response":"size:16"}
{"level":"info","ts":"2026-04-20T04:54:36.056465Z","caller":"traceutil/trace.go:171","msg":"trace[544078814] linearizableReadLoop","detail":"{readStateIndex:601; appliedIndex:599; }","duration":"221.474622ms","start":"2026-04-20T04:54:35.834976Z","end":"2026-04-20T04:54:36.05645Z","steps":["trace[544078814] 'read index received'  (duration: 43.427628ms)","trace[544078814] 'applied index is now lower than readState.Index'  (duration: 178.046194ms)"],"step_count":2}
{"level":"info","ts":"2026-04-20T04:54:36.056518Z","caller":"traceutil/trace.go:171","msg":"trace[533657594] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"583.479578ms","start":"2026-04-20T04:54:35.472989Z","end":"2026-04-20T04:54:36.056468Z","steps":["trace[533657594] 'process raft request'  (duration: 583.405686ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T04:54:36.056563Z","caller":"traceutil/trace.go:171","msg":"trace[1487715422] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"608.783197ms","start":"2026-04-20T04:54:35.447724Z","end":"2026-04-20T04:54:36.056507Z","steps":["trace[1487715422] 'process raft request'  (duration: 50.264889ms)","trace[1487715422] 'compare'  (duration: 557.942264ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-20T04:54:36.056606Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T04:54:35.472959Z","time spent":"583.607871ms","remote":"127.0.0.1:35890","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" mod_revision:0 > success:<request_put:<key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" value_size:2525 >> failure:<>"}
{"level":"warn","ts":"2026-04-20T04:54:36.056692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.710007ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-04-20T04:54:36.056765Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T04:54:35.447695Z","time spent":"608.957321ms","remote":"127.0.0.1:35914","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:566 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-04-20T04:54:36.056785Z","caller":"traceutil/trace.go:171","msg":"trace[1443696903] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:583; }","duration":"221.803759ms","start":"2026-04-20T04:54:35.834934Z","end":"2026-04-20T04:54:36.056738Z","steps":["trace[1443696903] 'agreement among raft nodes before linearized reading'  (duration: 221.569634ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T04:55:50.880697Z","caller":"traceutil/trace.go:171","msg":"trace[1555374795] transaction","detail":"{read_only:false; response_revision:1421; number_of_response:1; }","duration":"110.388672ms","start":"2026-04-20T04:55:50.770275Z","end":"2026-04-20T04:55:50.880663Z","steps":["trace[1555374795] 'process raft request'  (duration: 74.985305ms)","trace[1555374795] 'compare'  (duration: 35.208292ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-20T04:56:14.227619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.094181ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15853969938448757309 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:1741 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:461 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >>","response":"size:16"}
{"level":"info","ts":"2026-04-20T04:56:14.227806Z","caller":"traceutil/trace.go:171","msg":"trace[251313915] linearizableReadLoop","detail":"{readStateIndex:1865; appliedIndex:1864; }","duration":"360.298932ms","start":"2026-04-20T04:56:13.867483Z","end":"2026-04-20T04:56:14.227782Z","steps":["trace[251313915] 'read index received'  (duration: 255.903433ms)","trace[251313915] 'applied index is now lower than readState.Index'  (duration: 104.393509ms)"],"step_count":2}
{"level":"info","ts":"2026-04-20T04:56:14.227965Z","caller":"traceutil/trace.go:171","msg":"trace[316653912] transaction","detail":"{read_only:false; response_revision:1815; number_of_response:1; }","duration":"370.748572ms","start":"2026-04-20T04:56:13.857201Z","end":"2026-04-20T04:56:14.22795Z","steps":["trace[316653912] 'process raft request'  (duration: 266.142358ms)","trace[316653912] 'compare'  (duration: 103.920857ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-20T04:56:14.22805Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T04:56:13.85718Z","time spent":"370.826693ms","remote":"127.0.0.1:35914","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":537,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:1741 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:461 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-04-20T04:56:14.228164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.006351ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-04-20T04:56:14.228248Z","caller":"traceutil/trace.go:171","msg":"trace[1852543471] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1815; }","duration":"242.147214ms","start":"2026-04-20T04:56:13.98608Z","end":"2026-04-20T04:56:14.228227Z","steps":["trace[1852543471] 'agreement among raft nodes before linearized reading'  (duration: 241.898278ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T04:56:14.228218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"360.681091ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/08db1feb.percona.com\" ","response":"range_response_count:1 size:525"}
{"level":"info","ts":"2026-04-20T04:56:14.228389Z","caller":"traceutil/trace.go:171","msg":"trace[1593716535] range","detail":"{range_begin:/registry/leases/openstack/08db1feb.percona.com; range_end:; response_count:1; response_revision:1815; }","duration":"360.870076ms","start":"2026-04-20T04:56:13.867457Z","end":"2026-04-20T04:56:14.228327Z","steps":["trace[1593716535] 'agreement among raft nodes before linearized reading'  (duration: 360.511187ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T04:56:14.228373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.235713ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"warn","ts":"2026-04-20T04:56:14.228447Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T04:56:13.867372Z","time spent":"361.06347ms","remote":"127.0.0.1:35914","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":547,"request content":"key:\"/registry/leases/openstack/08db1feb.percona.com\" "}
{"level":"info","ts":"2026-04-20T04:56:14.22854Z","caller":"traceutil/trace.go:171","msg":"trace[1243720293] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1815; }","duration":"269.409417ms","start":"2026-04-20T04:56:13.959073Z","end":"2026-04-20T04:56:14.228482Z","steps":["trace[1243720293] 'agreement among raft nodes before linearized reading'  (duration: 268.902934ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T04:56:23.210979Z","caller":"traceutil/trace.go:171","msg":"trace[1836552843] transaction","detail":"{read_only:false; response_revision:1917; number_of_response:1; }","duration":"141.20682ms","start":"2026-04-20T04:56:23.06975Z","end":"2026-04-20T04:56:23.210957Z","steps":["trace[1836552843] 'process raft request'  (duration: 141.058686ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T04:56:57.761512Z","caller":"traceutil/trace.go:171","msg":"trace[31462502] transaction","detail":"{read_only:false; response_revision:2159; number_of_response:1; }","duration":"103.182289ms","start":"2026-04-20T04:56:57.658289Z","end":"2026-04-20T04:56:57.761472Z","steps":["trace[31462502] 'process raft request'  (duration: 102.849311ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T04:56:57.99506Z","caller":"traceutil/trace.go:171","msg":"trace[763109148] transaction","detail":"{read_only:false; response_revision:2160; number_of_response:1; }","duration":"227.72311ms","start":"2026-04-20T04:56:57.767254Z","end":"2026-04-20T04:56:57.994977Z","steps":["trace[763109148] 'process raft request'  (duration: 177.294003ms)","trace[763109148] 'compare'  (duration: 50.250902ms)"],"step_count":2}
{"level":"info","ts":"2026-04-20T04:56:58.007165Z","caller":"traceutil/trace.go:171","msg":"trace[1765919736] linearizableReadLoop","detail":"{readStateIndex:2228; appliedIndex:2226; }","duration":"202.506746ms","start":"2026-04-20T04:56:57.804638Z","end":"2026-04-20T04:56:58.007145Z","steps":["trace[1765919736] 'read index received'  (duration: 139.937578ms)","trace[1765919736] 'applied index is now lower than readState.Index'  (duration: 62.568368ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-20T04:56:58.007355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.99568ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-20T04:56:58.00741Z","caller":"traceutil/trace.go:171","msg":"trace[950638217] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2161; }","duration":"173.106923ms","start":"2026-04-20T04:56:57.834295Z","end":"2026-04-20T04:56:58.007402Z","steps":["trace[950638217] 'agreement among raft nodes before linearized reading'  (duration: 172.961319ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T04:56:58.007545Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.890815ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/percona-xtradb-haproxy-0.18a7f7c3abfc60fe\" ","response":"range_response_count:1 size:846"}
{"level":"info","ts":"2026-04-20T04:56:58.007657Z","caller":"traceutil/trace.go:171","msg":"trace[1919982105] range","detail":"{range_begin:/registry/events/openstack/percona-xtradb-haproxy-0.18a7f7c3abfc60fe; range_end:; response_count:1; response_revision:2161; }","duration":"203.052849ms","start":"2026-04-20T04:56:57.804584Z","end":"2026-04-20T04:56:58.007637Z","steps":["trace[1919982105] 'agreement among raft nodes before linearized reading'  (duration: 202.708211ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T04:56:58.007897Z","caller":"traceutil/trace.go:171","msg":"trace[1542905653] transaction","detail":"{read_only:false; response_revision:2161; number_of_response:1; }","duration":"238.223401ms","start":"2026-04-20T04:56:57.769613Z","end":"2026-04-20T04:56:58.007836Z","steps":["trace[1542905653] 'process raft request'  (duration: 237.431052ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T04:57:33.213666Z","caller":"traceutil/trace.go:171","msg":"trace[810336833] linearizableReadLoop","detail":"{readStateIndex:2539; appliedIndex:2538; }","duration":"104.229453ms","start":"2026-04-20T04:57:33.109416Z","end":"2026-04-20T04:57:33.213645Z","steps":["trace[810336833] 'read index received'  (duration: 104.09474ms)","trace[810336833] 'applied index is now lower than readState.Index'  (duration: 131.153µs)"],"step_count":2}
{"level":"warn","ts":"2026-04-20T04:57:33.21384Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.404418ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1296"}
{"level":"info","ts":"2026-04-20T04:57:33.213871Z","caller":"traceutil/trace.go:171","msg":"trace[1909811180] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2455; }","duration":"104.4792ms","start":"2026-04-20T04:57:33.109382Z","end":"2026-04-20T04:57:33.213862Z","steps":["trace[1909811180] 'agreement among raft nodes before linearized reading'  (duration: 104.343916ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T04:57:33.213782Z","caller":"traceutil/trace.go:171","msg":"trace[1301389769] transaction","detail":"{read_only:false; response_revision:2455; number_of_response:1; }","duration":"244.074051ms","start":"2026-04-20T04:57:32.969658Z","end":"2026-04-20T04:57:33.213732Z","steps":["trace[1301389769] 'process raft request'  (duration: 243.860585ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T04:58:04.910072Z","caller":"traceutil/trace.go:171","msg":"trace[140564840] linearizableReadLoop","detail":"{readStateIndex:2769; appliedIndex:2768; }","duration":"155.967563ms","start":"2026-04-20T04:58:04.754086Z","end":"2026-04-20T04:58:04.910054Z","steps":["trace[140564840] 'read index received'  (duration: 155.84003ms)","trace[140564840] 'applied index is now lower than readState.Index'  (duration: 127.093µs)"],"step_count":2}
{"level":"info","ts":"2026-04-20T04:58:04.910138Z","caller":"traceutil/trace.go:171","msg":"trace[1518405372] transaction","detail":"{read_only:false; response_revision:2673; number_of_response:1; }","duration":"206.907232ms","start":"2026-04-20T04:58:04.703209Z","end":"2026-04-20T04:58:04.910116Z","steps":["trace[1518405372] 'process raft request'  (duration: 206.744448ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T04:58:04.910281Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.175249ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:11496"}
{"level":"info","ts":"2026-04-20T04:58:04.910314Z","caller":"traceutil/trace.go:171","msg":"trace[1416100340] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2673; }","duration":"156.24411ms","start":"2026-04-20T04:58:04.75406Z","end":"2026-04-20T04:58:04.910305Z","steps":["trace[1416100340] 'agreement among raft nodes before linearized reading'  (duration: 156.099246ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T04:58:05.077098Z","caller":"traceutil/trace.go:171","msg":"trace[1427592549] linearizableReadLoop","detail":"{readStateIndex:2772; appliedIndex:2769; }","duration":"161.233909ms","start":"2026-04-20T04:58:04.915839Z","end":"2026-04-20T04:58:05.077073Z","steps":["trace[1427592549] 'read index received'  (duration: 2.311895ms)","trace[1427592549] 'applied index is now lower than readState.Index'  (duration: 158.921124ms)"],"step_count":2}
{"level":"info","ts":"2026-04-20T04:58:05.077121Z","caller":"traceutil/trace.go:171","msg":"trace[1702458781] transaction","detail":"{read_only:false; response_revision:2675; number_of_response:1; }","duration":"162.362706ms","start":"2026-04-20T04:58:04.914723Z","end":"2026-04-20T04:58:05.077085Z","steps":["trace[1702458781] 'process raft request'  (duration: 125.624966ms)","trace[1702458781] 'compare'  (duration: 36.179676ms)"],"step_count":2}
{"level":"info","ts":"2026-04-20T04:58:05.077194Z","caller":"traceutil/trace.go:171","msg":"trace[1896557617] transaction","detail":"{read_only:false; response_revision:2676; number_of_response:1; }","duration":"162.385486ms","start":"2026-04-20T04:58:04.914769Z","end":"2026-04-20T04:58:05.077155Z","steps":["trace[1896557617] 'process raft request'  (duration: 162.232463ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T04:58:05.077291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.443594ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:8612"}
{"level":"info","ts":"2026-04-20T04:58:05.077329Z","caller":"traceutil/trace.go:171","msg":"trace[369073240] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:2676; }","duration":"161.524146ms","start":"2026-04-20T04:58:04.915795Z","end":"2026-04-20T04:58:05.07732Z","steps":["trace[369073240] 'agreement among raft nodes before linearized reading'  (duration: 161.375603ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T04:58:10.394207Z","caller":"traceutil/trace.go:171","msg":"trace[1051571707] transaction","detail":"{read_only:false; response_revision:2709; number_of_response:1; }","duration":"147.686525ms","start":"2026-04-20T04:58:10.246487Z","end":"2026-04-20T04:58:10.394173Z","steps":["trace[1051571707] 'process raft request'  (duration: 147.47487ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T04:58:10.549817Z","caller":"traceutil/trace.go:171","msg":"trace[611619140] transaction","detail":"{read_only:false; number_of_response:0; response_revision:2710; }","duration":"148.499865ms","start":"2026-04-20T04:58:10.401292Z","end":"2026-04-20T04:58:10.549792Z","steps":["trace[611619140] 'process raft request'  (duration: 148.430173ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T04:58:10.549854Z","caller":"traceutil/trace.go:171","msg":"trace[1055456596] transaction","detail":"{read_only:false; response_revision:2710; number_of_response:1; }","duration":"149.801206ms","start":"2026-04-20T04:58:10.400004Z","end":"2026-04-20T04:58:10.549805Z","steps":["trace[1055456596] 'process raft request'  (duration: 67.124697ms)","trace[1055456596] 'compare'  (duration: 82.421553ms)"],"step_count":2}
{"level":"info","ts":"2026-04-20T04:59:07.084136Z","caller":"traceutil/trace.go:171","msg":"trace[487191766] transaction","detail":"{read_only:false; number_of_response:0; response_revision:3265; }","duration":"156.462338ms","start":"2026-04-20T04:59:06.927653Z","end":"2026-04-20T04:59:07.084115Z","steps":["trace[487191766] 'process raft request'  (duration: 131.887265ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T05:00:22.143239Z","caller":"traceutil/trace.go:171","msg":"trace[1403497509] linearizableReadLoop","detail":"{readStateIndex:4543; appliedIndex:4542; }","duration":"146.066349ms","start":"2026-04-20T05:00:21.997143Z","end":"2026-04-20T05:00:22.143209Z","steps":["trace[1403497509] 'read index received'  (duration: 135.953199ms)","trace[1403497509] 'applied index is now lower than readState.Index'  (duration: 10.11193ms)"],"step_count":2}
{"level":"info","ts":"2026-04-20T05:00:22.14329Z","caller":"traceutil/trace.go:171","msg":"trace[708699667] transaction","detail":"{read_only:false; number_of_response:0; response_revision:4364; }","duration":"153.338082ms","start":"2026-04-20T05:00:21.989917Z","end":"2026-04-20T05:00:22.143255Z","steps":["trace[708699667] 'process raft request'  (duration: 143.200031ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T05:00:22.143458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.296114ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:3465"}
{"level":"info","ts":"2026-04-20T05:00:22.143521Z","caller":"traceutil/trace.go:171","msg":"trace[766403242] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:4364; }","duration":"146.410517ms","start":"2026-04-20T05:00:21.997095Z","end":"2026-04-20T05:00:22.143505Z","steps":["trace[766403242] 'agreement among raft nodes before linearized reading'  (duration: 146.214483ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T05:00:24.993002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.808484ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/monitoring/vector\" ","response":"range_response_count:1 size:894"}
{"level":"warn","ts":"2026-04-20T05:00:24.993054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.765207ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-20T05:00:24.993098Z","caller":"traceutil/trace.go:171","msg":"trace[1089992681] range","detail":"{range_begin:/registry/serviceaccounts/monitoring/vector; range_end:; response_count:1; response_revision:4479; }","duration":"224.945687ms","start":"2026-04-20T05:00:24.768133Z","end":"2026-04-20T05:00:24.993078Z","steps":["trace[1089992681] 'range keys from in-memory index tree'  (duration: 224.65296ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T05:00:24.993215Z","caller":"traceutil/trace.go:171","msg":"trace[1324195756] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4479; }","duration":"157.976502ms","start":"2026-04-20T05:00:24.835211Z","end":"2026-04-20T05:00:24.993187Z","steps":["trace[1324195756] 'range keys from in-memory index tree'  (duration: 157.687815ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T05:00:24.993635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.630865ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:25 size:781796"}
{"level":"info","ts":"2026-04-20T05:00:24.993746Z","caller":"traceutil/trace.go:171","msg":"trace[1273812290] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:25; response_revision:4479; }","duration":"147.79884ms","start":"2026-04-20T05:00:24.845925Z","end":"2026-04-20T05:00:24.993723Z","steps":["trace[1273812290] 'range keys from in-memory index tree'  (duration: 147.011781ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T05:00:28.684017Z","caller":"traceutil/trace.go:171","msg":"trace[1479430923] transaction","detail":"{read_only:false; response_revision:4558; number_of_response:1; }","duration":"187.886655ms","start":"2026-04-20T05:00:28.496101Z","end":"2026-04-20T05:00:28.683988Z","steps":["trace[1479430923] 'process raft request'  (duration: 155.850602ms)","trace[1479430923] 'compare'  (duration: 31.91847ms)"],"step_count":2}
{"level":"info","ts":"2026-04-20T05:00:28.901665Z","caller":"traceutil/trace.go:171","msg":"trace[2141768954] transaction","detail":"{read_only:false; response_revision:4562; number_of_response:1; }","duration":"124.516076ms","start":"2026-04-20T05:00:28.777118Z","end":"2026-04-20T05:00:28.901634Z","steps":["trace[2141768954] 'process raft request'  (duration: 124.306691ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T05:00:28.901946Z","caller":"traceutil/trace.go:171","msg":"trace[1061640288] transaction","detail":"{read_only:false; response_revision:4563; number_of_response:1; }","duration":"124.583458ms","start":"2026-04-20T05:00:28.777341Z","end":"2026-04-20T05:00:28.901924Z","steps":["trace[1061640288] 'process raft request'  (duration: 124.215429ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T05:00:28.901949Z","caller":"traceutil/trace.go:171","msg":"trace[212272293] linearizableReadLoop","detail":"{readStateIndex:4747; appliedIndex:4744; }","duration":"118.681697ms","start":"2026-04-20T05:00:28.783238Z","end":"2026-04-20T05:00:28.90192Z","steps":["trace[212272293] 'read index received'  (duration: 5.421399ms)","trace[212272293] 'applied index is now lower than readState.Index'  (duration: 113.259618ms)"],"step_count":2}
{"level":"info","ts":"2026-04-20T05:00:28.902091Z","caller":"traceutil/trace.go:171","msg":"trace[1983397308] transaction","detail":"{read_only:false; response_revision:4564; number_of_response:1; }","duration":"118.626855ms","start":"2026-04-20T05:00:28.783434Z","end":"2026-04-20T05:00:28.902061Z","steps":["trace[1983397308] 'process raft request'  (duration: 118.363549ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T05:00:28.902236Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.974724ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:12975"}
{"level":"info","ts":"2026-04-20T05:00:28.902308Z","caller":"traceutil/trace.go:171","msg":"trace[1163115584] range","detail":"{range_begin:/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4564; }","duration":"119.092346ms","start":"2026-04-20T05:00:28.783193Z","end":"2026-04-20T05:00:28.902285Z","steps":["trace[1163115584] 'agreement among raft nodes before linearized reading'  (duration: 118.891522ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T05:00:28.902417Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.963803ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2082"}
{"level":"info","ts":"2026-04-20T05:00:28.902642Z","caller":"traceutil/trace.go:171","msg":"trace[1074477863] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4564; }","duration":"119.214899ms","start":"2026-04-20T05:00:28.783233Z","end":"2026-04-20T05:00:28.902448Z","steps":["trace[1074477863] 'agreement among raft nodes before linearized reading'  (duration: 118.868141ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T05:00:29.116393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.298531ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15853969938448764078 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" mod_revision:4309 > success:<request_put:<key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" value_size:13198 >> failure:<request_range:<key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" > >>","response":"size:16"}
{"level":"info","ts":"2026-04-20T05:00:29.116502Z","caller":"traceutil/trace.go:171","msg":"trace[1667458985] linearizableReadLoop","detail":"{readStateIndex:4749; appliedIndex:4748; }","duration":"173.213806ms","start":"2026-04-20T05:00:28.943271Z","end":"2026-04-20T05:00:29.116484Z","steps":["trace[1667458985] 'read index received'  (duration: 61.73221ms)","trace[1667458985] 'applied index is now lower than readState.Index'  (duration: 111.480066ms)"],"step_count":2}
{"level":"info","ts":"2026-04-20T05:00:29.116607Z","caller":"traceutil/trace.go:171","msg":"trace[596442082] transaction","detail":"{read_only:false; response_revision:4565; number_of_response:1; }","duration":"202.572785ms","start":"2026-04-20T05:00:28.914021Z","end":"2026-04-20T05:00:29.116594Z","steps":["trace[596442082] 'process raft request'  (duration: 90.965807ms)","trace[596442082] 'compare'  (duration: 111.040585ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-20T05:00:29.116866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.114823ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:11496"}
{"level":"info","ts":"2026-04-20T05:00:29.116972Z","caller":"traceutil/trace.go:171","msg":"trace[1281509708] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4565; }","duration":"152.259167ms","start":"2026-04-20T05:00:28.964687Z","end":"2026-04-20T05:00:29.116946Z","steps":["trace[1281509708] 'agreement among raft nodes before linearized reading'  (duration: 152.033761ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T05:00:29.117085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.78038ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-20T05:00:29.117178Z","caller":"traceutil/trace.go:171","msg":"trace[754770967] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:4565; }","duration":"173.923763ms","start":"2026-04-20T05:00:28.943236Z","end":"2026-04-20T05:00:29.11716Z","steps":["trace[754770967] 'agreement among raft nodes before linearized reading'  (duration: 173.760689ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T05:00:38.052585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.281976ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-20T05:00:38.052682Z","caller":"traceutil/trace.go:171","msg":"trace[1957392667] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4714; }","duration":"217.434309ms","start":"2026-04-20T05:00:37.835229Z","end":"2026-04-20T05:00:38.052664Z","steps":["trace[1957392667] 'range keys from in-memory index tree'  (duration: 217.211554ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T05:00:38.052706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.776935ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/memcached-memcached-c47d949f5-2pp84\" ","response":"range_response_count:1 size:7813"}
{"level":"info","ts":"2026-04-20T05:00:38.052774Z","caller":"traceutil/trace.go:171","msg":"trace[39353162] range","detail":"{range_begin:/registry/pods/openstack/memcached-memcached-c47d949f5-2pp84; range_end:; response_count:1; response_revision:4714; }","duration":"274.869267ms","start":"2026-04-20T05:00:37.77789Z","end":"2026-04-20T05:00:38.052759Z","steps":["trace[39353162] 'range keys from in-memory index tree'  (duration: 274.530499ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T05:00:44.926048Z","caller":"traceutil/trace.go:171","msg":"trace[1892580564] transaction","detail":"{read_only:false; response_revision:4877; number_of_response:1; }","duration":"392.262993ms","start":"2026-04-20T05:00:44.533762Z","end":"2026-04-20T05:00:44.926025Z","steps":["trace[1892580564] 'process raft request'  (duration: 392.061039ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T05:00:44.926249Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T05:00:44.533746Z","time spent":"392.404467ms","remote":"127.0.0.1:36122","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":16428,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/statefulsets/openstack/percona-xtradb-pxc\" mod_revision:4737 > success:<request_put:<key:\"/registry/statefulsets/openstack/percona-xtradb-pxc\" value_size:16368 >> failure:<request_range:<key:\"/registry/statefulsets/openstack/percona-xtradb-pxc\" > >"}
{"level":"info","ts":"2026-04-20T05:00:45.011618Z","caller":"traceutil/trace.go:171","msg":"trace[44685694] transaction","detail":"{read_only:false; response_revision:4878; number_of_response:1; }","duration":"477.801761ms","start":"2026-04-20T05:00:44.533791Z","end":"2026-04-20T05:00:45.011593Z","steps":["trace[44685694] 'process raft request'  (duration: 477.621977ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T05:00:45.01176Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T05:00:44.53378Z","time spent":"477.910294ms","remote":"127.0.0.1:35914","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:4776 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-04-20T05:00:45.011884Z","caller":"traceutil/trace.go:171","msg":"trace[18193307] linearizableReadLoop","detail":"{readStateIndex:5074; appliedIndex:5072; }","duration":"475.524347ms","start":"2026-04-20T05:00:44.536296Z","end":"2026-04-20T05:00:45.011821Z","steps":["trace[18193307] 'read index received'  (duration: 389.57603ms)","trace[18193307] 'applied index is now lower than readState.Index'  (duration: 85.945807ms)"],"step_count":2}
{"level":"info","ts":"2026-04-20T05:00:45.011925Z","caller":"traceutil/trace.go:171","msg":"trace[1415975586] transaction","detail":"{read_only:false; response_revision:4879; number_of_response:1; }","duration":"234.309182ms","start":"2026-04-20T05:00:44.777584Z","end":"2026-04-20T05:00:45.011893Z","steps":["trace[1415975586] 'process raft request'  (duration: 233.969284ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T05:00:45.012162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"475.844774ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/prometheuses/monitoring/kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:7614"}
{"level":"info","ts":"2026-04-20T05:00:45.012209Z","caller":"traceutil/trace.go:171","msg":"trace[1967602678] range","detail":"{range_begin:/registry/monitoring.coreos.com/prometheuses/monitoring/kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:4879; }","duration":"475.934107ms","start":"2026-04-20T05:00:44.536261Z","end":"2026-04-20T05:00:45.012195Z","steps":["trace[1967602678] 'agreement among raft nodes before linearized reading'  (duration: 475.743142ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T05:00:45.012242Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T05:00:44.536246Z","time spent":"475.988698ms","remote":"127.0.0.1:49972","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":1,"response size":7636,"request content":"key:\"/registry/monitoring.coreos.com/prometheuses/monitoring/kube-prometheus-stack-prometheus\" "}
{"level":"info","ts":"2026-04-20T05:00:45.19955Z","caller":"traceutil/trace.go:171","msg":"trace[121809029] linearizableReadLoop","detail":"{readStateIndex:5076; appliedIndex:5075; }","duration":"187.562907ms","start":"2026-04-20T05:00:45.011952Z","end":"2026-04-20T05:00:45.199514Z","steps":["trace[121809029] 'read index received'  (duration: 130.869327ms)","trace[121809029] 'applied index is now lower than readState.Index'  (duration: 56.69275ms)"],"step_count":2}
{"level":"info","ts":"2026-04-20T05:00:45.199656Z","caller":"traceutil/trace.go:171","msg":"trace[371671267] transaction","detail":"{read_only:false; number_of_response:0; response_revision:4879; }","duration":"266.384805ms","start":"2026-04-20T05:00:44.933239Z","end":"2026-04-20T05:00:45.199623Z","steps":["trace[371671267] 'process raft request'  (duration: 209.613063ms)","trace[371671267] 'compare'  (duration: 56.615238ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-20T05:00:45.199741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.791362ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"warn","ts":"2026-04-20T05:00:45.199794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"625.575501ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-576a1e9f-c394-4f7a-abe1-c972ed721805\" ","response":"range_response_count:1 size:3646"}
{"level":"warn","ts":"2026-04-20T05:00:45.199812Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.899189ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-576a1e9f-c394-4f7a-abe1-c972ed721805\" ","response":"range_response_count:1 size:3646"}
{"level":"warn","ts":"2026-04-20T05:00:45.199805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"583.474728ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:16290"}
{"level":"info","ts":"2026-04-20T05:00:45.199869Z","caller":"traceutil/trace.go:171","msg":"trace[2055036852] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-576a1e9f-c394-4f7a-abe1-c972ed721805; range_end:; response_count:1; response_revision:4879; }","duration":"625.675993ms","start":"2026-04-20T05:00:44.57416Z","end":"2026-04-20T05:00:45.199836Z","steps":["trace[2055036852] 'agreement among raft nodes before linearized reading'  (duration: 625.468358ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T05:00:45.199909Z","caller":"traceutil/trace.go:171","msg":"trace[1572267982] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-576a1e9f-c394-4f7a-abe1-c972ed721805; range_end:; response_count:1; response_revision:4879; }","duration":"351.041751ms","start":"2026-04-20T05:00:44.848844Z","end":"2026-04-20T05:00:45.199886Z","steps":["trace[1572267982] 'agreement among raft nodes before linearized reading'  (duration: 350.756785ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T05:00:45.199912Z","caller":"traceutil/trace.go:171","msg":"trace[156204598] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:4879; }","duration":"583.622642ms","start":"2026-04-20T05:00:44.616272Z","end":"2026-04-20T05:00:45.199894Z","steps":["trace[156204598] 'agreement among raft nodes before linearized reading'  (duration: 583.342655ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T05:00:45.199934Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T05:00:44.574098Z","time spent":"625.821446ms","remote":"127.0.0.1:35812","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3668,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-576a1e9f-c394-4f7a-abe1-c972ed721805\" "}
{"level":"warn","ts":"2026-04-20T05:00:45.199961Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T05:00:44.616255Z","time spent":"583.697183ms","remote":"127.0.0.1:35808","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":16312,"request content":"key:\"/registry/minions/instance\" "}
{"level":"info","ts":"2026-04-20T05:00:45.199801Z","caller":"traceutil/trace.go:171","msg":"trace[2107418529] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/; range_end:/registry/mutatingwebhookconfigurations0; response_count:0; response_revision:4879; }","duration":"323.905315ms","start":"2026-04-20T05:00:44.875882Z","end":"2026-04-20T05:00:45.199787Z","steps":["trace[2107418529] 'agreement among raft nodes before linearized reading'  (duration: 323.799882ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T05:00:45.200045Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T05:00:44.87586Z","time spent":"324.147611ms","remote":"127.0.0.1:36156","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":3,"response size":29,"request content":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true "}
{"level":"warn","ts":"2026-04-20T05:00:45.20003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"604.088799ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:660"}
{"level":"warn","ts":"2026-04-20T05:00:45.199961Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T05:00:44.848827Z","time spent":"351.124944ms","remote":"127.0.0.1:35812","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3668,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-576a1e9f-c394-4f7a-abe1-c972ed721805\" "}
{"level":"info","ts":"2026-04-20T05:00:45.200111Z","caller":"traceutil/trace.go:171","msg":"trace[1078936779] range","detail":"{range_begin:/registry/configmaps/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:4879; }","duration":"604.195421ms","start":"2026-04-20T05:00:44.595898Z","end":"2026-04-20T05:00:45.200094Z","steps":["trace[1078936779] 'agreement among raft nodes before linearized reading'  (duration: 603.937715ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T05:00:45.200684Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T05:00:44.595883Z","time spent":"604.781636ms","remote":"127.0.0.1:35726","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":1,"response size":682,"request content":"key:\"/registry/configmaps/openstack/messaging-topology-operator-leader-election\" "}
{"level":"warn","ts":"2026-04-20T05:00:45.201602Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"456.312349ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:57 size:2575989"}
{"level":"info","ts":"2026-04-20T05:00:45.20179Z","caller":"traceutil/trace.go:171","msg":"trace[485801754] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:57; response_revision:4879; }","duration":"456.536374ms","start":"2026-04-20T05:00:44.745232Z","end":"2026-04-20T05:00:45.201769Z","steps":["trace[485801754] 'agreement among raft nodes before linearized reading'  (duration: 454.654919ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T05:00:45.201913Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T05:00:44.745214Z","time spent":"456.679418ms","remote":"127.0.0.1:35726","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":57,"response size":2576011,"request content":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" "}
{"level":"info","ts":"2026-04-20T05:00:56.144929Z","caller":"traceutil/trace.go:171","msg":"trace[887564922] transaction","detail":"{read_only:false; response_revision:5019; number_of_response:1; }","duration":"150.096115ms","start":"2026-04-20T05:00:55.994792Z","end":"2026-04-20T05:00:56.144888Z","steps":["trace[887564922] 'process raft request'  (duration: 149.87317ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T05:00:56.274585Z","caller":"traceutil/trace.go:171","msg":"trace[1802821672] transaction","detail":"{read_only:false; response_revision:5023; number_of_response:1; }","duration":"122.832236ms","start":"2026-04-20T05:00:56.151704Z","end":"2026-04-20T05:00:56.274536Z","steps":["trace[1802821672] 'process raft request'  (duration: 122.684103ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T05:00:56.27487Z","caller":"traceutil/trace.go:171","msg":"trace[1027918867] transaction","detail":"{read_only:false; response_revision:5022; number_of_response:1; }","duration":"123.701407ms","start":"2026-04-20T05:00:56.151141Z","end":"2026-04-20T05:00:56.274842Z","steps":["trace[1027918867] 'process raft request'  (duration: 79.460813ms)","trace[1027918867] 'compare'  (duration: 43.602798ms)"],"step_count":2}
{"level":"info","ts":"2026-04-20T05:00:56.442528Z","caller":"traceutil/trace.go:171","msg":"trace[2008420491] transaction","detail":"{read_only:false; response_revision:5025; number_of_response:1; }","duration":"163.658598ms","start":"2026-04-20T05:00:56.278827Z","end":"2026-04-20T05:00:56.442485Z","steps":["trace[2008420491] 'process raft request'  (duration: 111.427114ms)","trace[2008420491] 'compare'  (duration: 52.044759ms)"],"step_count":2}
{"level":"info","ts":"2026-04-20T05:00:56.481929Z","caller":"traceutil/trace.go:171","msg":"trace[1123789939] linearizableReadLoop","detail":"{readStateIndex:5228; appliedIndex:5226; }","duration":"120.186783ms","start":"2026-04-20T05:00:56.361715Z","end":"2026-04-20T05:00:56.481902Z","steps":["trace[1123789939] 'read index received'  (duration: 28.571581ms)","trace[1123789939] 'applied index is now lower than readState.Index'  (duration: 91.613362ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-20T05:00:56.482165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.427058ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-04-20T05:00:56.482246Z","caller":"traceutil/trace.go:171","msg":"trace[57820600] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5025; }","duration":"120.563801ms","start":"2026-04-20T05:00:56.361663Z","end":"2026-04-20T05:00:56.482226Z","steps":["trace[57820600] 'agreement among raft nodes before linearized reading'  (duration: 120.328336ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T05:03:58.280335Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3211}
{"level":"info","ts":"2026-04-20T05:03:58.372948Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3211,"took":"90.911137ms","hash":2801257263,"current-db-size-bytes":60301312,"current-db-size":"60 MB","current-db-size-in-use-bytes":33996800,"current-db-size-in-use":"34 MB"}
{"level":"info","ts":"2026-04-20T05:03:58.373019Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2801257263,"revision":3211,"compact-revision":-1}
{"level":"info","ts":"2026-04-20T05:06:29.139773Z","caller":"traceutil/trace.go:171","msg":"trace[2112578345] linearizableReadLoop","detail":"{readStateIndex:8389; appliedIndex:8388; }","duration":"304.615507ms","start":"2026-04-20T05:06:28.835137Z","end":"2026-04-20T05:06:29.139753Z","steps":["trace[2112578345] 'read index received'  (duration: 304.455283ms)","trace[2112578345] 'applied index is now lower than readState.Index'  (duration: 159.554µs)"],"step_count":2}
{"level":"info","ts":"2026-04-20T05:06:29.13989Z","caller":"traceutil/trace.go:171","msg":"trace[1367769987] transaction","detail":"{read_only:false; response_revision:8040; number_of_response:1; }","duration":"389.674875ms","start":"2026-04-20T05:06:28.750207Z","end":"2026-04-20T05:06:29.139882Z","steps":["trace[1367769987] 'process raft request'  (duration: 389.439469ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T05:06:29.139978Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T05:06:28.750192Z","time spent":"389.720427ms","remote":"127.0.0.1:35914","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:8026 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-04-20T05:06:29.140084Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.929984ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-20T05:06:29.140169Z","caller":"traceutil/trace.go:171","msg":"trace[71844469] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8040; }","duration":"305.055687ms","start":"2026-04-20T05:06:28.835098Z","end":"2026-04-20T05:06:29.140153Z","steps":["trace[71844469] 'agreement among raft nodes before linearized reading'  (duration: 304.901034ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T05:06:29.140211Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T05:06:28.835086Z","time spent":"305.114778ms","remote":"127.0.0.1:35616","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-04-20T05:06:29.140223Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.692214ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:645"}
{"level":"warn","ts":"2026-04-20T05:06:29.140224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.206458ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:660"}
{"level":"info","ts":"2026-04-20T05:06:29.140318Z","caller":"traceutil/trace.go:171","msg":"trace[466546276] range","detail":"{range_begin:/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8040; }","duration":"114.842708ms","start":"2026-04-20T05:06:29.025452Z","end":"2026-04-20T05:06:29.140295Z","steps":["trace[466546276] 'agreement among raft nodes before linearized reading'  (duration: 114.568481ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T05:06:29.140352Z","caller":"traceutil/trace.go:171","msg":"trace[2110888283] range","detail":"{range_begin:/registry/configmaps/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:8040; }","duration":"241.395972ms","start":"2026-04-20T05:06:28.898925Z","end":"2026-04-20T05:06:29.140321Z","steps":["trace[2110888283] 'agreement among raft nodes before linearized reading'  (duration: 241.049604ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T05:06:33.605835Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000020ea.wal"}
{"level":"info","ts":"2026-04-20T05:06:40.359685Z","caller":"traceutil/trace.go:171","msg":"trace[106913694] transaction","detail":"{read_only:false; response_revision:8116; number_of_response:1; }","duration":"153.20938ms","start":"2026-04-20T05:06:40.206455Z","end":"2026-04-20T05:06:40.359664Z","steps":["trace[106913694] 'process raft request'  (duration: 153.072447ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T05:06:40.423077Z","caller":"traceutil/trace.go:171","msg":"trace[687458596] transaction","detail":"{read_only:false; response_revision:8117; number_of_response:1; }","duration":"126.292938ms","start":"2026-04-20T05:06:40.296741Z","end":"2026-04-20T05:06:40.423034Z","steps":["trace[687458596] 'process raft request'  (duration: 126.092903ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T05:06:41.09135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.608455ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-20T05:06:41.091433Z","caller":"traceutil/trace.go:171","msg":"trace[1400114594] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8118; }","duration":"255.730469ms","start":"2026-04-20T05:06:40.835683Z","end":"2026-04-20T05:06:41.091413Z","steps":["trace[1400114594] 'range keys from in-memory index tree'  (duration: 255.538744ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T05:06:41.091554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.199076ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-20T05:06:41.091636Z","caller":"traceutil/trace.go:171","msg":"trace[1206697021] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:8118; }","duration":"275.33904ms","start":"2026-04-20T05:06:40.816277Z","end":"2026-04-20T05:06:41.091616Z","steps":["trace[1206697021] 'count revisions from in-memory index tree'  (duration: 275.110064ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T05:06:41.817077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.912491ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-04-20T05:06:41.817163Z","caller":"traceutil/trace.go:171","msg":"trace[1857480990] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8126; }","duration":"181.044344ms","start":"2026-04-20T05:06:41.636098Z","end":"2026-04-20T05:06:41.817142Z","steps":["trace[1857480990] 'range keys from in-memory index tree'  (duration: 180.675765ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T05:06:42.020378Z","caller":"traceutil/trace.go:171","msg":"trace[1618955896] transaction","detail":"{read_only:false; response_revision:8127; number_of_response:1; }","duration":"199.270212ms","start":"2026-04-20T05:06:41.821082Z","end":"2026-04-20T05:06:42.020352Z","steps":["trace[1618955896] 'process raft request'  (duration: 199.122138ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T05:07:09.517805Z","caller":"traceutil/trace.go:171","msg":"trace[1889483279] linearizableReadLoop","detail":"{readStateIndex:8727; appliedIndex:8726; }","duration":"156.193458ms","start":"2026-04-20T05:07:09.361586Z","end":"2026-04-20T05:07:09.517779Z","steps":["trace[1889483279] 'read index received'  (duration: 155.996614ms)","trace[1889483279] 'applied index is now lower than readState.Index'  (duration: 195.424µs)"],"step_count":2}
{"level":"warn","ts":"2026-04-20T05:07:09.518018Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.410824ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"}
{"level":"info","ts":"2026-04-20T05:07:09.518051Z","caller":"traceutil/trace.go:171","msg":"trace[356297887] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8361; }","duration":"156.486646ms","start":"2026-04-20T05:07:09.361556Z","end":"2026-04-20T05:07:09.518043Z","steps":["trace[356297887] 'agreement among raft nodes before linearized reading'  (duration: 156.326222ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T05:07:09.518401Z","caller":"traceutil/trace.go:171","msg":"trace[1325167337] transaction","detail":"{read_only:false; response_revision:8361; number_of_response:1; }","duration":"341.255087ms","start":"2026-04-20T05:07:09.177136Z","end":"2026-04-20T05:07:09.518391Z","steps":["trace[1325167337] 'process raft request'  (duration: 340.457238ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T05:07:09.518485Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T05:07:09.177112Z","time spent":"341.317669ms","remote":"127.0.0.1:36122","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":16428,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/statefulsets/openstack/percona-xtradb-pxc\" mod_revision:8283 > success:<request_put:<key:\"/registry/statefulsets/openstack/percona-xtradb-pxc\" value_size:16368 >> failure:<request_range:<key:\"/registry/statefulsets/openstack/percona-xtradb-pxc\" > >"}
{"level":"info","ts":"2026-04-20T05:07:16.319454Z","caller":"traceutil/trace.go:171","msg":"trace[1915798726] transaction","detail":"{read_only:false; response_revision:8443; number_of_response:1; }","duration":"132.35231ms","start":"2026-04-20T05:07:16.187077Z","end":"2026-04-20T05:07:16.319429Z","steps":["trace[1915798726] 'process raft request'  (duration: 111.150722ms)","trace[1915798726] 'compare'  (duration: 20.978043ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-20T05:07:16.419769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.358958ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15853969938448774678 > lease_revoke:<id:5c049da93cf5f3d8>","response":"size:27"}
{"level":"info","ts":"2026-04-20T05:07:16.419855Z","caller":"traceutil/trace.go:171","msg":"trace[1620423490] linearizableReadLoop","detail":"{readStateIndex:8816; appliedIndex:8814; }","duration":"121.496724ms","start":"2026-04-20T05:07:16.298343Z","end":"2026-04-20T05:07:16.41984Z","steps":["trace[1620423490] 'read index received'  (duration: 4.176208ms)","trace[1620423490] 'applied index is now lower than readState.Index'  (duration: 117.319526ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-20T05:07:16.420017Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.665509ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"}
{"level":"info","ts":"2026-04-20T05:07:16.420074Z","caller":"traceutil/trace.go:171","msg":"trace[1194965088] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8443; }","duration":"121.769361ms","start":"2026-04-20T05:07:16.298292Z","end":"2026-04-20T05:07:16.420061Z","steps":["trace[1194965088] 'agreement among raft nodes before linearized reading'  (duration: 121.581177ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T05:07:22.027112Z","caller":"traceutil/trace.go:171","msg":"trace[843738575] transaction","detail":"{read_only:false; response_revision:8490; number_of_response:1; }","duration":"110.819413ms","start":"2026-04-20T05:07:21.916271Z","end":"2026-04-20T05:07:22.02709Z","steps":["trace[843738575] 'process raft request'  (duration: 104.29162ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T05:07:22.273667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.539155ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15853969938448774823 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:8468 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:473 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >>","response":"size:16"}
{"level":"info","ts":"2026-04-20T05:07:22.273793Z","caller":"traceutil/trace.go:171","msg":"trace[456313777] linearizableReadLoop","detail":"{readStateIndex:8869; appliedIndex:8868; }","duration":"135.547204ms","start":"2026-04-20T05:07:22.138224Z","end":"2026-04-20T05:07:22.273772Z","steps":["trace[456313777] 'read index received'  (duration: 13.844195ms)","trace[456313777] 'applied index is now lower than readState.Index'  (duration: 121.701539ms)"],"step_count":2}
{"level":"info","ts":"2026-04-20T05:07:22.273896Z","caller":"traceutil/trace.go:171","msg":"trace[74192676] transaction","detail":"{read_only:false; response_revision:8494; number_of_response:1; }","duration":"185.063818ms","start":"2026-04-20T05:07:22.088818Z","end":"2026-04-20T05:07:22.273882Z","steps":["trace[74192676] 'process raft request'  (duration: 63.199545ms)","trace[74192676] 'compare'  (duration: 121.371121ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-20T05:07:22.274153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.890903ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/policies/\" range_end:\"/registry/rabbitmq.com/policies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-20T05:07:22.274273Z","caller":"traceutil/trace.go:171","msg":"trace[844348421] range","detail":"{range_begin:/registry/rabbitmq.com/policies/; range_end:/registry/rabbitmq.com/policies0; response_count:0; response_revision:8494; }","duration":"136.097567ms","start":"2026-04-20T05:07:22.138143Z","end":"2026-04-20T05:07:22.27424Z","steps":["trace[844348421] 'agreement among raft nodes before linearized reading'  (duration: 135.822231ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T05:07:22.691865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.040463ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15853969938448774826 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:8469 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:367 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-04-20T05:07:22.692148Z","caller":"traceutil/trace.go:171","msg":"trace[2045852011] transaction","detail":"{read_only:false; response_revision:8495; number_of_response:1; }","duration":"413.019884ms","start":"2026-04-20T05:07:22.279077Z","end":"2026-04-20T05:07:22.692097Z","steps":["trace[2045852011] 'process raft request'  (duration: 131.664804ms)","trace[2045852011] 'compare'  (duration: 280.46592ms)"],"step_count":2}
{"level":"info","ts":"2026-04-20T05:07:22.692192Z","caller":"traceutil/trace.go:171","msg":"trace[657498132] linearizableReadLoop","detail":"{readStateIndex:8870; appliedIndex:8869; }","duration":"351.742065ms","start":"2026-04-20T05:07:22.340422Z","end":"2026-04-20T05:07:22.692164Z","steps":["trace[657498132] 'read index received'  (duration: 70.21754ms)","trace[657498132] 'applied index is now lower than readState.Index'  (duration: 281.523105ms)"],"step_count":2}
{"level":"info","ts":"2026-04-20T05:07:22.692199Z","caller":"traceutil/trace.go:171","msg":"trace[249900922] transaction","detail":"{read_only:false; response_revision:8496; number_of_response:1; }","duration":"221.980295ms","start":"2026-04-20T05:07:22.470198Z","end":"2026-04-20T05:07:22.692179Z","steps":["trace[249900922] 'process raft request'  (duration: 221.909244ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T05:07:22.692344Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T05:07:22.279047Z","time spent":"413.204278ms","remote":"127.0.0.1:35914","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:8469 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:367 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-04-20T05:07:22.692439Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"352.019061ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/08db1feb.percona.com\" ","response":"range_response_count:1 size:526"}
{"level":"info","ts":"2026-04-20T05:07:22.692497Z","caller":"traceutil/trace.go:171","msg":"trace[160210387] range","detail":"{range_begin:/registry/leases/openstack/08db1feb.percona.com; range_end:; response_count:1; response_revision:8496; }","duration":"352.126093ms","start":"2026-04-20T05:07:22.340355Z","end":"2026-04-20T05:07:22.692481Z","steps":["trace[160210387] 'agreement among raft nodes before linearized reading'  (duration: 351.918329ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T05:07:22.692535Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T05:07:22.340326Z","time spent":"352.200545ms","remote":"127.0.0.1:35914","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":548,"request content":"key:\"/registry/leases/openstack/08db1feb.percona.com\" "}
{"level":"info","ts":"2026-04-20T05:07:22.708906Z","caller":"traceutil/trace.go:171","msg":"trace[160987467] transaction","detail":"{read_only:false; response_revision:8497; number_of_response:1; }","duration":"116.312443ms","start":"2026-04-20T05:07:22.592568Z","end":"2026-04-20T05:07:22.70888Z","steps":["trace[160987467] 'process raft request'  (duration: 116.19737ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T05:07:22.709015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.543135ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-04-20T05:07:22.709073Z","caller":"traceutil/trace.go:171","msg":"trace[734223755] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:8497; }","duration":"284.656328ms","start":"2026-04-20T05:07:22.424399Z","end":"2026-04-20T05:07:22.709056Z","steps":["trace[734223755] 'agreement among raft nodes before linearized reading'  (duration: 284.494494ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T05:07:22.709183Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.438159ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-04-20T05:07:22.709272Z","caller":"traceutil/trace.go:171","msg":"trace[432041299] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8497; }","duration":"154.568462ms","start":"2026-04-20T05:07:22.55468Z","end":"2026-04-20T05:07:22.709248Z","steps":["trace[432041299] 'agreement among raft nodes before linearized reading'  (duration: 154.252005ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T05:07:22.709267Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.893012ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"}
{"level":"info","ts":"2026-04-20T05:07:22.709344Z","caller":"traceutil/trace.go:171","msg":"trace[1210525864] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8497; }","duration":"210.025905ms","start":"2026-04-20T05:07:22.499301Z","end":"2026-04-20T05:07:22.709327Z","steps":["trace[1210525864] 'agreement among raft nodes before linearized reading'  (duration: 209.79623ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T05:07:46.889806Z","caller":"traceutil/trace.go:171","msg":"trace[768372274] linearizableReadLoop","detail":"{readStateIndex:9185; appliedIndex:9184; }","duration":"370.121127ms","start":"2026-04-20T05:07:46.519662Z","end":"2026-04-20T05:07:46.889783Z","steps":["trace[768372274] 'read index received'  (duration: 369.706687ms)","trace[768372274] 'applied index is now lower than readState.Index'  (duration: 382.579µs)"],"step_count":2}
{"level":"info","ts":"2026-04-20T05:07:46.889847Z","caller":"traceutil/trace.go:171","msg":"trace[1938730463] transaction","detail":"{read_only:false; response_revision:8797; number_of_response:1; }","duration":"378.152495ms","start":"2026-04-20T05:07:46.511674Z","end":"2026-04-20T05:07:46.889826Z","steps":["trace[1938730463] 'process raft request'  (duration: 377.723464ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T05:07:46.889955Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T05:07:46.511658Z","time spent":"378.237507ms","remote":"127.0.0.1:35726","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":644,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/configmaps/openstack/messaging-topology-operator-leader-election\" mod_revision:8757 > success:<request_put:<key:\"/registry/configmaps/openstack/messaging-topology-operator-leader-election\" value_size:562 >> failure:<request_range:<key:\"/registry/configmaps/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-04-20T05:07:46.890114Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"370.415743ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:530"}
{"level":"info","ts":"2026-04-20T05:07:46.890522Z","caller":"traceutil/trace.go:171","msg":"trace[321868728] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:8797; }","duration":"370.580178ms","start":"2026-04-20T05:07:46.519589Z","end":"2026-04-20T05:07:46.890169Z","steps":["trace[321868728] 'agreement among raft nodes before linearized reading'  (duration: 370.335062ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T05:07:46.89056Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T05:07:46.519566Z","time spent":"370.986597ms","remote":"127.0.0.1:35914","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":552,"request content":"key:\"/registry/leases/cert-manager/cert-manager-controller\" "}
{"level":"warn","ts":"2026-04-20T05:07:46.890843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.142707ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-04-20T05:07:46.890874Z","caller":"traceutil/trace.go:171","msg":"trace[445776490] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8798; }","duration":"102.215339ms","start":"2026-04-20T05:07:46.788652Z","end":"2026-04-20T05:07:46.890867Z","steps":["trace[445776490] 'agreement among raft nodes before linearized reading'  (duration: 102.102376ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T05:07:46.891165Z","caller":"traceutil/trace.go:171","msg":"trace[976996050] transaction","detail":"{read_only:false; response_revision:8798; number_of_response:1; }","duration":"105.080666ms","start":"2026-04-20T05:07:46.786068Z","end":"2026-04-20T05:07:46.891149Z","steps":["trace[976996050] 'process raft request'  (duration: 104.562133ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T05:08:30.28827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.537861ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15853969938448776923 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:9213 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-04-20T05:08:30.28842Z","caller":"traceutil/trace.go:171","msg":"trace[1329824958] transaction","detail":"{read_only:false; response_revision:9225; number_of_response:1; }","duration":"237.952544ms","start":"2026-04-20T05:08:30.050445Z","end":"2026-04-20T05:08:30.288397Z","steps":["trace[1329824958] 'process raft request'  (duration: 76.204948ms)","trace[1329824958] 'compare'  (duration: 161.416089ms)"],"step_count":2}
{"level":"info","ts":"2026-04-20T05:08:30.318833Z","caller":"traceutil/trace.go:171","msg":"trace[1062432987] transaction","detail":"{read_only:false; response_revision:9226; number_of_response:1; }","duration":"245.580384ms","start":"2026-04-20T05:08:30.073228Z","end":"2026-04-20T05:08:30.318808Z","steps":["trace[1062432987] 'process raft request'  (duration: 245.40598ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T05:08:58.287419Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6574}
{"level":"info","ts":"2026-04-20T05:08:58.384893Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6574,"took":"95.602341ms","hash":1168343507,"current-db-size-bytes":60301312,"current-db-size":"60 MB","current-db-size-in-use-bytes":26988544,"current-db-size-in-use":"27 MB"}
{"level":"info","ts":"2026-04-20T05:08:58.384963Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1168343507,"revision":6574,"compact-revision":3211}
{"level":"info","ts":"2026-04-20T05:09:10.487235Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"5caa70ef1dd6dc04","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-04-20T05:09:10.494304Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001}
{"level":"info","ts":"2026-04-20T05:09:10.494454Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001}
{"level":"info","ts":"2026-04-20T05:10:48.848763Z","caller":"traceutil/trace.go:171","msg":"trace[24468210] transaction","detail":"{read_only:false; response_revision:10519; number_of_response:1; }","duration":"103.46495ms","start":"2026-04-20T05:10:48.745269Z","end":"2026-04-20T05:10:48.848734Z","steps":["trace[24468210] 'process raft request'  (duration: 102.229821ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T05:13:58.293812Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":9466}
{"level":"info","ts":"2026-04-20T05:13:58.376094Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":9466,"took":"80.01015ms","hash":2115276138,"current-db-size-bytes":60301312,"current-db-size":"60 MB","current-db-size-in-use-bytes":25124864,"current-db-size-in-use":"25 MB"}
{"level":"info","ts":"2026-04-20T05:13:58.376158Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2115276138,"revision":9466,"compact-revision":6574}