{"level":"warn","ts":"2026-04-17T18:37:07.664614Z","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-17T18:37:07.664705Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.113: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.113:2380","--initial-cluster=instance=https://199.204.45.113:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.113:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.113: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-17T18:37:07.664773Z","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-17T18:37:07.664788Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.113:2380"]}
{"level":"info","ts":"2026-04-17T18:37:07.664805Z","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-17T18:37:07.665468Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.113:2379"]}
{"level":"info","ts":"2026-04-17T18:37:07.665618Z","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":8,"max-cpu-available":8,"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.113:2380"],"listen-peer-urls":["https://199.204.45.113:2380"],"advertise-client-urls":["https://199.204.45.113:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.113:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.113: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-17T18:37:07.670172Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.305806ms"}
{"level":"info","ts":"2026-04-17T18:37:07.678099Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"a31e123290fcf0df","cluster-id":"37661d6ee45ed9e8"}
{"level":"info","ts":"2026-04-17T18:37:07.678216Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df switched to configuration voters=()"}
{"level":"info","ts":"2026-04-17T18:37:07.678257Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df became follower at term 0"}
{"level":"info","ts":"2026-04-17T18:37:07.678437Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft a31e123290fcf0df [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-04-17T18:37:07.678474Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df became follower at term 1"}
{"level":"info","ts":"2026-04-17T18:37:07.678803Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df switched to configuration voters=(11753852085873733855)"}
{"level":"warn","ts":"2026-04-17T18:37:07.685497Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-04-17T18:37:07.686901Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-04-17T18:37:07.68813Z","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-17T18:37:07.690308Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"a31e123290fcf0df","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-04-17T18:37:07.690603Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"a31e123290fcf0df","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-04-17T18:37:07.690822Z","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-17T18:37:07.691009Z","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-17T18:37:07.691094Z","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-17T18:37:07.692835Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df switched to configuration voters=(11753852085873733855)"}
{"level":"info","ts":"2026-04-17T18:37:07.693093Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"37661d6ee45ed9e8","local-member-id":"a31e123290fcf0df","added-peer-id":"a31e123290fcf0df","added-peer-peer-urls":["https://199.204.45.113:2380"]}
{"level":"info","ts":"2026-04-17T18:37:07.696059Z","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-17T18:37:07.696269Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"a31e123290fcf0df","initial-advertise-peer-urls":["https://199.204.45.113:2380"],"listen-peer-urls":["https://199.204.45.113:2380"],"advertise-client-urls":["https://199.204.45.113:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.113:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-04-17T18:37:07.696301Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-04-17T18:37:07.696402Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.113:2380"}
{"level":"info","ts":"2026-04-17T18:37:07.696416Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.113:2380"}
{"level":"info","ts":"2026-04-17T18:37:07.779472Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df is starting a new election at term 1"}
{"level":"info","ts":"2026-04-17T18:37:07.779668Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df became pre-candidate at term 1"}
{"level":"info","ts":"2026-04-17T18:37:07.77973Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df received MsgPreVoteResp from a31e123290fcf0df at term 1"}
{"level":"info","ts":"2026-04-17T18:37:07.779794Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df became candidate at term 2"}
{"level":"info","ts":"2026-04-17T18:37:07.779847Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df received MsgVoteResp from a31e123290fcf0df at term 2"}
{"level":"info","ts":"2026-04-17T18:37:07.779884Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df became leader at term 2"}
{"level":"info","ts":"2026-04-17T18:37:07.779927Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: a31e123290fcf0df elected leader a31e123290fcf0df at term 2"}
{"level":"info","ts":"2026-04-17T18:37:07.780735Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"a31e123290fcf0df","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.113:2379]}","request-path":"/0/members/a31e123290fcf0df/attributes","cluster-id":"37661d6ee45ed9e8","publish-timeout":"7s"}
{"level":"info","ts":"2026-04-17T18:37:07.782227Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-04-17T18:37:07.782387Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-04-17T18:37:07.78249Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-17T18:37:07.784014Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-04-17T18:37:07.784099Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-04-17T18:37:07.784298Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.113:2379"}
{"level":"info","ts":"2026-04-17T18:37:07.784669Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"37661d6ee45ed9e8","local-member-id":"a31e123290fcf0df","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-17T18:37:07.784818Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-17T18:37:07.784895Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-17T18:37:07.786067Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"warn","ts":"2026-04-17T18:37:36.132012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.240657ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/cilium\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-17T18:37:36.13211Z","caller":"traceutil/trace.go:171","msg":"trace[101724532] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/cilium; range_end:; response_count:0; response_revision:471; }","duration":"129.377651ms","start":"2026-04-17T18:37:36.002715Z","end":"2026-04-17T18:37:36.132093Z","steps":["trace[101724532] 'range keys from in-memory index tree'  (duration: 129.181016ms)"],"step_count":1}
{"level":"info","ts":"2026-04-17T18:37:39.555775Z","caller":"traceutil/trace.go:171","msg":"trace[1774253849] linearizableReadLoop","detail":"{readStateIndex:611; appliedIndex:610; }","duration":"302.426836ms","start":"2026-04-17T18:37:39.253323Z","end":"2026-04-17T18:37:39.55575Z","steps":["trace[1774253849] 'read index received'  (duration: 302.16576ms)","trace[1774253849] 'applied index is now lower than readState.Index'  (duration: 260.246µs)"],"step_count":2}
{"level":"info","ts":"2026-04-17T18:37:39.556095Z","caller":"traceutil/trace.go:171","msg":"trace[1881962719] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"313.149712ms","start":"2026-04-17T18:37:39.242899Z","end":"2026-04-17T18:37:39.556048Z","steps":["trace[1881962719] 'process raft request'  (duration: 312.644919ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-17T18:37:39.556703Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T18:37:39.242801Z","time spent":"313.455159ms","remote":"127.0.0.1:49132","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":208470,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/securitypolicies.gateway.envoyproxy.io\" mod_revision:584 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/securitypolicies.gateway.envoyproxy.io\" value_size:208365 >> failure:<request_range:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/securitypolicies.gateway.envoyproxy.io\" > >"}
{"level":"warn","ts":"2026-04-17T18:37:39.562697Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.358528ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/clienttrafficpolicies.gateway.envoyproxy.io\" ","response":"range_response_count:1 size:65436"}
{"level":"info","ts":"2026-04-17T18:37:39.56274Z","caller":"traceutil/trace.go:171","msg":"trace[1686458980] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/clienttrafficpolicies.gateway.envoyproxy.io; range_end:; response_count:1; response_revision:588; }","duration":"309.442301ms","start":"2026-04-17T18:37:39.253286Z","end":"2026-04-17T18:37:39.562728Z","steps":["trace[1686458980] 'agreement among raft nodes before linearized reading'  (duration: 302.56847ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-17T18:37:39.562767Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T18:37:39.253272Z","time spent":"309.489002ms","remote":"127.0.0.1:49132","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":65459,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/clienttrafficpolicies.gateway.envoyproxy.io\" "}
{"level":"warn","ts":"2026-04-17T18:37:39.687667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.081396ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/envoyextensionpolicies.gateway.envoyproxy.io\" ","response":"range_response_count:1 size:74769"}
{"level":"info","ts":"2026-04-17T18:37:39.68775Z","caller":"traceutil/trace.go:171","msg":"trace[549776715] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/envoyextensionpolicies.gateway.envoyproxy.io; range_end:; response_count:1; response_revision:588; }","duration":"111.211569ms","start":"2026-04-17T18:37:39.576519Z","end":"2026-04-17T18:37:39.68773Z","steps":["trace[549776715] 'range keys from in-memory index tree'  (duration: 110.86251ms)"],"step_count":1}
{"level":"info","ts":"2026-04-17T18:37:44.844842Z","caller":"traceutil/trace.go:171","msg":"trace[1259647825] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"198.782932ms","start":"2026-04-17T18:37:44.646034Z","end":"2026-04-17T18:37:44.844817Z","steps":["trace[1259647825] 'process raft request'  (duration: 198.148766ms)"],"step_count":1}
{"level":"info","ts":"2026-04-17T18:37:45.01612Z","caller":"traceutil/trace.go:171","msg":"trace[550639729] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"113.809051ms","start":"2026-04-17T18:37:44.90228Z","end":"2026-04-17T18:37:45.016089Z","steps":["trace[550639729] 'process raft request'  (duration: 73.811673ms)","trace[550639729] 'compare'  (duration: 39.867105ms)"],"step_count":2}
{"level":"info","ts":"2026-04-17T18:37:45.604647Z","caller":"traceutil/trace.go:171","msg":"trace[53591143] linearizableReadLoop","detail":"{readStateIndex:646; appliedIndex:645; }","duration":"268.363699ms","start":"2026-04-17T18:37:45.336252Z","end":"2026-04-17T18:37:45.604616Z","steps":["trace[53591143] 'read index received'  (duration: 268.226196ms)","trace[53591143] 'applied index is now lower than readState.Index'  (duration: 135.733µs)"],"step_count":2}
{"level":"info","ts":"2026-04-17T18:37:45.604714Z","caller":"traceutil/trace.go:171","msg":"trace[886246251] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"355.365807ms","start":"2026-04-17T18:37:45.249299Z","end":"2026-04-17T18:37:45.604664Z","steps":["trace[886246251] 'process raft request'  (duration: 355.112791ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-17T18:37:45.604902Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.626165ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-j5jm7\" ","response":"range_response_count:1 size:16965"}
{"level":"info","ts":"2026-04-17T18:37:45.60495Z","caller":"traceutil/trace.go:171","msg":"trace[1461471362] range","detail":"{range_begin:/registry/pods/kube-system/cilium-j5jm7; range_end:; response_count:1; response_revision:622; }","duration":"268.730217ms","start":"2026-04-17T18:37:45.336206Z","end":"2026-04-17T18:37:45.604936Z","steps":["trace[1461471362] 'agreement among raft nodes before linearized reading'  (duration: 268.525423ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-17T18:37:45.604944Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T18:37:45.249274Z","time spent":"355.532231ms","remote":"127.0.0.1:52940","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:608 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-04-17T18:37:45.838422Z","caller":"traceutil/trace.go:171","msg":"trace[570438996] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"406.509831ms","start":"2026-04-17T18:37:45.431877Z","end":"2026-04-17T18:37:45.838387Z","steps":["trace[570438996] 'process raft request'  (duration: 399.095097ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-17T18:37:45.83875Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T18:37:45.431845Z","time spent":"406.662845ms","remote":"127.0.0.1:49194","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036313,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" mod_revision:620 > success:<request_put:<key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" value_size:1036229 >> failure:<request_range:<key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" > >"}
{"level":"info","ts":"2026-04-17T18:37:45.841103Z","caller":"traceutil/trace.go:171","msg":"trace[643528651] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"221.689736ms","start":"2026-04-17T18:37:45.619354Z","end":"2026-04-17T18:37:45.841044Z","steps":["trace[643528651] 'process raft request'  (duration: 221.510602ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-17T18:38:00.888778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.415494ms","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-17T18:38:00.888879Z","caller":"traceutil/trace.go:171","msg":"trace[5893697] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:783; }","duration":"186.575039ms","start":"2026-04-17T18:38:00.702282Z","end":"2026-04-17T18:38:00.888857Z","steps":["trace[5893697] 'range keys from in-memory index tree'  (duration: 186.137508ms)"],"step_count":1}
{"level":"info","ts":"2026-04-17T18:38:42.716535Z","caller":"traceutil/trace.go:171","msg":"trace[1850015558] transaction","detail":"{read_only:false; response_revision:1312; number_of_response:1; }","duration":"158.594834ms","start":"2026-04-17T18:38:42.557912Z","end":"2026-04-17T18:38:42.716507Z","steps":["trace[1850015558] 'process raft request'  (duration: 158.43168ms)"],"step_count":1}
{"level":"info","ts":"2026-04-17T18:38:42.718392Z","caller":"traceutil/trace.go:171","msg":"trace[1939142532] transaction","detail":"{read_only:false; response_revision:1313; number_of_response:1; }","duration":"104.779682ms","start":"2026-04-17T18:38:42.61358Z","end":"2026-04-17T18:38:42.71836Z","steps":["trace[1939142532] 'process raft request'  (duration: 104.631039ms)"],"step_count":1}
{"level":"info","ts":"2026-04-17T18:38:48.38798Z","caller":"traceutil/trace.go:171","msg":"trace[1418427366] linearizableReadLoop","detail":"{readStateIndex:1466; appliedIndex:1465; }","duration":"172.707829ms","start":"2026-04-17T18:38:48.215251Z","end":"2026-04-17T18:38:48.387959Z","steps":["trace[1418427366] 'read index received'  (duration: 172.542495ms)","trace[1418427366] 'applied index is now lower than readState.Index'  (duration: 164.554µs)"],"step_count":2}
{"level":"info","ts":"2026-04-17T18:38:48.388101Z","caller":"traceutil/trace.go:171","msg":"trace[1977787732] transaction","detail":"{read_only:false; response_revision:1424; number_of_response:1; }","duration":"389.515759ms","start":"2026-04-17T18:38:47.998574Z","end":"2026-04-17T18:38:48.38809Z","steps":["trace[1977787732] 'process raft request'  (duration: 389.240243ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-17T18:38:48.388199Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T18:38:47.998545Z","time spent":"389.581732ms","remote":"127.0.0.1:52940","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:1328 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-04-17T18:38:48.388372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.204465ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"info","ts":"2026-04-17T18:38:48.388444Z","caller":"traceutil/trace.go:171","msg":"trace[1458062291] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1424; }","duration":"119.312658ms","start":"2026-04-17T18:38:48.269113Z","end":"2026-04-17T18:38:48.388426Z","steps":["trace[1458062291] 'agreement among raft nodes before linearized reading'  (duration: 119.131704ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-17T18:38:48.388606Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.312874ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-17T18:38:48.388696Z","caller":"traceutil/trace.go:171","msg":"trace[1807436991] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1424; }","duration":"173.463128ms","start":"2026-04-17T18:38:48.215205Z","end":"2026-04-17T18:38:48.388668Z","steps":["trace[1807436991] 'agreement among raft nodes before linearized reading'  (duration: 173.272624ms)"],"step_count":1}
{"level":"info","ts":"2026-04-17T18:38:48.585821Z","caller":"traceutil/trace.go:171","msg":"trace[1438454476] transaction","detail":"{read_only:false; response_revision:1425; number_of_response:1; }","duration":"193.353945ms","start":"2026-04-17T18:38:48.392446Z","end":"2026-04-17T18:38:48.5858Z","steps":["trace[1438454476] 'process raft request'  (duration: 189.852409ms)"],"step_count":1}
{"level":"info","ts":"2026-04-17T18:38:50.916774Z","caller":"traceutil/trace.go:171","msg":"trace[1558917515] linearizableReadLoop","detail":"{readStateIndex:1481; appliedIndex:1480; }","duration":"168.404273ms","start":"2026-04-17T18:38:50.748346Z","end":"2026-04-17T18:38:50.91675Z","steps":["trace[1558917515] 'read index received'  (duration: 168.210008ms)","trace[1558917515] 'applied index is now lower than readState.Index'  (duration: 193.355µs)"],"step_count":2}
{"level":"info","ts":"2026-04-17T18:38:50.916941Z","caller":"traceutil/trace.go:171","msg":"trace[706148445] transaction","detail":"{read_only:false; response_revision:1439; number_of_response:1; }","duration":"169.845277ms","start":"2026-04-17T18:38:50.747083Z","end":"2026-04-17T18:38:50.916928Z","steps":["trace[706148445] 'process raft request'  (duration: 169.5415ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-17T18:38:50.917251Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.914074ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"info","ts":"2026-04-17T18:38:50.917295Z","caller":"traceutil/trace.go:171","msg":"trace[311292414] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1439; }","duration":"169.033927ms","start":"2026-04-17T18:38:50.748247Z","end":"2026-04-17T18:38:50.917281Z","steps":["trace[311292414] 'agreement among raft nodes before linearized reading'  (duration: 168.615908ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-17T18:38:51.137314Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.302557ms","expected-duration":"100ms","prefix":"","request":"header:<ID:17356764785395558964 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:1428 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:16"}
{"level":"info","ts":"2026-04-17T18:38:51.137457Z","caller":"traceutil/trace.go:171","msg":"trace[2030059379] transaction","detail":"{read_only:false; response_revision:1440; number_of_response:1; }","duration":"214.453622ms","start":"2026-04-17T18:38:50.922967Z","end":"2026-04-17T18:38:51.13742Z","steps":["trace[2030059379] 'process raft request'  (duration: 92.748777ms)","trace[2030059379] 'compare'  (duration: 121.140862ms)"],"step_count":2}
{"level":"info","ts":"2026-04-17T18:38:51.381858Z","caller":"traceutil/trace.go:171","msg":"trace[62522373] linearizableReadLoop","detail":"{readStateIndex:1483; appliedIndex:1482; }","duration":"166.546738ms","start":"2026-04-17T18:38:51.215257Z","end":"2026-04-17T18:38:51.381804Z","steps":["trace[62522373] 'read index received'  (duration: 165.134632ms)","trace[62522373] 'applied index is now lower than readState.Index'  (duration: 1.409556ms)"],"step_count":2}
{"level":"info","ts":"2026-04-17T18:38:51.381944Z","caller":"traceutil/trace.go:171","msg":"trace[1685121548] transaction","detail":"{read_only:false; response_revision:1441; number_of_response:1; }","duration":"219.804624ms","start":"2026-04-17T18:38:51.162083Z","end":"2026-04-17T18:38:51.381888Z","steps":["trace[1685121548] 'process raft request'  (duration: 218.236035ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-17T18:38:51.382041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.759733ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-17T18:38:51.382115Z","caller":"traceutil/trace.go:171","msg":"trace[263456872] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1441; }","duration":"166.886576ms","start":"2026-04-17T18:38:51.215209Z","end":"2026-04-17T18:38:51.382096Z","steps":["trace[263456872] 'agreement among raft nodes before linearized reading'  (duration: 166.759793ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-17T18:39:17.54718Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17356764785395559826,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-04-17T18:39:17.966728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.759598ms","expected-duration":"100ms","prefix":"","request":"header:<ID:17356764785395559833 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" mod_revision:1737 > success:<request_put:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" value_size:416 >> failure:<request_range:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" > >>","response":"size:16"}
{"level":"info","ts":"2026-04-17T18:39:17.966897Z","caller":"traceutil/trace.go:171","msg":"trace[1915044389] linearizableReadLoop","detail":"{readStateIndex:1914; appliedIndex:1912; }","duration":"920.56294ms","start":"2026-04-17T18:39:17.046315Z","end":"2026-04-17T18:39:17.966878Z","steps":["trace[1915044389] 'read index received'  (duration: 704.549937ms)","trace[1915044389] 'applied index is now lower than readState.Index'  (duration: 216.012003ms)"],"step_count":2}
{"level":"info","ts":"2026-04-17T18:39:17.966986Z","caller":"traceutil/trace.go:171","msg":"trace[544326032] transaction","detail":"{read_only:false; response_revision:1842; number_of_response:1; }","duration":"998.83045ms","start":"2026-04-17T18:39:16.968141Z","end":"2026-04-17T18:39:17.966972Z","steps":["trace[544326032] 'process raft request'  (duration: 782.732424ms)","trace[544326032] 'compare'  (duration: 215.653705ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-17T18:39:17.967052Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T18:39:16.968116Z","time spent":"998.901462ms","remote":"127.0.0.1:52940","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" mod_revision:1737 > success:<request_put:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" value_size:416 >> failure:<request_range:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" > >"}
{"level":"warn","ts":"2026-04-17T18:39:17.967121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"920.798157ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-04-17T18:39:17.967205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"752.83861ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-17T18:39:17.967243Z","caller":"traceutil/trace.go:171","msg":"trace[585166325] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1843; }","duration":"752.896333ms","start":"2026-04-17T18:39:17.214336Z","end":"2026-04-17T18:39:17.967232Z","steps":["trace[585166325] 'agreement among raft nodes before linearized reading'  (duration: 752.841402ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-17T18:39:17.967275Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T18:39:17.214319Z","time spent":"752.950744ms","remote":"127.0.0.1:49118","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-04-17T18:39:17.967303Z","caller":"traceutil/trace.go:171","msg":"trace[1590429681] transaction","detail":"{read_only:false; response_revision:1843; number_of_response:1; }","duration":"948.023054ms","start":"2026-04-17T18:39:17.019264Z","end":"2026-04-17T18:39:17.967288Z","steps":["trace[1590429681] 'process raft request'  (duration: 947.564402ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-17T18:39:17.967392Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T18:39:17.019248Z","time spent":"948.079935ms","remote":"127.0.0.1:52940","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:1771 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:458 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"warn","ts":"2026-04-17T18:39:17.967564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"501.130972ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"warn","ts":"2026-04-17T18:39:17.967616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"640.845466ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-17T18:39:17.967665Z","caller":"traceutil/trace.go:171","msg":"trace[1368217279] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:1843; }","duration":"501.317267ms","start":"2026-04-17T18:39:17.466332Z","end":"2026-04-17T18:39:17.967649Z","steps":["trace[1368217279] 'agreement among raft nodes before linearized reading'  (duration: 501.116772ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-17T18:39:17.967673Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"703.947002ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"}
{"level":"warn","ts":"2026-04-17T18:39:17.967708Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T18:39:17.466321Z","time spent":"501.375568ms","remote":"127.0.0.1:53002","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":23,"response size":30,"request content":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true "}
{"level":"info","ts":"2026-04-17T18:39:17.967726Z","caller":"traceutil/trace.go:171","msg":"trace[550538846] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1843; }","duration":"704.030394ms","start":"2026-04-17T18:39:17.263683Z","end":"2026-04-17T18:39:17.967713Z","steps":["trace[550538846] 'agreement among raft nodes before linearized reading'  (duration: 703.925682ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-17T18:39:17.967647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"435.664547ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"warn","ts":"2026-04-17T18:39:17.967784Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T18:39:17.263665Z","time spent":"704.108576ms","remote":"127.0.0.1:52940","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-04-17T18:39:17.967793Z","caller":"traceutil/trace.go:171","msg":"trace[135915153] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1843; }","duration":"435.832881ms","start":"2026-04-17T18:39:17.531945Z","end":"2026-04-17T18:39:17.967778Z","steps":["trace[135915153] 'agreement among raft nodes before linearized reading'  (duration: 435.603285ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-17T18:39:17.967827Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T18:39:17.531934Z","time spent":"435.885453ms","remote":"127.0.0.1:52940","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-04-17T18:39:17.967841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"580.287361ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:570"}
{"level":"info","ts":"2026-04-17T18:39:17.967874Z","caller":"traceutil/trace.go:171","msg":"trace[979861767] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:1843; }","duration":"580.338363ms","start":"2026-04-17T18:39:17.387525Z","end":"2026-04-17T18:39:17.967864Z","steps":["trace[979861767] 'agreement among raft nodes before linearized reading'  (duration: 580.21432ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-17T18:39:17.967917Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T18:39:17.387516Z","time spent":"580.390884ms","remote":"127.0.0.1:52940","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":593,"request content":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" "}
{"level":"info","ts":"2026-04-17T18:39:17.967201Z","caller":"traceutil/trace.go:171","msg":"trace[563354383] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1843; }","duration":"920.928711ms","start":"2026-04-17T18:39:17.046254Z","end":"2026-04-17T18:39:17.967183Z","steps":["trace[563354383] 'agreement among raft nodes before linearized reading'  (duration: 920.758356ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-17T18:39:17.967975Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T18:39:17.046223Z","time spent":"921.741359ms","remote":"127.0.0.1:49116","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-04-17T18:39:17.967999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.925793ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-84badc68-bbf6-4c0c-af21-8a16acec971c\" ","response":"range_response_count:1 size:3627"}
{"level":"warn","ts":"2026-04-17T18:39:17.967958Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.437187ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"info","ts":"2026-04-17T18:39:17.968064Z","caller":"traceutil/trace.go:171","msg":"trace[891304875] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-84badc68-bbf6-4c0c-af21-8a16acec971c; range_end:; response_count:1; response_revision:1843; }","duration":"154.020214ms","start":"2026-04-17T18:39:17.814031Z","end":"2026-04-17T18:39:17.968051Z","steps":["trace[891304875] 'agreement among raft nodes before linearized reading'  (duration: 153.879021ms)"],"step_count":1}
{"level":"info","ts":"2026-04-17T18:39:17.967702Z","caller":"traceutil/trace.go:171","msg":"trace[112300051] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:1843; }","duration":"640.991048ms","start":"2026-04-17T18:39:17.326692Z","end":"2026-04-17T18:39:17.967683Z","steps":["trace[112300051] 'agreement among raft nodes before linearized reading'  (duration: 640.844965ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-17T18:39:17.968154Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"629.372705ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"}
{"level":"warn","ts":"2026-04-17T18:39:17.968153Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T18:39:17.326674Z","time spent":"641.46117ms","remote":"127.0.0.1:40498","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true "}
{"level":"info","ts":"2026-04-17T18:39:17.968178Z","caller":"traceutil/trace.go:171","msg":"trace[2113731935] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1843; }","duration":"330.705384ms","start":"2026-04-17T18:39:17.637391Z","end":"2026-04-17T18:39:17.968096Z","steps":["trace[2113731935] 'agreement among raft nodes before linearized reading'  (duration: 330.070729ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-17T18:39:17.96828Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T18:39:17.637375Z","time spent":"330.890269ms","remote":"127.0.0.1:52940","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"info","ts":"2026-04-17T18:39:17.968199Z","caller":"traceutil/trace.go:171","msg":"trace[1827637160] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1843; }","duration":"629.451587ms","start":"2026-04-17T18:39:17.338733Z","end":"2026-04-17T18:39:17.968185Z","steps":["trace[1827637160] 'agreement among raft nodes before linearized reading'  (duration: 629.347284ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-17T18:39:17.968451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"473.041993ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-84badc68-bbf6-4c0c-af21-8a16acec971c\" ","response":"range_response_count:1 size:3627"}
{"level":"info","ts":"2026-04-17T18:39:17.968504Z","caller":"traceutil/trace.go:171","msg":"trace[1853121950] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-84badc68-bbf6-4c0c-af21-8a16acec971c; range_end:; response_count:1; response_revision:1843; }","duration":"473.170936ms","start":"2026-04-17T18:39:17.495318Z","end":"2026-04-17T18:39:17.968489Z","steps":["trace[1853121950] 'agreement among raft nodes before linearized reading'  (duration: 472.768106ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-17T18:39:17.968504Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T18:39:17.338713Z","time spent":"629.776694ms","remote":"127.0.0.1:55230","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5467,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "}
{"level":"warn","ts":"2026-04-17T18:39:17.968537Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T18:39:17.495305Z","time spent":"473.223027ms","remote":"127.0.0.1:52868","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3650,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-84badc68-bbf6-4c0c-af21-8a16acec971c\" "}
{"level":"info","ts":"2026-04-17T18:39:18.233041Z","caller":"traceutil/trace.go:171","msg":"trace[663404920] transaction","detail":"{read_only:false; response_revision:1847; number_of_response:1; }","duration":"257.8802ms","start":"2026-04-17T18:39:17.975126Z","end":"2026-04-17T18:39:18.233006Z","steps":["trace[663404920] 'process raft request'  (duration: 257.48037ms)"],"step_count":1}
{"level":"info","ts":"2026-04-17T18:39:18.233096Z","caller":"traceutil/trace.go:171","msg":"trace[1404878617] transaction","detail":"{read_only:false; response_revision:1848; number_of_response:1; }","duration":"257.794118ms","start":"2026-04-17T18:39:17.975283Z","end":"2026-04-17T18:39:18.233077Z","steps":["trace[1404878617] 'process raft request'  (duration: 257.379297ms)"],"step_count":1}
{"level":"info","ts":"2026-04-17T18:39:18.233036Z","caller":"traceutil/trace.go:171","msg":"trace[1710278122] transaction","detail":"{read_only:false; response_revision:1845; number_of_response:1; }","duration":"258.581928ms","start":"2026-04-17T18:39:17.974424Z","end":"2026-04-17T18:39:18.233006Z","steps":["trace[1710278122] 'process raft request'  (duration: 245.772424ms)","trace[1710278122] 'compare'  (duration: 12.22016ms)"],"step_count":2}
{"level":"info","ts":"2026-04-17T18:39:18.233135Z","caller":"traceutil/trace.go:171","msg":"trace[736412279] transaction","detail":"{read_only:false; response_revision:1846; number_of_response:1; }","duration":"258.348071ms","start":"2026-04-17T18:39:17.974745Z","end":"2026-04-17T18:39:18.233093Z","steps":["trace[736412279] 'process raft request'  (duration: 257.796437ms)"],"step_count":1}
{"level":"info","ts":"2026-04-17T18:39:18.233235Z","caller":"traceutil/trace.go:171","msg":"trace[1503466671] transaction","detail":"{read_only:false; response_revision:1849; number_of_response:1; }","duration":"257.376867ms","start":"2026-04-17T18:39:17.975845Z","end":"2026-04-17T18:39:18.233222Z","steps":["trace[1503466671] 'process raft request'  (duration: 256.864445ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-17T18:39:19.045602Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"496.972031ms","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-17T18:39:19.045683Z","caller":"traceutil/trace.go:171","msg":"trace[1134865814] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1849; }","duration":"497.112794ms","start":"2026-04-17T18:39:18.548552Z","end":"2026-04-17T18:39:19.045665Z","steps":["trace[1134865814] 'range keys from in-memory index tree'  (duration: 496.781575ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-17T18:39:19.045723Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T18:39:18.548524Z","time spent":"497.190685ms","remote":"127.0.0.1:52940","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-04-17T18:39:19.04587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.955695ms","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-17T18:39:19.045998Z","caller":"traceutil/trace.go:171","msg":"trace[481996617] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1849; }","duration":"303.106049ms","start":"2026-04-17T18:39:18.742864Z","end":"2026-04-17T18:39:19.04597Z","steps":["trace[481996617] 'range keys from in-memory index tree'  (duration: 302.791341ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-17T18:39:19.046057Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T18:39:18.7428Z","time spent":"303.246832ms","remote":"127.0.0.1:52940","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-04-17T18:39:19.046141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.329101ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"}
{"level":"info","ts":"2026-04-17T18:39:19.046223Z","caller":"traceutil/trace.go:171","msg":"trace[102227142] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:1849; }","duration":"327.468674ms","start":"2026-04-17T18:39:18.718732Z","end":"2026-04-17T18:39:19.046201Z","steps":["trace[102227142] 'range keys from in-memory index tree'  (duration: 326.47465ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-17T18:39:19.046264Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T18:39:18.718707Z","time spent":"327.547897ms","remote":"127.0.0.1:52940","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":579,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "}
{"level":"info","ts":"2026-04-17T18:39:26.318519Z","caller":"traceutil/trace.go:171","msg":"trace[278999488] linearizableReadLoop","detail":"{readStateIndex:1999; appliedIndex:1998; }","duration":"225.66552ms","start":"2026-04-17T18:39:26.092825Z","end":"2026-04-17T18:39:26.318491Z","steps":["trace[278999488] 'read index received'  (duration: 225.31796ms)","trace[278999488] 'applied index is now lower than readState.Index'  (duration: 346.81µs)"],"step_count":2}
{"level":"info","ts":"2026-04-17T18:39:26.318654Z","caller":"traceutil/trace.go:171","msg":"trace[108604285] transaction","detail":"{read_only:false; response_revision:1926; number_of_response:1; }","duration":"319.073538ms","start":"2026-04-17T18:39:25.999567Z","end":"2026-04-17T18:39:26.318641Z","steps":["trace[108604285] 'process raft request'  (duration: 318.493993ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-17T18:39:26.318787Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T18:39:25.999534Z","time spent":"319.15115ms","remote":"127.0.0.1:52940","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:1914 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:459 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"warn","ts":"2026-04-17T18:39:26.318824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.214179ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-17T18:39:26.318919Z","caller":"traceutil/trace.go:171","msg":"trace[1692360783] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1926; }","duration":"103.384223ms","start":"2026-04-17T18:39:26.215514Z","end":"2026-04-17T18:39:26.318898Z","steps":["trace[1692360783] 'agreement among raft nodes before linearized reading'  (duration: 103.2446ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-17T18:39:26.319219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.403667ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"}
{"level":"info","ts":"2026-04-17T18:39:26.319264Z","caller":"traceutil/trace.go:171","msg":"trace[1505466869] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1926; }","duration":"226.502898ms","start":"2026-04-17T18:39:26.092748Z","end":"2026-04-17T18:39:26.319251Z","steps":["trace[1505466869] 'agreement among raft nodes before linearized reading'  (duration: 226.364215ms)"],"step_count":1}
{"level":"info","ts":"2026-04-17T18:39:26.487674Z","caller":"traceutil/trace.go:171","msg":"trace[1235455344] transaction","detail":"{read_only:false; response_revision:1927; number_of_response:1; }","duration":"162.556013ms","start":"2026-04-17T18:39:26.325085Z","end":"2026-04-17T18:39:26.487641Z","steps":["trace[1235455344] 'process raft request'  (duration: 155.238713ms)"],"step_count":1}
{"level":"info","ts":"2026-04-17T18:39:26.495619Z","caller":"traceutil/trace.go:171","msg":"trace[1128420428] transaction","detail":"{read_only:false; response_revision:1928; number_of_response:1; }","duration":"170.363774ms","start":"2026-04-17T18:39:26.325229Z","end":"2026-04-17T18:39:26.495593Z","steps":["trace[1128420428] 'process raft request'  (duration: 170.140339ms)"],"step_count":1}
{"level":"info","ts":"2026-04-17T18:39:26.495657Z","caller":"traceutil/trace.go:171","msg":"trace[527858900] transaction","detail":"{read_only:false; response_revision:1929; number_of_response:1; }","duration":"170.328273ms","start":"2026-04-17T18:39:26.325299Z","end":"2026-04-17T18:39:26.495627Z","steps":["trace[527858900] 'process raft request'  (duration: 170.22563ms)"],"step_count":1}
{"level":"info","ts":"2026-04-17T18:39:26.495809Z","caller":"traceutil/trace.go:171","msg":"trace[478585981] transaction","detail":"{read_only:false; response_revision:1930; number_of_response:1; }","duration":"169.940573ms","start":"2026-04-17T18:39:26.325858Z","end":"2026-04-17T18:39:26.495799Z","steps":["trace[478585981] 'process raft request'  (duration: 169.718668ms)"],"step_count":1}
{"level":"info","ts":"2026-04-17T18:39:35.661665Z","caller":"traceutil/trace.go:171","msg":"trace[204200763] linearizableReadLoop","detail":"{readStateIndex:2061; appliedIndex:2060; }","duration":"499.72731ms","start":"2026-04-17T18:39:35.161911Z","end":"2026-04-17T18:39:35.661638Z","steps":["trace[204200763] 'read index received'  (duration: 499.542096ms)","trace[204200763] 'applied index is now lower than readState.Index'  (duration: 184.284µs)"],"step_count":2}
{"level":"warn","ts":"2026-04-17T18:39:35.662111Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"500.176462ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"}
{"level":"warn","ts":"2026-04-17T18:39:35.662257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"447.289066ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-17T18:39:35.662453Z","caller":"traceutil/trace.go:171","msg":"trace[747143615] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1986; }","duration":"447.358258ms","start":"2026-04-17T18:39:35.214941Z","end":"2026-04-17T18:39:35.662299Z","steps":["trace[747143615] 'agreement among raft nodes before linearized reading'  (duration: 447.286216ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-17T18:39:35.662569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"497.057364ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"info","ts":"2026-04-17T18:39:35.662626Z","caller":"traceutil/trace.go:171","msg":"trace[524051840] transaction","detail":"{read_only:false; response_revision:1986; number_of_response:1; }","duration":"520.784656ms","start":"2026-04-17T18:39:35.141811Z","end":"2026-04-17T18:39:35.662595Z","steps":["trace[524051840] 'process raft request'  (duration: 519.658958ms)"],"step_count":1}
{"level":"info","ts":"2026-04-17T18:39:35.662668Z","caller":"traceutil/trace.go:171","msg":"trace[1715336339] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1986; }","duration":"497.242568ms","start":"2026-04-17T18:39:35.165414Z","end":"2026-04-17T18:39:35.662656Z","steps":["trace[1715336339] 'agreement among raft nodes before linearized reading'  (duration: 496.932061ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-17T18:39:35.662809Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T18:39:35.141767Z","time spent":"520.93602ms","remote":"127.0.0.1:52940","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:1976 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"info","ts":"2026-04-17T18:39:35.662233Z","caller":"traceutil/trace.go:171","msg":"trace[1892909499] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:1986; }","duration":"500.356906ms","start":"2026-04-17T18:39:35.161858Z","end":"2026-04-17T18:39:35.662214Z","steps":["trace[1892909499] 'agreement among raft nodes before linearized reading'  (duration: 500.083379ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-17T18:39:35.662831Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T18:39:35.165407Z","time spent":"497.379532ms","remote":"127.0.0.1:52940","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-04-17T18:39:35.662146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"497.493946ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-04-17T18:39:35.663097Z","caller":"traceutil/trace.go:171","msg":"trace[935469892] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1986; }","duration":"498.453349ms","start":"2026-04-17T18:39:35.1646Z","end":"2026-04-17T18:39:35.663053Z","steps":["trace[935469892] 'agreement among raft nodes before linearized reading'  (duration: 497.379922ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-17T18:39:35.662444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.296065ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"}
{"level":"warn","ts":"2026-04-17T18:39:35.663054Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T18:39:35.214931Z","time spent":"447.599503ms","remote":"127.0.0.1:49116","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-04-17T18:39:35.663194Z","caller":"traceutil/trace.go:171","msg":"trace[615397292] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1986; }","duration":"281.090944ms","start":"2026-04-17T18:39:35.382075Z","end":"2026-04-17T18:39:35.663166Z","steps":["trace[615397292] 'agreement among raft nodes before linearized reading'  (duration: 280.10505ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-17T18:39:35.663208Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T18:39:35.16459Z","time spent":"498.570552ms","remote":"127.0.0.1:52940","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-04-17T18:39:35.662926Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T18:39:35.161835Z","time spent":"501.061754ms","remote":"127.0.0.1:52940","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":578,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "}
{"level":"info","ts":"2026-04-17T18:39:52.999389Z","caller":"traceutil/trace.go:171","msg":"trace[1349838482] linearizableReadLoop","detail":"{readStateIndex:2168; appliedIndex:2167; }","duration":"366.043091ms","start":"2026-04-17T18:39:52.633313Z","end":"2026-04-17T18:39:52.999357Z","steps":["trace[1349838482] 'read index received'  (duration: 365.856527ms)","trace[1349838482] 'applied index is now lower than readState.Index'  (duration: 185.364µs)"],"step_count":2}
{"level":"info","ts":"2026-04-17T18:39:52.999551Z","caller":"traceutil/trace.go:171","msg":"trace[1732760856] transaction","detail":"{read_only:false; response_revision:2089; number_of_response:1; }","duration":"368.139552ms","start":"2026-04-17T18:39:52.631382Z","end":"2026-04-17T18:39:52.999521Z","steps":["trace[1732760856] 'process raft request'  (duration: 367.802634ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-17T18:39:52.999718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"366.38224ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"warn","ts":"2026-04-17T18:39:52.999721Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T18:39:52.631363Z","time spent":"368.256166ms","remote":"127.0.0.1:52940","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:2077 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-04-17T18:39:52.999775Z","caller":"traceutil/trace.go:171","msg":"trace[923952883] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2089; }","duration":"366.466322ms","start":"2026-04-17T18:39:52.633298Z","end":"2026-04-17T18:39:52.999764Z","steps":["trace[923952883] 'agreement among raft nodes before linearized reading'  (duration: 366.221375ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-17T18:39:52.99981Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T18:39:52.633291Z","time spent":"366.511203ms","remote":"127.0.0.1:52940","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-04-17T18:39:53.515253Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.430761ms","expected-duration":"100ms","prefix":"","request":"header:<ID:17356764785395560408 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:2078 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:16"}
{"level":"info","ts":"2026-04-17T18:39:53.515356Z","caller":"traceutil/trace.go:171","msg":"trace[298997877] linearizableReadLoop","detail":"{readStateIndex:2169; appliedIndex:2168; }","duration":"515.857261ms","start":"2026-04-17T18:39:52.99948Z","end":"2026-04-17T18:39:53.515337Z","steps":["trace[298997877] 'read index received'  (duration: 352.240155ms)","trace[298997877] 'applied index is now lower than readState.Index'  (duration: 163.615986ms)"],"step_count":2}
{"level":"info","ts":"2026-04-17T18:39:53.515634Z","caller":"traceutil/trace.go:171","msg":"trace[1458327482] transaction","detail":"{read_only:false; response_revision:2090; number_of_response:1; }","duration":"880.486887ms","start":"2026-04-17T18:39:52.635097Z","end":"2026-04-17T18:39:53.515584Z","steps":["trace[1458327482] 'process raft request'  (duration: 716.645366ms)","trace[1458327482] 'compare'  (duration: 163.310778ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-17T18:39:53.515707Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T18:39:52.635074Z","time spent":"880.596019ms","remote":"127.0.0.1:52940","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:2078 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-04-17T18:39:53.51573Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"744.20182ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"}
{"level":"warn","ts":"2026-04-17T18:39:53.515812Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"880.719733ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:570"}
{"level":"info","ts":"2026-04-17T18:39:53.515917Z","caller":"traceutil/trace.go:171","msg":"trace[818454347] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:2090; }","duration":"880.848145ms","start":"2026-04-17T18:39:52.635037Z","end":"2026-04-17T18:39:53.515885Z","steps":["trace[818454347] 'agreement among raft nodes before linearized reading'  (duration: 880.463726ms)"],"step_count":1}
{"level":"info","ts":"2026-04-17T18:39:53.515833Z","caller":"traceutil/trace.go:171","msg":"trace[107910300] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2090; }","duration":"744.366644ms","start":"2026-04-17T18:39:52.771445Z","end":"2026-04-17T18:39:53.515811Z","steps":["trace[107910300] 'agreement among raft nodes before linearized reading'  (duration: 744.037926ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-17T18:39:53.51598Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T18:39:52.634957Z","time spent":"881.011149ms","remote":"127.0.0.1:52940","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":593,"request content":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" "}
{"level":"warn","ts":"2026-04-17T18:39:53.516026Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T18:39:52.771422Z","time spent":"744.584398ms","remote":"127.0.0.1:55230","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5467,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "}
{"level":"info","ts":"2026-04-17T18:39:53.52929Z","caller":"traceutil/trace.go:171","msg":"trace[684752122] transaction","detail":"{read_only:false; response_revision:2092; number_of_response:1; }","duration":"201.013012ms","start":"2026-04-17T18:39:53.328261Z","end":"2026-04-17T18:39:53.529274Z","steps":["trace[684752122] 'process raft request'  (duration: 200.96608ms)"],"step_count":1}
{"level":"info","ts":"2026-04-17T18:39:53.529692Z","caller":"traceutil/trace.go:171","msg":"trace[1337005162] transaction","detail":"{read_only:false; response_revision:2091; number_of_response:1; }","duration":"525.201488ms","start":"2026-04-17T18:39:53.004467Z","end":"2026-04-17T18:39:53.529668Z","steps":["trace[1337005162] 'process raft request'  (duration: 524.679615ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-17T18:39:53.529734Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.46022ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-17T18:39:53.529829Z","caller":"traceutil/trace.go:171","msg":"trace[1457882140] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2092; }","duration":"314.591762ms","start":"2026-04-17T18:39:53.215224Z","end":"2026-04-17T18:39:53.529816Z","steps":["trace[1457882140] 'agreement among raft nodes before linearized reading'  (duration: 314.461499ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-17T18:39:53.529824Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T18:39:53.004431Z","time spent":"525.304581ms","remote":"127.0.0.1:52940","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:2079 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"warn","ts":"2026-04-17T18:39:53.529862Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T18:39:53.215203Z","time spent":"314.651434ms","remote":"127.0.0.1:49116","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-04-17T18:39:53.529852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"529.224307ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-04-17T18:39:53.529902Z","caller":"traceutil/trace.go:171","msg":"trace[404850198] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:2092; }","duration":"529.30529ms","start":"2026-04-17T18:39:53.000585Z","end":"2026-04-17T18:39:53.52989Z","steps":["trace[404850198] 'agreement among raft nodes before linearized reading'  (duration: 529.076094ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-17T18:39:53.529941Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T18:39:53.000561Z","time spent":"529.369851ms","remote":"127.0.0.1:49194","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":20,"response size":30,"request content":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true "}
{"level":"info","ts":"2026-04-17T18:39:55.31101Z","caller":"traceutil/trace.go:171","msg":"trace[1755424171] linearizableReadLoop","detail":"{readStateIndex:2178; appliedIndex:2177; }","duration":"150.401852ms","start":"2026-04-17T18:39:55.160584Z","end":"2026-04-17T18:39:55.310986Z","steps":["trace[1755424171] 'read index received'  (duration: 150.123655ms)","trace[1755424171] 'applied index is now lower than readState.Index'  (duration: 277.037µs)"],"step_count":2}
{"level":"info","ts":"2026-04-17T18:39:55.311187Z","caller":"traceutil/trace.go:171","msg":"trace[1616962225] transaction","detail":"{read_only:false; response_revision:2099; number_of_response:1; }","duration":"293.543987ms","start":"2026-04-17T18:39:55.017581Z","end":"2026-04-17T18:39:55.311125Z","steps":["trace[1616962225] 'process raft request'  (duration: 293.203719ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-17T18:39:55.31128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.656768ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-17T18:39:55.311547Z","caller":"traceutil/trace.go:171","msg":"trace[274476955] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:2099; }","duration":"150.968816ms","start":"2026-04-17T18:39:55.16055Z","end":"2026-04-17T18:39:55.311519Z","steps":["trace[274476955] 'agreement among raft nodes before linearized reading'  (duration: 150.653838ms)"],"step_count":1}
{"level":"info","ts":"2026-04-17T18:39:55.964741Z","caller":"traceutil/trace.go:171","msg":"trace[1610966292] linearizableReadLoop","detail":"{readStateIndex:2179; appliedIndex:2178; }","duration":"444.243565ms","start":"2026-04-17T18:39:55.520474Z","end":"2026-04-17T18:39:55.964717Z","steps":["trace[1610966292] 'read index received'  (duration: 444.100412ms)","trace[1610966292] 'applied index is now lower than readState.Index'  (duration: 141.923µs)"],"step_count":2}
{"level":"info","ts":"2026-04-17T18:39:55.964915Z","caller":"traceutil/trace.go:171","msg":"trace[1268011937] transaction","detail":"{read_only:false; response_revision:2100; number_of_response:1; }","duration":"461.099128ms","start":"2026-04-17T18:39:55.503741Z","end":"2026-04-17T18:39:55.96484Z","steps":["trace[1268011937] 'process raft request'  (duration: 460.830852ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-17T18:39:55.964956Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"444.4614ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"info","ts":"2026-04-17T18:39:55.96501Z","caller":"traceutil/trace.go:171","msg":"trace[1260122650] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2100; }","duration":"444.547693ms","start":"2026-04-17T18:39:55.520438Z","end":"2026-04-17T18:39:55.964986Z","steps":["trace[1260122650] 'agreement among raft nodes before linearized reading'  (duration: 444.396869ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-17T18:39:55.965044Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T18:39:55.52043Z","time spent":"444.605814ms","remote":"127.0.0.1:52940","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-04-17T18:39:55.965101Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T18:39:55.503712Z","time spent":"461.279933ms","remote":"127.0.0.1:52940","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" mod_revision:2065 > success:<request_put:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" value_size:416 >> failure:<request_range:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" > >"}
{"level":"info","ts":"2026-04-17T18:39:56.261591Z","caller":"traceutil/trace.go:171","msg":"trace[1071534868] linearizableReadLoop","detail":"{readStateIndex:2180; appliedIndex:2179; }","duration":"296.743215ms","start":"2026-04-17T18:39:55.964809Z","end":"2026-04-17T18:39:56.261552Z","steps":["trace[1071534868] 'read index received'  (duration: 295.852343ms)","trace[1071534868] 'applied index is now lower than readState.Index'  (duration: 889.202µs)"],"step_count":2}
{"level":"warn","ts":"2026-04-17T18:39:56.261872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"456.790792ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"}
{"level":"info","ts":"2026-04-17T18:39:56.261972Z","caller":"traceutil/trace.go:171","msg":"trace[257762566] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2101; }","duration":"456.942596ms","start":"2026-04-17T18:39:55.805006Z","end":"2026-04-17T18:39:56.261949Z","steps":["trace[257762566] 'agreement among raft nodes before linearized reading'  (duration: 456.550676ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-17T18:39:56.262002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"461.18541ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"warn","ts":"2026-04-17T18:39:56.262028Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T18:39:55.804996Z","time spent":"457.020459ms","remote":"127.0.0.1:52940","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":579,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "}
{"level":"info","ts":"2026-04-17T18:39:56.262047Z","caller":"traceutil/trace.go:171","msg":"trace[2136790414] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2101; }","duration":"461.262252ms","start":"2026-04-17T18:39:55.800769Z","end":"2026-04-17T18:39:56.262031Z","steps":["trace[2136790414] 'agreement among raft nodes before linearized reading'  (duration: 461.1755ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-17T18:39:56.26209Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T18:39:55.800745Z","time spent":"461.337324ms","remote":"127.0.0.1:52940","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-04-17T18:39:56.262152Z","caller":"traceutil/trace.go:171","msg":"trace[1879979584] transaction","detail":"{read_only:false; response_revision:2101; number_of_response:1; }","duration":"494.24414ms","start":"2026-04-17T18:39:55.767887Z","end":"2026-04-17T18:39:56.262132Z","steps":["trace[1879979584] 'process raft request'  (duration: 492.745482ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-17T18:39:56.261896Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"698.54833ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:570"}
{"level":"info","ts":"2026-04-17T18:39:56.262236Z","caller":"traceutil/trace.go:171","msg":"trace[124274693] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:2101; }","duration":"698.923661ms","start":"2026-04-17T18:39:55.563297Z","end":"2026-04-17T18:39:56.26222Z","steps":["trace[124274693] 'agreement among raft nodes before linearized reading'  (duration: 698.388017ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-17T18:39:56.262274Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T18:39:55.563285Z","time spent":"698.980082ms","remote":"127.0.0.1:52940","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":593,"request content":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" "}
{"level":"warn","ts":"2026-04-17T18:39:56.262579Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T18:39:55.767859Z","time spent":"494.363793ms","remote":"127.0.0.1:52940","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:2094 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"warn","ts":"2026-04-17T18:39:56.263012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"728.786132ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"info","ts":"2026-04-17T18:39:56.263068Z","caller":"traceutil/trace.go:171","msg":"trace[197609541] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2101; }","duration":"728.866774ms","start":"2026-04-17T18:39:55.534189Z","end":"2026-04-17T18:39:56.263055Z","steps":["trace[197609541] 'agreement among raft nodes before linearized reading'  (duration: 727.4989ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-17T18:39:56.263103Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T18:39:55.534178Z","time spent":"728.917445ms","remote":"127.0.0.1:52940","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-04-17T18:39:56.263182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"347.723413ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12386"}
{"level":"info","ts":"2026-04-17T18:39:56.263241Z","caller":"traceutil/trace.go:171","msg":"trace[921244381] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2101; }","duration":"347.830075ms","start":"2026-04-17T18:39:55.915396Z","end":"2026-04-17T18:39:56.263226Z","steps":["trace[921244381] 'agreement among raft nodes before linearized reading'  (duration: 346.709988ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-17T18:39:56.263247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"480.857343ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/percona-xtradb-haproxy-0.18a738f1016ffff5\" ","response":"range_response_count:1 size:846"}
{"level":"warn","ts":"2026-04-17T18:39:56.263278Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T18:39:55.915377Z","time spent":"347.893107ms","remote":"127.0.0.1:52868","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12409,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "}
{"level":"info","ts":"2026-04-17T18:39:56.263285Z","caller":"traceutil/trace.go:171","msg":"trace[1243983572] range","detail":"{range_begin:/registry/events/openstack/percona-xtradb-haproxy-0.18a738f1016ffff5; range_end:; response_count:1; response_revision:2101; }","duration":"480.924183ms","start":"2026-04-17T18:39:55.782345Z","end":"2026-04-17T18:39:56.263269Z","steps":["trace[1243983572] 'agreement among raft nodes before linearized reading'  (duration: 479.687683ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-17T18:39:56.263319Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T18:39:55.782315Z","time spent":"480.997775ms","remote":"127.0.0.1:49168","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":869,"request content":"key:\"/registry/events/openstack/percona-xtradb-haproxy-0.18a738f1016ffff5\" "}
{"level":"warn","ts":"2026-04-17T18:39:56.263545Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"733.435485ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"}
{"level":"info","ts":"2026-04-17T18:39:56.263592Z","caller":"traceutil/trace.go:171","msg":"trace[1630015511] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2101; }","duration":"733.545329ms","start":"2026-04-17T18:39:55.530033Z","end":"2026-04-17T18:39:56.263579Z","steps":["trace[1630015511] 'agreement among raft nodes before linearized reading'  (duration: 732.013822ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-17T18:39:56.263628Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T18:39:55.529993Z","time spent":"733.626101ms","remote":"127.0.0.1:55230","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5467,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "}
{"level":"warn","ts":"2026-04-17T18:39:56.26365Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"457.333186ms","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-17T18:39:56.263687Z","caller":"traceutil/trace.go:171","msg":"trace[707721148] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2101; }","duration":"457.388407ms","start":"2026-04-17T18:39:55.806289Z","end":"2026-04-17T18:39:56.263677Z","steps":["trace[707721148] 'agreement among raft nodes before linearized reading'  (duration: 455.905271ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-17T18:39:56.263725Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T18:39:55.806278Z","time spent":"457.440718ms","remote":"127.0.0.1:52940","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-04-17T18:39:56.26403Z","caller":"traceutil/trace.go:171","msg":"trace[849047403] transaction","detail":"{read_only:false; response_revision:2102; number_of_response:1; }","duration":"295.247178ms","start":"2026-04-17T18:39:55.968771Z","end":"2026-04-17T18:39:56.264018Z","steps":["trace[849047403] 'process raft request'  (duration: 293.158767ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-17T18:39:56.264159Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.790554ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-04-17T18:39:56.264595Z","caller":"traceutil/trace.go:171","msg":"trace[56759183] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:2102; }","duration":"283.261854ms","start":"2026-04-17T18:39:55.981318Z","end":"2026-04-17T18:39:56.26458Z","steps":["trace[56759183] 'agreement among raft nodes before linearized reading'  (duration: 281.760998ms)"],"step_count":1}
{"level":"info","ts":"2026-04-17T18:39:56.703585Z","caller":"traceutil/trace.go:171","msg":"trace[788692540] transaction","detail":"{read_only:false; response_revision:2103; number_of_response:1; }","duration":"436.785012ms","start":"2026-04-17T18:39:56.266768Z","end":"2026-04-17T18:39:56.703553Z","steps":["trace[788692540] 'process raft request'  (duration: 432.59631ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-17T18:39:56.703751Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T18:39:56.266746Z","time spent":"436.918646ms","remote":"127.0.0.1:49168","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":831,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/events/openstack/percona-xtradb-haproxy-0.18a738f1016ffff5\" mod_revision:2082 > success:<request_put:<key:\"/registry/events/openstack/percona-xtradb-haproxy-0.18a738f1016ffff5\" value_size:745 lease:8133392748540783870 >> failure:<request_range:<key:\"/registry/events/openstack/percona-xtradb-haproxy-0.18a738f1016ffff5\" > >"}
{"level":"info","ts":"2026-04-17T18:39:56.709962Z","caller":"traceutil/trace.go:171","msg":"trace[2094624677] transaction","detail":"{read_only:false; response_revision:2104; number_of_response:1; }","duration":"441.462307ms","start":"2026-04-17T18:39:56.268487Z","end":"2026-04-17T18:39:56.709949Z","steps":["trace[2094624677] 'process raft request'  (duration: 441.349095ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-17T18:39:56.710031Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T18:39:56.268474Z","time spent":"441.523448ms","remote":"127.0.0.1:52940","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:2096 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:465 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"info","ts":"2026-04-17T18:39:56.710348Z","caller":"traceutil/trace.go:171","msg":"trace[210156391] transaction","detail":"{read_only:false; response_revision:2105; number_of_response:1; }","duration":"441.471007ms","start":"2026-04-17T18:39:56.268868Z","end":"2026-04-17T18:39:56.710339Z","steps":["trace[210156391] 'process raft request'  (duration: 441.050377ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-17T18:39:56.710398Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T18:39:56.268848Z","time spent":"441.525538ms","remote":"127.0.0.1:52940","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:2093 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:477 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"info","ts":"2026-04-17T18:39:56.710862Z","caller":"traceutil/trace.go:171","msg":"trace[1881076140] linearizableReadLoop","detail":"{readStateIndex:2187; appliedIndex:2181; }","duration":"438.094426ms","start":"2026-04-17T18:39:56.272758Z","end":"2026-04-17T18:39:56.710852Z","steps":["trace[1881076140] 'read index received'  (duration: 426.615794ms)","trace[1881076140] 'applied index is now lower than readState.Index'  (duration: 11.478021ms)"],"step_count":2}
{"level":"info","ts":"2026-04-17T18:39:56.710877Z","caller":"traceutil/trace.go:171","msg":"trace[287169246] transaction","detail":"{read_only:false; response_revision:2107; number_of_response:1; }","duration":"440.034252ms","start":"2026-04-17T18:39:56.270826Z","end":"2026-04-17T18:39:56.71086Z","steps":["trace[287169246] 'process raft request'  (duration: 439.910439ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-17T18:39:56.71093Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"438.167447ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-04-17T18:39:56.710959Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T18:39:56.270817Z","time spent":"440.097674ms","remote":"127.0.0.1:52940","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:2091 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-04-17T18:39:56.711052Z","caller":"traceutil/trace.go:171","msg":"trace[170458551] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:2109; }","duration":"438.212318ms","start":"2026-04-17T18:39:56.272735Z","end":"2026-04-17T18:39:56.710948Z","steps":["trace[170458551] 'agreement among raft nodes before linearized reading'  (duration: 438.153356ms)"],"step_count":1}
{"level":"info","ts":"2026-04-17T18:39:56.711047Z","caller":"traceutil/trace.go:171","msg":"trace[1121840603] transaction","detail":"{read_only:false; response_revision:2108; number_of_response:1; }","duration":"439.839187ms","start":"2026-04-17T18:39:56.271181Z","end":"2026-04-17T18:39:56.711021Z","steps":["trace[1121840603] 'process raft request'  (duration: 439.593642ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-17T18:39:56.711099Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T18:39:56.272729Z","time spent":"438.362882ms","remote":"127.0.0.1:53112","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":0,"response size":28,"request content":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" "}
{"level":"info","ts":"2026-04-17T18:39:56.71109Z","caller":"traceutil/trace.go:171","msg":"trace[150415440] transaction","detail":"{read_only:false; response_revision:2109; number_of_response:1; }","duration":"227.681414ms","start":"2026-04-17T18:39:56.483385Z","end":"2026-04-17T18:39:56.711066Z","steps":["trace[150415440] 'process raft request'  (duration: 227.434668ms)"],"step_count":1}
{"level":"info","ts":"2026-04-17T18:39:56.711139Z","caller":"traceutil/trace.go:171","msg":"trace[1097036082] transaction","detail":"{read_only:false; response_revision:2106; number_of_response:1; }","duration":"440.316529ms","start":"2026-04-17T18:39:56.27081Z","end":"2026-04-17T18:39:56.711126Z","steps":["trace[1097036082] 'process raft request'  (duration: 439.484558ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-17T18:39:56.711179Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T18:39:56.271175Z","time spent":"439.930949ms","remote":"127.0.0.1:52940","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:2095 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-04-17T18:39:56.711204Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T18:39:56.270802Z","time spent":"440.36842ms","remote":"127.0.0.1:52940","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:2097 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-04-17T18:41:32.957456Z","caller":"traceutil/trace.go:171","msg":"trace[1966095124] transaction","detail":"{read_only:false; response_revision:2723; number_of_response:1; }","duration":"184.589294ms","start":"2026-04-17T18:41:32.772835Z","end":"2026-04-17T18:41:32.957424Z","steps":["trace[1966095124] 'process raft request'  (duration: 184.345917ms)"],"step_count":1}
{"level":"info","ts":"2026-04-17T18:41:33.232758Z","caller":"traceutil/trace.go:171","msg":"trace[147755278] linearizableReadLoop","detail":"{readStateIndex:2826; appliedIndex:2825; }","duration":"124.261147ms","start":"2026-04-17T18:41:33.108447Z","end":"2026-04-17T18:41:33.232708Z","steps":["trace[147755278] 'read index received'  (duration: 69.084387ms)","trace[147755278] 'applied index is now lower than readState.Index'  (duration: 55.17528ms)"],"step_count":2}
{"level":"info","ts":"2026-04-17T18:41:33.232863Z","caller":"traceutil/trace.go:171","msg":"trace[2035683026] transaction","detail":"{read_only:false; response_revision:2724; number_of_response:1; }","duration":"170.009657ms","start":"2026-04-17T18:41:33.062822Z","end":"2026-04-17T18:41:33.232832Z","steps":["trace[2035683026] 'process raft request'  (duration: 114.641853ms)","trace[2035683026] 'compare'  (duration: 54.893151ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-17T18:41:33.233028Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.557675ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/auth-system/keycloak-0.18a739042c4cf6f0\" ","response":"range_response_count:1 size:781"}
{"level":"info","ts":"2026-04-17T18:41:33.233097Z","caller":"traceutil/trace.go:171","msg":"trace[1741397344] range","detail":"{range_begin:/registry/events/auth-system/keycloak-0.18a739042c4cf6f0; range_end:; response_count:1; response_revision:2724; }","duration":"124.685128ms","start":"2026-04-17T18:41:33.1084Z","end":"2026-04-17T18:41:33.233086Z","steps":["trace[1741397344] 'agreement among raft nodes before linearized reading'  (duration: 124.441801ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-17T18:45:36.106652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.911612ms","expected-duration":"100ms","prefix":"","request":"header:<ID:17356764785395567053 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/monitoring/kube-prometheus-stack-grafana-7d7d475876-xsc9k.18a739427df0e370\" mod_revision:0 > success:<request_put:<key:\"/registry/events/monitoring/kube-prometheus-stack-grafana-7d7d475876-xsc9k.18a739427df0e370\" value_size:774 lease:8133392748540791098 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-04-17T18:45:36.106789Z","caller":"traceutil/trace.go:171","msg":"trace[1580436313] linearizableReadLoop","detail":"{readStateIndex:4889; appliedIndex:4888; }","duration":"339.378583ms","start":"2026-04-17T18:45:35.767392Z","end":"2026-04-17T18:45:36.10677Z","steps":["trace[1580436313] 'read index received'  (duration: 164.315008ms)","trace[1580436313] 'applied index is now lower than readState.Index'  (duration: 175.062515ms)"],"step_count":2}
{"level":"info","ts":"2026-04-17T18:45:36.107699Z","caller":"traceutil/trace.go:171","msg":"trace[241342113] transaction","detail":"{read_only:false; response_revision:4707; number_of_response:1; }","duration":"341.363974ms","start":"2026-04-17T18:45:35.766315Z","end":"2026-04-17T18:45:36.107679Z","steps":["trace[241342113] 'process raft request'  (duration: 165.342584ms)","trace[241342113] 'compare'  (duration: 174.377308ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-17T18:45:36.107786Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T18:45:35.766298Z","time spent":"341.449745ms","remote":"127.0.0.1:49168","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":883,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/events/monitoring/kube-prometheus-stack-grafana-7d7d475876-xsc9k.18a739427df0e370\" mod_revision:0 > success:<request_put:<key:\"/registry/events/monitoring/kube-prometheus-stack-grafana-7d7d475876-xsc9k.18a739427df0e370\" value_size:774 lease:8133392748540791098 >> failure:<>"}
{"level":"warn","ts":"2026-04-17T18:45:36.108025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.618545ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:12973"}
{"level":"info","ts":"2026-04-17T18:45:36.108115Z","caller":"traceutil/trace.go:171","msg":"trace[32854313] range","detail":"{range_begin:/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4707; }","duration":"340.775728ms","start":"2026-04-17T18:45:35.76732Z","end":"2026-04-17T18:45:36.108096Z","steps":["trace[32854313] 'agreement among raft nodes before linearized reading'  (duration: 340.532703ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-17T18:45:36.108156Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T18:45:35.767293Z","time spent":"340.855911ms","remote":"127.0.0.1:52868","response type":"/etcdserverpb.KV/Range","request count":0,"request size":77,"response count":1,"response size":12996,"request content":"key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" "}
{"level":"warn","ts":"2026-04-17T18:45:36.108789Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"332.948933ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"}
{"level":"info","ts":"2026-04-17T18:45:36.108842Z","caller":"traceutil/trace.go:171","msg":"trace[394314855] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4707; }","duration":"333.009155ms","start":"2026-04-17T18:45:35.775819Z","end":"2026-04-17T18:45:36.108828Z","steps":["trace[394314855] 'agreement among raft nodes before linearized reading'  (duration: 332.838531ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-17T18:45:36.108876Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T18:45:35.775807Z","time spent":"333.061606ms","remote":"127.0.0.1:49262","response type":"/etcdserverpb.KV/Range","request count":0,"request size":147,"response count":1,"response size":1958,"request content":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" "}
{"level":"info","ts":"2026-04-17T18:45:36.743051Z","caller":"traceutil/trace.go:171","msg":"trace[970618148] linearizableReadLoop","detail":"{readStateIndex:4898; appliedIndex:4897; }","duration":"142.514633ms","start":"2026-04-17T18:45:36.600502Z","end":"2026-04-17T18:45:36.743017Z","steps":["trace[970618148] 'read index received'  (duration: 142.276588ms)","trace[970618148] 'applied index is now lower than readState.Index'  (duration: 235.725µs)"],"step_count":2}
{"level":"info","ts":"2026-04-17T18:45:36.743112Z","caller":"traceutil/trace.go:171","msg":"trace[65913865] transaction","detail":"{read_only:false; response_revision:4716; number_of_response:1; }","duration":"154.114922ms","start":"2026-04-17T18:45:36.588943Z","end":"2026-04-17T18:45:36.743058Z","steps":["trace[65913865] 'process raft request'  (duration: 153.797295ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-17T18:45:36.743377Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.851202ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"}
{"level":"info","ts":"2026-04-17T18:45:36.74343Z","caller":"traceutil/trace.go:171","msg":"trace[1810361196] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4716; }","duration":"142.987706ms","start":"2026-04-17T18:45:36.600431Z","end":"2026-04-17T18:45:36.743418Z","steps":["trace[1810361196] 'agreement among raft nodes before linearized reading'  (duration: 142.786511ms)"],"step_count":1}
{"level":"info","ts":"2026-04-17T18:45:38.913715Z","caller":"traceutil/trace.go:171","msg":"trace[1352359606] linearizableReadLoop","detail":"{readStateIndex:4925; appliedIndex:4924; }","duration":"151.780915ms","start":"2026-04-17T18:45:38.761916Z","end":"2026-04-17T18:45:38.913697Z","steps":["trace[1352359606] 'read index received'  (duration: 151.619951ms)","trace[1352359606] 'applied index is now lower than readState.Index'  (duration: 156.744µs)"],"step_count":2}
{"level":"info","ts":"2026-04-17T18:45:38.913975Z","caller":"traceutil/trace.go:171","msg":"trace[1416046532] transaction","detail":"{read_only:false; response_revision:4742; number_of_response:1; }","duration":"152.752519ms","start":"2026-04-17T18:45:38.761199Z","end":"2026-04-17T18:45:38.913952Z","steps":["trace[1416046532] 'process raft request'  (duration: 152.356839ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-17T18:45:38.914222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.512919ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"}
{"level":"info","ts":"2026-04-17T18:45:38.91425Z","caller":"traceutil/trace.go:171","msg":"trace[636457073] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4742; }","duration":"151.57335ms","start":"2026-04-17T18:45:38.76267Z","end":"2026-04-17T18:45:38.914244Z","steps":["trace[636457073] 'agreement among raft nodes before linearized reading'  (duration: 151.460486ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-17T18:45:38.914281Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.165134ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:571"}
{"level":"warn","ts":"2026-04-17T18:45:38.914356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.437641ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:557"}
{"level":"info","ts":"2026-04-17T18:45:38.914376Z","caller":"traceutil/trace.go:171","msg":"trace[915557585] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:4742; }","duration":"152.321768ms","start":"2026-04-17T18:45:38.762034Z","end":"2026-04-17T18:45:38.914356Z","steps":["trace[915557585] 'agreement among raft nodes before linearized reading'  (duration: 152.0381ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-17T18:45:38.914496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.193994ms","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-17T18:45:38.91452Z","caller":"traceutil/trace.go:171","msg":"trace[1755260743] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4742; }","duration":"152.228685ms","start":"2026-04-17T18:45:38.762287Z","end":"2026-04-17T18:45:38.914515Z","steps":["trace[1755260743] 'agreement among raft nodes before linearized reading'  (duration: 152.174574ms)"],"step_count":1}
{"level":"info","ts":"2026-04-17T18:45:38.914384Z","caller":"traceutil/trace.go:171","msg":"trace[492580423] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4742; }","duration":"152.483253ms","start":"2026-04-17T18:45:38.761893Z","end":"2026-04-17T18:45:38.914376Z","steps":["trace[492580423] 'agreement among raft nodes before linearized reading'  (duration: 152.420711ms)"],"step_count":1}
{"level":"info","ts":"2026-04-17T18:45:43.572755Z","caller":"traceutil/trace.go:171","msg":"trace[1151606204] transaction","detail":"{read_only:false; response_revision:4871; number_of_response:1; }","duration":"170.184991ms","start":"2026-04-17T18:45:43.402543Z","end":"2026-04-17T18:45:43.572728Z","steps":["trace[1151606204] 'process raft request'  (duration: 169.998907ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-17T18:45:44.296016Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.60247ms","expected-duration":"100ms","prefix":"","request":"header:<ID:17356764785395567435 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:4683 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:472 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >>","response":"size:16"}
{"level":"info","ts":"2026-04-17T18:45:44.2968Z","caller":"traceutil/trace.go:171","msg":"trace[1900695959] linearizableReadLoop","detail":"{readStateIndex:5060; appliedIndex:5058; }","duration":"441.0129ms","start":"2026-04-17T18:45:43.855757Z","end":"2026-04-17T18:45:44.29677Z","steps":["trace[1900695959] 'read index received'  (duration: 182.525848ms)","trace[1900695959] 'applied index is now lower than readState.Index'  (duration: 258.485232ms)"],"step_count":2}
{"level":"info","ts":"2026-04-17T18:45:44.29683Z","caller":"traceutil/trace.go:171","msg":"trace[695946973] transaction","detail":"{read_only:false; response_revision:4872; number_of_response:1; }","duration":"638.582434ms","start":"2026-04-17T18:45:43.658208Z","end":"2026-04-17T18:45:44.29679Z","steps":["trace[695946973] 'process raft request'  (duration: 380.055732ms)","trace[695946973] 'compare'  (duration: 257.341573ms)"],"step_count":2}
{"level":"info","ts":"2026-04-17T18:45:44.296833Z","caller":"traceutil/trace.go:171","msg":"trace[1396749823] transaction","detail":"{read_only:false; response_revision:4873; number_of_response:1; }","duration":"531.126386ms","start":"2026-04-17T18:45:43.765652Z","end":"2026-04-17T18:45:44.296779Z","steps":["trace[1396749823] 'process raft request'  (duration: 530.50302ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-17T18:45:44.297028Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T18:45:43.658174Z","time spent":"638.751909ms","remote":"127.0.0.1:52940","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:4683 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:472 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"warn","ts":"2026-04-17T18:45:44.297202Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"441.38511ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/kube-prometheus-stack-prometheus-node-exporter-q5df6\" ","response":"range_response_count:1 size:9901"}
{"level":"warn","ts":"2026-04-17T18:45:44.297246Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T18:45:43.765612Z","time spent":"531.531187ms","remote":"127.0.0.1:52940","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:4772 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"info","ts":"2026-04-17T18:45:44.297361Z","caller":"traceutil/trace.go:171","msg":"trace[1274820069] range","detail":"{range_begin:/registry/pods/monitoring/kube-prometheus-stack-prometheus-node-exporter-q5df6; range_end:; response_count:1; response_revision:4873; }","duration":"441.589405ms","start":"2026-04-17T18:45:43.855698Z","end":"2026-04-17T18:45:44.297288Z","steps":["trace[1274820069] 'agreement among raft nodes before linearized reading'  (duration: 441.157804ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-17T18:45:44.297479Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T18:45:43.855669Z","time spent":"441.76731ms","remote":"127.0.0.1:52868","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":1,"response size":9924,"request content":"key:\"/registry/pods/monitoring/kube-prometheus-stack-prometheus-node-exporter-q5df6\" "}
{"level":"info","ts":"2026-04-17T18:45:44.468281Z","caller":"traceutil/trace.go:171","msg":"trace[957634461] transaction","detail":"{read_only:false; response_revision:4876; number_of_response:1; }","duration":"158.345157ms","start":"2026-04-17T18:45:44.309903Z","end":"2026-04-17T18:45:44.468248Z","steps":["trace[957634461] 'process raft request'  (duration: 158.222874ms)"],"step_count":1}
{"level":"info","ts":"2026-04-17T18:45:44.468601Z","caller":"traceutil/trace.go:171","msg":"trace[1773949250] transaction","detail":"{read_only:false; response_revision:4875; number_of_response:1; }","duration":"256.122063ms","start":"2026-04-17T18:45:44.212444Z","end":"2026-04-17T18:45:44.468566Z","steps":["trace[1773949250] 'process raft request'  (duration: 255.591ms)"],"step_count":1}
{"level":"info","ts":"2026-04-17T18:45:44.468617Z","caller":"traceutil/trace.go:171","msg":"trace[909532393] transaction","detail":"{read_only:false; response_revision:4874; number_of_response:1; }","duration":"423.932725ms","start":"2026-04-17T18:45:44.044651Z","end":"2026-04-17T18:45:44.468584Z","steps":["trace[909532393] 'process raft request'  (duration: 393.682671ms)","trace[909532393] 'compare'  (duration: 29.481885ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-17T18:45:44.46908Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.315658ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"warn","ts":"2026-04-17T18:45:44.469087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"544.806188ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-17T18:45:44.469119Z","caller":"traceutil/trace.go:171","msg":"trace[1076861463] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4876; }","duration":"197.39488ms","start":"2026-04-17T18:45:44.271716Z","end":"2026-04-17T18:45:44.469111Z","steps":["trace[1076861463] 'agreement among raft nodes before linearized reading'  (duration: 197.199775ms)"],"step_count":1}
{"level":"info","ts":"2026-04-17T18:45:44.469147Z","caller":"traceutil/trace.go:171","msg":"trace[623185920] range","detail":"{range_begin:/registry/csistoragecapacities/; range_end:/registry/csistoragecapacities0; response_count:0; response_revision:4876; }","duration":"544.972952ms","start":"2026-04-17T18:45:43.924159Z","end":"2026-04-17T18:45:44.469132Z","steps":["trace[623185920] 'agreement among raft nodes before linearized reading'  (duration: 544.779507ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-17T18:45:44.469191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"539.762752ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"}
{"level":"warn","ts":"2026-04-17T18:45:44.469204Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T18:45:43.924139Z","time spent":"545.052484ms","remote":"127.0.0.1:53074","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":0,"response size":28,"request content":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true "}
{"level":"info","ts":"2026-04-17T18:45:44.468862Z","caller":"traceutil/trace.go:171","msg":"trace[1831901833] linearizableReadLoop","detail":"{readStateIndex:5062; appliedIndex:5060; }","duration":"171.959785ms","start":"2026-04-17T18:45:44.296852Z","end":"2026-04-17T18:45:44.468811Z","steps":["trace[1831901833] 'read index received'  (duration: 141.556118ms)","trace[1831901833] 'applied index is now lower than readState.Index'  (duration: 30.395587ms)"],"step_count":2}
{"level":"info","ts":"2026-04-17T18:45:44.469249Z","caller":"traceutil/trace.go:171","msg":"trace[107361240] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4876; }","duration":"539.900345ms","start":"2026-04-17T18:45:43.92933Z","end":"2026-04-17T18:45:44.46923Z","steps":["trace[107361240] 'agreement among raft nodes before linearized reading'  (duration: 539.578817ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-17T18:45:44.469291Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T18:45:43.9293Z","time spent":"539.981267ms","remote":"127.0.0.1:49262","response type":"/etcdserverpb.KV/Range","request count":0,"request size":147,"response count":1,"response size":1958,"request content":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" "}
{"level":"warn","ts":"2026-04-17T18:45:44.469735Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.412466ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-17T18:45:44.469871Z","caller":"traceutil/trace.go:171","msg":"trace[63426807] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4876; }","duration":"253.627111ms","start":"2026-04-17T18:45:44.216218Z","end":"2026-04-17T18:45:44.469845Z","steps":["trace[63426807] 'agreement among raft nodes before linearized reading'  (duration: 253.417796ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-17T18:45:44.469789Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T18:45:44.044619Z","time spent":"424.398817ms","remote":"127.0.0.1:52862","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":11705,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/minions/instance\" mod_revision:3547 > success:<request_put:<key:\"/registry/minions/instance\" value_size:11671 >> failure:<request_range:<key:\"/registry/minions/instance\" > >"}
{"level":"info","ts":"2026-04-17T18:45:51.161986Z","caller":"traceutil/trace.go:171","msg":"trace[768669731] transaction","detail":"{read_only:false; response_revision:4952; number_of_response:1; }","duration":"181.535022ms","start":"2026-04-17T18:45:50.980415Z","end":"2026-04-17T18:45:51.16195Z","steps":["trace[768669731] 'process raft request'  (duration: 181.334856ms)"],"step_count":1}
{"level":"info","ts":"2026-04-17T18:45:51.281413Z","caller":"traceutil/trace.go:171","msg":"trace[1405689221] linearizableReadLoop","detail":"{readStateIndex:5141; appliedIndex:5139; }","duration":"295.366517ms","start":"2026-04-17T18:45:50.986018Z","end":"2026-04-17T18:45:51.281385Z","steps":["trace[1405689221] 'read index received'  (duration: 175.705046ms)","trace[1405689221] 'applied index is now lower than readState.Index'  (duration: 119.660161ms)"],"step_count":2}
{"level":"info","ts":"2026-04-17T18:45:51.281479Z","caller":"traceutil/trace.go:171","msg":"trace[1727169296] transaction","detail":"{read_only:false; response_revision:4953; number_of_response:1; }","duration":"296.442025ms","start":"2026-04-17T18:45:50.985004Z","end":"2026-04-17T18:45:51.281446Z","steps":["trace[1727169296] 'process raft request'  (duration: 294.198329ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-17T18:45:51.281734Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.693535ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:571"}
{"level":"info","ts":"2026-04-17T18:45:51.281806Z","caller":"traceutil/trace.go:171","msg":"trace[1287291968] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:4953; }","duration":"295.803058ms","start":"2026-04-17T18:45:50.985983Z","end":"2026-04-17T18:45:51.281786Z","steps":["trace[1287291968] 'agreement among raft nodes before linearized reading'  (duration: 295.560472ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-17T18:45:51.281816Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.774717ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"warn","ts":"2026-04-17T18:45:51.282232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.62982ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:557"}
{"level":"info","ts":"2026-04-17T18:45:51.283716Z","caller":"traceutil/trace.go:171","msg":"trace[747339577] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4953; }","duration":"286.131647ms","start":"2026-04-17T18:45:50.997557Z","end":"2026-04-17T18:45:51.283689Z","steps":["trace[747339577] 'agreement among raft nodes before linearized reading'  (duration: 284.23623ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-17T18:45:51.282428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.582173ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-04-17T18:45:51.282895Z","caller":"traceutil/trace.go:171","msg":"trace[746290475] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4953; }","duration":"291.88916ms","start":"2026-04-17T18:45:50.990004Z","end":"2026-04-17T18:45:51.281893Z","steps":["trace[746290475] 'agreement among raft nodes before linearized reading'  (duration: 291.592843ms)"],"step_count":1}
{"level":"info","ts":"2026-04-17T18:45:51.283886Z","caller":"traceutil/trace.go:171","msg":"trace[1775425626] range","detail":"{range_begin:/registry/endpointslices/; range_end:/registry/endpointslices0; response_count:0; response_revision:4953; }","duration":"287.087731ms","start":"2026-04-17T18:45:50.996734Z","end":"2026-04-17T18:45:51.283822Z","steps":["trace[1775425626] 'agreement among raft nodes before linearized reading'  (duration: 285.519832ms)"],"step_count":1}
{"level":"info","ts":"2026-04-17T18:45:55.402209Z","caller":"traceutil/trace.go:171","msg":"trace[601718725] transaction","detail":"{read_only:false; response_revision:4983; number_of_response:1; }","duration":"102.934632ms","start":"2026-04-17T18:45:55.299244Z","end":"2026-04-17T18:45:55.402179Z","steps":["trace[601718725] 'process raft request'  (duration: 102.768708ms)"],"step_count":1}
{"level":"info","ts":"2026-04-17T18:45:55.499205Z","caller":"traceutil/trace.go:171","msg":"trace[2135621833] linearizableReadLoop","detail":"{readStateIndex:5173; appliedIndex:5171; }","duration":"196.460572ms","start":"2026-04-17T18:45:55.302711Z","end":"2026-04-17T18:45:55.499172Z","steps":["trace[2135621833] 'read index received'  (duration: 99.289433ms)","trace[2135621833] 'applied index is now lower than readState.Index'  (duration: 97.170249ms)"],"step_count":2}
{"level":"info","ts":"2026-04-17T18:45:55.499404Z","caller":"traceutil/trace.go:171","msg":"trace[1570303807] transaction","detail":"{read_only:false; response_revision:4984; number_of_response:1; }","duration":"197.58942ms","start":"2026-04-17T18:45:55.301734Z","end":"2026-04-17T18:45:55.499324Z","steps":["trace[1570303807] 'process raft request'  (duration: 165.993413ms)","trace[1570303807] 'compare'  (duration: 31.280859ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-17T18:45:55.499524Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.783471ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:557"}
{"level":"info","ts":"2026-04-17T18:45:55.499571Z","caller":"traceutil/trace.go:171","msg":"trace[2073780270] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4984; }","duration":"196.875672ms","start":"2026-04-17T18:45:55.302679Z","end":"2026-04-17T18:45:55.499555Z","steps":["trace[2073780270] 'agreement among raft nodes before linearized reading'  (duration: 196.645206ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-17T18:45:55.499746Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.069958ms","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-17T18:45:55.499847Z","caller":"traceutil/trace.go:171","msg":"trace[1222040930] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4984; }","duration":"193.186191ms","start":"2026-04-17T18:45:55.306646Z","end":"2026-04-17T18:45:55.499833Z","steps":["trace[1222040930] 'agreement among raft nodes before linearized reading'  (duration: 192.935645ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-17T18:45:55.499914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.447912ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:571"}
{"level":"info","ts":"2026-04-17T18:45:55.500071Z","caller":"traceutil/trace.go:171","msg":"trace[803364573] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:4984; }","duration":"192.652357ms","start":"2026-04-17T18:45:55.307386Z","end":"2026-04-17T18:45:55.500038Z","steps":["trace[803364573] 'agreement among raft nodes before linearized reading'  (duration: 192.308158ms)"],"step_count":1}
{"level":"info","ts":"2026-04-17T18:46:45.900906Z","caller":"traceutil/trace.go:171","msg":"trace[1217059100] transaction","detail":"{read_only:false; response_revision:5400; number_of_response:1; }","duration":"109.217211ms","start":"2026-04-17T18:46:45.791659Z","end":"2026-04-17T18:46:45.900877Z","steps":["trace[1217059100] 'process raft request'  (duration: 13.251768ms)","trace[1217059100] 'compare'  (duration: 95.724657ms)"],"step_count":2}
{"level":"info","ts":"2026-04-17T18:46:45.901329Z","caller":"traceutil/trace.go:171","msg":"trace[1088503833] transaction","detail":"{read_only:false; response_revision:5402; number_of_response:1; }","duration":"104.119714ms","start":"2026-04-17T18:46:45.797176Z","end":"2026-04-17T18:46:45.901295Z","steps":["trace[1088503833] 'process raft request'  (duration: 103.996231ms)"],"step_count":1}
{"level":"info","ts":"2026-04-17T18:46:45.901629Z","caller":"traceutil/trace.go:171","msg":"trace[1841296116] transaction","detail":"{read_only:false; response_revision:5401; number_of_response:1; }","duration":"108.567746ms","start":"2026-04-17T18:46:45.793004Z","end":"2026-04-17T18:46:45.901572Z","steps":["trace[1841296116] 'process raft request'  (duration: 107.832708ms)"],"step_count":1}
{"level":"info","ts":"2026-04-17T18:47:08.309724Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2913}
{"level":"info","ts":"2026-04-17T18:47:08.389615Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2913,"took":"77.924093ms","hash":956975763,"current-db-size-bytes":54374400,"current-db-size":"54 MB","current-db-size-in-use-bytes":29593600,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-04-17T18:47:08.389712Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":956975763,"revision":2913,"compact-revision":-1}
{"level":"info","ts":"2026-04-17T18:52:08.316499Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5573}
{"level":"info","ts":"2026-04-17T18:52:08.39798Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5573,"took":"79.218219ms","hash":2445855115,"current-db-size-bytes":54374400,"current-db-size":"54 MB","current-db-size-in-use-bytes":18403328,"current-db-size-in-use":"18 MB"}
{"level":"info","ts":"2026-04-17T18:52:08.398052Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2445855115,"revision":5573,"compact-revision":2913}