{"level":"warn","ts":"2026-04-08T00:33:35.380005Z","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-08T00:33:35.380088Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.250: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.250:2380","--initial-cluster=instance=https://199.204.45.250:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.250:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.250: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-08T00:33:35.380154Z","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-08T00:33:35.380166Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.250:2380"]}
{"level":"info","ts":"2026-04-08T00:33:35.380185Z","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-08T00:33:35.380781Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.250:2379"]}
{"level":"info","ts":"2026-04-08T00:33:35.380846Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.250:2380"],"listen-peer-urls":["https://199.204.45.250:2380"],"advertise-client-urls":["https://199.204.45.250:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.250:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.250: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-08T00:33:35.384966Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.92301ms"}
{"level":"info","ts":"2026-04-08T00:33:35.392256Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"d98d5f2c752cc52d","cluster-id":"c785b4aaf4bd3b11"}
{"level":"info","ts":"2026-04-08T00:33:35.392364Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d switched to configuration voters=()"}
{"level":"info","ts":"2026-04-08T00:33:35.392395Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d became follower at term 0"}
{"level":"info","ts":"2026-04-08T00:33:35.39241Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft d98d5f2c752cc52d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-04-08T00:33:35.392428Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d became follower at term 1"}
{"level":"info","ts":"2026-04-08T00:33:35.392485Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d switched to configuration voters=(15676290522495632685)"}
{"level":"warn","ts":"2026-04-08T00:33:35.398712Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-04-08T00:33:35.401256Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-04-08T00:33:35.402413Z","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-08T00:33:35.405851Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"d98d5f2c752cc52d","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-04-08T00:33:35.406068Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"d98d5f2c752cc52d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-04-08T00:33:35.407481Z","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-08T00:33:35.407876Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d switched to configuration voters=(15676290522495632685)"}
{"level":"info","ts":"2026-04-08T00:33:35.408206Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"c785b4aaf4bd3b11","local-member-id":"d98d5f2c752cc52d","added-peer-id":"d98d5f2c752cc52d","added-peer-peer-urls":["https://199.204.45.250:2380"]}
{"level":"info","ts":"2026-04-08T00:33:35.407722Z","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-08T00:33:35.410614Z","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-08T00:33:35.410695Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.250:2380"}
{"level":"info","ts":"2026-04-08T00:33:35.410743Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.250:2380"}
{"level":"info","ts":"2026-04-08T00:33:35.410851Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"d98d5f2c752cc52d","initial-advertise-peer-urls":["https://199.204.45.250:2380"],"listen-peer-urls":["https://199.204.45.250:2380"],"advertise-client-urls":["https://199.204.45.250:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.250:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-04-08T00:33:35.410891Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-04-08T00:33:35.411027Z","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-08T00:33:36.193747Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d is starting a new election at term 1"}
{"level":"info","ts":"2026-04-08T00:33:36.193805Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d became pre-candidate at term 1"}
{"level":"info","ts":"2026-04-08T00:33:36.19385Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d received MsgPreVoteResp from d98d5f2c752cc52d at term 1"}
{"level":"info","ts":"2026-04-08T00:33:36.193869Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d became candidate at term 2"}
{"level":"info","ts":"2026-04-08T00:33:36.193882Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d received MsgVoteResp from d98d5f2c752cc52d at term 2"}
{"level":"info","ts":"2026-04-08T00:33:36.193909Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d became leader at term 2"}
{"level":"info","ts":"2026-04-08T00:33:36.193929Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: d98d5f2c752cc52d elected leader d98d5f2c752cc52d at term 2"}
{"level":"info","ts":"2026-04-08T00:33:36.19517Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"d98d5f2c752cc52d","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.250:2379]}","request-path":"/0/members/d98d5f2c752cc52d/attributes","cluster-id":"c785b4aaf4bd3b11","publish-timeout":"7s"}
{"level":"info","ts":"2026-04-08T00:33:36.195183Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-08T00:33:36.195332Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-04-08T00:33:36.195428Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-04-08T00:33:36.195619Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-04-08T00:33:36.195747Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-04-08T00:33:36.198698Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-04-08T00:33:36.199265Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.250:2379"}
{"level":"info","ts":"2026-04-08T00:33:36.208615Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"c785b4aaf4bd3b11","local-member-id":"d98d5f2c752cc52d","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-08T00:33:36.208727Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-08T00:33:36.208757Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-08T00:33:51.071142Z","caller":"traceutil/trace.go:171","msg":"trace[209752975] linearizableReadLoop","detail":"{readStateIndex:381; appliedIndex:380; }","duration":"186.274375ms","start":"2026-04-08T00:33:50.884844Z","end":"2026-04-08T00:33:51.071118Z","steps":["trace[209752975] 'read index received'  (duration: 186.01367ms)","trace[209752975] 'applied index is now lower than readState.Index'  (duration: 259.555µs)"],"step_count":2}
{"level":"info","ts":"2026-04-08T00:33:51.07119Z","caller":"traceutil/trace.go:171","msg":"trace[486621085] transaction","detail":"{read_only:false; response_revision:371; number_of_response:1; }","duration":"256.041426ms","start":"2026-04-08T00:33:50.81512Z","end":"2026-04-08T00:33:51.071161Z","steps":["trace[486621085] 'process raft request'  (duration: 255.824993ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T00:33:51.0713Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.441747ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-vip-instance\" ","response":"range_response_count:1 size:4795"}
{"level":"info","ts":"2026-04-08T00:33:51.071371Z","caller":"traceutil/trace.go:171","msg":"trace[304687328] range","detail":"{range_begin:/registry/pods/kube-system/kube-vip-instance; range_end:; response_count:1; response_revision:371; }","duration":"186.56995ms","start":"2026-04-08T00:33:50.884789Z","end":"2026-04-08T00:33:51.071359Z","steps":["trace[304687328] 'agreement among raft nodes before linearized reading'  (duration: 186.439868ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T00:34:02.143141Z","caller":"traceutil/trace.go:171","msg":"trace[537864784] linearizableReadLoop","detail":"{readStateIndex:440; appliedIndex:439; }","duration":"200.920334ms","start":"2026-04-08T00:34:01.942196Z","end":"2026-04-08T00:34:02.143117Z","steps":["trace[537864784] 'read index received'  (duration: 200.754092ms)","trace[537864784] 'applied index is now lower than readState.Index'  (duration: 165.282µs)"],"step_count":2}
{"level":"info","ts":"2026-04-08T00:34:02.143196Z","caller":"traceutil/trace.go:171","msg":"trace[1560224726] transaction","detail":"{read_only:false; response_revision:427; number_of_response:1; }","duration":"227.363185ms","start":"2026-04-08T00:34:01.915799Z","end":"2026-04-08T00:34:02.143162Z","steps":["trace[1560224726] 'process raft request'  (duration: 227.125011ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T00:34:02.143308Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.094857ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-04-08T00:34:02.143341Z","caller":"traceutil/trace.go:171","msg":"trace[446230580] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:427; }","duration":"201.1804ms","start":"2026-04-08T00:34:01.942151Z","end":"2026-04-08T00:34:02.143332Z","steps":["trace[446230580] 'agreement among raft nodes before linearized reading'  (duration: 201.099009ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T00:34:06.400104Z","caller":"traceutil/trace.go:171","msg":"trace[1738685672] transaction","detail":"{read_only:false; response_revision:470; number_of_response:1; }","duration":"138.160757ms","start":"2026-04-08T00:34:06.261917Z","end":"2026-04-08T00:34:06.400077Z","steps":["trace[1738685672] 'process raft request'  (duration: 138.012975ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T00:34:06.7411Z","caller":"traceutil/trace.go:171","msg":"trace[656508977] transaction","detail":"{read_only:false; response_revision:471; number_of_response:1; }","duration":"327.141692ms","start":"2026-04-08T00:34:06.413936Z","end":"2026-04-08T00:34:06.741078Z","steps":["trace[656508977] 'process raft request'  (duration: 327.02918ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T00:34:06.741586Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T00:34:06.413917Z","time spent":"327.250714ms","remote":"127.0.0.1:56264","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/referencegrants.gateway.networking.k8s.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/referencegrants.gateway.networking.k8s.io\" value_size:6209 >> failure:<>"}
{"level":"info","ts":"2026-04-08T00:34:06.864562Z","caller":"traceutil/trace.go:171","msg":"trace[25166064] transaction","detail":"{read_only:false; response_revision:473; number_of_response:1; }","duration":"447.459342ms","start":"2026-04-08T00:34:06.417078Z","end":"2026-04-08T00:34:06.864537Z","steps":["trace[25166064] 'process raft request'  (duration: 447.084275ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T00:34:06.864577Z","caller":"traceutil/trace.go:171","msg":"trace[1076431268] transaction","detail":"{read_only:false; response_revision:474; number_of_response:1; }","duration":"438.959661ms","start":"2026-04-08T00:34:06.425596Z","end":"2026-04-08T00:34:06.864556Z","steps":["trace[1076431268] 'process raft request'  (duration: 438.619065ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T00:34:06.864687Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T00:34:06.425577Z","time spent":"439.046632ms","remote":"127.0.0.1:56264","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/xbackendtrafficpolicies.gateway.networking.x-k8s.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/xbackendtrafficpolicies.gateway.networking.x-k8s.io\" value_size:21901 >> failure:<>"}
{"level":"warn","ts":"2026-04-08T00:34:06.864667Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T00:34:06.417065Z","time spent":"447.553614ms","remote":"127.0.0.1:56264","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/gatewayclasses.gateway.networking.k8s.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/gatewayclasses.gateway.networking.k8s.io\" value_size:9385 >> failure:<>"}
{"level":"info","ts":"2026-04-08T00:34:06.86483Z","caller":"traceutil/trace.go:171","msg":"trace[1395772560] transaction","detail":"{read_only:false; response_revision:475; number_of_response:1; }","duration":"439.126773ms","start":"2026-04-08T00:34:06.425691Z","end":"2026-04-08T00:34:06.864818Z","steps":["trace[1395772560] 'process raft request'  (duration: 438.576654ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T00:34:06.864796Z","caller":"traceutil/trace.go:171","msg":"trace[200802121] transaction","detail":"{read_only:false; response_revision:476; number_of_response:1; }","duration":"438.160567ms","start":"2026-04-08T00:34:06.426573Z","end":"2026-04-08T00:34:06.864734Z","steps":["trace[200802121] 'process raft request'  (duration: 437.884692ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T00:34:06.864847Z","caller":"traceutil/trace.go:171","msg":"trace[1536408908] transaction","detail":"{read_only:false; response_revision:472; number_of_response:1; }","duration":"449.538869ms","start":"2026-04-08T00:34:06.415261Z","end":"2026-04-08T00:34:06.8648Z","steps":["trace[1536408908] 'process raft request'  (duration: 448.707435ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T00:34:06.864884Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T00:34:06.425637Z","time spent":"439.225555ms","remote":"127.0.0.1:56264","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/tcproutes.gateway.networking.k8s.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/tcproutes.gateway.networking.k8s.io\" value_size:29718 >> failure:<>"}
{"level":"info","ts":"2026-04-08T00:34:06.864867Z","caller":"traceutil/trace.go:171","msg":"trace[1781472332] transaction","detail":"{read_only:false; response_revision:477; number_of_response:1; }","duration":"436.444536ms","start":"2026-04-08T00:34:06.428391Z","end":"2026-04-08T00:34:06.864835Z","steps":["trace[1781472332] 'process raft request'  (duration: 436.12801ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T00:34:06.864984Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T00:34:06.415252Z","time spent":"449.651941ms","remote":"127.0.0.1:56264","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/xmeshes.gateway.networking.x-k8s.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/xmeshes.gateway.networking.x-k8s.io\" value_size:8062 >> failure:<>"}
{"level":"warn","ts":"2026-04-08T00:34:06.864979Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T00:34:06.426562Z","time spent":"438.32814ms","remote":"127.0.0.1:56264","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/xlistenersets.gateway.networking.x-k8s.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/xlistenersets.gateway.networking.x-k8s.io\" value_size:28354 >> failure:<>"}
{"level":"info","ts":"2026-04-08T00:34:06.864989Z","caller":"traceutil/trace.go:171","msg":"trace[1060523943] transaction","detail":"{read_only:false; response_revision:478; number_of_response:1; }","duration":"433.818729ms","start":"2026-04-08T00:34:06.431074Z","end":"2026-04-08T00:34:06.864893Z","steps":["trace[1060523943] 'process raft request'  (duration: 433.517364ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T00:34:06.865143Z","caller":"traceutil/trace.go:171","msg":"trace[1831990807] transaction","detail":"{read_only:false; response_revision:479; number_of_response:1; }","duration":"428.102498ms","start":"2026-04-08T00:34:06.436959Z","end":"2026-04-08T00:34:06.865061Z","steps":["trace[1831990807] 'process raft request'  (duration: 427.780751ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T00:34:06.865191Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T00:34:06.431058Z","time spent":"434.052414ms","remote":"127.0.0.1:56264","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/backendtlspolicies.gateway.networking.k8s.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/backendtlspolicies.gateway.networking.k8s.io\" value_size:28055 >> failure:<>"}
{"level":"info","ts":"2026-04-08T00:34:06.86526Z","caller":"traceutil/trace.go:171","msg":"trace[1750260209] transaction","detail":"{read_only:false; response_revision:480; number_of_response:1; }","duration":"424.780489ms","start":"2026-04-08T00:34:06.440434Z","end":"2026-04-08T00:34:06.865214Z","steps":["trace[1750260209] 'process raft request'  (duration: 424.464013ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T00:34:06.866619Z","caller":"traceutil/trace.go:171","msg":"trace[402707300] transaction","detail":"{read_only:false; response_revision:481; number_of_response:1; }","duration":"393.253668ms","start":"2026-04-08T00:34:06.472104Z","end":"2026-04-08T00:34:06.865358Z","steps":["trace[402707300] 'process raft request'  (duration: 393.006993ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T00:34:06.866675Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T00:34:06.436937Z","time spent":"428.311102ms","remote":"127.0.0.1:56264","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/tlsroutes.gateway.networking.k8s.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/tlsroutes.gateway.networking.k8s.io\" value_size:63787 >> failure:<>"}
{"level":"warn","ts":"2026-04-08T00:34:06.866646Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T00:34:06.440412Z","time spent":"426.168104ms","remote":"127.0.0.1:56264","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/gateways.gateway.networking.k8s.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/gateways.gateway.networking.k8s.io\" value_size:58170 >> failure:<>"}
{"level":"warn","ts":"2026-04-08T00:34:06.865112Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T00:34:06.428366Z","time spent":"436.599238ms","remote":"127.0.0.1:56264","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/udproutes.gateway.networking.k8s.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/udproutes.gateway.networking.k8s.io\" value_size:29699 >> failure:<>"}
{"level":"warn","ts":"2026-04-08T00:34:06.866823Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T00:34:06.47208Z","time spent":"394.624733ms","remote":"127.0.0.1:56264","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/grpcroutes.gateway.networking.k8s.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/grpcroutes.gateway.networking.k8s.io\" value_size:79271 >> failure:<>"}
{"level":"info","ts":"2026-04-08T00:34:06.869199Z","caller":"traceutil/trace.go:171","msg":"trace[1607138566] transaction","detail":"{read_only:false; response_revision:482; number_of_response:1; }","duration":"284.3746ms","start":"2026-04-08T00:34:06.58478Z","end":"2026-04-08T00:34:06.869155Z","steps":["trace[1607138566] 'process raft request'  (duration: 282.329764ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T00:34:06.869703Z","caller":"traceutil/trace.go:171","msg":"trace[238528497] transaction","detail":"{read_only:false; response_revision:484; number_of_response:1; }","duration":"119.68816ms","start":"2026-04-08T00:34:06.749988Z","end":"2026-04-08T00:34:06.869676Z","steps":["trace[238528497] 'process raft request'  (duration: 119.489137ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T00:34:06.869708Z","caller":"traceutil/trace.go:171","msg":"trace[1799595464] transaction","detail":"{read_only:false; number_of_response:1; response_revision:484; }","duration":"119.596538ms","start":"2026-04-08T00:34:06.750078Z","end":"2026-04-08T00:34:06.869674Z","steps":["trace[1799595464] 'process raft request'  (duration: 119.545807ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T00:34:06.869685Z","caller":"traceutil/trace.go:171","msg":"trace[80256040] transaction","detail":"{read_only:false; response_revision:483; number_of_response:1; }","duration":"121.465981ms","start":"2026-04-08T00:34:06.748192Z","end":"2026-04-08T00:34:06.869658Z","steps":["trace[80256040] 'process raft request'  (duration: 121.209177ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T00:34:08.084475Z","caller":"traceutil/trace.go:171","msg":"trace[1907242075] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"105.736654ms","start":"2026-04-08T00:34:07.978709Z","end":"2026-04-08T00:34:08.084445Z","steps":["trace[1907242075] 'process raft request'  (duration: 64.419895ms)","trace[1907242075] 'compare'  (duration: 41.203677ms)"],"step_count":2}
{"level":"info","ts":"2026-04-08T00:34:08.099795Z","caller":"traceutil/trace.go:171","msg":"trace[1374970962] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"120.800599ms","start":"2026-04-08T00:34:07.97895Z","end":"2026-04-08T00:34:08.099751Z","steps":["trace[1374970962] 'process raft request'  (duration: 120.576965ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T00:34:13.311816Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.98814ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14208185480201413830 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/pods/kube-system/cilium-dnxtz\" mod_revision:462 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-dnxtz\" value_size:17085 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-dnxtz\" > >>","response":"size:16"}
{"level":"info","ts":"2026-04-08T00:34:13.311932Z","caller":"traceutil/trace.go:171","msg":"trace[39845627] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"310.09417ms","start":"2026-04-08T00:34:13.001819Z","end":"2026-04-08T00:34:13.311913Z","steps":["trace[39845627] 'process raft request'  (duration: 97.665092ms)","trace[39845627] 'compare'  (duration: 211.839997ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-08T00:34:13.312043Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T00:34:13.001784Z","time spent":"310.181343ms","remote":"127.0.0.1:56414","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/cilium-dnxtz\" mod_revision:462 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-dnxtz\" value_size:17085 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-dnxtz\" > >"}
{"level":"info","ts":"2026-04-08T00:34:13.362656Z","caller":"traceutil/trace.go:171","msg":"trace[274293758] linearizableReadLoop","detail":"{readStateIndex:600; appliedIndex:599; }","duration":"176.840666ms","start":"2026-04-08T00:34:13.185752Z","end":"2026-04-08T00:34:13.362593Z","steps":["trace[274293758] 'read index received'  (duration: 171.287361ms)","trace[274293758] 'applied index is now lower than readState.Index'  (duration: 5.552125ms)"],"step_count":2}
{"level":"info","ts":"2026-04-08T00:34:13.36277Z","caller":"traceutil/trace.go:171","msg":"trace[642615514] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"302.496178ms","start":"2026-04-08T00:34:13.060234Z","end":"2026-04-08T00:34:13.36273Z","steps":["trace[642615514] 'process raft request'  (duration: 297.591776ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T00:34:13.362832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.06797ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-08T00:34:13.362872Z","caller":"traceutil/trace.go:171","msg":"trace[1723152920] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:580; }","duration":"177.162682ms","start":"2026-04-08T00:34:13.185696Z","end":"2026-04-08T00:34:13.362859Z","steps":["trace[1723152920] 'agreement among raft nodes before linearized reading'  (duration: 177.081161ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T00:34:13.362948Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T00:34:13.060206Z","time spent":"302.65218ms","remote":"127.0.0.1:56304","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036273,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" mod_revision:575 > success:<request_put:<key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" value_size:1036189 >> failure:<request_range:<key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" > >"}
{"level":"warn","ts":"2026-04-08T00:34:14.065483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"622.23152ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14208185480201413835 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:565 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-04-08T00:34:14.065635Z","caller":"traceutil/trace.go:171","msg":"trace[1718357576] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"651.280508ms","start":"2026-04-08T00:34:13.414338Z","end":"2026-04-08T00:34:14.065619Z","steps":["trace[1718357576] 'process raft request'  (duration: 651.233047ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T00:34:14.065689Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T00:34:13.414313Z","time spent":"651.35266ms","remote":"127.0.0.1:56742","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" mod_revision:0 > success:<request_put:<key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" value_size:1527 >> failure:<>"}
{"level":"info","ts":"2026-04-08T00:34:14.065781Z","caller":"traceutil/trace.go:171","msg":"trace[1531803465] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"697.45036ms","start":"2026-04-08T00:34:13.368274Z","end":"2026-04-08T00:34:14.065724Z","steps":["trace[1531803465] 'process raft request'  (duration: 74.900724ms)","trace[1531803465] 'compare'  (duration: 622.113598ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-08T00:34:14.065999Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T00:34:13.368211Z","time spent":"697.663293ms","remote":"127.0.0.1:56486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:565 > 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-08T00:34:15.598535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.038849ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-04-08T00:34:15.598597Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.279496ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-08T00:34:15.598657Z","caller":"traceutil/trace.go:171","msg":"trace[1009958969] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:598; }","duration":"106.348207ms","start":"2026-04-08T00:34:15.492293Z","end":"2026-04-08T00:34:15.598642Z","steps":["trace[1009958969] 'count revisions from in-memory index tree'  (duration: 106.086211ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T00:34:15.598657Z","caller":"traceutil/trace.go:171","msg":"trace[53078066] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:598; }","duration":"107.215333ms","start":"2026-04-08T00:34:15.491419Z","end":"2026-04-08T00:34:15.598634Z","steps":["trace[53078066] 'range keys from in-memory index tree'  (duration: 106.891307ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T00:34:30.277837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.341808ms","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-08T00:34:30.277978Z","caller":"traceutil/trace.go:171","msg":"trace[1305369172] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:743; }","duration":"131.537811ms","start":"2026-04-08T00:34:30.146414Z","end":"2026-04-08T00:34:30.277952Z","steps":["trace[1305369172] 'range keys from in-memory index tree'  (duration: 131.055182ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T00:34:30.277837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.297307ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-8d7b9\" ","response":"range_response_count:1 size:3965"}
{"level":"info","ts":"2026-04-08T00:34:30.278145Z","caller":"traceutil/trace.go:171","msg":"trace[1253848898] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-8d7b9; range_end:; response_count:1; response_revision:743; }","duration":"193.645904ms","start":"2026-04-08T00:34:30.08446Z","end":"2026-04-08T00:34:30.278106Z","steps":["trace[1253848898] 'range keys from in-memory index tree'  (duration: 193.118134ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T00:34:44.536476Z","caller":"traceutil/trace.go:171","msg":"trace[508616658] transaction","detail":"{read_only:false; response_revision:905; number_of_response:1; }","duration":"174.500843ms","start":"2026-04-08T00:34:44.361956Z","end":"2026-04-08T00:34:44.536457Z","steps":["trace[508616658] 'process raft request'  (duration: 174.33939ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T00:35:11.651814Z","caller":"traceutil/trace.go:171","msg":"trace[1278493376] transaction","detail":"{read_only:false; response_revision:1272; number_of_response:1; }","duration":"265.305015ms","start":"2026-04-08T00:35:11.386472Z","end":"2026-04-08T00:35:11.651777Z","steps":["trace[1278493376] 'process raft request'  (duration: 265.141942ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T00:35:41.270035Z","caller":"traceutil/trace.go:171","msg":"trace[168983746] linearizableReadLoop","detail":"{readStateIndex:1853; appliedIndex:1852; }","duration":"307.694782ms","start":"2026-04-08T00:35:40.962309Z","end":"2026-04-08T00:35:41.270004Z","steps":["trace[168983746] 'read index received'  (duration: 307.516079ms)","trace[168983746] 'applied index is now lower than readState.Index'  (duration: 177.273µs)"],"step_count":2}
{"level":"info","ts":"2026-04-08T00:35:41.270085Z","caller":"traceutil/trace.go:171","msg":"trace[952350972] transaction","detail":"{read_only:false; response_revision:1789; number_of_response:1; }","duration":"328.071632ms","start":"2026-04-08T00:35:40.94198Z","end":"2026-04-08T00:35:41.270051Z","steps":["trace[952350972] 'process raft request'  (duration: 327.831448ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T00:35:41.270337Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T00:35:40.941957Z","time spent":"328.209404ms","remote":"127.0.0.1:56486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:1717 > 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-08T00:35:41.270343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.005038ms","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-08T00:35:41.270441Z","caller":"traceutil/trace.go:171","msg":"trace[1424870130] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1789; }","duration":"308.159412ms","start":"2026-04-08T00:35:40.962262Z","end":"2026-04-08T00:35:41.270422Z","steps":["trace[1424870130] 'agreement among raft nodes before linearized reading'  (duration: 307.915617ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T00:35:41.270445Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.139338ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"warn","ts":"2026-04-08T00:35:41.270508Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T00:35:40.962244Z","time spent":"308.249693ms","remote":"127.0.0.1:56486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-04-08T00:35:41.270647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.319678ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-04-08T00:35:41.270725Z","caller":"traceutil/trace.go:171","msg":"trace[180726684] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:1789; }","duration":"171.43229ms","start":"2026-04-08T00:35:41.099262Z","end":"2026-04-08T00:35:41.270694Z","steps":["trace[180726684] 'agreement among raft nodes before linearized reading'  (duration: 171.311488ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T00:35:41.270739Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.422363ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:569"}
{"level":"info","ts":"2026-04-08T00:35:41.270785Z","caller":"traceutil/trace.go:171","msg":"trace[290746936] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:1789; }","duration":"258.506614ms","start":"2026-04-08T00:35:41.012265Z","end":"2026-04-08T00:35:41.270771Z","steps":["trace[290746936] 'agreement among raft nodes before linearized reading'  (duration: 258.356292ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T00:35:41.271138Z","caller":"traceutil/trace.go:171","msg":"trace[1131313175] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1789; }","duration":"303.2637ms","start":"2026-04-08T00:35:40.967261Z","end":"2026-04-08T00:35:41.270525Z","steps":["trace[1131313175] 'agreement among raft nodes before linearized reading'  (duration: 303.014244ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T00:35:41.271232Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T00:35:40.967251Z","time spent":"303.954072ms","remote":"127.0.0.1:56486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-04-08T00:35:41.438317Z","caller":"traceutil/trace.go:171","msg":"trace[81537070] transaction","detail":"{read_only:false; response_revision:1790; number_of_response:1; }","duration":"163.267156ms","start":"2026-04-08T00:35:41.275017Z","end":"2026-04-08T00:35:41.438284Z","steps":["trace[81537070] 'process raft request'  (duration: 163.024541ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T00:35:41.478647Z","caller":"traceutil/trace.go:171","msg":"trace[2031297171] transaction","detail":"{read_only:false; response_revision:1792; number_of_response:1; }","duration":"202.874086ms","start":"2026-04-08T00:35:41.275749Z","end":"2026-04-08T00:35:41.478623Z","steps":["trace[2031297171] 'process raft request'  (duration: 202.781274ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T00:35:41.478655Z","caller":"traceutil/trace.go:171","msg":"trace[166471771] transaction","detail":"{read_only:false; response_revision:1791; number_of_response:1; }","duration":"203.449767ms","start":"2026-04-08T00:35:41.275169Z","end":"2026-04-08T00:35:41.478619Z","steps":["trace[166471771] 'process raft request'  (duration: 203.264794ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T00:35:41.9234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.737212ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-04-08T00:35:41.923522Z","caller":"traceutil/trace.go:171","msg":"trace[1481931507] range","detail":"{range_begin:/registry/storageclasses/; range_end:/registry/storageclasses0; response_count:0; response_revision:1794; }","duration":"181.925886ms","start":"2026-04-08T00:35:41.741575Z","end":"2026-04-08T00:35:41.923501Z","steps":["trace[1481931507] 'count revisions from in-memory index tree'  (duration: 181.64701ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T00:35:41.923654Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.197092ms","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-08T00:35:41.923749Z","caller":"traceutil/trace.go:171","msg":"trace[1719636105] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1794; }","duration":"159.342173ms","start":"2026-04-08T00:35:41.764378Z","end":"2026-04-08T00:35:41.92372Z","steps":["trace[1719636105] 'range keys from in-memory index tree'  (duration: 158.994168ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T00:35:41.923926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.868184ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-08T00:35:41.92494Z","caller":"traceutil/trace.go:171","msg":"trace[1427040382] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:1794; }","duration":"204.879523ms","start":"2026-04-08T00:35:41.720041Z","end":"2026-04-08T00:35:41.92492Z","steps":["trace[1427040382] 'count revisions from in-memory index tree'  (duration: 203.740832ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T00:35:57.821835Z","caller":"traceutil/trace.go:171","msg":"trace[1849208258] transaction","detail":"{read_only:false; response_revision:1928; number_of_response:1; }","duration":"100.439765ms","start":"2026-04-08T00:35:57.721362Z","end":"2026-04-08T00:35:57.821802Z","steps":["trace[1849208258] 'process raft request'  (duration: 65.219078ms)","trace[1849208258] 'compare'  (duration: 35.071494ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-08T00:36:25.975171Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.270116ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-04-08T00:36:25.975271Z","caller":"traceutil/trace.go:171","msg":"trace[1599449211] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2089; }","duration":"194.410839ms","start":"2026-04-08T00:36:25.780838Z","end":"2026-04-08T00:36:25.975249Z","steps":["trace[1599449211] 'range keys from in-memory index tree'  (duration: 193.992991ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T00:36:26.033114Z","caller":"traceutil/trace.go:171","msg":"trace[1099877753] transaction","detail":"{read_only:false; response_revision:2090; number_of_response:1; }","duration":"106.443234ms","start":"2026-04-08T00:36:25.926652Z","end":"2026-04-08T00:36:26.033095Z","steps":["trace[1099877753] 'process raft request'  (duration: 106.310311ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T00:36:26.388097Z","caller":"traceutil/trace.go:171","msg":"trace[490542522] transaction","detail":"{read_only:false; response_revision:2092; number_of_response:1; }","duration":"169.611514ms","start":"2026-04-08T00:36:26.218459Z","end":"2026-04-08T00:36:26.38807Z","steps":["trace[490542522] 'process raft request'  (duration: 169.465432ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T00:36:31.787693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.794049ms","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-08T00:36:31.787705Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.225843ms","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-08T00:36:31.787793Z","caller":"traceutil/trace.go:171","msg":"trace[241565691] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2117; }","duration":"217.942072ms","start":"2026-04-08T00:36:31.569818Z","end":"2026-04-08T00:36:31.78776Z","steps":["trace[241565691] 'range keys from in-memory index tree'  (duration: 217.615446ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T00:36:31.787801Z","caller":"traceutil/trace.go:171","msg":"trace[1179853620] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2117; }","duration":"159.354335ms","start":"2026-04-08T00:36:31.628427Z","end":"2026-04-08T00:36:31.787781Z","steps":["trace[1179853620] 'range keys from in-memory index tree'  (duration: 159.080801ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T00:36:31.947388Z","caller":"traceutil/trace.go:171","msg":"trace[1042294278] transaction","detail":"{read_only:false; response_revision:2118; number_of_response:1; }","duration":"154.893105ms","start":"2026-04-08T00:36:31.792433Z","end":"2026-04-08T00:36:31.947327Z","steps":["trace[1042294278] 'process raft request'  (duration: 154.698061ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T00:36:31.955606Z","caller":"traceutil/trace.go:171","msg":"trace[1624804324] transaction","detail":"{read_only:false; response_revision:2119; number_of_response:1; }","duration":"162.967422ms","start":"2026-04-08T00:36:31.792611Z","end":"2026-04-08T00:36:31.955579Z","steps":["trace[1624804324] 'process raft request'  (duration: 162.753418ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T00:36:31.955805Z","caller":"traceutil/trace.go:171","msg":"trace[266299687] transaction","detail":"{read_only:false; response_revision:2120; number_of_response:1; }","duration":"162.954512ms","start":"2026-04-08T00:36:31.792828Z","end":"2026-04-08T00:36:31.955782Z","steps":["trace[266299687] 'process raft request'  (duration: 162.706697ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T00:36:32.223657Z","caller":"traceutil/trace.go:171","msg":"trace[1410792484] linearizableReadLoop","detail":"{readStateIndex:2197; appliedIndex:2196; }","duration":"152.413328ms","start":"2026-04-08T00:36:32.071218Z","end":"2026-04-08T00:36:32.223632Z","steps":["trace[1410792484] 'read index received'  (duration: 97.612312ms)","trace[1410792484] 'applied index is now lower than readState.Index'  (duration: 54.799946ms)"],"step_count":2}
{"level":"info","ts":"2026-04-08T00:36:32.223701Z","caller":"traceutil/trace.go:171","msg":"trace[1940197050] transaction","detail":"{read_only:false; response_revision:2121; number_of_response:1; }","duration":"172.725321ms","start":"2026-04-08T00:36:32.050939Z","end":"2026-04-08T00:36:32.223664Z","steps":["trace[1940197050] 'process raft request'  (duration: 117.893144ms)","trace[1940197050] 'compare'  (duration: 54.529262ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-08T00:36:32.224256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.998299ms","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-08T00:36:32.224406Z","caller":"traceutil/trace.go:171","msg":"trace[1186595503] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2121; }","duration":"153.209453ms","start":"2026-04-08T00:36:32.071163Z","end":"2026-04-08T00:36:32.224373Z","steps":["trace[1186595503] 'agreement among raft nodes before linearized reading'  (duration: 152.583151ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T00:37:17.466371Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.053814ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12209"}
{"level":"info","ts":"2026-04-08T00:37:17.46647Z","caller":"traceutil/trace.go:171","msg":"trace[1902520720] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2413; }","duration":"162.209717ms","start":"2026-04-08T00:37:17.304238Z","end":"2026-04-08T00:37:17.466448Z","steps":["trace[1902520720] 'range keys from in-memory index tree'  (duration: 161.757839ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T00:37:17.46723Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.196163ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-08T00:37:17.467352Z","caller":"traceutil/trace.go:171","msg":"trace[1759962266] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2413; }","duration":"281.393517ms","start":"2026-04-08T00:37:17.18593Z","end":"2026-04-08T00:37:17.467323Z","steps":["trace[1759962266] 'range keys from in-memory index tree'  (duration: 280.821876ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T00:37:49.410069Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.727924ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14208185480201418302 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:2580 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >>","response":"size:16"}
{"level":"info","ts":"2026-04-08T00:37:49.410198Z","caller":"traceutil/trace.go:171","msg":"trace[1616602670] linearizableReadLoop","detail":"{readStateIndex:2682; appliedIndex:2681; }","duration":"223.246543ms","start":"2026-04-08T00:37:49.186932Z","end":"2026-04-08T00:37:49.410179Z","steps":["trace[1616602670] 'read index received'  (duration: 115.309725ms)","trace[1616602670] 'applied index is now lower than readState.Index'  (duration: 107.935118ms)"],"step_count":2}
{"level":"info","ts":"2026-04-08T00:37:49.410299Z","caller":"traceutil/trace.go:171","msg":"trace[101946433] transaction","detail":"{read_only:false; response_revision:2589; number_of_response:1; }","duration":"230.447506ms","start":"2026-04-08T00:37:49.179799Z","end":"2026-04-08T00:37:49.410246Z","steps":["trace[101946433] 'process raft request'  (duration: 122.449177ms)","trace[101946433] 'compare'  (duration: 107.592662ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-08T00:37:49.410329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.367515ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-08T00:37:49.41043Z","caller":"traceutil/trace.go:171","msg":"trace[1742581651] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2589; }","duration":"223.500268ms","start":"2026-04-08T00:37:49.186904Z","end":"2026-04-08T00:37:49.410405Z","steps":["trace[1742581651] 'agreement among raft nodes before linearized reading'  (duration: 223.339465ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T00:37:49.410495Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.289225ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.250\" ","response":"range_response_count:1 size:135"}
{"level":"info","ts":"2026-04-08T00:37:49.410538Z","caller":"traceutil/trace.go:171","msg":"trace[2010849997] range","detail":"{range_begin:/registry/masterleases/199.204.45.250; range_end:; response_count:1; response_revision:2589; }","duration":"189.396107ms","start":"2026-04-08T00:37:49.221129Z","end":"2026-04-08T00:37:49.410525Z","steps":["trace[2010849997] 'agreement among raft nodes before linearized reading'  (duration: 189.149002ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T00:40:35.976306Z","caller":"traceutil/trace.go:171","msg":"trace[1508744587] transaction","detail":"{read_only:false; response_revision:3653; number_of_response:1; }","duration":"169.986353ms","start":"2026-04-08T00:40:35.806288Z","end":"2026-04-08T00:40:35.976274Z","steps":["trace[1508744587] 'process raft request'  (duration: 169.302309ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T00:40:41.311168Z","caller":"traceutil/trace.go:171","msg":"trace[271941581] transaction","detail":"{read_only:false; response_revision:3679; number_of_response:1; }","duration":"141.696873ms","start":"2026-04-08T00:40:41.169444Z","end":"2026-04-08T00:40:41.311141Z","steps":["trace[271941581] 'process raft request'  (duration: 141.473719ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T00:40:41.88109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.43946ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14208185480201421325 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:3672 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-04-08T00:40:41.881218Z","caller":"traceutil/trace.go:171","msg":"trace[211435022] transaction","detail":"{read_only:false; response_revision:3680; number_of_response:1; }","duration":"566.18805ms","start":"2026-04-08T00:40:41.315006Z","end":"2026-04-08T00:40:41.881194Z","steps":["trace[211435022] 'process raft request'  (duration: 427.535386ms)","trace[211435022] 'compare'  (duration: 138.293347ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-08T00:40:41.88128Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T00:40:41.314961Z","time spent":"566.291381ms","remote":"127.0.0.1:56486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:3672 > 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-08T00:40:41.884485Z","caller":"traceutil/trace.go:171","msg":"trace[690605289] transaction","detail":"{read_only:false; response_revision:3681; number_of_response:1; }","duration":"569.085735ms","start":"2026-04-08T00:40:41.315365Z","end":"2026-04-08T00:40:41.884451Z","steps":["trace[690605289] 'process raft request'  (duration: 568.82697ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T00:40:41.884584Z","caller":"traceutil/trace.go:171","msg":"trace[2104997877] transaction","detail":"{read_only:false; response_revision:3682; number_of_response:1; }","duration":"569.066866ms","start":"2026-04-08T00:40:41.31548Z","end":"2026-04-08T00:40:41.884547Z","steps":["trace[2104997877] 'process raft request'  (duration: 568.890882ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T00:40:41.884471Z","caller":"traceutil/trace.go:171","msg":"trace[2049501961] linearizableReadLoop","detail":"{readStateIndex:3817; appliedIndex:3814; }","duration":"465.347825ms","start":"2026-04-08T00:40:41.419084Z","end":"2026-04-08T00:40:41.884432Z","steps":["trace[2049501961] 'read index received'  (duration: 323.5308ms)","trace[2049501961] 'applied index is now lower than readState.Index'  (duration: 141.815565ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-08T00:40:41.884733Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"465.622781ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12209"}
{"level":"info","ts":"2026-04-08T00:40:41.884804Z","caller":"traceutil/trace.go:171","msg":"trace[1236370374] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:3682; }","duration":"465.763383ms","start":"2026-04-08T00:40:41.419023Z","end":"2026-04-08T00:40:41.884787Z","steps":["trace[1236370374] 'agreement among raft nodes before linearized reading'  (duration: 465.522999ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T00:40:41.884807Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T00:40:41.315454Z","time spent":"569.260159ms","remote":"127.0.0.1:56486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:3673 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-04-08T00:40:41.884884Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T00:40:41.41898Z","time spent":"465.865185ms","remote":"127.0.0.1:56414","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12233,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "}
{"level":"warn","ts":"2026-04-08T00:40:41.884897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"360.563944ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"}
{"level":"info","ts":"2026-04-08T00:40:41.884975Z","caller":"traceutil/trace.go:171","msg":"trace[949985691] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:3682; }","duration":"360.639816ms","start":"2026-04-08T00:40:41.524313Z","end":"2026-04-08T00:40:41.884953Z","steps":["trace[949985691] 'agreement among raft nodes before linearized reading'  (duration: 360.434632ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T00:40:41.885032Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T00:40:41.524242Z","time spent":"360.777138ms","remote":"127.0.0.1:56486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":504,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-04-08T00:40:41.884807Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T00:40:41.315353Z","time spent":"569.212328ms","remote":"127.0.0.1:56486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:3671 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:477 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-04-08T00:40:41.885028Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.756732ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-s598f\" ","response":"range_response_count:1 size:6524"}
{"level":"info","ts":"2026-04-08T00:40:41.885137Z","caller":"traceutil/trace.go:171","msg":"trace[1012187277] range","detail":"{range_begin:/registry/pods/openstack/keepalived-s598f; range_end:; response_count:1; response_revision:3682; }","duration":"158.914336ms","start":"2026-04-08T00:40:41.7262Z","end":"2026-04-08T00:40:41.885114Z","steps":["trace[1012187277] 'agreement among raft nodes before linearized reading'  (duration: 158.642261ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T00:41:58.592342Z","caller":"traceutil/trace.go:171","msg":"trace[1231880952] linearizableReadLoop","detail":"{readStateIndex:4862; appliedIndex:4861; }","duration":"125.917105ms","start":"2026-04-08T00:41:58.466395Z","end":"2026-04-08T00:41:58.592312Z","steps":["trace[1231880952] 'read index received'  (duration: 100.278ms)","trace[1231880952] 'applied index is now lower than readState.Index'  (duration: 25.636825ms)"],"step_count":2}
{"level":"info","ts":"2026-04-08T00:41:58.592376Z","caller":"traceutil/trace.go:171","msg":"trace[938556551] transaction","detail":"{read_only:false; response_revision:4688; number_of_response:1; }","duration":"126.475356ms","start":"2026-04-08T00:41:58.465848Z","end":"2026-04-08T00:41:58.592323Z","steps":["trace[938556551] 'process raft request'  (duration: 100.787721ms)","trace[938556551] 'compare'  (duration: 25.419659ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-08T00:41:58.592681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.164599ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/monitoring/prometheus-operated\" ","response":"range_response_count:1 size:993"}
{"level":"info","ts":"2026-04-08T00:41:58.592807Z","caller":"traceutil/trace.go:171","msg":"trace[1403896142] range","detail":"{range_begin:/registry/services/specs/monitoring/prometheus-operated; range_end:; response_count:1; response_revision:4688; }","duration":"126.433664ms","start":"2026-04-08T00:41:58.466349Z","end":"2026-04-08T00:41:58.592782Z","steps":["trace[1403896142] 'agreement among raft nodes before linearized reading'  (duration: 126.047737ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T00:42:03.545916Z","caller":"traceutil/trace.go:171","msg":"trace[1492369040] transaction","detail":"{read_only:false; response_revision:4832; number_of_response:1; }","duration":"165.540907ms","start":"2026-04-08T00:42:03.380344Z","end":"2026-04-08T00:42:03.545885Z","steps":["trace[1492369040] 'process raft request'  (duration: 165.312193ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T00:42:03.75988Z","caller":"traceutil/trace.go:171","msg":"trace[648328956] linearizableReadLoop","detail":"{readStateIndex:5012; appliedIndex:5011; }","duration":"137.854324ms","start":"2026-04-08T00:42:03.62199Z","end":"2026-04-08T00:42:03.759844Z","steps":["trace[648328956] 'read index received'  (duration: 137.596439ms)","trace[648328956] 'applied index is now lower than readState.Index'  (duration: 256.185µs)"],"step_count":2}
{"level":"info","ts":"2026-04-08T00:42:03.759972Z","caller":"traceutil/trace.go:171","msg":"trace[1520250279] transaction","detail":"{read_only:false; response_revision:4834; number_of_response:1; }","duration":"150.848633ms","start":"2026-04-08T00:42:03.609088Z","end":"2026-04-08T00:42:03.759937Z","steps":["trace[1520250279] 'process raft request'  (duration: 150.511097ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T00:42:03.760211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.186521ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12209"}
{"level":"info","ts":"2026-04-08T00:42:03.760271Z","caller":"traceutil/trace.go:171","msg":"trace[1113300205] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4834; }","duration":"138.333383ms","start":"2026-04-08T00:42:03.621924Z","end":"2026-04-08T00:42:03.760257Z","steps":["trace[1113300205] 'agreement among raft nodes before linearized reading'  (duration: 138.078428ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T00:42:05.085917Z","caller":"traceutil/trace.go:171","msg":"trace[557566119] transaction","detail":"{read_only:false; response_revision:4870; number_of_response:1; }","duration":"109.219293ms","start":"2026-04-08T00:42:04.97667Z","end":"2026-04-08T00:42:05.085889Z","steps":["trace[557566119] 'process raft request'  (duration: 98.741742ms)","trace[557566119] 'compare'  (duration: 10.325128ms)"],"step_count":2}
{"level":"info","ts":"2026-04-08T00:42:14.799345Z","caller":"traceutil/trace.go:171","msg":"trace[736378490] transaction","detail":"{read_only:false; response_revision:5038; number_of_response:1; }","duration":"322.155923ms","start":"2026-04-08T00:42:14.477155Z","end":"2026-04-08T00:42:14.799311Z","steps":["trace[736378490] 'process raft request'  (duration: 321.925339ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T00:42:14.799572Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T00:42:14.477134Z","time spent":"322.318356ms","remote":"127.0.0.1:56486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:5004 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:478 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"info","ts":"2026-04-08T00:42:14.799746Z","caller":"traceutil/trace.go:171","msg":"trace[249059264] transaction","detail":"{read_only:false; response_revision:5039; number_of_response:1; }","duration":"322.413728ms","start":"2026-04-08T00:42:14.477304Z","end":"2026-04-08T00:42:14.799717Z","steps":["trace[249059264] 'process raft request'  (duration: 321.959689ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T00:42:14.799916Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T00:42:14.477273Z","time spent":"322.56782ms","remote":"127.0.0.1:56486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:5000 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-04-08T00:42:14.800185Z","caller":"traceutil/trace.go:171","msg":"trace[626529601] transaction","detail":"{read_only:false; response_revision:5040; number_of_response:1; }","duration":"322.836136ms","start":"2026-04-08T00:42:14.477342Z","end":"2026-04-08T00:42:14.800178Z","steps":["trace[626529601] 'process raft request'  (duration: 322.279975ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T00:42:14.800227Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T00:42:14.477329Z","time spent":"322.880077ms","remote":"127.0.0.1:56486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:5001 > 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-08T00:42:14.800444Z","caller":"traceutil/trace.go:171","msg":"trace[1275762392] transaction","detail":"{read_only:false; response_revision:5042; number_of_response:1; }","duration":"313.6954ms","start":"2026-04-08T00:42:14.486742Z","end":"2026-04-08T00:42:14.800438Z","steps":["trace[1275762392] 'process raft request'  (duration: 313.577288ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T00:42:14.800486Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T00:42:14.486732Z","time spent":"313.733071ms","remote":"127.0.0.1:56414","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8041,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/pods/openstack/memcached-memcached-6479589586-64wnq\" mod_revision:5027 > success:<request_put:<key:\"/registry/pods/openstack/memcached-memcached-6479589586-64wnq\" value_size:7972 >> failure:<request_range:<key:\"/registry/pods/openstack/memcached-memcached-6479589586-64wnq\" > >"}
{"level":"info","ts":"2026-04-08T00:42:14.800708Z","caller":"traceutil/trace.go:171","msg":"trace[2003037295] transaction","detail":"{read_only:false; response_revision:5041; number_of_response:1; }","duration":"323.07216ms","start":"2026-04-08T00:42:14.477333Z","end":"2026-04-08T00:42:14.800405Z","steps":["trace[2003037295] 'process raft request'  (duration: 322.816705ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T00:42:14.800836Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T00:42:14.477298Z","time spent":"323.435297ms","remote":"127.0.0.1:56486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:5002 > 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-08T00:42:14.862661Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.261123ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"}
{"level":"info","ts":"2026-04-08T00:42:14.862763Z","caller":"traceutil/trace.go:171","msg":"trace[1942878285] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5042; }","duration":"310.421787ms","start":"2026-04-08T00:42:14.552328Z","end":"2026-04-08T00:42:14.862749Z","steps":["trace[1942878285] 'agreement among raft nodes before linearized reading'  (duration: 310.126912ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T00:42:14.862818Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T00:42:14.552311Z","time spent":"310.495368ms","remote":"127.0.0.1:56486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":517,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-04-08T00:42:14.863978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"385.931531ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:1 size:122913"}
{"level":"info","ts":"2026-04-08T00:42:14.864678Z","caller":"traceutil/trace.go:171","msg":"trace[1056049175] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:1; response_revision:5042; }","duration":"386.650006ms","start":"2026-04-08T00:42:14.478011Z","end":"2026-04-08T00:42:14.864661Z","steps":["trace[1056049175] 'agreement among raft nodes before linearized reading'  (duration: 385.772838ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T00:42:14.864728Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T00:42:14.478003Z","time spent":"386.711356ms","remote":"127.0.0.1:56268","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":1,"response size":122937,"request content":"key:\"/registry/ranges/serviceips\" "}
{"level":"info","ts":"2026-04-08T00:42:14.866139Z","caller":"traceutil/trace.go:171","msg":"trace[758687959] linearizableReadLoop","detail":"{readStateIndex:5227; appliedIndex:5221; }","duration":"300.464706ms","start":"2026-04-08T00:42:14.561621Z","end":"2026-04-08T00:42:14.862086Z","steps":["trace[758687959] 'read index received'  (duration: 237.378911ms)","trace[758687959] 'applied index is now lower than readState.Index'  (duration: 63.078415ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-08T00:42:14.866454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.933686ms","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-08T00:42:14.866514Z","caller":"traceutil/trace.go:171","msg":"trace[676178117] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5042; }","duration":"124.061169ms","start":"2026-04-08T00:42:14.742436Z","end":"2026-04-08T00:42:14.866497Z","steps":["trace[676178117] 'agreement among raft nodes before linearized reading'  (duration: 123.907987ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T00:42:17.140431Z","caller":"traceutil/trace.go:171","msg":"trace[856509812] transaction","detail":"{read_only:false; response_revision:5073; number_of_response:1; }","duration":"331.661845ms","start":"2026-04-08T00:42:16.808732Z","end":"2026-04-08T00:42:17.140394Z","steps":["trace[856509812] 'process raft request'  (duration: 331.457241ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T00:42:17.140654Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T00:42:16.808711Z","time spent":"331.836779ms","remote":"127.0.0.1:56486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:5039 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-04-08T00:42:17.143324Z","caller":"traceutil/trace.go:171","msg":"trace[1413297554] linearizableReadLoop","detail":"{readStateIndex:5261; appliedIndex:5257; }","duration":"236.174208ms","start":"2026-04-08T00:42:16.907112Z","end":"2026-04-08T00:42:17.143286Z","steps":["trace[1413297554] 'read index received'  (duration: 233.026427ms)","trace[1413297554] 'applied index is now lower than readState.Index'  (duration: 3.146471ms)"],"step_count":2}
{"level":"info","ts":"2026-04-08T00:42:17.1435Z","caller":"traceutil/trace.go:171","msg":"trace[382127839] transaction","detail":"{read_only:false; response_revision:5076; number_of_response:1; }","duration":"332.015063ms","start":"2026-04-08T00:42:16.811472Z","end":"2026-04-08T00:42:17.143487Z","steps":["trace[382127839] 'process raft request'  (duration: 331.762308ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T00:42:17.143458Z","caller":"traceutil/trace.go:171","msg":"trace[1567015321] transaction","detail":"{read_only:false; response_revision:5075; number_of_response:1; }","duration":"331.90112ms","start":"2026-04-08T00:42:16.811464Z","end":"2026-04-08T00:42:17.143365Z","steps":["trace[1567015321] 'process raft request'  (duration: 331.724647ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T00:42:17.143724Z","caller":"traceutil/trace.go:171","msg":"trace[1597529237] transaction","detail":"{read_only:false; response_revision:5074; number_of_response:1; }","duration":"332.238637ms","start":"2026-04-08T00:42:16.811461Z","end":"2026-04-08T00:42:17.143699Z","steps":["trace[1597529237] 'process raft request'  (duration: 331.569104ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T00:42:17.143873Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T00:42:16.811438Z","time spent":"332.372669ms","remote":"127.0.0.1:56486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:5038 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:478 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-04-08T00:42:17.143982Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T00:42:16.811443Z","time spent":"332.305408ms","remote":"127.0.0.1:56486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:5040 > 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":"warn","ts":"2026-04-08T00:42:17.143989Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.83824ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"}
{"level":"info","ts":"2026-04-08T00:42:17.144101Z","caller":"traceutil/trace.go:171","msg":"trace[1373569275] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5076; }","duration":"237.005104ms","start":"2026-04-08T00:42:16.907071Z","end":"2026-04-08T00:42:17.144076Z","steps":["trace[1373569275] 'agreement among raft nodes before linearized reading'  (duration: 236.626406ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T00:42:17.143643Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T00:42:16.811435Z","time spent":"332.101474ms","remote":"127.0.0.1:56486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:5041 > 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-08T00:42:17.144482Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.24865ms","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-08T00:42:17.144702Z","caller":"traceutil/trace.go:171","msg":"trace[1094305992] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5076; }","duration":"182.532265ms","start":"2026-04-08T00:42:16.962141Z","end":"2026-04-08T00:42:17.144673Z","steps":["trace[1094305992] 'agreement among raft nodes before linearized reading'  (duration: 181.511725ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T00:42:23.3445Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.321709ms","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-08T00:42:23.344671Z","caller":"traceutil/trace.go:171","msg":"trace[1008905701] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5211; }","duration":"170.589205ms","start":"2026-04-08T00:42:23.174048Z","end":"2026-04-08T00:42:23.344637Z","steps":["trace[1008905701] 'range keys from in-memory index tree'  (duration: 169.966913ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T00:42:23.344706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.700687ms","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":"warn","ts":"2026-04-08T00:42:23.344569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.493872ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-432912f4-f973-46fc-ab84-8a1eda125c6f\" ","response":"range_response_count:1 size:3646"}
{"level":"warn","ts":"2026-04-08T00:42:23.3445Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.600942ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-04-08T00:42:23.344825Z","caller":"traceutil/trace.go:171","msg":"trace[1856836805] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5211; }","duration":"174.01648ms","start":"2026-04-08T00:42:23.170799Z","end":"2026-04-08T00:42:23.344815Z","steps":["trace[1856836805] 'range keys from in-memory index tree'  (duration: 173.362348ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T00:42:23.344817Z","caller":"traceutil/trace.go:171","msg":"trace[577766293] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5211; }","duration":"155.846561ms","start":"2026-04-08T00:42:23.188942Z","end":"2026-04-08T00:42:23.344788Z","steps":["trace[577766293] 'range keys from in-memory index tree'  (duration: 155.507234ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T00:42:23.344834Z","caller":"traceutil/trace.go:171","msg":"trace[258730503] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-432912f4-f973-46fc-ab84-8a1eda125c6f; range_end:; response_count:1; response_revision:5211; }","duration":"130.772637ms","start":"2026-04-08T00:42:23.214035Z","end":"2026-04-08T00:42:23.344807Z","steps":["trace[258730503] 'range keys from in-memory index tree'  (duration: 130.318909ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T00:42:23.344896Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.668421ms","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-08T00:42:23.344891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.049493ms","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-08T00:42:23.344934Z","caller":"traceutil/trace.go:171","msg":"trace[1021731031] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5211; }","duration":"163.738742ms","start":"2026-04-08T00:42:23.181188Z","end":"2026-04-08T00:42:23.344926Z","steps":["trace[1021731031] 'range keys from in-memory index tree'  (duration: 163.530459ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T00:42:23.344964Z","caller":"traceutil/trace.go:171","msg":"trace[2013861731] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5211; }","duration":"171.140315ms","start":"2026-04-08T00:42:23.173805Z","end":"2026-04-08T00:42:23.344945Z","steps":["trace[2013861731] 'range keys from in-memory index tree'  (duration: 170.926411ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T00:42:23.344928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.126004ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-04-08T00:42:23.345122Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.524002ms","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-08T00:42:23.345162Z","caller":"traceutil/trace.go:171","msg":"trace[1609815141] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5211; }","duration":"158.424341ms","start":"2026-04-08T00:42:23.186673Z","end":"2026-04-08T00:42:23.345098Z","steps":["trace[1609815141] 'range keys from in-memory index tree'  (duration: 158.049393ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T00:42:23.345243Z","caller":"traceutil/trace.go:171","msg":"trace[120815363] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:5211; }","duration":"171.689626ms","start":"2026-04-08T00:42:23.173524Z","end":"2026-04-08T00:42:23.345214Z","steps":["trace[120815363] 'range keys from in-memory index tree'  (duration: 171.307858ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T00:42:23.512831Z","caller":"traceutil/trace.go:171","msg":"trace[189428123] transaction","detail":"{read_only:false; response_revision:5212; number_of_response:1; }","duration":"162.675852ms","start":"2026-04-08T00:42:23.350117Z","end":"2026-04-08T00:42:23.512793Z","steps":["trace[189428123] 'process raft request'  (duration: 162.404687ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T00:42:23.757484Z","caller":"traceutil/trace.go:171","msg":"trace[43185368] transaction","detail":"{read_only:false; response_revision:5213; number_of_response:1; }","duration":"406.722511ms","start":"2026-04-08T00:42:23.350716Z","end":"2026-04-08T00:42:23.757438Z","steps":["trace[43185368] 'process raft request'  (duration: 370.712787ms)","trace[43185368] 'compare'  (duration: 35.518285ms)"],"step_count":2}
{"level":"info","ts":"2026-04-08T00:42:23.757526Z","caller":"traceutil/trace.go:171","msg":"trace[2058742184] transaction","detail":"{read_only:false; response_revision:5214; number_of_response:1; }","duration":"406.601078ms","start":"2026-04-08T00:42:23.35089Z","end":"2026-04-08T00:42:23.757491Z","steps":["trace[2058742184] 'process raft request'  (duration: 406.441075ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T00:42:23.757602Z","caller":"traceutil/trace.go:171","msg":"trace[538581944] linearizableReadLoop","detail":"{readStateIndex:5407; appliedIndex:5401; }","duration":"353.499726ms","start":"2026-04-08T00:42:23.404068Z","end":"2026-04-08T00:42:23.757568Z","steps":["trace[538581944] 'read index received'  (duration: 108.420667ms)","trace[538581944] 'applied index is now lower than readState.Index'  (duration: 245.077389ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-08T00:42:23.757689Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T00:42:23.350686Z","time spent":"406.896795ms","remote":"127.0.0.1:56486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:5138 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:477 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-04-08T00:42:23.757719Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T00:42:23.35088Z","time spent":"406.72341ms","remote":"127.0.0.1:56486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:5137 > 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-08T00:42:23.757792Z","caller":"traceutil/trace.go:171","msg":"trace[1784801658] transaction","detail":"{read_only:false; response_revision:5215; number_of_response:1; }","duration":"406.582658ms","start":"2026-04-08T00:42:23.351193Z","end":"2026-04-08T00:42:23.757775Z","steps":["trace[1784801658] 'process raft request'  (duration: 406.210082ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T00:42:23.757941Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T00:42:23.351186Z","time spent":"406.64916ms","remote":"127.0.0.1:56486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:5142 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:464 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-04-08T00:42:23.758018Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"353.855652ms","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-08T00:42:23.758054Z","caller":"traceutil/trace.go:171","msg":"trace[903645378] transaction","detail":"{read_only:false; response_revision:5216; number_of_response:1; }","duration":"406.478666ms","start":"2026-04-08T00:42:23.35156Z","end":"2026-04-08T00:42:23.758039Z","steps":["trace[903645378] 'process raft request'  (duration: 405.907856ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T00:42:23.758089Z","caller":"traceutil/trace.go:171","msg":"trace[591295373] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:5217; }","duration":"354.041886ms","start":"2026-04-08T00:42:23.404026Z","end":"2026-04-08T00:42:23.758068Z","steps":["trace[591295373] 'agreement among raft nodes before linearized reading'  (duration: 353.843592ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T00:42:23.758124Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T00:42:23.351549Z","time spent":"406.539307ms","remote":"127.0.0.1:56486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:5136 > 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-08T00:42:23.758133Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T00:42:23.404012Z","time spent":"354.108177ms","remote":"127.0.0.1:41154","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true "}
{"level":"warn","ts":"2026-04-08T00:42:23.758226Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.877836ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-432912f4-f973-46fc-ab84-8a1eda125c6f\" ","response":"range_response_count:1 size:3646"}
{"level":"info","ts":"2026-04-08T00:42:23.758189Z","caller":"traceutil/trace.go:171","msg":"trace[1306778343] transaction","detail":"{read_only:false; response_revision:5217; number_of_response:1; }","duration":"405.875754ms","start":"2026-04-08T00:42:23.352261Z","end":"2026-04-08T00:42:23.758136Z","steps":["trace[1306778343] 'process raft request'  (duration: 405.251293ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T00:42:23.758282Z","caller":"traceutil/trace.go:171","msg":"trace[1300325070] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-432912f4-f973-46fc-ab84-8a1eda125c6f; range_end:; response_count:1; response_revision:5217; }","duration":"229.965239ms","start":"2026-04-08T00:42:23.528301Z","end":"2026-04-08T00:42:23.758267Z","steps":["trace[1300325070] 'agreement among raft nodes before linearized reading'  (duration: 229.770884ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T00:42:23.75845Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T00:42:23.352252Z","time spent":"406.052468ms","remote":"127.0.0.1:56486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:5140 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-04-08T00:42:24.067279Z","caller":"traceutil/trace.go:171","msg":"trace[1152045658] linearizableReadLoop","detail":"{readStateIndex:5408; appliedIndex:5407; }","duration":"281.165914ms","start":"2026-04-08T00:42:23.786071Z","end":"2026-04-08T00:42:24.067237Z","steps":["trace[1152045658] 'read index received'  (duration: 231.955996ms)","trace[1152045658] 'applied index is now lower than readState.Index'  (duration: 49.208798ms)"],"step_count":2}
{"level":"info","ts":"2026-04-08T00:42:24.067323Z","caller":"traceutil/trace.go:171","msg":"trace[236967566] transaction","detail":"{read_only:false; response_revision:5218; number_of_response:1; }","duration":"301.669337ms","start":"2026-04-08T00:42:23.765604Z","end":"2026-04-08T00:42:24.067274Z","steps":["trace[236967566] 'process raft request'  (duration: 252.493621ms)","trace[236967566] 'compare'  (duration: 48.938442ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-08T00:42:24.067449Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.346848ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-04-08T00:42:24.067544Z","caller":"traceutil/trace.go:171","msg":"trace[424123797] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:5218; }","duration":"281.523001ms","start":"2026-04-08T00:42:23.785999Z","end":"2026-04-08T00:42:24.067522Z","steps":["trace[424123797] 'agreement among raft nodes before linearized reading'  (duration: 281.328227ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T00:42:24.067673Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T00:42:23.765575Z","time spent":"301.824481ms","remote":"127.0.0.1:56414","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3751,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-432912f4-f973-46fc-ab84-8a1eda125c6f\" mod_revision:5195 > success:<request_put:<key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-432912f4-f973-46fc-ab84-8a1eda125c6f\" value_size:3651 >> failure:<request_range:<key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-432912f4-f973-46fc-ab84-8a1eda125c6f\" > >"}
{"level":"info","ts":"2026-04-08T00:42:24.096221Z","caller":"traceutil/trace.go:171","msg":"trace[214100465] transaction","detail":"{read_only:false; response_revision:5219; number_of_response:1; }","duration":"214.761706ms","start":"2026-04-08T00:42:23.881393Z","end":"2026-04-08T00:42:24.096155Z","steps":["trace[214100465] 'process raft request'  (duration: 214.589073ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T00:42:36.409314Z","caller":"traceutil/trace.go:171","msg":"trace[938741491] transaction","detail":"{read_only:false; response_revision:5376; number_of_response:1; }","duration":"208.824681ms","start":"2026-04-08T00:42:36.200448Z","end":"2026-04-08T00:42:36.409273Z","steps":["trace[938741491] 'process raft request'  (duration: 124.09871ms)","trace[938741491] 'compare'  (duration: 84.482256ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-08T00:42:36.875438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.219927ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14208185480201425171 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/endpointslices/openstack/rabbitmq-keystone-nodes-9lnhd\" mod_revision:5159 > success:<request_put:<key:\"/registry/endpointslices/openstack/rabbitmq-keystone-nodes-9lnhd\" value_size:1434 >> failure:<request_range:<key:\"/registry/endpointslices/openstack/rabbitmq-keystone-nodes-9lnhd\" > >>","response":"size:16"}
{"level":"info","ts":"2026-04-08T00:42:36.87587Z","caller":"traceutil/trace.go:171","msg":"trace[2115948491] linearizableReadLoop","detail":"{readStateIndex:5577; appliedIndex:5574; }","duration":"127.333892ms","start":"2026-04-08T00:42:36.748518Z","end":"2026-04-08T00:42:36.875852Z","steps":["trace[2115948491] 'read index received'  (duration: 9.500493ms)","trace[2115948491] 'applied index is now lower than readState.Index'  (duration: 117.832569ms)"],"step_count":2}
{"level":"info","ts":"2026-04-08T00:42:36.875964Z","caller":"traceutil/trace.go:171","msg":"trace[518277320] transaction","detail":"{read_only:false; response_revision:5383; number_of_response:1; }","duration":"147.327497ms","start":"2026-04-08T00:42:36.728627Z","end":"2026-04-08T00:42:36.875954Z","steps":["trace[518277320] 'process raft request'  (duration: 147.175674ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T00:42:36.875942Z","caller":"traceutil/trace.go:171","msg":"trace[302994723] transaction","detail":"{read_only:false; response_revision:5382; number_of_response:1; }","duration":"149.470537ms","start":"2026-04-08T00:42:36.726444Z","end":"2026-04-08T00:42:36.875915Z","steps":["trace[302994723] 'process raft request'  (duration: 149.10054ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T00:42:36.876033Z","caller":"traceutil/trace.go:171","msg":"trace[298486632] transaction","detail":"{read_only:false; response_revision:5381; number_of_response:1; }","duration":"150.325684ms","start":"2026-04-08T00:42:36.725678Z","end":"2026-04-08T00:42:36.876003Z","steps":["trace[298486632] 'process raft request'  (duration: 32.421964ms)","trace[298486632] 'compare'  (duration: 116.983272ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-08T00:42:36.876232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.561328ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"}
{"level":"info","ts":"2026-04-08T00:42:36.876296Z","caller":"traceutil/trace.go:171","msg":"trace[1362139791] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5383; }","duration":"125.6538ms","start":"2026-04-08T00:42:36.750624Z","end":"2026-04-08T00:42:36.876278Z","steps":["trace[1362139791] 'agreement among raft nodes before linearized reading'  (duration: 125.423814ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T00:42:36.876381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.854192ms","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-08T00:42:36.876417Z","caller":"traceutil/trace.go:171","msg":"trace[1498181042] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5383; }","duration":"127.920544ms","start":"2026-04-08T00:42:36.748486Z","end":"2026-04-08T00:42:36.876406Z","steps":["trace[1498181042] 'agreement among raft nodes before linearized reading'  (duration: 127.803252ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T00:42:36.876584Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.71098ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-s598f\" ","response":"range_response_count:1 size:6524"}
{"level":"info","ts":"2026-04-08T00:42:36.87663Z","caller":"traceutil/trace.go:171","msg":"trace[673827239] range","detail":"{range_begin:/registry/pods/openstack/keepalived-s598f; range_end:; response_count:1; response_revision:5383; }","duration":"125.802322ms","start":"2026-04-08T00:42:36.750815Z","end":"2026-04-08T00:42:36.876617Z","steps":["trace[673827239] 'agreement among raft nodes before linearized reading'  (duration: 125.662469ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T00:43:11.174855Z","caller":"traceutil/trace.go:171","msg":"trace[1329078310] linearizableReadLoop","detail":"{readStateIndex:5902; appliedIndex:5901; }","duration":"104.177251ms","start":"2026-04-08T00:43:11.070656Z","end":"2026-04-08T00:43:11.174833Z","steps":["trace[1329078310] 'read index received'  (duration: 104.07379ms)","trace[1329078310] 'applied index is now lower than readState.Index'  (duration: 102.441µs)"],"step_count":2}
{"level":"info","ts":"2026-04-08T00:43:11.174976Z","caller":"traceutil/trace.go:171","msg":"trace[1157346692] transaction","detail":"{read_only:false; response_revision:5700; number_of_response:1; }","duration":"105.13503ms","start":"2026-04-08T00:43:11.069778Z","end":"2026-04-08T00:43:11.174913Z","steps":["trace[1157346692] 'process raft request'  (duration: 104.891355ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T00:43:11.175227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.559349ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:10 size:84880"}
{"level":"info","ts":"2026-04-08T00:43:11.175269Z","caller":"traceutil/trace.go:171","msg":"trace[1092218228] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:10; response_revision:5700; }","duration":"104.672391ms","start":"2026-04-08T00:43:11.070587Z","end":"2026-04-08T00:43:11.175259Z","steps":["trace[1092218228] 'agreement among raft nodes before linearized reading'  (duration: 104.338564ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T00:43:36.229059Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2834}
{"level":"info","ts":"2026-04-08T00:43:36.371353Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2834,"took":"139.913925ms","hash":514605532,"current-db-size-bytes":57819136,"current-db-size":"58 MB","current-db-size-in-use-bytes":32735232,"current-db-size-in-use":"33 MB"}
{"level":"info","ts":"2026-04-08T00:43:36.371439Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":514605532,"revision":2834,"compact-revision":-1}
{"level":"warn","ts":"2026-04-08T00:44:17.74848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.866722ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-s598f\" ","response":"range_response_count:1 size:6524"}
{"level":"info","ts":"2026-04-08T00:44:17.748613Z","caller":"traceutil/trace.go:171","msg":"trace[1139477749] range","detail":"{range_begin:/registry/pods/openstack/keepalived-s598f; range_end:; response_count:1; response_revision:6185; }","duration":"109.074446ms","start":"2026-04-08T00:44:17.63951Z","end":"2026-04-08T00:44:17.748585Z","steps":["trace[1139477749] 'range keys from in-memory index tree'  (duration: 108.519696ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T00:44:18.77968Z","caller":"traceutil/trace.go:171","msg":"trace[1632522843] transaction","detail":"{read_only:false; response_revision:6188; number_of_response:1; }","duration":"107.553568ms","start":"2026-04-08T00:44:18.672097Z","end":"2026-04-08T00:44:18.779651Z","steps":["trace[1632522843] 'process raft request'  (duration: 107.387005ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T00:44:18.779985Z","caller":"traceutil/trace.go:171","msg":"trace[450757456] transaction","detail":"{read_only:false; response_revision:6189; number_of_response:1; }","duration":"106.880925ms","start":"2026-04-08T00:44:18.67309Z","end":"2026-04-08T00:44:18.779971Z","steps":["trace[450757456] 'process raft request'  (duration: 106.519369ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T00:44:18.780047Z","caller":"traceutil/trace.go:171","msg":"trace[1738509813] transaction","detail":"{read_only:false; response_revision:6190; number_of_response:1; }","duration":"106.177632ms","start":"2026-04-08T00:44:18.673845Z","end":"2026-04-08T00:44:18.780022Z","steps":["trace[1738509813] 'process raft request'  (duration: 106.030449ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T00:44:18.780039Z","caller":"traceutil/trace.go:171","msg":"trace[627867075] linearizableReadLoop","detail":"{readStateIndex:6407; appliedIndex:6403; }","duration":"105.377196ms","start":"2026-04-08T00:44:18.674597Z","end":"2026-04-08T00:44:18.779974Z","steps":["trace[627867075] 'read index received'  (duration: 71.867138ms)","trace[627867075] 'applied index is now lower than readState.Index'  (duration: 33.508968ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-08T00:44:18.780293Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.673222ms","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-08T00:44:18.78043Z","caller":"traceutil/trace.go:171","msg":"trace[437037014] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:6190; }","duration":"105.877046ms","start":"2026-04-08T00:44:18.674522Z","end":"2026-04-08T00:44:18.780399Z","steps":["trace[437037014] 'agreement among raft nodes before linearized reading'  (duration: 105.610541ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T00:44:18.929848Z","caller":"traceutil/trace.go:171","msg":"trace[1853084209] transaction","detail":"{read_only:false; response_revision:6192; number_of_response:1; }","duration":"137.261194ms","start":"2026-04-08T00:44:18.792562Z","end":"2026-04-08T00:44:18.929824Z","steps":["trace[1853084209] 'process raft request'  (duration: 136.982869ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T00:45:39.346856Z","caller":"traceutil/trace.go:171","msg":"trace[2053994129] linearizableReadLoop","detail":"{readStateIndex:6878; appliedIndex:6876; }","duration":"101.36275ms","start":"2026-04-08T00:45:39.245453Z","end":"2026-04-08T00:45:39.346816Z","steps":["trace[2053994129] 'read index received'  (duration: 72.283317ms)","trace[2053994129] 'applied index is now lower than readState.Index'  (duration: 29.078003ms)"],"step_count":2}
{"level":"info","ts":"2026-04-08T00:45:39.346973Z","caller":"traceutil/trace.go:171","msg":"trace[2084261862] transaction","detail":"{read_only:false; response_revision:6644; number_of_response:1; }","duration":"106.998358ms","start":"2026-04-08T00:45:39.239945Z","end":"2026-04-08T00:45:39.346943Z","steps":["trace[2084261862] 'process raft request'  (duration: 106.667742ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T00:45:39.347366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.869101ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.250\" ","response":"range_response_count:1 size:135"}
{"level":"info","ts":"2026-04-08T00:45:39.347476Z","caller":"traceutil/trace.go:171","msg":"trace[801427125] range","detail":"{range_begin:/registry/masterleases/199.204.45.250; range_end:; response_count:1; response_revision:6644; }","duration":"102.033374ms","start":"2026-04-08T00:45:39.245417Z","end":"2026-04-08T00:45:39.34745Z","steps":["trace[801427125] 'agreement among raft nodes before linearized reading'  (duration: 101.671097ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T00:45:39.368639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.859277ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-08T00:45:39.368746Z","caller":"traceutil/trace.go:171","msg":"trace[1044777918] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:6645; }","duration":"117.094501ms","start":"2026-04-08T00:45:39.251632Z","end":"2026-04-08T00:45:39.368727Z","steps":["trace[1044777918] 'agreement among raft nodes before linearized reading'  (duration: 116.839226ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T00:45:53.668305Z","caller":"traceutil/trace.go:171","msg":"trace[1773848882] transaction","detail":"{read_only:false; response_revision:6747; number_of_response:1; }","duration":"120.463184ms","start":"2026-04-08T00:45:53.547808Z","end":"2026-04-08T00:45:53.668271Z","steps":["trace[1773848882] 'process raft request'  (duration: 120.2346ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T00:45:53.669865Z","caller":"traceutil/trace.go:171","msg":"trace[1329882412] transaction","detail":"{read_only:false; response_revision:6749; number_of_response:1; }","duration":"121.391972ms","start":"2026-04-08T00:45:53.548442Z","end":"2026-04-08T00:45:53.669834Z","steps":["trace[1329882412] 'process raft request'  (duration: 121.335851ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T00:45:53.67008Z","caller":"traceutil/trace.go:171","msg":"trace[1218134402] transaction","detail":"{read_only:false; response_revision:6748; number_of_response:1; }","duration":"121.82963ms","start":"2026-04-08T00:45:53.548215Z","end":"2026-04-08T00:45:53.670045Z","steps":["trace[1218134402] 'process raft request'  (duration: 121.415572ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T00:48:15.612815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"359.413999ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-s598f\" ","response":"range_response_count:1 size:6524"}
{"level":"info","ts":"2026-04-08T00:48:15.612951Z","caller":"traceutil/trace.go:171","msg":"trace[3785688] range","detail":"{range_begin:/registry/pods/openstack/keepalived-s598f; range_end:; response_count:1; response_revision:7977; }","duration":"359.616932ms","start":"2026-04-08T00:48:15.253305Z","end":"2026-04-08T00:48:15.612922Z","steps":["trace[3785688] 'range keys from in-memory index tree'  (duration: 359.174974ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T00:48:15.613017Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T00:48:15.253274Z","time spent":"359.726675ms","remote":"127.0.0.1:56414","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6548,"request content":"key:\"/registry/pods/openstack/keepalived-s598f\" "}
{"level":"info","ts":"2026-04-08T00:48:26.487772Z","caller":"traceutil/trace.go:171","msg":"trace[582178676] transaction","detail":"{read_only:false; response_revision:8036; number_of_response:1; }","duration":"142.321072ms","start":"2026-04-08T00:48:26.345417Z","end":"2026-04-08T00:48:26.487738Z","steps":["trace[582178676] 'process raft request'  (duration: 137.851558ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T00:48:26.795914Z","caller":"traceutil/trace.go:171","msg":"trace[761272380] linearizableReadLoop","detail":"{readStateIndex:8315; appliedIndex:8314; }","duration":"212.782195ms","start":"2026-04-08T00:48:26.583067Z","end":"2026-04-08T00:48:26.795849Z","steps":["trace[761272380] 'read index received'  (duration: 174.425496ms)","trace[761272380] 'applied index is now lower than readState.Index'  (duration: 38.354339ms)"],"step_count":2}
{"level":"info","ts":"2026-04-08T00:48:26.796017Z","caller":"traceutil/trace.go:171","msg":"trace[1659446571] transaction","detail":"{read_only:false; response_revision:8038; number_of_response:1; }","duration":"249.323252ms","start":"2026-04-08T00:48:26.546608Z","end":"2026-04-08T00:48:26.795931Z","steps":["trace[1659446571] 'process raft request'  (duration: 211.012343ms)","trace[1659446571] 'compare'  (duration: 37.910471ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-08T00:48:26.79624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.143694ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:572"}
{"level":"info","ts":"2026-04-08T00:48:26.796405Z","caller":"traceutil/trace.go:171","msg":"trace[142865844] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:8038; }","duration":"213.312416ms","start":"2026-04-08T00:48:26.583032Z","end":"2026-04-08T00:48:26.796344Z","steps":["trace[142865844] 'agreement among raft nodes before linearized reading'  (duration: 212.98188ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T00:48:26.928895Z","caller":"traceutil/trace.go:171","msg":"trace[200240568] transaction","detail":"{read_only:false; response_revision:8040; number_of_response:1; }","duration":"126.377053ms","start":"2026-04-08T00:48:26.802473Z","end":"2026-04-08T00:48:26.92885Z","steps":["trace[200240568] 'process raft request'  (duration: 95.240588ms)","trace[200240568] 'compare'  (duration: 30.963332ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-08T00:48:27.314046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.122006ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12209"}
{"level":"info","ts":"2026-04-08T00:48:27.314159Z","caller":"traceutil/trace.go:171","msg":"trace[16614429] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:8041; }","duration":"111.309881ms","start":"2026-04-08T00:48:27.202823Z","end":"2026-04-08T00:48:27.314133Z","steps":["trace[16614429] 'range keys from in-memory index tree'  (duration: 110.878682ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T00:48:28.59579Z","caller":"traceutil/trace.go:171","msg":"trace[909486096] transaction","detail":"{read_only:false; response_revision:8042; number_of_response:1; }","duration":"697.434276ms","start":"2026-04-08T00:48:27.898323Z","end":"2026-04-08T00:48:28.595758Z","steps":["trace[909486096] 'process raft request'  (duration: 697.214182ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T00:48:28.595983Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T00:48:27.898304Z","time spent":"697.566479ms","remote":"127.0.0.1:56486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:8033 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-04-08T00:48:28.733532Z","caller":"traceutil/trace.go:171","msg":"trace[1070653049] linearizableReadLoop","detail":"{readStateIndex:8320; appliedIndex:8318; }","duration":"635.276888ms","start":"2026-04-08T00:48:28.098224Z","end":"2026-04-08T00:48:28.733501Z","steps":["trace[1070653049] 'read index received'  (duration: 497.334218ms)","trace[1070653049] 'applied index is now lower than readState.Index'  (duration: 137.94092ms)"],"step_count":2}
{"level":"info","ts":"2026-04-08T00:48:28.733886Z","caller":"traceutil/trace.go:171","msg":"trace[1686093439] transaction","detail":"{read_only:false; response_revision:8044; number_of_response:1; }","duration":"217.194379ms","start":"2026-04-08T00:48:28.516666Z","end":"2026-04-08T00:48:28.733861Z","steps":["trace[1686093439] 'process raft request'  (duration: 216.764691ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T00:48:28.733671Z","caller":"traceutil/trace.go:171","msg":"trace[413329867] transaction","detail":"{read_only:false; response_revision:8043; number_of_response:1; }","duration":"662.47968ms","start":"2026-04-08T00:48:28.071132Z","end":"2026-04-08T00:48:28.733612Z","steps":["trace[413329867] 'process raft request'  (duration: 605.295317ms)","trace[413329867] 'compare'  (duration: 56.831756ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-08T00:48:28.734126Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T00:48:28.071101Z","time spent":"662.859757ms","remote":"127.0.0.1:56486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:8034 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:457 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"warn","ts":"2026-04-08T00:48:28.734485Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"588.093403ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-08T00:48:28.73454Z","caller":"traceutil/trace.go:171","msg":"trace[1676351773] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:8044; }","duration":"588.175854ms","start":"2026-04-08T00:48:28.14635Z","end":"2026-04-08T00:48:28.734526Z","steps":["trace[1676351773] 'agreement among raft nodes before linearized reading'  (duration: 588.059782ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T00:48:28.734578Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T00:48:28.146315Z","time spent":"588.252836ms","remote":"127.0.0.1:41176","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "}
{"level":"warn","ts":"2026-04-08T00:48:28.734671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.072856ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"}
{"level":"info","ts":"2026-04-08T00:48:28.734764Z","caller":"traceutil/trace.go:171","msg":"trace[278721178] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8044; }","duration":"291.207268ms","start":"2026-04-08T00:48:28.443533Z","end":"2026-04-08T00:48:28.73474Z","steps":["trace[278721178] 'agreement among raft nodes before linearized reading'  (duration: 290.965434ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T00:48:28.734802Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"547.956919ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-04-08T00:48:28.734847Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"580.314987ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-04-08T00:48:28.734859Z","caller":"traceutil/trace.go:171","msg":"trace[751741684] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8044; }","duration":"548.067801ms","start":"2026-04-08T00:48:28.186778Z","end":"2026-04-08T00:48:28.734846Z","steps":["trace[751741684] 'agreement among raft nodes before linearized reading'  (duration: 547.971539ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T00:48:28.734896Z","caller":"traceutil/trace.go:171","msg":"trace[1415911065] range","detail":"{range_begin:/registry/controllerrevisions/; range_end:/registry/controllerrevisions0; response_count:0; response_revision:8044; }","duration":"580.413528ms","start":"2026-04-08T00:48:28.154467Z","end":"2026-04-08T00:48:28.734881Z","steps":["trace[1415911065] 'agreement among raft nodes before linearized reading'  (duration: 580.314086ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T00:48:28.734897Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T00:48:28.186741Z","time spent":"548.149953ms","remote":"127.0.0.1:56182","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-04-08T00:48:28.734934Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T00:48:28.154445Z","time spent":"580.48148ms","remote":"127.0.0.1:56724","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":19,"response size":31,"request content":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true "}
{"level":"warn","ts":"2026-04-08T00:48:28.735172Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.363772ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-04-08T00:48:28.73528Z","caller":"traceutil/trace.go:171","msg":"trace[1401063062] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:8044; }","duration":"339.542227ms","start":"2026-04-08T00:48:28.39571Z","end":"2026-04-08T00:48:28.735252Z","steps":["trace[1401063062] 'agreement among raft nodes before linearized reading'  (duration: 339.22999ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T00:48:28.735336Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T00:48:28.395687Z","time spent":"339.637058ms","remote":"127.0.0.1:41254","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":1,"response size":31,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "}
{"level":"warn","ts":"2026-04-08T00:48:28.735346Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"637.123694ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/barbican-api-6dcf44d94b-x65r4.18a43b3d6cd29f78\" ","response":"range_response_count:1 size:1135"}
{"level":"info","ts":"2026-04-08T00:48:28.735409Z","caller":"traceutil/trace.go:171","msg":"trace[901392625] range","detail":"{range_begin:/registry/events/openstack/barbican-api-6dcf44d94b-x65r4.18a43b3d6cd29f78; range_end:; response_count:1; response_revision:8044; }","duration":"637.222065ms","start":"2026-04-08T00:48:28.098157Z","end":"2026-04-08T00:48:28.735379Z","steps":["trace[901392625] 'agreement among raft nodes before linearized reading'  (duration: 635.940201ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T00:48:28.735462Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T00:48:28.098127Z","time spent":"637.320597ms","remote":"127.0.0.1:56288","response type":"/etcdserverpb.KV/Range","request count":0,"request size":75,"response count":1,"response size":1159,"request content":"key:\"/registry/events/openstack/barbican-api-6dcf44d94b-x65r4.18a43b3d6cd29f78\" "}
{"level":"warn","ts":"2026-04-08T00:48:28.735453Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.526513ms","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-08T00:48:28.735552Z","caller":"traceutil/trace.go:171","msg":"trace[794367796] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8044; }","duration":"243.673085ms","start":"2026-04-08T00:48:28.491854Z","end":"2026-04-08T00:48:28.735527Z","steps":["trace[794367796] 'agreement among raft nodes before linearized reading'  (duration: 242.968102ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T00:48:29.079115Z","caller":"traceutil/trace.go:171","msg":"trace[1607784336] transaction","detail":"{read_only:false; response_revision:8051; number_of_response:1; }","duration":"135.558166ms","start":"2026-04-08T00:48:28.943522Z","end":"2026-04-08T00:48:29.07908Z","steps":["trace[1607784336] 'process raft request'  (duration: 66.199114ms)","trace[1607784336] 'compare'  (duration: 69.188069ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-08T00:48:29.402895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.843674ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.250\" ","response":"range_response_count:1 size:135"}
{"level":"info","ts":"2026-04-08T00:48:29.403078Z","caller":"traceutil/trace.go:171","msg":"trace[1232660556] range","detail":"{range_begin:/registry/masterleases/199.204.45.250; range_end:; response_count:1; response_revision:8052; }","duration":"150.112571ms","start":"2026-04-08T00:48:29.252937Z","end":"2026-04-08T00:48:29.40305Z","steps":["trace[1232660556] 'range keys from in-memory index tree'  (duration: 149.560769ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T00:48:30.036741Z","caller":"traceutil/trace.go:171","msg":"trace[1225940591] transaction","detail":"{read_only:false; response_revision:8053; number_of_response:1; }","duration":"547.95686ms","start":"2026-04-08T00:48:29.488758Z","end":"2026-04-08T00:48:30.036715Z","steps":["trace[1225940591] 'process raft request'  (duration: 547.731736ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T00:48:30.037019Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T00:48:29.488736Z","time spent":"548.086623ms","remote":"127.0.0.1:56486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" mod_revision:8013 > success:<request_put:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" value_size:415 >> failure:<request_range:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" > >"}
{"level":"info","ts":"2026-04-08T00:48:30.076174Z","caller":"traceutil/trace.go:171","msg":"trace[490864385] linearizableReadLoop","detail":"{readStateIndex:8332; appliedIndex:8330; }","duration":"367.904059ms","start":"2026-04-08T00:48:29.708252Z","end":"2026-04-08T00:48:30.076156Z","steps":["trace[490864385] 'read index received'  (duration: 328.346276ms)","trace[490864385] 'applied index is now lower than readState.Index'  (duration: 39.556643ms)"],"step_count":2}
{"level":"info","ts":"2026-04-08T00:48:30.076333Z","caller":"traceutil/trace.go:171","msg":"trace[1087475993] transaction","detail":"{read_only:false; response_revision:8054; number_of_response:1; }","duration":"394.486908ms","start":"2026-04-08T00:48:29.681788Z","end":"2026-04-08T00:48:30.076275Z","steps":["trace[1087475993] 'process raft request'  (duration: 394.241893ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T00:48:30.076537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"368.264247ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-s598f\" ","response":"range_response_count:1 size:6524"}
{"level":"warn","ts":"2026-04-08T00:48:30.076589Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T00:48:29.681758Z","time spent":"394.702841ms","remote":"127.0.0.1:56236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/masterleases/199.204.45.250\" mod_revision:7998 > success:<request_put:<key:\"/registry/masterleases/199.204.45.250\" value_size:67 lease:4984813443346656734 >> failure:<request_range:<key:\"/registry/masterleases/199.204.45.250\" > >"}
{"level":"info","ts":"2026-04-08T00:48:30.076627Z","caller":"traceutil/trace.go:171","msg":"trace[588461763] range","detail":"{range_begin:/registry/pods/openstack/keepalived-s598f; range_end:; response_count:1; response_revision:8054; }","duration":"368.41797ms","start":"2026-04-08T00:48:29.708191Z","end":"2026-04-08T00:48:30.076609Z","steps":["trace[588461763] 'agreement among raft nodes before linearized reading'  (duration: 368.043862ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T00:48:30.076679Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T00:48:29.708167Z","time spent":"368.500722ms","remote":"127.0.0.1:56414","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6548,"request content":"key:\"/registry/pods/openstack/keepalived-s598f\" "}
{"level":"info","ts":"2026-04-08T00:48:30.716511Z","caller":"traceutil/trace.go:171","msg":"trace[544428598] transaction","detail":"{read_only:false; response_revision:8055; number_of_response:1; }","duration":"111.101006ms","start":"2026-04-08T00:48:30.605034Z","end":"2026-04-08T00:48:30.716135Z","steps":["trace[544428598] 'process raft request'  (duration: 110.895443ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T00:48:30.898788Z","caller":"traceutil/trace.go:171","msg":"trace[103947058] transaction","detail":"{read_only:false; response_revision:8057; number_of_response:1; }","duration":"155.287426ms","start":"2026-04-08T00:48:30.743467Z","end":"2026-04-08T00:48:30.898754Z","steps":["trace[103947058] 'process raft request'  (duration: 154.835227ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T00:48:30.89904Z","caller":"traceutil/trace.go:171","msg":"trace[1839322179] transaction","detail":"{read_only:false; response_revision:8056; number_of_response:1; }","duration":"158.72022ms","start":"2026-04-08T00:48:30.740296Z","end":"2026-04-08T00:48:30.899016Z","steps":["trace[1839322179] 'process raft request'  (duration: 84.550927ms)","trace[1839322179] 'compare'  (duration: 73.315406ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-08T00:48:31.152151Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.857776ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14208185480201432559 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:8046 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-04-08T00:48:31.1526Z","caller":"traceutil/trace.go:171","msg":"trace[1294269004] transaction","detail":"{read_only:false; response_revision:8058; number_of_response:1; }","duration":"248.986535ms","start":"2026-04-08T00:48:30.90352Z","end":"2026-04-08T00:48:31.152506Z","steps":["trace[1294269004] 'process raft request'  (duration: 100.62436ms)","trace[1294269004] 'compare'  (duration: 147.481818ms)"],"step_count":2}
{"level":"info","ts":"2026-04-08T00:48:31.152859Z","caller":"traceutil/trace.go:171","msg":"trace[283869634] transaction","detail":"{read_only:false; response_revision:8059; number_of_response:1; }","duration":"249.23089ms","start":"2026-04-08T00:48:30.903571Z","end":"2026-04-08T00:48:31.152802Z","steps":["trace[283869634] 'process raft request'  (duration: 248.855113ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T00:48:31.153044Z","caller":"traceutil/trace.go:171","msg":"trace[1306787583] linearizableReadLoop","detail":"{readStateIndex:8338; appliedIndex:8335; }","duration":"243.843458ms","start":"2026-04-08T00:48:30.909178Z","end":"2026-04-08T00:48:31.153021Z","steps":["trace[1306787583] 'read index received'  (duration: 94.985824ms)","trace[1306787583] 'applied index is now lower than readState.Index'  (duration: 148.855684ms)"],"step_count":2}
{"level":"info","ts":"2026-04-08T00:48:31.153125Z","caller":"traceutil/trace.go:171","msg":"trace[485583956] transaction","detail":"{read_only:false; response_revision:8060; number_of_response:1; }","duration":"249.383602ms","start":"2026-04-08T00:48:30.903674Z","end":"2026-04-08T00:48:31.153057Z","steps":["trace[485583956] 'process raft request'  (duration: 249.088767ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T00:48:31.153556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.335308ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:572"}
{"level":"info","ts":"2026-04-08T00:48:31.153672Z","caller":"traceutil/trace.go:171","msg":"trace[23705820] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:8060; }","duration":"244.516632ms","start":"2026-04-08T00:48:30.909126Z","end":"2026-04-08T00:48:31.153643Z","steps":["trace[23705820] 'agreement among raft nodes before linearized reading'  (duration: 244.126055ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T00:48:31.153773Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.605231ms","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-08T00:48:31.153885Z","caller":"traceutil/trace.go:171","msg":"trace[1365360936] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8060; }","duration":"189.757414ms","start":"2026-04-08T00:48:30.964103Z","end":"2026-04-08T00:48:31.15386Z","steps":["trace[1365360936] 'agreement among raft nodes before linearized reading'  (duration: 189.382867ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T00:48:36.235236Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5894}
{"level":"info","ts":"2026-04-08T00:48:36.325185Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5894,"took":"88.002331ms","hash":4046565607,"current-db-size-bytes":57819136,"current-db-size":"58 MB","current-db-size-in-use-bytes":26304512,"current-db-size-in-use":"26 MB"}
{"level":"info","ts":"2026-04-08T00:48:36.32528Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4046565607,"revision":5894,"compact-revision":2834}
{"level":"info","ts":"2026-04-08T00:48:37.355282Z","caller":"traceutil/trace.go:171","msg":"trace[621395305] transaction","detail":"{read_only:false; response_revision:8099; number_of_response:1; }","duration":"164.484619ms","start":"2026-04-08T00:48:37.190763Z","end":"2026-04-08T00:48:37.355247Z","steps":["trace[621395305] 'process raft request'  (duration: 98.910077ms)","trace[621395305] 'compare'  (duration: 65.388868ms)"],"step_count":2}
{"level":"info","ts":"2026-04-08T00:48:37.355717Z","caller":"traceutil/trace.go:171","msg":"trace[244676818] transaction","detail":"{read_only:false; response_revision:8100; number_of_response:1; }","duration":"163.124493ms","start":"2026-04-08T00:48:37.192318Z","end":"2026-04-08T00:48:37.355443Z","steps":["trace[244676818] 'process raft request'  (duration: 162.882099ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T00:48:55.292972Z","caller":"traceutil/trace.go:171","msg":"trace[1210122870] linearizableReadLoop","detail":"{readStateIndex:8524; appliedIndex:8523; }","duration":"106.437648ms","start":"2026-04-08T00:48:55.186501Z","end":"2026-04-08T00:48:55.292939Z","steps":["trace[1210122870] 'read index received'  (duration: 106.214703ms)","trace[1210122870] 'applied index is now lower than readState.Index'  (duration: 221.015µs)"],"step_count":2}
{"level":"info","ts":"2026-04-08T00:48:55.293452Z","caller":"traceutil/trace.go:171","msg":"trace[1064377943] transaction","detail":"{read_only:false; response_revision:8239; number_of_response:1; }","duration":"166.816502ms","start":"2026-04-08T00:48:55.126611Z","end":"2026-04-08T00:48:55.293428Z","steps":["trace[1064377943] 'process raft request'  (duration: 166.137379ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T00:48:55.293765Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.251854ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-08T00:48:55.293824Z","caller":"traceutil/trace.go:171","msg":"trace[1355478438] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8239; }","duration":"107.326755ms","start":"2026-04-08T00:48:55.186479Z","end":"2026-04-08T00:48:55.293806Z","steps":["trace[1355478438] 'agreement among raft nodes before linearized reading'  (duration: 107.213443ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T00:48:59.186265Z","caller":"traceutil/trace.go:171","msg":"trace[1697871595] transaction","detail":"{read_only:false; response_revision:8258; number_of_response:1; }","duration":"261.055242ms","start":"2026-04-08T00:48:58.925165Z","end":"2026-04-08T00:48:59.18622Z","steps":["trace[1697871595] 'process raft request'  (duration: 260.799207ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T00:48:59.464244Z","caller":"traceutil/trace.go:171","msg":"trace[2139400306] transaction","detail":"{read_only:false; response_revision:8259; number_of_response:1; }","duration":"413.575557ms","start":"2026-04-08T00:48:59.050631Z","end":"2026-04-08T00:48:59.464207Z","steps":["trace[2139400306] 'process raft request'  (duration: 365.694678ms)","trace[2139400306] 'compare'  (duration: 47.589494ms)"],"step_count":2}
{"level":"info","ts":"2026-04-08T00:48:59.464502Z","caller":"traceutil/trace.go:171","msg":"trace[715222602] transaction","detail":"{read_only:false; response_revision:8260; number_of_response:1; }","duration":"412.009826ms","start":"2026-04-08T00:48:59.052437Z","end":"2026-04-08T00:48:59.464447Z","steps":["trace[715222602] 'process raft request'  (duration: 411.701321ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T00:48:59.464396Z","caller":"traceutil/trace.go:171","msg":"trace[1149572712] linearizableReadLoop","detail":"{readStateIndex:8545; appliedIndex:8543; }","duration":"210.445712ms","start":"2026-04-08T00:48:59.253899Z","end":"2026-04-08T00:48:59.464345Z","steps":["trace[1149572712] 'read index received'  (duration: 162.40869ms)","trace[1149572712] 'applied index is now lower than readState.Index'  (duration: 48.034161ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-08T00:48:59.464651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.728886ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.250\" ","response":"range_response_count:1 size:135"}
{"level":"info","ts":"2026-04-08T00:48:59.464704Z","caller":"traceutil/trace.go:171","msg":"trace[70895252] range","detail":"{range_begin:/registry/masterleases/199.204.45.250; range_end:; response_count:1; response_revision:8260; }","duration":"210.83681ms","start":"2026-04-08T00:48:59.253847Z","end":"2026-04-08T00:48:59.464683Z","steps":["trace[70895252] 'agreement among raft nodes before linearized reading'  (duration: 210.615636ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T00:48:59.464753Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T00:48:59.052413Z","time spent":"412.21626ms","remote":"127.0.0.1:56486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:8250 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"warn","ts":"2026-04-08T00:48:59.465306Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T00:48:59.050607Z","time spent":"414.574995ms","remote":"127.0.0.1:56486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:8249 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:457 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"warn","ts":"2026-04-08T00:48:59.491189Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.24317ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"}
{"level":"info","ts":"2026-04-08T00:48:59.491249Z","caller":"traceutil/trace.go:171","msg":"trace[1793562290] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8261; }","duration":"151.340592ms","start":"2026-04-08T00:48:59.339895Z","end":"2026-04-08T00:48:59.491235Z","steps":["trace[1793562290] 'agreement among raft nodes before linearized reading'  (duration: 151.143138ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T00:48:59.491466Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.904888ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"}
{"level":"warn","ts":"2026-04-08T00:48:59.491548Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.853676ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"}
{"level":"info","ts":"2026-04-08T00:48:59.491667Z","caller":"traceutil/trace.go:171","msg":"trace[686700357] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8261; }","duration":"156.010468ms","start":"2026-04-08T00:48:59.335636Z","end":"2026-04-08T00:48:59.491647Z","steps":["trace[686700357] 'agreement among raft nodes before linearized reading'  (duration: 155.52615ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T00:48:59.491818Z","caller":"traceutil/trace.go:171","msg":"trace[1296384584] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8261; }","duration":"164.124902ms","start":"2026-04-08T00:48:59.327488Z","end":"2026-04-08T00:48:59.491613Z","steps":["trace[1296384584] 'agreement among raft nodes before linearized reading'  (duration: 163.674734ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T00:49:12.013099Z","caller":"traceutil/trace.go:171","msg":"trace[104845687] transaction","detail":"{read_only:false; response_revision:8374; number_of_response:1; }","duration":"152.097765ms","start":"2026-04-08T00:49:11.860973Z","end":"2026-04-08T00:49:12.013071Z","steps":["trace[104845687] 'process raft request'  (duration: 151.905262ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T00:49:12.279285Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.166222ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusterbackups/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusterbackups0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-08T00:49:12.279477Z","caller":"traceutil/trace.go:171","msg":"trace[609329548] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusterbackups/; range_end:/registry/pxc.percona.com/perconaxtradbclusterbackups0; response_count:0; response_revision:8374; }","duration":"172.487859ms","start":"2026-04-08T00:49:12.10694Z","end":"2026-04-08T00:49:12.279428Z","steps":["trace[609329548] 'count revisions from in-memory index tree'  (duration: 172.000718ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T00:49:12.400337Z","caller":"traceutil/trace.go:171","msg":"trace[1643245457] transaction","detail":"{read_only:false; response_revision:8376; number_of_response:1; }","duration":"104.550154ms","start":"2026-04-08T00:49:12.295753Z","end":"2026-04-08T00:49:12.400303Z","steps":["trace[1643245457] 'process raft request'  (duration: 87.122106ms)","trace[1643245457] 'compare'  (duration: 17.090002ms)"],"step_count":2}
{"level":"info","ts":"2026-04-08T00:49:13.285525Z","caller":"traceutil/trace.go:171","msg":"trace[2071772793] linearizableReadLoop","detail":"{readStateIndex:8668; appliedIndex:8667; }","duration":"298.860531ms","start":"2026-04-08T00:49:12.986636Z","end":"2026-04-08T00:49:13.285496Z","steps":["trace[2071772793] 'read index received'  (duration: 298.600727ms)","trace[2071772793] 'applied index is now lower than readState.Index'  (duration: 258.914µs)"],"step_count":2}
{"level":"info","ts":"2026-04-08T00:49:13.285612Z","caller":"traceutil/trace.go:171","msg":"trace[1940802657] transaction","detail":"{read_only:false; response_revision:8377; number_of_response:1; }","duration":"460.215291ms","start":"2026-04-08T00:49:12.825349Z","end":"2026-04-08T00:49:13.285565Z","steps":["trace[1940802657] 'process raft request'  (duration: 459.970956ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T00:49:13.285797Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.146416ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"}
{"level":"warn","ts":"2026-04-08T00:49:13.285828Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T00:49:12.825316Z","time spent":"460.392445ms","remote":"127.0.0.1:56456","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3037,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/jobs/openstack/rook-ceph-detect-version\" mod_revision:8368 > success:<request_put:<key:\"/registry/jobs/openstack/rook-ceph-detect-version\" value_size:2980 >> failure:<request_range:<key:\"/registry/jobs/openstack/rook-ceph-detect-version\" > >"}
{"level":"info","ts":"2026-04-08T00:49:13.285845Z","caller":"traceutil/trace.go:171","msg":"trace[1199625666] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:8377; }","duration":"299.266088ms","start":"2026-04-08T00:49:12.986566Z","end":"2026-04-08T00:49:13.285832Z","steps":["trace[1199625666] 'agreement among raft nodes before linearized reading'  (duration: 299.071205ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T00:49:14.614397Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14208185480201433580,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-04-08T00:49:14.700688Z","caller":"traceutil/trace.go:171","msg":"trace[1242736688] transaction","detail":"{read_only:false; response_revision:8389; number_of_response:1; }","duration":"654.901458ms","start":"2026-04-08T00:49:14.045758Z","end":"2026-04-08T00:49:14.700659Z","steps":["trace[1242736688] 'process raft request'  (duration: 654.719485ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T00:49:14.700885Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T00:49:14.045742Z","time spent":"655.01556ms","remote":"127.0.0.1:57984","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7439,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/monitoring.coreos.com/prometheuses/monitoring/kube-prometheus-stack-prometheus\" mod_revision:8308 > success:<request_put:<key:\"/registry/monitoring.coreos.com/prometheuses/monitoring/kube-prometheus-stack-prometheus\" value_size:7343 >> failure:<request_range:<key:\"/registry/monitoring.coreos.com/prometheuses/monitoring/kube-prometheus-stack-prometheus\" > >"}
{"level":"warn","ts":"2026-04-08T00:49:14.882213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.784411ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14208185480201433582 > lease_revoke:<id:452d9d6a8244f05a>","response":"size:29"}
{"level":"info","ts":"2026-04-08T00:49:14.882357Z","caller":"traceutil/trace.go:171","msg":"trace[1642920135] linearizableReadLoop","detail":"{readStateIndex:8681; appliedIndex:8679; }","duration":"768.42573ms","start":"2026-04-08T00:49:14.113907Z","end":"2026-04-08T00:49:14.882333Z","steps":["trace[1642920135] 'read index received'  (duration: 586.458413ms)","trace[1642920135] 'applied index is now lower than readState.Index'  (duration: 181.965477ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-08T00:49:14.882551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"768.628193ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-08T00:49:14.882596Z","caller":"traceutil/trace.go:171","msg":"trace[1980893849] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:8389; }","duration":"768.722935ms","start":"2026-04-08T00:49:14.113857Z","end":"2026-04-08T00:49:14.88258Z","steps":["trace[1980893849] 'agreement among raft nodes before linearized reading'  (duration: 768.616983ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T00:49:14.882642Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T00:49:14.113836Z","time spent":"768.793946ms","remote":"127.0.0.1:41188","response type":"/etcdserverpb.KV/Range","request count":0,"request size":130,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true "}
{"level":"warn","ts":"2026-04-08T00:49:14.882698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"727.368739ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectstores/openstack/ceph\" ","response":"range_response_count:1 size:3173"}
{"level":"info","ts":"2026-04-08T00:49:14.882797Z","caller":"traceutil/trace.go:171","msg":"trace[616064728] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectstores/openstack/ceph; range_end:; response_count:1; response_revision:8389; }","duration":"727.505201ms","start":"2026-04-08T00:49:14.155265Z","end":"2026-04-08T00:49:14.88277Z","steps":["trace[616064728] 'agreement among raft nodes before linearized reading'  (duration: 727.243127ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T00:49:14.882849Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T00:49:14.155253Z","time spent":"727.587853ms","remote":"127.0.0.1:48254","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":3197,"request content":"key:\"/registry/ceph.rook.io/cephobjectstores/openstack/ceph\" "}
{"level":"warn","ts":"2026-04-08T00:49:14.883141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.999155ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-04-08T00:49:14.883186Z","caller":"traceutil/trace.go:171","msg":"trace[81841160] range","detail":"{range_begin:/registry/validatingwebhookconfigurations/; range_end:/registry/validatingwebhookconfigurations0; response_count:0; response_revision:8389; }","duration":"290.044766ms","start":"2026-04-08T00:49:14.593127Z","end":"2026-04-08T00:49:14.883172Z","steps":["trace[81841160] 'agreement among raft nodes before linearized reading'  (duration: 289.967754ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T00:49:14.883267Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"469.349223ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-s598f\" ","response":"range_response_count:1 size:6524"}
{"level":"info","ts":"2026-04-08T00:49:14.883317Z","caller":"traceutil/trace.go:171","msg":"trace[841634603] range","detail":"{range_begin:/registry/pods/openstack/keepalived-s598f; range_end:; response_count:1; response_revision:8389; }","duration":"469.440325ms","start":"2026-04-08T00:49:14.413865Z","end":"2026-04-08T00:49:14.883306Z","steps":["trace[841634603] 'agreement among raft nodes before linearized reading'  (duration: 469.248682ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T00:49:14.88335Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T00:49:14.413845Z","time spent":"469.497526ms","remote":"127.0.0.1:56414","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6548,"request content":"key:\"/registry/pods/openstack/keepalived-s598f\" "}
{"level":"warn","ts":"2026-04-08T00:49:14.883569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"468.096321ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-04-08T00:49:14.883613Z","caller":"traceutil/trace.go:171","msg":"trace[1124740680] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:8389; }","duration":"468.188402ms","start":"2026-04-08T00:49:14.415413Z","end":"2026-04-08T00:49:14.883601Z","steps":["trace[1124740680] 'agreement among raft nodes before linearized reading'  (duration: 468.1195ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T00:49:14.883643Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T00:49:14.415391Z","time spent":"468.244313ms","remote":"127.0.0.1:50180","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":31,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "}
{"level":"info","ts":"2026-04-08T00:49:20.248118Z","caller":"traceutil/trace.go:171","msg":"trace[896299276] transaction","detail":"{read_only:false; response_revision:8442; number_of_response:1; }","duration":"122.439739ms","start":"2026-04-08T00:49:20.125642Z","end":"2026-04-08T00:49:20.248082Z","steps":["trace[896299276] 'process raft request'  (duration: 121.732835ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T00:49:20.355154Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.121555ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-08T00:49:20.355276Z","caller":"traceutil/trace.go:171","msg":"trace[108473990] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8442; }","duration":"104.334089ms","start":"2026-04-08T00:49:20.250911Z","end":"2026-04-08T00:49:20.355245Z","steps":["trace[108473990] 'range keys from in-memory index tree'  (duration: 103.956342ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T00:49:20.429358Z","caller":"traceutil/trace.go:171","msg":"trace[347058663] transaction","detail":"{read_only:false; response_revision:8443; number_of_response:1; }","duration":"135.699008ms","start":"2026-04-08T00:49:20.293616Z","end":"2026-04-08T00:49:20.429315Z","steps":["trace[347058663] 'process raft request'  (duration: 135.388993ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T00:49:21.297247Z","caller":"traceutil/trace.go:171","msg":"trace[564410883] linearizableReadLoop","detail":"{readStateIndex:8738; appliedIndex:8737; }","duration":"111.688507ms","start":"2026-04-08T00:49:21.185526Z","end":"2026-04-08T00:49:21.297214Z","steps":["trace[564410883] 'read index received'  (duration: 35.911374ms)","trace[564410883] 'applied index is now lower than readState.Index'  (duration: 75.774913ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-08T00:49:21.297451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.883181ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-08T00:49:21.297602Z","caller":"traceutil/trace.go:171","msg":"trace[399183290] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8444; }","duration":"112.070596ms","start":"2026-04-08T00:49:21.185494Z","end":"2026-04-08T00:49:21.297564Z","steps":["trace[399183290] 'agreement among raft nodes before linearized reading'  (duration: 111.82946ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T00:50:08.81321Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002428.wal"}
{"level":"info","ts":"2026-04-08T00:50:21.323155Z","caller":"traceutil/trace.go:171","msg":"trace[1170574373] transaction","detail":"{read_only:false; response_revision:9017; number_of_response:1; }","duration":"120.358722ms","start":"2026-04-08T00:50:21.202748Z","end":"2026-04-08T00:50:21.323107Z","steps":["trace[1170574373] 'process raft request'  (duration: 120.090137ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T00:50:21.900035Z","caller":"traceutil/trace.go:171","msg":"trace[1256118410] transaction","detail":"{read_only:false; response_revision:9018; number_of_response:1; }","duration":"143.640185ms","start":"2026-04-08T00:50:21.756347Z","end":"2026-04-08T00:50:21.899987Z","steps":["trace[1256118410] 'process raft request'  (duration: 143.334649ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T00:50:22.046236Z","caller":"traceutil/trace.go:171","msg":"trace[507476580] transaction","detail":"{read_only:false; response_revision:9020; number_of_response:1; }","duration":"140.656938ms","start":"2026-04-08T00:50:21.905547Z","end":"2026-04-08T00:50:22.046204Z","steps":["trace[507476580] 'process raft request'  (duration: 140.421894ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T00:50:22.046397Z","caller":"traceutil/trace.go:171","msg":"trace[1506862419] transaction","detail":"{read_only:false; response_revision:9021; number_of_response:1; }","duration":"123.01036ms","start":"2026-04-08T00:50:21.923349Z","end":"2026-04-08T00:50:22.04636Z","steps":["trace[1506862419] 'process raft request'  (duration: 122.798726ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T00:51:09.040378Z","caller":"traceutil/trace.go:171","msg":"trace[84951375] linearizableReadLoop","detail":"{readStateIndex:9755; appliedIndex:9754; }","duration":"115.743986ms","start":"2026-04-08T00:51:08.924609Z","end":"2026-04-08T00:51:09.040353Z","steps":["trace[84951375] 'read index received'  (duration: 115.239437ms)","trace[84951375] 'applied index is now lower than readState.Index'  (duration: 503.569µs)"],"step_count":2}
{"level":"warn","ts":"2026-04-08T00:51:09.040586Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.9553ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rook-ceph-pdbstatemap\" ","response":"range_response_count:1 size:356"}
{"level":"info","ts":"2026-04-08T00:51:09.040639Z","caller":"traceutil/trace.go:171","msg":"trace[2058388435] range","detail":"{range_begin:/registry/configmaps/openstack/rook-ceph-pdbstatemap; range_end:; response_count:1; response_revision:9435; }","duration":"116.081283ms","start":"2026-04-08T00:51:08.924542Z","end":"2026-04-08T00:51:09.040623Z","steps":["trace[2058388435] 'agreement among raft nodes before linearized reading'  (duration: 115.916179ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T00:51:09.040859Z","caller":"traceutil/trace.go:171","msg":"trace[1627327788] transaction","detail":"{read_only:false; response_revision:9435; number_of_response:1; }","duration":"175.849892ms","start":"2026-04-08T00:51:08.864999Z","end":"2026-04-08T00:51:09.040849Z","steps":["trace[1627327788] 'process raft request'  (duration: 174.978745ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T00:51:40.65851Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"d98d5f2c752cc52d","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-04-08T00:51:40.663728Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001}
{"level":"info","ts":"2026-04-08T00:51:40.663807Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001}
{"level":"info","ts":"2026-04-08T00:52:44.630023Z","caller":"traceutil/trace.go:171","msg":"trace[210390216] transaction","detail":"{read_only:false; response_revision:10187; number_of_response:1; }","duration":"106.834889ms","start":"2026-04-08T00:52:44.523166Z","end":"2026-04-08T00:52:44.630001Z","steps":["trace[210390216] 'process raft request'  (duration: 106.654566ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T00:52:44.683567Z","caller":"traceutil/trace.go:171","msg":"trace[454364714] transaction","detail":"{read_only:false; response_revision:10189; number_of_response:1; }","duration":"115.270536ms","start":"2026-04-08T00:52:44.568273Z","end":"2026-04-08T00:52:44.683544Z","steps":["trace[454364714] 'process raft request'  (duration: 115.226266ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T00:52:44.683587Z","caller":"traceutil/trace.go:171","msg":"trace[135216123] transaction","detail":"{read_only:false; response_revision:10188; number_of_response:1; }","duration":"119.368924ms","start":"2026-04-08T00:52:44.564179Z","end":"2026-04-08T00:52:44.683548Z","steps":["trace[135216123] 'process raft request'  (duration: 119.15607ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T00:53:36.242507Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8089}
{"level":"info","ts":"2026-04-08T00:53:36.31861Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8089,"took":"73.364992ms","hash":760428819,"current-db-size-bytes":57819136,"current-db-size":"58 MB","current-db-size-in-use-bytes":29323264,"current-db-size-in-use":"29 MB"}
{"level":"info","ts":"2026-04-08T00:53:36.318677Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":760428819,"revision":8089,"compact-revision":5894}
{"level":"info","ts":"2026-04-08T00:58:36.250154Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10513}
{"level":"info","ts":"2026-04-08T00:58:36.333102Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10513,"took":"80.836301ms","hash":2518226271,"current-db-size-bytes":57819136,"current-db-size":"58 MB","current-db-size-in-use-bytes":19976192,"current-db-size-in-use":"20 MB"}
{"level":"info","ts":"2026-04-08T00:58:36.333209Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2518226271,"revision":10513,"compact-revision":8089}