{"level":"warn","ts":"2026-05-04T15:28:53.25088Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-05-04T15:28:53.250999Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.210: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.210:2380","--initial-cluster=instance=https://199.204.45.210:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.210:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.210:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]}
{"level":"warn","ts":"2026-05-04T15:28:53.251089Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-05-04T15:28:53.251107Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.210:2380"]}
{"level":"info","ts":"2026-05-04T15:28:53.251139Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-05-04T15:28:53.257699Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.210:2379"]}
{"level":"info","ts":"2026-05-04T15:28:53.25781Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.210:2380"],"listen-peer-urls":["https://199.204.45.210:2380"],"advertise-client-urls":["https://199.204.45.210:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.210:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.210:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"}
{"level":"info","ts":"2026-05-04T15:28:53.266121Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.8837ms"}
{"level":"info","ts":"2026-05-04T15:28:53.278349Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"1cac722af8b2b8a6","cluster-id":"ba0a336ca61ee41d"}
{"level":"info","ts":"2026-05-04T15:28:53.278423Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 switched to configuration voters=()"}
{"level":"info","ts":"2026-05-04T15:28:53.278443Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 became follower at term 0"}
{"level":"info","ts":"2026-05-04T15:28:53.278489Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 1cac722af8b2b8a6 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-05-04T15:28:53.278498Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 became follower at term 1"}
{"level":"info","ts":"2026-05-04T15:28:53.278556Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 switched to configuration voters=(2066151857942870182)"}
{"level":"warn","ts":"2026-05-04T15:28:53.289417Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-05-04T15:28:53.29069Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-05-04T15:28:53.292681Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"}
{"level":"info","ts":"2026-05-04T15:28:53.297912Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"1cac722af8b2b8a6","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-05-04T15:28:53.298443Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"1cac722af8b2b8a6","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-05-04T15:28:53.298137Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"}
{"level":"info","ts":"2026-05-04T15:28:53.298812Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"}
{"level":"info","ts":"2026-05-04T15:28:53.298859Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"}
{"level":"info","ts":"2026-05-04T15:28:53.301827Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 switched to configuration voters=(2066151857942870182)"}
{"level":"info","ts":"2026-05-04T15:28:53.301963Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"ba0a336ca61ee41d","local-member-id":"1cac722af8b2b8a6","added-peer-id":"1cac722af8b2b8a6","added-peer-peer-urls":["https://199.204.45.210:2380"]}
{"level":"info","ts":"2026-05-04T15:28:53.302843Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-05-04T15:28:53.303227Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"1cac722af8b2b8a6","initial-advertise-peer-urls":["https://199.204.45.210:2380"],"listen-peer-urls":["https://199.204.45.210:2380"],"advertise-client-urls":["https://199.204.45.210:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.210:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-05-04T15:28:53.303255Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-05-04T15:28:53.303414Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.210:2380"}
{"level":"info","ts":"2026-05-04T15:28:53.303427Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.210:2380"}
{"level":"info","ts":"2026-05-04T15:28:53.479042Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 is starting a new election at term 1"}
{"level":"info","ts":"2026-05-04T15:28:53.479102Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 became pre-candidate at term 1"}
{"level":"info","ts":"2026-05-04T15:28:53.47914Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 received MsgPreVoteResp from 1cac722af8b2b8a6 at term 1"}
{"level":"info","ts":"2026-05-04T15:28:53.479156Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 became candidate at term 2"}
{"level":"info","ts":"2026-05-04T15:28:53.479163Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 received MsgVoteResp from 1cac722af8b2b8a6 at term 2"}
{"level":"info","ts":"2026-05-04T15:28:53.479175Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 became leader at term 2"}
{"level":"info","ts":"2026-05-04T15:28:53.479185Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 1cac722af8b2b8a6 elected leader 1cac722af8b2b8a6 at term 2"}
{"level":"info","ts":"2026-05-04T15:28:53.480825Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"1cac722af8b2b8a6","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.210:2379]}","request-path":"/0/members/1cac722af8b2b8a6/attributes","cluster-id":"ba0a336ca61ee41d","publish-timeout":"7s"}
{"level":"info","ts":"2026-05-04T15:28:53.48102Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-05-04T15:28:53.481077Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-05-04T15:28:53.48113Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-05-04T15:28:53.481142Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-04T15:28:53.481185Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-05-04T15:28:53.48241Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"ba0a336ca61ee41d","local-member-id":"1cac722af8b2b8a6","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-04T15:28:53.482587Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-04T15:28:53.482661Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-04T15:28:53.484053Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.210:2379"}
{"level":"info","ts":"2026-05-04T15:28:53.484136Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-05-04T15:28:55.320409Z","caller":"traceutil/trace.go:171","msg":"trace[499691973] transaction","detail":"{read_only:false; response_revision:2; number_of_response:1; }","duration":"278.754644ms","start":"2026-05-04T15:28:55.041626Z","end":"2026-05-04T15:28:55.320381Z","steps":["trace[499691973] 'process raft request'  (duration: 278.535195ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:28:55.842216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"428.487217ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13305495818720517753 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/ranges/serviceips\" mod_revision:0 > success:<request_put:<key:\"/registry/ranges/serviceips\" value_size:67 >> failure:<request_range:<key:\"/registry/ranges/serviceips\" > >>","response":"size:14"}
{"level":"info","ts":"2026-05-04T15:28:55.842589Z","caller":"traceutil/trace.go:171","msg":"trace[1640805460] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"800.786092ms","start":"2026-05-04T15:28:55.041734Z","end":"2026-05-04T15:28:55.84252Z","steps":["trace[1640805460] 'process raft request'  (duration: 371.284322ms)","trace[1640805460] 'compare'  (duration: 428.295719ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T15:28:55.842751Z","caller":"traceutil/trace.go:171","msg":"trace[47803155] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"723.179649ms","start":"2026-05-04T15:28:55.11948Z","end":"2026-05-04T15:28:55.842659Z","steps":["trace[47803155] 'process raft request'  (duration: 722.928371ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T15:28:55.842853Z","caller":"traceutil/trace.go:171","msg":"trace[32793206] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"723.04009ms","start":"2026-05-04T15:28:55.119749Z","end":"2026-05-04T15:28:55.842789Z","steps":["trace[32793206] 'process raft request'  (duration: 722.695102ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T15:28:55.842855Z","caller":"traceutil/trace.go:171","msg":"trace[811408491] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"724.26301ms","start":"2026-05-04T15:28:55.118512Z","end":"2026-05-04T15:28:55.842775Z","steps":["trace[811408491] 'process raft request'  (duration: 723.848033ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:28:55.842885Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T15:28:55.041726Z","time spent":"800.959481ms","remote":"127.0.0.1:38400","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":100,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/ranges/serviceips\" mod_revision:0 > success:<request_put:<key:\"/registry/ranges/serviceips\" value_size:67 >> failure:<request_range:<key:\"/registry/ranges/serviceips\" > >"}
{"level":"warn","ts":"2026-05-04T15:28:55.843021Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T15:28:55.119697Z","time spent":"723.236988ms","remote":"127.0.0.1:38894","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":992,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/apiregistration.k8s.io/apiservices/v1.admissionregistration.k8s.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiregistration.k8s.io/apiservices/v1.admissionregistration.k8s.io\" value_size:908 >> failure:<>"}
{"level":"warn","ts":"2026-05-04T15:28:55.843069Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T15:28:55.118496Z","time spent":"724.486998ms","remote":"127.0.0.1:38798","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":698,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/prioritylevelconfigurations/system\" mod_revision:0 > success:<request_put:<key:\"/registry/prioritylevelconfigurations/system\" value_size:646 >> failure:<>"}
{"level":"warn","ts":"2026-05-04T15:28:55.843146Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T15:28:55.11946Z","time spent":"723.416176ms","remote":"127.0.0.1:38894","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":920,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/apiregistration.k8s.io/apiservices/v1.apps\" mod_revision:0 > success:<request_put:<key:\"/registry/apiregistration.k8s.io/apiservices/v1.apps\" value_size:860 >> failure:<>"}
{"level":"info","ts":"2026-05-04T15:28:55.843031Z","caller":"traceutil/trace.go:171","msg":"trace[1162995908] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"722.822181ms","start":"2026-05-04T15:28:55.119871Z","end":"2026-05-04T15:28:55.842694Z","steps":["trace[1162995908] 'process raft request'  (duration: 722.702792ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:28:55.843493Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T15:28:55.119833Z","time spent":"723.516106ms","remote":"127.0.0.1:38894","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":971,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/apiregistration.k8s.io/apiservices/v1.authentication.k8s.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiregistration.k8s.io/apiservices/v1.authentication.k8s.io\" value_size:894 >> failure:<>"}
{"level":"info","ts":"2026-05-04T15:28:55.843538Z","caller":"traceutil/trace.go:171","msg":"trace[83569703] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"723.309127ms","start":"2026-05-04T15:28:55.120215Z","end":"2026-05-04T15:28:55.843524Z","steps":["trace[83569703] 'process raft request'  (duration: 722.390444ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T15:28:55.843546Z","caller":"traceutil/trace.go:171","msg":"trace[1250348503] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"717.988555ms","start":"2026-05-04T15:28:55.125545Z","end":"2026-05-04T15:28:55.843534Z","steps":["trace[1250348503] 'process raft request'  (duration: 717.118252ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:28:55.843601Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T15:28:55.120125Z","time spent":"723.444056ms","remote":"127.0.0.1:38894","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":883,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/apiregistration.k8s.io/apiservices/v1.\" mod_revision:0 > success:<request_put:<key:\"/registry/apiregistration.k8s.io/apiservices/v1.\" value_size:827 >> failure:<>"}
{"level":"warn","ts":"2026-05-04T15:28:55.843613Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T15:28:55.125535Z","time spent":"718.043904ms","remote":"127.0.0.1:38622","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":849,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/certificatesigningrequests/csr-sq9fk\" mod_revision:0 > success:<request_put:<key:\"/registry/certificatesigningrequests/csr-sq9fk\" value_size:795 >> failure:<>"}
{"level":"info","ts":"2026-05-04T15:28:55.843692Z","caller":"traceutil/trace.go:171","msg":"trace[1585473542] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"708.556352ms","start":"2026-05-04T15:28:55.135061Z","end":"2026-05-04T15:28:55.843617Z","steps":["trace[1585473542] 'process raft request'  (duration: 707.653008ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T15:28:55.843729Z","caller":"traceutil/trace.go:171","msg":"trace[1917763440] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"723.458446ms","start":"2026-05-04T15:28:55.120224Z","end":"2026-05-04T15:28:55.843683Z","steps":["trace[1917763440] 'process raft request'  (duration: 722.413394ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:28:55.843809Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T15:28:55.120201Z","time spent":"723.555406ms","remote":"127.0.0.1:38894","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/apiregistration.k8s.io/apiservices/v1.apiextensions.k8s.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiregistration.k8s.io/apiservices/v1.apiextensions.k8s.io\" value_size:892 >> failure:<>"}
{"level":"warn","ts":"2026-05-04T15:28:55.84399Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T15:28:55.135045Z","time spent":"708.683991ms","remote":"127.0.0.1:38538","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3159,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/minions/instance\" mod_revision:0 > success:<request_put:<key:\"/registry/minions/instance\" value_size:3125 >> failure:<>"}
{"level":"info","ts":"2026-05-04T15:28:55.846282Z","caller":"traceutil/trace.go:171","msg":"trace[1336282916] linearizableReadLoop","detail":"{readStateIndex:6; appliedIndex:4; }","duration":"792.256561ms","start":"2026-05-04T15:28:55.053988Z","end":"2026-05-04T15:28:55.846245Z","steps":["trace[1336282916] 'read index received'  (duration: 266.079253ms)","trace[1336282916] 'applied index is now lower than readState.Index'  (duration: 526.170848ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-04T15:28:55.846578Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"792.535299ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-05-04T15:28:55.846626Z","caller":"traceutil/trace.go:171","msg":"trace[2049357831] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:11; }","duration":"792.638429ms","start":"2026-05-04T15:28:55.053973Z","end":"2026-05-04T15:28:55.846611Z","steps":["trace[2049357831] 'agreement among raft nodes before linearized reading'  (duration: 792.46077ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:28:55.846666Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T15:28:55.053966Z","time spent":"792.690268ms","remote":"127.0.0.1:38752","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":0,"response size":27,"request content":"key:\"/registry/csinodes/instance\" "}
{"level":"warn","ts":"2026-05-04T15:28:55.846869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"758.127793ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-05-04T15:28:55.847172Z","caller":"traceutil/trace.go:171","msg":"trace[585408859] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"758.455601ms","start":"2026-05-04T15:28:55.088698Z","end":"2026-05-04T15:28:55.847153Z","steps":["trace[585408859] 'agreement among raft nodes before linearized reading'  (duration: 758.096142ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:28:55.847624Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T15:28:55.088686Z","time spent":"758.909857ms","remote":"127.0.0.1:38464","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "}
{"level":"warn","ts":"2026-05-04T15:28:55.847305Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"729.435646ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-05-04T15:28:55.848793Z","caller":"traceutil/trace.go:171","msg":"trace[621331501] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"730.921145ms","start":"2026-05-04T15:28:55.117856Z","end":"2026-05-04T15:28:55.848777Z","steps":["trace[621331501] 'agreement among raft nodes before linearized reading'  (duration: 729.060578ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:28:55.847062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"730.02864ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.210\" ","response":"range_response_count:0 size:4"}
{"level":"warn","ts":"2026-05-04T15:28:55.847023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"727.030582ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:4"}
{"level":"warn","ts":"2026-05-04T15:28:55.847011Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"678.094587ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-05-04T15:28:55.849165Z","caller":"traceutil/trace.go:171","msg":"trace[1410245018] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"680.272682ms","start":"2026-05-04T15:28:55.168875Z","end":"2026-05-04T15:28:55.849148Z","steps":["trace[1410245018] 'agreement among raft nodes before linearized reading'  (duration: 678.107858ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:28:55.849243Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T15:28:55.168863Z","time spent":"680.362641ms","remote":"127.0.0.1:38464","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "}
{"level":"warn","ts":"2026-05-04T15:28:55.849359Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T15:28:55.117841Z","time spent":"731.507839ms","remote":"127.0.0.1:38464","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "}
{"level":"info","ts":"2026-05-04T15:28:55.849475Z","caller":"traceutil/trace.go:171","msg":"trace[1833685555] range","detail":"{range_begin:/registry/masterleases/199.204.45.210; range_end:; response_count:0; response_revision:11; }","duration":"732.438293ms","start":"2026-05-04T15:28:55.117026Z","end":"2026-05-04T15:28:55.849464Z","steps":["trace[1833685555] 'agreement among raft nodes before linearized reading'  (duration: 730.01964ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:28:55.849545Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T15:28:55.116914Z","time spent":"732.619402ms","remote":"127.0.0.1:38380","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":0,"response size":27,"request content":"key:\"/registry/masterleases/199.204.45.210\" "}
{"level":"info","ts":"2026-05-04T15:28:55.849545Z","caller":"traceutil/trace.go:171","msg":"trace[683366157] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:11; }","duration":"729.658952ms","start":"2026-05-04T15:28:55.119859Z","end":"2026-05-04T15:28:55.849518Z","steps":["trace[683366157] 'agreement among raft nodes before linearized reading'  (duration: 727.015842ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:28:55.849773Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T15:28:55.119844Z","time spent":"729.915321ms","remote":"127.0.0.1:38436","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":27,"request content":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" "}
{"level":"warn","ts":"2026-05-04T15:29:23.9681Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13305495818720518672,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-05-04T15:29:24.070396Z","caller":"traceutil/trace.go:171","msg":"trace[1112695329] linearizableReadLoop","detail":"{readStateIndex:487; appliedIndex:486; }","duration":"603.325458ms","start":"2026-05-04T15:29:23.467042Z","end":"2026-05-04T15:29:24.070367Z","steps":["trace[1112695329] 'read index received'  (duration: 603.111726ms)","trace[1112695329] 'applied index is now lower than readState.Index'  (duration: 212.642µs)"],"step_count":2}
{"level":"warn","ts":"2026-05-04T15:29:24.070535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"603.467409ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-04T15:29:24.070579Z","caller":"traceutil/trace.go:171","msg":"trace[767671272] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:0; response_revision:470; }","duration":"603.55996ms","start":"2026-05-04T15:29:23.467005Z","end":"2026-05-04T15:29:24.070565Z","steps":["trace[767671272] 'agreement among raft nodes before linearized reading'  (duration: 603.468139ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:29:24.070624Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T15:29:23.466989Z","time spent":"603.625521ms","remote":"127.0.0.1:38448","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":28,"request content":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" "}
{"level":"info","ts":"2026-05-04T15:29:24.07046Z","caller":"traceutil/trace.go:171","msg":"trace[1277517144] transaction","detail":"{read_only:false; response_revision:470; number_of_response:1; }","duration":"661.622015ms","start":"2026-05-04T15:29:23.408784Z","end":"2026-05-04T15:29:24.070406Z","steps":["trace[1277517144] 'process raft request'  (duration: 661.433323ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:29:24.071079Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T15:29:23.408745Z","time spent":"662.11884ms","remote":"127.0.0.1:38638","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:432 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-05-04T15:29:28.757153Z","caller":"traceutil/trace.go:171","msg":"trace[1046553410] transaction","detail":"{read_only:false; response_revision:565; number_of_response:1; }","duration":"139.826061ms","start":"2026-05-04T15:29:28.617287Z","end":"2026-05-04T15:29:28.757113Z","steps":["trace[1046553410] 'process raft request'  (duration: 139.084982ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:29:29.512354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"524.024208ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13305495818720518832 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/roles/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" mod_revision:0 > success:<request_put:<key:\"/registry/roles/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" value_size:818 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-05-04T15:29:29.512475Z","caller":"traceutil/trace.go:171","msg":"trace[1218559101] transaction","detail":"{read_only:false; response_revision:566; number_of_response:1; }","duration":"687.68731ms","start":"2026-05-04T15:29:28.824769Z","end":"2026-05-04T15:29:29.512457Z","steps":["trace[1218559101] 'process raft request'  (duration: 163.487521ms)","trace[1218559101] 'compare'  (duration: 523.872105ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-04T15:29:29.512536Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T15:29:28.824732Z","time spent":"687.776121ms","remote":"127.0.0.1:38700","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":897,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/roles/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" mod_revision:0 > success:<request_put:<key:\"/registry/roles/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" value_size:818 >> failure:<>"}
{"level":"info","ts":"2026-05-04T15:29:29.515283Z","caller":"traceutil/trace.go:171","msg":"trace[122722514] linearizableReadLoop","detail":"{readStateIndex:588; appliedIndex:587; }","duration":"250.987622ms","start":"2026-05-04T15:29:29.264274Z","end":"2026-05-04T15:29:29.515261Z","steps":["trace[122722514] 'read index received'  (duration: 250.80305ms)","trace[122722514] 'applied index is now lower than readState.Index'  (duration: 182.932µs)"],"step_count":2}
{"level":"info","ts":"2026-05-04T15:29:29.51555Z","caller":"traceutil/trace.go:171","msg":"trace[9337617] transaction","detail":"{read_only:false; response_revision:567; number_of_response:1; }","duration":"393.886371ms","start":"2026-05-04T15:29:29.121652Z","end":"2026-05-04T15:29:29.515539Z","steps":["trace[9337617] 'process raft request'  (duration: 393.494746ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:29:29.515668Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T15:29:29.121625Z","time spent":"393.964813ms","remote":"127.0.0.1:38638","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:426 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:471 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"warn","ts":"2026-05-04T15:29:29.516124Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.842954ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-04T15:29:29.5162Z","caller":"traceutil/trace.go:171","msg":"trace[1005897506] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:567; }","duration":"251.954935ms","start":"2026-05-04T15:29:29.264231Z","end":"2026-05-04T15:29:29.516186Z","steps":["trace[1005897506] 'agreement among raft nodes before linearized reading'  (duration: 251.60246ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:29:29.516453Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.47092ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"info","ts":"2026-05-04T15:29:29.516506Z","caller":"traceutil/trace.go:171","msg":"trace[106507359] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:567; }","duration":"140.580921ms","start":"2026-05-04T15:29:29.375912Z","end":"2026-05-04T15:29:29.516492Z","steps":["trace[106507359] 'agreement among raft nodes before linearized reading'  (duration: 140.44109ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T15:29:30.880806Z","caller":"traceutil/trace.go:171","msg":"trace[1476989910] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"408.136291ms","start":"2026-05-04T15:29:30.472582Z","end":"2026-05-04T15:29:30.880719Z","steps":["trace[1476989910] 'process raft request'  (duration: 406.973246ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:29:30.881096Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T15:29:30.472546Z","time spent":"408.428444ms","remote":"127.0.0.1:38448","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036225,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" mod_revision:569 > success:<request_put:<key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" value_size:1036141 >> failure:<request_range:<key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" > >"}
{"level":"warn","ts":"2026-05-04T15:29:32.026642Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13305495818720518858,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-05-04T15:29:32.389568Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.125192793s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-04T15:29:32.389672Z","caller":"traceutil/trace.go:171","msg":"trace[1790283442] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:579; }","duration":"1.125360436s","start":"2026-05-04T15:29:31.264284Z","end":"2026-05-04T15:29:32.389644Z","steps":["trace[1790283442] 'range keys from in-memory index tree'  (duration: 1.125078692s)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:29:32.389743Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T15:29:31.264255Z","time spent":"1.125471098s","remote":"127.0.0.1:38350","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-05-04T15:29:32.38965Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T15:29:31.44053Z","time spent":"949.103259ms","remote":"127.0.0.1:47632","response type":"/etcdserverpb.Maintenance/Status","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"warn","ts":"2026-05-04T15:29:32.426908Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.00984929s","expected-duration":"1s"}
{"level":"info","ts":"2026-05-04T15:29:32.428286Z","caller":"traceutil/trace.go:171","msg":"trace[15369755] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"1.013097094s","start":"2026-05-04T15:29:31.415157Z","end":"2026-05-04T15:29:32.428254Z","steps":["trace[15369755] 'process raft request'  (duration: 1.012362944s)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:29:32.428549Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T15:29:31.415127Z","time spent":"1.013233915s","remote":"127.0.0.1:38448","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036261,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" mod_revision:577 > success:<request_put:<key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" value_size:1036177 >> failure:<request_range:<key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" > >"}
{"level":"info","ts":"2026-05-04T15:29:32.461385Z","caller":"traceutil/trace.go:171","msg":"trace[2138957508] linearizableReadLoop","detail":"{readStateIndex:602; appliedIndex:600; }","duration":"935.062936ms","start":"2026-05-04T15:29:31.52629Z","end":"2026-05-04T15:29:32.461353Z","steps":["trace[2138957508] 'read index received'  (duration: 901.028967ms)","trace[2138957508] 'applied index is now lower than readState.Index'  (duration: 34.032329ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-04T15:29:32.461642Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"935.337799ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"info","ts":"2026-05-04T15:29:32.461672Z","caller":"traceutil/trace.go:171","msg":"trace[1281036598] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:580; }","duration":"935.424711ms","start":"2026-05-04T15:29:31.526237Z","end":"2026-05-04T15:29:32.461662Z","steps":["trace[1281036598] 'agreement among raft nodes before linearized reading'  (duration: 935.266289ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:29:32.461679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"353.931017ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"}
{"level":"warn","ts":"2026-05-04T15:29:32.461699Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T15:29:31.52622Z","time spent":"935.472582ms","remote":"127.0.0.1:38638","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-05-04T15:29:32.46171Z","caller":"traceutil/trace.go:171","msg":"trace[2028001794] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:580; }","duration":"353.997249ms","start":"2026-05-04T15:29:32.107705Z","end":"2026-05-04T15:29:32.461702Z","steps":["trace[2028001794] 'agreement among raft nodes before linearized reading'  (duration: 353.879917ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:29:32.461735Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T15:29:32.107687Z","time spent":"354.042909ms","remote":"127.0.0.1:38638","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-05-04T15:29:32.461765Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.507607ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"}
{"level":"info","ts":"2026-05-04T15:29:32.461823Z","caller":"traceutil/trace.go:171","msg":"trace[289576104] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:580; }","duration":"146.570178ms","start":"2026-05-04T15:29:32.315239Z","end":"2026-05-04T15:29:32.461809Z","steps":["trace[289576104] 'agreement among raft nodes before linearized reading'  (duration: 146.424386ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:29:32.461841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.337975ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-05-04T15:29:32.46186Z","caller":"traceutil/trace.go:171","msg":"trace[667503742] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:580; }","duration":"172.402677ms","start":"2026-05-04T15:29:32.28945Z","end":"2026-05-04T15:29:32.461853Z","steps":["trace[667503742] 'agreement among raft nodes before linearized reading'  (duration: 172.347556ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:29:34.363645Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.184949ms","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":"info","ts":"2026-05-04T15:29:34.363697Z","caller":"traceutil/trace.go:171","msg":"trace[1006709229] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:612; }","duration":"308.29786ms","start":"2026-05-04T15:29:34.055388Z","end":"2026-05-04T15:29:34.363686Z","steps":["trace[1006709229] 'range keys from in-memory index tree'  (duration: 308.098677ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:29:34.363723Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T15:29:34.055363Z","time spent":"308.355051ms","remote":"127.0.0.1:47692","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 "}
{"level":"warn","ts":"2026-05-04T15:29:34.363692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.977496ms","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-05-04T15:29:34.363812Z","caller":"traceutil/trace.go:171","msg":"trace[116684526] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:612; }","duration":"308.178259ms","start":"2026-05-04T15:29:34.055617Z","end":"2026-05-04T15:29:34.363795Z","steps":["trace[116684526] 'count revisions from in-memory index tree'  (duration: 307.829904ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:29:34.363879Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T15:29:34.05559Z","time spent":"308.27927ms","remote":"127.0.0.1:47692","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "}
{"level":"info","ts":"2026-05-04T15:29:34.368232Z","caller":"traceutil/trace.go:171","msg":"trace[2074018670] linearizableReadLoop","detail":"{readStateIndex:635; appliedIndex:634; }","duration":"184.306876ms","start":"2026-05-04T15:29:34.183871Z","end":"2026-05-04T15:29:34.368177Z","steps":["trace[2074018670] 'read index received'  (duration: 183.854819ms)","trace[2074018670] 'applied index is now lower than readState.Index'  (duration: 450.897µs)"],"step_count":2}
{"level":"info","ts":"2026-05-04T15:29:34.369056Z","caller":"traceutil/trace.go:171","msg":"trace[812489271] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"203.824916ms","start":"2026-05-04T15:29:34.164576Z","end":"2026-05-04T15:29:34.368401Z","steps":["trace[812489271] 'process raft request'  (duration: 203.245938ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:29:34.369474Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.399172ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:10000 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-04T15:29:34.369542Z","caller":"traceutil/trace.go:171","msg":"trace[206085495] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:613; }","duration":"185.706446ms","start":"2026-05-04T15:29:34.183815Z","end":"2026-05-04T15:29:34.369522Z","steps":["trace[206085495] 'agreement among raft nodes before linearized reading'  (duration: 185.345881ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:29:34.369604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.561734ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-04T15:29:34.369759Z","caller":"traceutil/trace.go:171","msg":"trace[2048591106] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:613; }","duration":"185.807437ms","start":"2026-05-04T15:29:34.183899Z","end":"2026-05-04T15:29:34.369707Z","steps":["trace[2048591106] 'agreement among raft nodes before linearized reading'  (duration: 185.543404ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:29:34.369925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.117038ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-04T15:29:34.369985Z","caller":"traceutil/trace.go:171","msg":"trace[422837510] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:613; }","duration":"120.186659ms","start":"2026-05-04T15:29:34.249781Z","end":"2026-05-04T15:29:34.369968Z","steps":["trace[422837510] 'agreement among raft nodes before linearized reading'  (duration: 120.097598ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:29:34.370156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.539147ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:500 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-04T15:29:34.370218Z","caller":"traceutil/trace.go:171","msg":"trace[1139883500] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:613; }","duration":"144.616858ms","start":"2026-05-04T15:29:34.225575Z","end":"2026-05-04T15:29:34.370191Z","steps":["trace[1139883500] 'agreement among raft nodes before linearized reading'  (duration: 144.530647ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:29:34.370502Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.438581ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-04T15:29:34.370543Z","caller":"traceutil/trace.go:171","msg":"trace[706577098] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:613; }","duration":"150.498212ms","start":"2026-05-04T15:29:34.220026Z","end":"2026-05-04T15:29:34.370525Z","steps":["trace[706577098] 'agreement among raft nodes before linearized reading'  (duration: 150.437521ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:29:34.37059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.144784ms","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-05-04T15:29:34.37067Z","caller":"traceutil/trace.go:171","msg":"trace[62112685] 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:613; }","duration":"103.217566ms","start":"2026-05-04T15:29:34.267415Z","end":"2026-05-04T15:29:34.370632Z","steps":["trace[62112685] 'agreement among raft nodes before linearized reading'  (duration: 103.103774ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:29:34.370726Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.35043ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:500 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-04T15:29:34.370762Z","caller":"traceutil/trace.go:171","msg":"trace[113256448] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:613; }","duration":"166.409271ms","start":"2026-05-04T15:29:34.20434Z","end":"2026-05-04T15:29:34.37075Z","steps":["trace[113256448] 'agreement among raft nodes before linearized reading'  (duration: 166.35482ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:29:34.370888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.483261ms","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\" limit:10000 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-04T15:29:34.370945Z","caller":"traceutil/trace.go:171","msg":"trace[210657246] 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:613; }","duration":"103.552331ms","start":"2026-05-04T15:29:34.267377Z","end":"2026-05-04T15:29:34.370929Z","steps":["trace[210657246] 'agreement among raft nodes before linearized reading'  (duration: 103.321798ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:29:34.37121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.556487ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-04T15:29:34.371245Z","caller":"traceutil/trace.go:171","msg":"trace[75346925] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:613; }","duration":"167.613518ms","start":"2026-05-04T15:29:34.20362Z","end":"2026-05-04T15:29:34.371234Z","steps":["trace[75346925] 'agreement among raft nodes before linearized reading'  (duration: 167.461006ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:29:34.371251Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.931484ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-04T15:29:34.371299Z","caller":"traceutil/trace.go:171","msg":"trace[1217481117] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:613; }","duration":"107.979765ms","start":"2026-05-04T15:29:34.263297Z","end":"2026-05-04T15:29:34.371277Z","steps":["trace[1217481117] 'agreement among raft nodes before linearized reading'  (duration: 107.918394ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:29:34.371678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.486298ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:500 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-04T15:29:34.371727Z","caller":"traceutil/trace.go:171","msg":"trace[1528980830] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:613; }","duration":"121.532888ms","start":"2026-05-04T15:29:34.250171Z","end":"2026-05-04T15:29:34.371704Z","steps":["trace[1528980830] 'agreement among raft nodes before linearized reading'  (duration: 121.463117ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:29:34.371781Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.175345ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:10000 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-04T15:29:34.371825Z","caller":"traceutil/trace.go:171","msg":"trace[1131943169] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:613; }","duration":"168.266997ms","start":"2026-05-04T15:29:34.203548Z","end":"2026-05-04T15:29:34.371815Z","steps":["trace[1131943169] 'agreement among raft nodes before linearized reading'  (duration: 167.819391ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:29:34.372119Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.259259ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:10000 ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-05-04T15:29:34.372142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.888607ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:500 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-04T15:29:34.372154Z","caller":"traceutil/trace.go:171","msg":"trace[1533727685] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:613; }","duration":"122.31708ms","start":"2026-05-04T15:29:34.249827Z","end":"2026-05-04T15:29:34.372144Z","steps":["trace[1533727685] 'agreement among raft nodes before linearized reading'  (duration: 122.112978ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T15:29:34.372178Z","caller":"traceutil/trace.go:171","msg":"trace[399589498] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:613; }","duration":"187.915988ms","start":"2026-05-04T15:29:34.184243Z","end":"2026-05-04T15:29:34.372159Z","steps":["trace[399589498] 'agreement among raft nodes before linearized reading'  (duration: 187.866487ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:29:34.372388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.296018ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-operator-869df985b8-fl2qx\" ","response":"range_response_count:1 size:4888"}
{"level":"info","ts":"2026-05-04T15:29:34.372453Z","caller":"traceutil/trace.go:171","msg":"trace[664286784] range","detail":"{range_begin:/registry/pods/kube-system/cilium-operator-869df985b8-fl2qx; range_end:; response_count:1; response_revision:613; }","duration":"103.372028ms","start":"2026-05-04T15:29:34.269054Z","end":"2026-05-04T15:29:34.372426Z","steps":["trace[664286784] 'agreement among raft nodes before linearized reading'  (duration: 103.106895ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:29:34.372691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.719774ms","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\" limit:500 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-04T15:29:34.373648Z","caller":"traceutil/trace.go:171","msg":"trace[1241202355] 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:613; }","duration":"103.783605ms","start":"2026-05-04T15:29:34.268943Z","end":"2026-05-04T15:29:34.372726Z","steps":["trace[1241202355] 'agreement among raft nodes before linearized reading'  (duration: 103.707123ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:29:34.370678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.672846ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-04T15:29:34.373785Z","caller":"traceutil/trace.go:171","msg":"trace[978327689] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:613; }","duration":"153.79862ms","start":"2026-05-04T15:29:34.219972Z","end":"2026-05-04T15:29:34.373771Z","steps":["trace[978327689] 'agreement among raft nodes before linearized reading'  (duration: 150.671896ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:29:37.329994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.876085ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io\" ","response":"range_response_count:1 size:4180"}
{"level":"info","ts":"2026-05-04T15:29:37.33009Z","caller":"traceutil/trace.go:171","msg":"trace[489614844] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io; range_end:; response_count:1; response_revision:664; }","duration":"155.050428ms","start":"2026-05-04T15:29:37.175018Z","end":"2026-05-04T15:29:37.330068Z","steps":["trace[489614844] 'range keys from in-memory index tree'  (duration: 154.642642ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:29:48.998366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"427.818353ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"warn","ts":"2026-05-04T15:29:48.998557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"447.369058ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-05-04T15:29:48.998617Z","caller":"traceutil/trace.go:171","msg":"trace[207682705] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:744; }","duration":"447.484491ms","start":"2026-05-04T15:29:48.551118Z","end":"2026-05-04T15:29:48.998602Z","steps":["trace[207682705] 'range keys from in-memory index tree'  (duration: 447.201925ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:29:48.998597Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"427.076937ms","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-05-04T15:29:48.998632Z","caller":"traceutil/trace.go:171","msg":"trace[750271115] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:744; }","duration":"428.082077ms","start":"2026-05-04T15:29:48.570492Z","end":"2026-05-04T15:29:48.998574Z","steps":["trace[750271115] 'range keys from in-memory index tree'  (duration: 427.646429ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:29:48.998661Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T15:29:48.551085Z","time spent":"447.565122ms","remote":"127.0.0.1:38638","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-05-04T15:29:48.998683Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T15:29:48.570481Z","time spent":"428.190599ms","remote":"127.0.0.1:38638","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-05-04T15:29:48.998682Z","caller":"traceutil/trace.go:171","msg":"trace[1033284037] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:744; }","duration":"427.20882ms","start":"2026-05-04T15:29:48.571453Z","end":"2026-05-04T15:29:48.998662Z","steps":["trace[1033284037] 'range keys from in-memory index tree'  (duration: 426.919794ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:29:48.998657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"435.913547ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"}
{"level":"warn","ts":"2026-05-04T15:29:48.998732Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T15:29:48.571439Z","time spent":"427.284561ms","remote":"127.0.0.1:38638","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-05-04T15:29:48.998749Z","caller":"traceutil/trace.go:171","msg":"trace[409938385] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:744; }","duration":"436.0581ms","start":"2026-05-04T15:29:48.56267Z","end":"2026-05-04T15:29:48.998728Z","steps":["trace[409938385] 'range keys from in-memory index tree'  (duration: 435.744274ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:29:48.998799Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T15:29:48.562651Z","time spent":"436.132091ms","remote":"127.0.0.1:38638","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-05-04T15:29:49.197145Z","caller":"traceutil/trace.go:171","msg":"trace[371989085] transaction","detail":"{read_only:false; response_revision:745; number_of_response:1; }","duration":"193.519823ms","start":"2026-05-04T15:29:49.00358Z","end":"2026-05-04T15:29:49.197099Z","steps":["trace[371989085] 'process raft request'  (duration: 193.33046ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T15:29:49.238Z","caller":"traceutil/trace.go:171","msg":"trace[201601248] transaction","detail":"{read_only:false; response_revision:746; number_of_response:1; }","duration":"233.909426ms","start":"2026-05-04T15:29:49.004066Z","end":"2026-05-04T15:29:49.237975Z","steps":["trace[201601248] 'process raft request'  (duration: 233.700802ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T15:29:49.238382Z","caller":"traceutil/trace.go:171","msg":"trace[470647486] linearizableReadLoop","detail":"{readStateIndex:775; appliedIndex:770; }","duration":"211.334584ms","start":"2026-05-04T15:29:49.027026Z","end":"2026-05-04T15:29:49.238361Z","steps":["trace[470647486] 'read index received'  (duration: 169.909841ms)","trace[470647486] 'applied index is now lower than readState.Index'  (duration: 41.423833ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-04T15:29:49.23862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.567848ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-7c96b6546b-phw7z\" ","response":"range_response_count:1 size:5050"}
{"level":"info","ts":"2026-05-04T15:29:49.238672Z","caller":"traceutil/trace.go:171","msg":"trace[1879340702] range","detail":"{range_begin:/registry/pods/kube-system/coredns-7c96b6546b-phw7z; range_end:; response_count:1; response_revision:749; }","duration":"211.66593ms","start":"2026-05-04T15:29:49.02699Z","end":"2026-05-04T15:29:49.238656Z","steps":["trace[1879340702] 'agreement among raft nodes before linearized reading'  (duration: 211.459776ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T15:29:49.238983Z","caller":"traceutil/trace.go:171","msg":"trace[293403205] transaction","detail":"{read_only:false; response_revision:747; number_of_response:1; }","duration":"232.954986ms","start":"2026-05-04T15:29:49.00601Z","end":"2026-05-04T15:29:49.238965Z","steps":["trace[293403205] 'process raft request'  (duration: 231.921406ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T15:29:49.239753Z","caller":"traceutil/trace.go:171","msg":"trace[1649156484] transaction","detail":"{read_only:false; response_revision:749; number_of_response:1; }","duration":"218.632466ms","start":"2026-05-04T15:29:49.021084Z","end":"2026-05-04T15:29:49.239716Z","steps":["trace[1649156484] 'process raft request'  (duration: 217.225299ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T15:29:49.240056Z","caller":"traceutil/trace.go:171","msg":"trace[776751050] transaction","detail":"{read_only:false; response_revision:748; number_of_response:1; }","duration":"233.958666ms","start":"2026-05-04T15:29:49.006088Z","end":"2026-05-04T15:29:49.240047Z","steps":["trace[776751050] 'process raft request'  (duration: 232.118421ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T15:30:15.529513Z","caller":"traceutil/trace.go:171","msg":"trace[1987544115] linearizableReadLoop","detail":"{readStateIndex:1170; appliedIndex:1169; }","duration":"177.730603ms","start":"2026-05-04T15:30:15.351766Z","end":"2026-05-04T15:30:15.529497Z","steps":["trace[1987544115] 'read index received'  (duration: 177.600659ms)","trace[1987544115] 'applied index is now lower than readState.Index'  (duration: 129.204µs)"],"step_count":2}
{"level":"info","ts":"2026-05-04T15:30:15.529786Z","caller":"traceutil/trace.go:171","msg":"trace[604949568] transaction","detail":"{read_only:false; response_revision:1137; number_of_response:1; }","duration":"186.973265ms","start":"2026-05-04T15:30:15.342719Z","end":"2026-05-04T15:30:15.529693Z","steps":["trace[604949568] 'process raft request'  (duration: 186.690137ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:30:15.530222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.380899ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-05-04T15:30:15.530345Z","caller":"traceutil/trace.go:171","msg":"trace[1291413102] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1137; }","duration":"178.502242ms","start":"2026-05-04T15:30:15.35179Z","end":"2026-05-04T15:30:15.530292Z","steps":["trace[1291413102] 'agreement among raft nodes before linearized reading'  (duration: 178.194934ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:30:15.530266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.481642ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"}
{"level":"info","ts":"2026-05-04T15:30:15.530553Z","caller":"traceutil/trace.go:171","msg":"trace[1460044978] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1137; }","duration":"178.7756ms","start":"2026-05-04T15:30:15.35173Z","end":"2026-05-04T15:30:15.530505Z","steps":["trace[1460044978] 'agreement among raft nodes before linearized reading'  (duration: 178.40611ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:30:18.653891Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13305495818720519968,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-05-04T15:30:18.817774Z","caller":"traceutil/trace.go:171","msg":"trace[1753653395] transaction","detail":"{read_only:false; response_revision:1153; number_of_response:1; }","duration":"828.066649ms","start":"2026-05-04T15:30:17.989683Z","end":"2026-05-04T15:30:18.81775Z","steps":["trace[1753653395] 'process raft request'  (duration: 827.909835ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:30:18.817941Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T15:30:17.989659Z","time spent":"828.182703ms","remote":"127.0.0.1:38638","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:1076 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"info","ts":"2026-05-04T15:30:18.819107Z","caller":"traceutil/trace.go:171","msg":"trace[503687687] linearizableReadLoop","detail":"{readStateIndex:1188; appliedIndex:1186; }","duration":"665.693293ms","start":"2026-05-04T15:30:18.153381Z","end":"2026-05-04T15:30:18.819074Z","steps":["trace[503687687] 'read index received'  (duration: 664.299226ms)","trace[503687687] 'applied index is now lower than readState.Index'  (duration: 1.392457ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T15:30:18.819284Z","caller":"traceutil/trace.go:171","msg":"trace[1066089051] transaction","detail":"{read_only:false; response_revision:1154; number_of_response:1; }","duration":"651.016798ms","start":"2026-05-04T15:30:18.168252Z","end":"2026-05-04T15:30:18.819268Z","steps":["trace[1066089051] 'process raft request'  (duration: 650.655909ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:30:18.819399Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"617.091497ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"info","ts":"2026-05-04T15:30:18.819462Z","caller":"traceutil/trace.go:171","msg":"trace[666648793] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1154; }","duration":"617.179849ms","start":"2026-05-04T15:30:18.202266Z","end":"2026-05-04T15:30:18.819446Z","steps":["trace[666648793] 'agreement among raft nodes before linearized reading'  (duration: 617.025825ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:30:18.819468Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T15:30:18.168236Z","time spent":"651.116152ms","remote":"127.0.0.1:38638","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:1141 > 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-05-04T15:30:18.819569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"666.189426ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-04T15:30:18.819626Z","caller":"traceutil/trace.go:171","msg":"trace[626044959] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:1154; }","duration":"666.282829ms","start":"2026-05-04T15:30:18.153331Z","end":"2026-05-04T15:30:18.819614Z","steps":["trace[626044959] 'agreement among raft nodes before linearized reading'  (duration: 666.205097ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:30:18.819511Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T15:30:18.202254Z","time spent":"617.245181ms","remote":"127.0.0.1:38638","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-05-04T15:30:18.819702Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"555.208943ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-05-04T15:30:18.819666Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T15:30:18.153314Z","time spent":"666.338961ms","remote":"127.0.0.1:38502","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":0,"response size":28,"request content":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true "}
{"level":"info","ts":"2026-05-04T15:30:18.819781Z","caller":"traceutil/trace.go:171","msg":"trace[1895993781] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1154; }","duration":"555.286185ms","start":"2026-05-04T15:30:18.26445Z","end":"2026-05-04T15:30:18.819737Z","steps":["trace[1895993781] 'agreement among raft nodes before linearized reading'  (duration: 555.177092ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:30:18.819824Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T15:30:18.264439Z","time spent":"555.375707ms","remote":"127.0.0.1:38350","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-05-04T15:30:35.813352Z","caller":"traceutil/trace.go:171","msg":"trace[63684662] linearizableReadLoop","detail":"{readStateIndex:1331; appliedIndex:1330; }","duration":"149.159204ms","start":"2026-05-04T15:30:35.66417Z","end":"2026-05-04T15:30:35.813329Z","steps":["trace[63684662] 'read index received'  (duration: 149.02205ms)","trace[63684662] 'applied index is now lower than readState.Index'  (duration: 135.704µs)"],"step_count":2}
{"level":"info","ts":"2026-05-04T15:30:35.813474Z","caller":"traceutil/trace.go:171","msg":"trace[577413351] transaction","detail":"{read_only:false; response_revision:1290; number_of_response:1; }","duration":"152.631147ms","start":"2026-05-04T15:30:35.660834Z","end":"2026-05-04T15:30:35.813465Z","steps":["trace[577413351] 'process raft request'  (duration: 152.353709ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:30:35.813695Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.500734ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-05-04T15:30:35.81372Z","caller":"traceutil/trace.go:171","msg":"trace[2046963133] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1290; }","duration":"149.561555ms","start":"2026-05-04T15:30:35.664151Z","end":"2026-05-04T15:30:35.813712Z","steps":["trace[2046963133] 'agreement among raft nodes before linearized reading'  (duration: 149.421811ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:30:35.813811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.533555ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"}
{"level":"info","ts":"2026-05-04T15:30:35.813827Z","caller":"traceutil/trace.go:171","msg":"trace[60962340] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1290; }","duration":"149.558835ms","start":"2026-05-04T15:30:35.664264Z","end":"2026-05-04T15:30:35.813822Z","steps":["trace[60962340] 'agreement among raft nodes before linearized reading'  (duration: 149.514834ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:30:35.814054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.979743ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-04T15:30:35.814186Z","caller":"traceutil/trace.go:171","msg":"trace[1883761110] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:1290; }","duration":"117.194998ms","start":"2026-05-04T15:30:35.696967Z","end":"2026-05-04T15:30:35.814162Z","steps":["trace[1883761110] 'agreement among raft nodes before linearized reading'  (duration: 116.90084ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:30:35.81407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.614157ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"info","ts":"2026-05-04T15:30:35.814379Z","caller":"traceutil/trace.go:171","msg":"trace[1726200662] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1290; }","duration":"149.937236ms","start":"2026-05-04T15:30:35.664417Z","end":"2026-05-04T15:30:35.814354Z","steps":["trace[1726200662] 'agreement among raft nodes before linearized reading'  (duration: 149.486573ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:30:42.443053Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.316753ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-04T15:30:42.443165Z","caller":"traceutil/trace.go:171","msg":"trace[974276638] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1414; }","duration":"178.492638ms","start":"2026-05-04T15:30:42.26465Z","end":"2026-05-04T15:30:42.443142Z","steps":["trace[974276638] 'range keys from in-memory index tree'  (duration: 178.171967ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:30:45.393374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.908258ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13305495818720520496 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:1419 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-04T15:30:45.393775Z","caller":"traceutil/trace.go:171","msg":"trace[342051191] transaction","detail":"{read_only:false; response_revision:1426; number_of_response:1; }","duration":"255.978811ms","start":"2026-05-04T15:30:45.137749Z","end":"2026-05-04T15:30:45.393728Z","steps":["trace[342051191] 'process raft request'  (duration: 94.617518ms)","trace[342051191] 'compare'  (duration: 160.744244ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-04T15:30:45.393986Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.277827ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-04T15:30:45.394307Z","caller":"traceutil/trace.go:171","msg":"trace[836392129] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:1426; }","duration":"198.737102ms","start":"2026-05-04T15:30:45.195543Z","end":"2026-05-04T15:30:45.39428Z","steps":["trace[836392129] 'agreement among raft nodes before linearized reading'  (duration: 198.271746ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T15:30:45.393518Z","caller":"traceutil/trace.go:171","msg":"trace[887198511] linearizableReadLoop","detail":"{readStateIndex:1470; appliedIndex:1469; }","duration":"197.902025ms","start":"2026-05-04T15:30:45.195599Z","end":"2026-05-04T15:30:45.393501Z","steps":["trace[887198511] 'read index received'  (duration: 36.745859ms)","trace[887198511] 'applied index is now lower than readState.Index'  (duration: 161.155306ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-04T15:30:45.394635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.044453ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-04T15:30:45.394667Z","caller":"traceutil/trace.go:171","msg":"trace[1290419532] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1426; }","duration":"129.126445ms","start":"2026-05-04T15:30:45.265531Z","end":"2026-05-04T15:30:45.394657Z","steps":["trace[1290419532] 'agreement among raft nodes before linearized reading'  (duration: 129.065203ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T15:31:04.165281Z","caller":"traceutil/trace.go:171","msg":"trace[1194619218] transaction","detail":"{read_only:false; response_revision:1740; number_of_response:1; }","duration":"147.455282ms","start":"2026-05-04T15:31:04.017793Z","end":"2026-05-04T15:31:04.165248Z","steps":["trace[1194619218] 'process raft request'  (duration: 147.405941ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T15:31:04.165666Z","caller":"traceutil/trace.go:171","msg":"trace[1499098649] transaction","detail":"{read_only:false; response_revision:1739; number_of_response:1; }","duration":"148.56073ms","start":"2026-05-04T15:31:04.01706Z","end":"2026-05-04T15:31:04.165621Z","steps":["trace[1499098649] 'process raft request'  (duration: 148.088904ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T15:31:04.165337Z","caller":"traceutil/trace.go:171","msg":"trace[564611457] transaction","detail":"{read_only:false; response_revision:1738; number_of_response:1; }","duration":"148.931142ms","start":"2026-05-04T15:31:04.016367Z","end":"2026-05-04T15:31:04.165298Z","steps":["trace[564611457] 'process raft request'  (duration: 146.058936ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:31:12.210633Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.079799714s","expected-duration":"100ms","prefix":"","request":"header:<ID:13305495818720521365 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:1694 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:471 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-04T15:31:12.210917Z","caller":"traceutil/trace.go:171","msg":"trace[2145160075] transaction","detail":"{read_only:false; response_revision:1851; number_of_response:1; }","duration":"935.873909ms","start":"2026-05-04T15:31:11.27502Z","end":"2026-05-04T15:31:12.210894Z","steps":["trace[2145160075] 'process raft request'  (duration: 935.762025ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:31:12.211Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T15:31:11.274972Z","time spent":"935.990332ms","remote":"127.0.0.1:38638","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:1815 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:458 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"info","ts":"2026-05-04T15:31:12.211213Z","caller":"traceutil/trace.go:171","msg":"trace[1738782436] transaction","detail":"{read_only:false; response_revision:1850; number_of_response:1; }","duration":"1.100980956s","start":"2026-05-04T15:31:11.110215Z","end":"2026-05-04T15:31:12.211196Z","steps":["trace[1738782436] 'process raft request'  (duration: 20.457417ms)","trace[1738782436] 'compare'  (duration: 1.078555683s)"],"step_count":2}
{"level":"warn","ts":"2026-05-04T15:31:12.211269Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T15:31:11.110191Z","time spent":"1.101046229s","remote":"127.0.0.1:38638","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:1694 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:471 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"info","ts":"2026-05-04T15:31:12.211418Z","caller":"traceutil/trace.go:171","msg":"trace[1625346563] linearizableReadLoop","detail":"{readStateIndex:1921; appliedIndex:1920; }","duration":"1.086792333s","start":"2026-05-04T15:31:11.124614Z","end":"2026-05-04T15:31:12.211406Z","steps":["trace[1625346563] 'read index received'  (duration: 5.980894ms)","trace[1625346563] 'applied index is now lower than readState.Index'  (duration: 1.080809039s)"],"step_count":2}
{"level":"warn","ts":"2026-05-04T15:31:12.211608Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.08698589s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-fc566c4a-28da-41ef-942d-1a4dedd15077\" ","response":"range_response_count:1 size:3627"}
{"level":"info","ts":"2026-05-04T15:31:12.211653Z","caller":"traceutil/trace.go:171","msg":"trace[1509323449] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-fc566c4a-28da-41ef-942d-1a4dedd15077; range_end:; response_count:1; response_revision:1851; }","duration":"1.087053782s","start":"2026-05-04T15:31:11.124588Z","end":"2026-05-04T15:31:12.211642Z","steps":["trace[1509323449] 'agreement among raft nodes before linearized reading'  (duration: 1.086884556s)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:31:12.211685Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T15:31:11.124579Z","time spent":"1.087098023s","remote":"127.0.0.1:38540","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3650,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-fc566c4a-28da-41ef-942d-1a4dedd15077\" "}
{"level":"warn","ts":"2026-05-04T15:31:13.034178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"821.76195ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13305495818720521367 > lease_revoke:<id:38a69df39b482aec>","response":"size:28"}
{"level":"info","ts":"2026-05-04T15:31:13.034767Z","caller":"traceutil/trace.go:171","msg":"trace[1766699688] linearizableReadLoop","detail":"{readStateIndex:1923; appliedIndex:1922; }","duration":"823.266993ms","start":"2026-05-04T15:31:12.211439Z","end":"2026-05-04T15:31:13.034706Z","steps":["trace[1766699688] 'read index received'  (duration: 920.172µs)","trace[1766699688] 'applied index is now lower than readState.Index'  (duration: 822.345341ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-04T15:31:13.034902Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.173210875s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-fc566c4a-28da-41ef-942d-1a4dedd15077\" ","response":"range_response_count:1 size:3627"}
{"level":"info","ts":"2026-05-04T15:31:13.034947Z","caller":"traceutil/trace.go:171","msg":"trace[1374102384] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-fc566c4a-28da-41ef-942d-1a4dedd15077; range_end:; response_count:1; response_revision:1851; }","duration":"1.173306618s","start":"2026-05-04T15:31:11.861626Z","end":"2026-05-04T15:31:13.034932Z","steps":["trace[1374102384] 'agreement among raft nodes before linearized reading'  (duration: 1.173136553s)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:31:13.03498Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T15:31:11.8616Z","time spent":"1.173369711s","remote":"127.0.0.1:38540","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3650,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-fc566c4a-28da-41ef-942d-1a4dedd15077\" "}
{"level":"warn","ts":"2026-05-04T15:31:13.035064Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"982.308286ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"}
{"level":"info","ts":"2026-05-04T15:31:13.035159Z","caller":"traceutil/trace.go:171","msg":"trace[88039198] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1851; }","duration":"982.460941ms","start":"2026-05-04T15:31:12.05268Z","end":"2026-05-04T15:31:13.035141Z","steps":["trace[88039198] 'agreement among raft nodes before linearized reading'  (duration: 982.11229ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:31:13.035232Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T15:31:12.05265Z","time spent":"982.570335ms","remote":"127.0.0.1:38638","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-05-04T15:31:13.035535Z","caller":"traceutil/trace.go:171","msg":"trace[362683997] transaction","detail":"{read_only:false; response_revision:1852; number_of_response:1; }","duration":"622.528346ms","start":"2026-05-04T15:31:12.412999Z","end":"2026-05-04T15:31:13.035527Z","steps":["trace[362683997] 'process raft request'  (duration: 621.362286ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:31:13.03654Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T15:31:12.412965Z","time spent":"623.503519ms","remote":"127.0.0.1:38638","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:1837 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"warn","ts":"2026-05-04T15:31:13.185035Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.057955353s","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-05-04T15:31:13.185119Z","caller":"traceutil/trace.go:171","msg":"trace[218301007] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:1852; }","duration":"2.058082967s","start":"2026-05-04T15:31:11.127014Z","end":"2026-05-04T15:31:13.185097Z","steps":["trace[218301007] 'agreement among raft nodes before linearized reading'  (duration: 1.908651298s)","trace[218301007] 'count revisions from in-memory index tree'  (duration: 149.244263ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-04T15:31:13.185163Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T15:31:11.127002Z","time spent":"2.05814875s","remote":"127.0.0.1:47868","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":1,"response size":30,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "}
{"level":"warn","ts":"2026-05-04T15:31:13.185123Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"977.999752ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"}
{"level":"info","ts":"2026-05-04T15:31:13.185273Z","caller":"traceutil/trace.go:171","msg":"trace[921610206] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1852; }","duration":"978.242061ms","start":"2026-05-04T15:31:12.206999Z","end":"2026-05-04T15:31:13.185241Z","steps":["trace[921610206] 'agreement among raft nodes before linearized reading'  (duration: 828.421249ms)","trace[921610206] 'range keys from in-memory index tree'  (duration: 149.47977ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-04T15:31:13.185387Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T15:31:12.206967Z","time spent":"978.400416ms","remote":"127.0.0.1:38638","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-05-04T15:31:13.185462Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.920479545s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-04T15:31:13.185498Z","caller":"traceutil/trace.go:171","msg":"trace[1468063064] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1852; }","duration":"1.920554968s","start":"2026-05-04T15:31:11.264929Z","end":"2026-05-04T15:31:13.185484Z","steps":["trace[1468063064] 'agreement among raft nodes before linearized reading'  (duration: 1.770512988s)","trace[1468063064] 'range keys from in-memory index tree'  (duration: 150.003428ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-04T15:31:13.185519Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T15:31:11.264906Z","time spent":"1.920608089s","remote":"127.0.0.1:38350","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-05-04T15:31:13.185865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.079822445s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"}
{"level":"warn","ts":"2026-05-04T15:31:13.185859Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.605077035s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-05-04T15:31:13.185918Z","caller":"traceutil/trace.go:171","msg":"trace[1240319980] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1852; }","duration":"1.079944069s","start":"2026-05-04T15:31:12.105957Z","end":"2026-05-04T15:31:13.185902Z","steps":["trace[1240319980] 'agreement among raft nodes before linearized reading'  (duration: 928.781411ms)","trace[1240319980] 'range keys from in-memory index tree'  (duration: 150.010639ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-04T15:31:13.185955Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T15:31:12.105934Z","time spent":"1.080013602s","remote":"127.0.0.1:41160","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "}
{"level":"info","ts":"2026-05-04T15:31:13.186082Z","caller":"traceutil/trace.go:171","msg":"trace[1388339234] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1852; }","duration":"1.605375015s","start":"2026-05-04T15:31:11.580675Z","end":"2026-05-04T15:31:13.18605Z","steps":["trace[1388339234] 'agreement among raft nodes before linearized reading'  (duration: 1.454694674s)","trace[1388339234] 'range keys from in-memory index tree'  (duration: 150.183495ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-04T15:31:13.186259Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T15:31:11.580647Z","time spent":"1.60552949s","remote":"127.0.0.1:38638","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-05-04T15:31:13.18689Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.245331ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13305495818720521370 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:1840 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:465 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-04T15:31:13.187227Z","caller":"traceutil/trace.go:171","msg":"trace[22325846] linearizableReadLoop","detail":"{readStateIndex:1926; appliedIndex:1924; }","duration":"152.36698ms","start":"2026-05-04T15:31:13.034837Z","end":"2026-05-04T15:31:13.187204Z","steps":["trace[22325846] 'read index received'  (duration: 148.158896ms)","trace[22325846] 'applied index is now lower than readState.Index'  (duration: 4.206244ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T15:31:13.187438Z","caller":"traceutil/trace.go:171","msg":"trace[1629395289] transaction","detail":"{read_only:false; response_revision:1853; number_of_response:1; }","duration":"373.285857ms","start":"2026-05-04T15:31:12.814134Z","end":"2026-05-04T15:31:13.187419Z","steps":["trace[1629395289] 'process raft request'  (duration: 221.385453ms)","trace[1629395289] 'compare'  (duration: 150.93451ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-04T15:31:13.187578Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T15:31:12.814114Z","time spent":"373.413491ms","remote":"127.0.0.1:38638","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:1840 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:465 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"info","ts":"2026-05-04T15:31:13.187922Z","caller":"traceutil/trace.go:171","msg":"trace[1899667669] transaction","detail":"{read_only:false; response_revision:1854; number_of_response:1; }","duration":"191.244808ms","start":"2026-05-04T15:31:12.996655Z","end":"2026-05-04T15:31:13.1879Z","steps":["trace[1899667669] 'process raft request'  (duration: 190.449301ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:31:13.188039Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"975.179146ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"}
{"level":"warn","ts":"2026-05-04T15:31:13.188148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"975.492007ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"}
{"level":"info","ts":"2026-05-04T15:31:13.188218Z","caller":"traceutil/trace.go:171","msg":"trace[2111951471] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1854; }","duration":"975.58229ms","start":"2026-05-04T15:31:12.21262Z","end":"2026-05-04T15:31:13.188202Z","steps":["trace[2111951471] 'agreement among raft nodes before linearized reading'  (duration: 975.419555ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:31:13.188436Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T15:31:12.212609Z","time spent":"975.809117ms","remote":"127.0.0.1:38638","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-05-04T15:31:13.188459Z","caller":"traceutil/trace.go:171","msg":"trace[723296779] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1854; }","duration":"975.430304ms","start":"2026-05-04T15:31:12.212723Z","end":"2026-05-04T15:31:13.188153Z","steps":["trace[723296779] 'agreement among raft nodes before linearized reading'  (duration: 975.116364ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:31:13.188586Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T15:31:12.212696Z","time spent":"975.8774ms","remote":"127.0.0.1:38638","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-05-04T15:31:13.187625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"828.863316ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-04T15:31:13.188943Z","caller":"traceutil/trace.go:171","msg":"trace[963710158] range","detail":"{range_begin:/registry/csistoragecapacities/; range_end:/registry/csistoragecapacities0; response_count:0; response_revision:1854; }","duration":"830.189721ms","start":"2026-05-04T15:31:12.358735Z","end":"2026-05-04T15:31:13.188925Z","steps":["trace[963710158] 'agreement among raft nodes before linearized reading'  (duration: 828.739481ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:31:13.189034Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T15:31:12.358598Z","time spent":"830.419049ms","remote":"127.0.0.1:38766","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":0,"response size":28,"request content":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true "}
{"level":"info","ts":"2026-05-04T15:31:13.193273Z","caller":"traceutil/trace.go:171","msg":"trace[1114875636] transaction","detail":"{read_only:false; response_revision:1855; number_of_response:1; }","duration":"152.93999ms","start":"2026-05-04T15:31:13.040315Z","end":"2026-05-04T15:31:13.193255Z","steps":["trace[1114875636] 'process raft request'  (duration: 152.622769ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T15:31:13.193553Z","caller":"traceutil/trace.go:171","msg":"trace[641515026] transaction","detail":"{read_only:false; response_revision:1856; number_of_response:1; }","duration":"149.181271ms","start":"2026-05-04T15:31:13.044352Z","end":"2026-05-04T15:31:13.193534Z","steps":["trace[641515026] 'process raft request'  (duration: 148.696004ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T15:31:18.357377Z","caller":"traceutil/trace.go:171","msg":"trace[362323820] linearizableReadLoop","detail":"{readStateIndex:1977; appliedIndex:1976; }","duration":"129.732788ms","start":"2026-05-04T15:31:18.2276Z","end":"2026-05-04T15:31:18.357333Z","steps":["trace[362323820] 'read index received'  (duration: 129.713047ms)","trace[362323820] 'applied index is now lower than readState.Index'  (duration: 18.211µs)"],"step_count":2}
{"level":"info","ts":"2026-05-04T15:31:18.357441Z","caller":"traceutil/trace.go:171","msg":"trace[1619451507] transaction","detail":"{read_only:false; response_revision:1904; number_of_response:1; }","duration":"221.214242ms","start":"2026-05-04T15:31:18.136174Z","end":"2026-05-04T15:31:18.357389Z","steps":["trace[1619451507] 'process raft request'  (duration: 220.993084ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:31:18.357615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.994726ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"}
{"level":"info","ts":"2026-05-04T15:31:18.357654Z","caller":"traceutil/trace.go:171","msg":"trace[1760018902] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1904; }","duration":"130.10282ms","start":"2026-05-04T15:31:18.22754Z","end":"2026-05-04T15:31:18.357642Z","steps":["trace[1760018902] 'agreement among raft nodes before linearized reading'  (duration: 129.916144ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T15:31:18.360358Z","caller":"traceutil/trace.go:171","msg":"trace[1166932857] transaction","detail":"{read_only:false; response_revision:1905; number_of_response:1; }","duration":"130.785683ms","start":"2026-05-04T15:31:18.229538Z","end":"2026-05-04T15:31:18.360323Z","steps":["trace[1166932857] 'process raft request'  (duration: 130.600647ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T15:31:21.318152Z","caller":"traceutil/trace.go:171","msg":"trace[243457883] transaction","detail":"{read_only:false; response_revision:1917; number_of_response:1; }","duration":"104.379634ms","start":"2026-05-04T15:31:21.213744Z","end":"2026-05-04T15:31:21.318124Z","steps":["trace[243457883] 'process raft request'  (duration: 104.190747ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T15:31:21.322199Z","caller":"traceutil/trace.go:171","msg":"trace[258951435] transaction","detail":"{read_only:false; response_revision:1918; number_of_response:1; }","duration":"107.560326ms","start":"2026-05-04T15:31:21.214613Z","end":"2026-05-04T15:31:21.322173Z","steps":["trace[258951435] 'process raft request'  (duration: 107.39024ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T15:31:25.548948Z","caller":"traceutil/trace.go:171","msg":"trace[49408811] linearizableReadLoop","detail":"{readStateIndex:2029; appliedIndex:2028; }","duration":"182.356102ms","start":"2026-05-04T15:31:25.366561Z","end":"2026-05-04T15:31:25.548917Z","steps":["trace[49408811] 'read index received'  (duration: 165.023373ms)","trace[49408811] 'applied index is now lower than readState.Index'  (duration: 17.331639ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T15:31:25.549085Z","caller":"traceutil/trace.go:171","msg":"trace[1978639052] transaction","detail":"{read_only:false; response_revision:1955; number_of_response:1; }","duration":"184.32865ms","start":"2026-05-04T15:31:25.36471Z","end":"2026-05-04T15:31:25.549039Z","steps":["trace[1978639052] 'process raft request'  (duration: 166.857177ms)","trace[1978639052] 'compare'  (duration: 17.081789ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-04T15:31:25.549218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.640262ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-05-04T15:31:25.54925Z","caller":"traceutil/trace.go:171","msg":"trace[1860034251] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1955; }","duration":"182.751087ms","start":"2026-05-04T15:31:25.366488Z","end":"2026-05-04T15:31:25.549239Z","steps":["trace[1860034251] 'agreement among raft nodes before linearized reading'  (duration: 182.57439ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T15:31:25.75471Z","caller":"traceutil/trace.go:171","msg":"trace[1109309576] linearizableReadLoop","detail":"{readStateIndex:2030; appliedIndex:2029; }","duration":"205.65989ms","start":"2026-05-04T15:31:25.549022Z","end":"2026-05-04T15:31:25.754681Z","steps":["trace[1109309576] 'read index received'  (duration: 205.481294ms)","trace[1109309576] 'applied index is now lower than readState.Index'  (duration: 177.106µs)"],"step_count":2}
{"level":"info","ts":"2026-05-04T15:31:25.754837Z","caller":"traceutil/trace.go:171","msg":"trace[2103161629] transaction","detail":"{read_only:false; response_revision:1956; number_of_response:1; }","duration":"386.00655ms","start":"2026-05-04T15:31:25.36882Z","end":"2026-05-04T15:31:25.754827Z","steps":["trace[2103161629] 'process raft request'  (duration: 385.69505ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:31:25.755051Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T15:31:25.368805Z","time spent":"386.125165ms","remote":"127.0.0.1:38638","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:1945 > 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-05-04T15:31:25.755168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.259843ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-04T15:31:25.755275Z","caller":"traceutil/trace.go:171","msg":"trace[1371577408] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:1956; }","duration":"275.439779ms","start":"2026-05-04T15:31:25.47981Z","end":"2026-05-04T15:31:25.75525Z","steps":["trace[1371577408] 'agreement among raft nodes before linearized reading'  (duration: 275.240992ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:31:25.755451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"388.00258ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-05-04T15:31:25.755506Z","caller":"traceutil/trace.go:171","msg":"trace[711043684] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1956; }","duration":"388.078573ms","start":"2026-05-04T15:31:25.367417Z","end":"2026-05-04T15:31:25.755496Z","steps":["trace[711043684] 'agreement among raft nodes before linearized reading'  (duration: 387.898226ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:31:25.755532Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T15:31:25.367404Z","time spent":"388.120715ms","remote":"127.0.0.1:38638","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-05-04T15:31:25.75556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"388.763097ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"info","ts":"2026-05-04T15:31:25.755602Z","caller":"traceutil/trace.go:171","msg":"trace[1182442803] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1956; }","duration":"388.81607ms","start":"2026-05-04T15:31:25.366773Z","end":"2026-05-04T15:31:25.755589Z","steps":["trace[1182442803] 'agreement among raft nodes before linearized reading'  (duration: 388.618443ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:31:25.755648Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T15:31:25.366764Z","time spent":"388.871011ms","remote":"127.0.0.1:38638","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-05-04T15:31:25.755659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.030615ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"}
{"level":"info","ts":"2026-05-04T15:31:25.75575Z","caller":"traceutil/trace.go:171","msg":"trace[705990438] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1956; }","duration":"275.17037ms","start":"2026-05-04T15:31:25.480558Z","end":"2026-05-04T15:31:25.755728Z","steps":["trace[705990438] 'agreement among raft nodes before linearized reading'  (duration: 274.810897ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T15:31:25.763123Z","caller":"traceutil/trace.go:171","msg":"trace[442668257] transaction","detail":"{read_only:false; response_revision:1957; number_of_response:1; }","duration":"209.019118ms","start":"2026-05-04T15:31:25.554082Z","end":"2026-05-04T15:31:25.763101Z","steps":["trace[442668257] 'process raft request'  (duration: 208.79808ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:31:25.763234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.871309ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:559"}
{"level":"info","ts":"2026-05-04T15:31:25.763319Z","caller":"traceutil/trace.go:171","msg":"trace[275246839] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:1957; }","duration":"128.001544ms","start":"2026-05-04T15:31:25.635299Z","end":"2026-05-04T15:31:25.763301Z","steps":["trace[275246839] 'agreement among raft nodes before linearized reading'  (duration: 127.816097ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:31:25.763465Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.620111ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rabbitmq-cluster-operator-54f767cff8-8hmqm\" ","response":"range_response_count:1 size:5855"}
{"level":"info","ts":"2026-05-04T15:31:25.763655Z","caller":"traceutil/trace.go:171","msg":"trace[266373245] range","detail":"{range_begin:/registry/pods/openstack/rabbitmq-cluster-operator-54f767cff8-8hmqm; range_end:; response_count:1; response_revision:1957; }","duration":"188.868179ms","start":"2026-05-04T15:31:25.574762Z","end":"2026-05-04T15:31:25.76363Z","steps":["trace[266373245] 'agreement among raft nodes before linearized reading'  (duration: 188.276259ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T15:31:26.362541Z","caller":"traceutil/trace.go:171","msg":"trace[127713600] transaction","detail":"{read_only:false; response_revision:1959; number_of_response:1; }","duration":"601.871244ms","start":"2026-05-04T15:31:25.760634Z","end":"2026-05-04T15:31:26.362506Z","steps":["trace[127713600] 'process raft request'  (duration: 601.741429ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T15:31:26.362663Z","caller":"traceutil/trace.go:171","msg":"trace[1719093199] transaction","detail":"{read_only:false; response_revision:1958; number_of_response:1; }","duration":"601.972966ms","start":"2026-05-04T15:31:25.760531Z","end":"2026-05-04T15:31:26.362504Z","steps":["trace[1719093199] 'process raft request'  (duration: 582.581334ms)","trace[1719093199] 'compare'  (duration: 18.686198ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-04T15:31:26.36274Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T15:31:25.760625Z","time spent":"602.010188ms","remote":"127.0.0.1:38638","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:1947 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"warn","ts":"2026-05-04T15:31:26.362931Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T15:31:25.760503Z","time spent":"602.250266ms","remote":"127.0.0.1:38638","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:1946 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-05-04T15:31:26.437445Z","caller":"traceutil/trace.go:171","msg":"trace[577117632] transaction","detail":"{read_only:false; response_revision:1960; number_of_response:1; }","duration":"668.757696ms","start":"2026-05-04T15:31:25.768652Z","end":"2026-05-04T15:31:26.43741Z","steps":["trace[577117632] 'process raft request'  (duration: 668.504716ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:31:26.437806Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T15:31:25.768644Z","time spent":"668.88157ms","remote":"127.0.0.1:38638","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":544,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" mod_revision:1839 > success:<request_put:<key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" value_size:467 >> failure:<request_range:<key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" > >"}
{"level":"info","ts":"2026-05-04T15:31:26.437816Z","caller":"traceutil/trace.go:171","msg":"trace[713023751] linearizableReadLoop","detail":"{readStateIndex:2036; appliedIndex:2031; }","duration":"481.436511ms","start":"2026-05-04T15:31:25.956355Z","end":"2026-05-04T15:31:26.437792Z","steps":["trace[713023751] 'read index received'  (duration: 386.872164ms)","trace[713023751] 'applied index is now lower than readState.Index'  (duration: 94.562246ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T15:31:26.437902Z","caller":"traceutil/trace.go:171","msg":"trace[1968506253] transaction","detail":"{read_only:false; response_revision:1962; number_of_response:1; }","duration":"573.98667ms","start":"2026-05-04T15:31:25.863895Z","end":"2026-05-04T15:31:26.437881Z","steps":["trace[1968506253] 'process raft request'  (duration: 573.728091ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:31:26.43811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"481.723661ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-04T15:31:26.438166Z","caller":"traceutil/trace.go:171","msg":"trace[367043134] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:1962; }","duration":"481.865805ms","start":"2026-05-04T15:31:25.956284Z","end":"2026-05-04T15:31:26.43815Z","steps":["trace[367043134] 'agreement among raft nodes before linearized reading'  (duration: 481.70887ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:31:26.438205Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T15:31:25.956258Z","time spent":"481.935598ms","remote":"127.0.0.1:47900","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true "}
{"level":"info","ts":"2026-05-04T15:31:26.438397Z","caller":"traceutil/trace.go:171","msg":"trace[821093964] transaction","detail":"{read_only:false; response_revision:1961; number_of_response:1; }","duration":"660.634671ms","start":"2026-05-04T15:31:25.777171Z","end":"2026-05-04T15:31:26.437805Z","steps":["trace[821093964] 'process raft request'  (duration: 660.145614ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:31:26.438685Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T15:31:25.777138Z","time spent":"661.401228ms","remote":"127.0.0.1:38540","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5626,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/openstack/rabbitmq-cluster-operator-54f767cff8-8hmqm\" mod_revision:1676 > success:<request_put:<key:\"/registry/pods/openstack/rabbitmq-cluster-operator-54f767cff8-8hmqm\" value_size:5551 >> failure:<request_range:<key:\"/registry/pods/openstack/rabbitmq-cluster-operator-54f767cff8-8hmqm\" > >"}
{"level":"warn","ts":"2026-05-04T15:31:26.43906Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T15:31:25.863865Z","time spent":"574.079003ms","remote":"127.0.0.1:38638","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" mod_revision:1904 > 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":"warn","ts":"2026-05-04T15:31:26.518068Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.393328ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-05-04T15:31:26.518152Z","caller":"traceutil/trace.go:171","msg":"trace[1887839359] transaction","detail":"{read_only:false; response_revision:1963; number_of_response:1; }","duration":"118.467256ms","start":"2026-05-04T15:31:26.399657Z","end":"2026-05-04T15:31:26.518124Z","steps":["trace[1887839359] 'process raft request'  (duration: 80.067707ms)","trace[1887839359] 'compare'  (duration: 38.045007ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-04T15:31:26.518066Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.232351ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-04T15:31:26.518215Z","caller":"traceutil/trace.go:171","msg":"trace[863030143] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1963; }","duration":"246.445968ms","start":"2026-05-04T15:31:26.271759Z","end":"2026-05-04T15:31:26.518205Z","steps":["trace[863030143] 'agreement among raft nodes before linearized reading'  (duration: 246.20521ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T15:31:26.518164Z","caller":"traceutil/trace.go:171","msg":"trace[1652165992] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; response_count:0; response_revision:1963; }","duration":"285.560234ms","start":"2026-05-04T15:31:26.232584Z","end":"2026-05-04T15:31:26.518145Z","steps":["trace[1652165992] 'agreement among raft nodes before linearized reading'  (duration: 285.383188ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T15:31:26.567596Z","caller":"traceutil/trace.go:171","msg":"trace[480708368] transaction","detail":"{read_only:false; response_revision:1964; number_of_response:1; }","duration":"120.84006ms","start":"2026-05-04T15:31:26.446715Z","end":"2026-05-04T15:31:26.567555Z","steps":["trace[480708368] 'process raft request'  (duration: 120.572141ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T15:31:26.567865Z","caller":"traceutil/trace.go:171","msg":"trace[596444374] transaction","detail":"{read_only:false; response_revision:1965; number_of_response:1; }","duration":"118.790308ms","start":"2026-05-04T15:31:26.449038Z","end":"2026-05-04T15:31:26.567828Z","steps":["trace[596444374] 'process raft request'  (duration: 118.440846ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:31:26.568258Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.27631ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rabbitmq-messaging-topology-operator-6f465c979f-f6k2v\" ","response":"range_response_count:1 size:6144"}
{"level":"info","ts":"2026-05-04T15:31:26.568373Z","caller":"traceutil/trace.go:171","msg":"trace[395983689] range","detail":"{range_begin:/registry/pods/openstack/rabbitmq-messaging-topology-operator-6f465c979f-f6k2v; range_end:; response_count:1; response_revision:1965; }","duration":"124.467708ms","start":"2026-05-04T15:31:26.443846Z","end":"2026-05-04T15:31:26.568314Z","steps":["trace[395983689] 'agreement among raft nodes before linearized reading'  (duration: 124.040753ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T15:31:26.693002Z","caller":"traceutil/trace.go:171","msg":"trace[185720163] transaction","detail":"{read_only:false; response_revision:1966; number_of_response:1; }","duration":"114.598801ms","start":"2026-05-04T15:31:26.578362Z","end":"2026-05-04T15:31:26.692961Z","steps":["trace[185720163] 'process raft request'  (duration: 42.823727ms)","trace[185720163] 'compare'  (duration: 71.490554ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T15:31:26.693263Z","caller":"traceutil/trace.go:171","msg":"trace[1419209957] transaction","detail":"{read_only:false; response_revision:1967; number_of_response:1; }","duration":"112.798637ms","start":"2026-05-04T15:31:26.580425Z","end":"2026-05-04T15:31:26.693224Z","steps":["trace[1419209957] 'process raft request'  (duration: 112.455986ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T15:31:26.846873Z","caller":"traceutil/trace.go:171","msg":"trace[69702781] transaction","detail":"{read_only:false; response_revision:1969; number_of_response:1; }","duration":"143.347202ms","start":"2026-05-04T15:31:26.703488Z","end":"2026-05-04T15:31:26.846835Z","steps":["trace[69702781] 'process raft request'  (duration: 135.671192ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T15:31:26.847272Z","caller":"traceutil/trace.go:171","msg":"trace[2014421785] transaction","detail":"{read_only:false; response_revision:1970; number_of_response:1; }","duration":"143.58543ms","start":"2026-05-04T15:31:26.703658Z","end":"2026-05-04T15:31:26.847244Z","steps":["trace[2014421785] 'process raft request'  (duration: 143.105913ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T15:31:26.84808Z","caller":"traceutil/trace.go:171","msg":"trace[1415526983] transaction","detail":"{read_only:false; response_revision:1971; number_of_response:1; }","duration":"144.009665ms","start":"2026-05-04T15:31:26.704059Z","end":"2026-05-04T15:31:26.848068Z","steps":["trace[1415526983] 'process raft request'  (duration: 143.060102ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:31:29.882927Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13305495818720521638,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-05-04T15:31:30.130451Z","caller":"traceutil/trace.go:171","msg":"trace[1249777189] transaction","detail":"{read_only:false; response_revision:1986; number_of_response:1; }","duration":"758.112085ms","start":"2026-05-04T15:31:29.372307Z","end":"2026-05-04T15:31:30.130419Z","steps":["trace[1249777189] 'process raft request'  (duration: 757.869246ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:31:30.130705Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T15:31:29.372285Z","time spent":"758.26088ms","remote":"127.0.0.1:38638","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:1977 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:465 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"info","ts":"2026-05-04T15:31:30.143753Z","caller":"traceutil/trace.go:171","msg":"trace[1041806558] linearizableReadLoop","detail":"{readStateIndex:2062; appliedIndex:2060; }","duration":"761.574048ms","start":"2026-05-04T15:31:29.38215Z","end":"2026-05-04T15:31:30.143724Z","steps":["trace[1041806558] 'read index received'  (duration: 748.173633ms)","trace[1041806558] 'applied index is now lower than readState.Index'  (duration: 13.398784ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T15:31:30.143915Z","caller":"traceutil/trace.go:171","msg":"trace[366908351] transaction","detail":"{read_only:false; response_revision:1987; number_of_response:1; }","duration":"770.844056ms","start":"2026-05-04T15:31:29.373059Z","end":"2026-05-04T15:31:30.143903Z","steps":["trace[366908351] 'process raft request'  (duration: 770.484823ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:31:30.144014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"585.064614ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"warn","ts":"2026-05-04T15:31:30.144053Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T15:31:29.373053Z","time spent":"770.894158ms","remote":"127.0.0.1:38638","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:1978 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:478 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"info","ts":"2026-05-04T15:31:30.144075Z","caller":"traceutil/trace.go:171","msg":"trace[1270103503] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:1987; }","duration":"585.188228ms","start":"2026-05-04T15:31:29.558869Z","end":"2026-05-04T15:31:30.144057Z","steps":["trace[1270103503] 'agreement among raft nodes before linearized reading'  (duration: 585.069334ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:31:30.14413Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T15:31:29.558841Z","time spent":"585.264641ms","remote":"127.0.0.1:38550","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":15,"response size":30,"request content":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true "}
{"level":"warn","ts":"2026-05-04T15:31:30.144237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.262494ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"}
{"level":"info","ts":"2026-05-04T15:31:30.144327Z","caller":"traceutil/trace.go:171","msg":"trace[1660312472] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1987; }","duration":"271.42143ms","start":"2026-05-04T15:31:29.872885Z","end":"2026-05-04T15:31:30.144306Z","steps":["trace[1660312472] 'agreement among raft nodes before linearized reading'  (duration: 271.197262ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:31:30.144447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"366.68943ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-05-04T15:31:30.144488Z","caller":"traceutil/trace.go:171","msg":"trace[53596871] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1987; }","duration":"366.780863ms","start":"2026-05-04T15:31:29.777696Z","end":"2026-05-04T15:31:30.144477Z","steps":["trace[53596871] 'agreement among raft nodes before linearized reading'  (duration: 366.625848ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:31:30.144522Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T15:31:29.777666Z","time spent":"366.849655ms","remote":"127.0.0.1:38638","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-05-04T15:31:30.144613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"762.47091ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:11989"}
{"level":"info","ts":"2026-05-04T15:31:30.144642Z","caller":"traceutil/trace.go:171","msg":"trace[632708288] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:1987; }","duration":"762.524811ms","start":"2026-05-04T15:31:29.38211Z","end":"2026-05-04T15:31:30.144635Z","steps":["trace[632708288] 'agreement among raft nodes before linearized reading'  (duration: 762.449148ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:31:30.144668Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T15:31:29.382101Z","time spent":"762.557902ms","remote":"127.0.0.1:38540","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12012,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "}
{"level":"warn","ts":"2026-05-04T15:31:30.144691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"576.519282ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"}
{"level":"info","ts":"2026-05-04T15:31:30.144733Z","caller":"traceutil/trace.go:171","msg":"trace[438320438] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1987; }","duration":"576.578045ms","start":"2026-05-04T15:31:29.568143Z","end":"2026-05-04T15:31:30.144721Z","steps":["trace[438320438] 'agreement among raft nodes before linearized reading'  (duration: 576.420369ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:31:30.14481Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T15:31:29.568134Z","time spent":"576.668107ms","remote":"127.0.0.1:38638","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-05-04T15:31:30.145031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"373.157339ms","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-05-04T15:31:30.145096Z","caller":"traceutil/trace.go:171","msg":"trace[522430883] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1987; }","duration":"373.283773ms","start":"2026-05-04T15:31:29.771797Z","end":"2026-05-04T15:31:30.145081Z","steps":["trace[522430883] 'agreement among raft nodes before linearized reading'  (duration: 373.097147ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:31:30.145137Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T15:31:29.771767Z","time spent":"373.361626ms","remote":"127.0.0.1:38638","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-05-04T15:31:30.145107Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.605878ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-05-04T15:31:30.145204Z","caller":"traceutil/trace.go:171","msg":"trace[996529474] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:1987; }","duration":"132.772815ms","start":"2026-05-04T15:31:30.012409Z","end":"2026-05-04T15:31:30.145181Z","steps":["trace[996529474] 'agreement among raft nodes before linearized reading'  (duration: 132.291148ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T15:31:47.34997Z","caller":"traceutil/trace.go:171","msg":"trace[1786873590] transaction","detail":"{read_only:false; response_revision:2088; number_of_response:1; }","duration":"145.194993ms","start":"2026-05-04T15:31:47.204739Z","end":"2026-05-04T15:31:47.349934Z","steps":["trace[1786873590] 'process raft request'  (duration: 144.87745ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T15:31:52.630208Z","caller":"traceutil/trace.go:171","msg":"trace[755128678] transaction","detail":"{read_only:false; response_revision:2116; number_of_response:1; }","duration":"101.945893ms","start":"2026-05-04T15:31:52.528214Z","end":"2026-05-04T15:31:52.630159Z","steps":["trace[755128678] 'process raft request'  (duration: 33.959384ms)","trace[755128678] 'compare'  (duration: 67.860734ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T15:31:53.032176Z","caller":"traceutil/trace.go:171","msg":"trace[183448179] transaction","detail":"{read_only:false; response_revision:2117; number_of_response:1; }","duration":"414.533472ms","start":"2026-05-04T15:31:52.617613Z","end":"2026-05-04T15:31:53.032147Z","steps":["trace[183448179] 'process raft request'  (duration: 414.384897ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:31:53.032359Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T15:31:52.617579Z","time spent":"414.680908ms","remote":"127.0.0.1:38638","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:2107 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:458 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"info","ts":"2026-05-04T15:31:53.147828Z","caller":"traceutil/trace.go:171","msg":"trace[1997592814] linearizableReadLoop","detail":"{readStateIndex:2198; appliedIndex:2196; }","duration":"267.928287ms","start":"2026-05-04T15:31:52.879858Z","end":"2026-05-04T15:31:53.147786Z","steps":["trace[1997592814] 'read index received'  (duration: 152.067568ms)","trace[1997592814] 'applied index is now lower than readState.Index'  (duration: 115.858818ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T15:31:53.147958Z","caller":"traceutil/trace.go:171","msg":"trace[744422939] transaction","detail":"{read_only:false; response_revision:2118; number_of_response:1; }","duration":"313.170536ms","start":"2026-05-04T15:31:52.834744Z","end":"2026-05-04T15:31:53.147914Z","steps":["trace[744422939] 'process raft request'  (duration: 293.316718ms)","trace[744422939] 'compare'  (duration: 19.551287ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-04T15:31:53.148011Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.131334ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-05-04T15:31:53.148058Z","caller":"traceutil/trace.go:171","msg":"trace[2058625190] range","detail":"{range_begin:/registry/certificatesigningrequests/; range_end:/registry/certificatesigningrequests0; response_count:0; response_revision:2118; }","duration":"268.264589ms","start":"2026-05-04T15:31:52.879779Z","end":"2026-05-04T15:31:53.148044Z","steps":["trace[2058625190] 'agreement among raft nodes before linearized reading'  (duration: 268.140884ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:31:53.148177Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T15:31:52.834707Z","time spent":"313.343052ms","remote":"127.0.0.1:38638","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:2066 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:472 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"info","ts":"2026-05-04T15:31:54.740424Z","caller":"traceutil/trace.go:171","msg":"trace[524815097] transaction","detail":"{read_only:false; response_revision:2120; number_of_response:1; }","duration":"500.417932ms","start":"2026-05-04T15:31:54.239979Z","end":"2026-05-04T15:31:54.740397Z","steps":["trace[524815097] 'process raft request'  (duration: 500.239145ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:31:54.740711Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T15:31:54.23994Z","time spent":"500.67398ms","remote":"127.0.0.1:38638","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:2110 > 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":"info","ts":"2026-05-04T15:31:54.789651Z","caller":"traceutil/trace.go:171","msg":"trace[911472524] transaction","detail":"{read_only:false; response_revision:2121; number_of_response:1; }","duration":"544.892173ms","start":"2026-05-04T15:31:54.244731Z","end":"2026-05-04T15:31:54.789623Z","steps":["trace[911472524] 'process raft request'  (duration: 544.682715ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:31:54.789805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"526.337322ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-05-04T15:31:54.789851Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T15:31:54.244702Z","time spent":"545.044638ms","remote":"127.0.0.1:38638","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:2111 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:477 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"info","ts":"2026-05-04T15:31:54.789867Z","caller":"traceutil/trace.go:171","msg":"trace[639345213] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2121; }","duration":"526.450297ms","start":"2026-05-04T15:31:54.263401Z","end":"2026-05-04T15:31:54.789851Z","steps":["trace[639345213] 'agreement among raft nodes before linearized reading'  (duration: 526.333953ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:31:54.790055Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T15:31:54.263387Z","time spent":"526.657924ms","remote":"127.0.0.1:38350","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-05-04T15:31:54.790582Z","caller":"traceutil/trace.go:171","msg":"trace[1865702540] linearizableReadLoop","detail":"{readStateIndex:2201; appliedIndex:2199; }","duration":"526.125755ms","start":"2026-05-04T15:31:54.263446Z","end":"2026-05-04T15:31:54.789572Z","steps":["trace[1865702540] 'read index received'  (duration: 476.878698ms)","trace[1865702540] 'applied index is now lower than readState.Index'  (duration: 49.245137ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-04T15:31:54.790902Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.223206ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-05-04T15:31:54.790952Z","caller":"traceutil/trace.go:171","msg":"trace[67486066] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2121; }","duration":"156.322719ms","start":"2026-05-04T15:31:54.634617Z","end":"2026-05-04T15:31:54.79094Z","steps":["trace[67486066] 'agreement among raft nodes before linearized reading'  (duration: 156.124661ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:31:54.790969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.463818ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"info","ts":"2026-05-04T15:31:54.791195Z","caller":"traceutil/trace.go:171","msg":"trace[2044947941] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2121; }","duration":"249.694177ms","start":"2026-05-04T15:31:54.541489Z","end":"2026-05-04T15:31:54.791183Z","steps":["trace[2044947941] 'agreement among raft nodes before linearized reading'  (duration: 249.314503ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:31:54.791207Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"355.228971ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"}
{"level":"warn","ts":"2026-05-04T15:31:54.791308Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"463.337981ms","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-05-04T15:31:54.791348Z","caller":"traceutil/trace.go:171","msg":"trace[1139118859] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2121; }","duration":"463.392962ms","start":"2026-05-04T15:31:54.327944Z","end":"2026-05-04T15:31:54.791337Z","steps":["trace[1139118859] 'agreement among raft nodes before linearized reading'  (duration: 463.294459ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:31:54.79138Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T15:31:54.327937Z","time spent":"463.436214ms","remote":"127.0.0.1:38638","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-05-04T15:31:54.791596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"381.92757ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:530"}
{"level":"info","ts":"2026-05-04T15:31:54.79163Z","caller":"traceutil/trace.go:171","msg":"trace[1714278075] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:2121; }","duration":"382.035424ms","start":"2026-05-04T15:31:54.409585Z","end":"2026-05-04T15:31:54.791621Z","steps":["trace[1714278075] 'agreement among raft nodes before linearized reading'  (duration: 381.92714ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:31:54.791653Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T15:31:54.40957Z","time spent":"382.076596ms","remote":"127.0.0.1:38638","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":553,"request content":"key:\"/registry/leases/cert-manager/cert-manager-controller\" "}
{"level":"warn","ts":"2026-05-04T15:31:54.791741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"463.981264ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"}
{"level":"warn","ts":"2026-05-04T15:31:54.791812Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"482.755362ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/percona-xtradb-haproxy-0.18ac668ad11a7a45\" ","response":"range_response_count:1 size:846"}
{"level":"info","ts":"2026-05-04T15:31:54.791862Z","caller":"traceutil/trace.go:171","msg":"trace[1836880562] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2121; }","duration":"464.16054ms","start":"2026-05-04T15:31:54.327678Z","end":"2026-05-04T15:31:54.791839Z","steps":["trace[1836880562] 'agreement among raft nodes before linearized reading'  (duration: 463.778256ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:31:54.791937Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T15:31:54.327657Z","time spent":"464.268044ms","remote":"127.0.0.1:38638","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-05-04T15:31:54.791941Z","caller":"traceutil/trace.go:171","msg":"trace[1815490609] range","detail":"{range_begin:/registry/events/openstack/percona-xtradb-haproxy-0.18ac668ad11a7a45; range_end:; response_count:1; response_revision:2121; }","duration":"482.95191ms","start":"2026-05-04T15:31:54.308959Z","end":"2026-05-04T15:31:54.791911Z","steps":["trace[1815490609] 'agreement among raft nodes before linearized reading'  (duration: 481.719875ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:31:54.792001Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T15:31:54.308938Z","time spent":"483.051003ms","remote":"127.0.0.1:38420","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":869,"request content":"key:\"/registry/events/openstack/percona-xtradb-haproxy-0.18ac668ad11a7a45\" "}
{"level":"warn","ts":"2026-05-04T15:31:54.792137Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"464.488932ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-05-04T15:31:54.792241Z","caller":"traceutil/trace.go:171","msg":"trace[435894982] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2121; }","duration":"355.46946ms","start":"2026-05-04T15:31:54.435866Z","end":"2026-05-04T15:31:54.791336Z","steps":["trace[435894982] 'agreement among raft nodes before linearized reading'  (duration: 354.852548ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T15:31:54.792274Z","caller":"traceutil/trace.go:171","msg":"trace[1260353697] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2121; }","duration":"464.71639ms","start":"2026-05-04T15:31:54.327529Z","end":"2026-05-04T15:31:54.792245Z","steps":["trace[1260353697] 'agreement among raft nodes before linearized reading'  (duration: 464.020935ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:31:54.792406Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T15:31:54.327437Z","time spent":"464.953139ms","remote":"127.0.0.1:38638","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-05-04T15:31:54.79236Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T15:31:54.435856Z","time spent":"356.483377ms","remote":"127.0.0.1:41160","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "}
{"level":"info","ts":"2026-05-04T15:31:54.921274Z","caller":"traceutil/trace.go:171","msg":"trace[810509395] transaction","detail":"{read_only:false; response_revision:2122; number_of_response:1; }","duration":"124.982318ms","start":"2026-05-04T15:31:54.796257Z","end":"2026-05-04T15:31:54.921239Z","steps":["trace[810509395] 'process raft request'  (duration: 124.778351ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T15:31:55.013966Z","caller":"traceutil/trace.go:171","msg":"trace[695787307] transaction","detail":"{read_only:false; response_revision:2123; number_of_response:1; }","duration":"217.654221ms","start":"2026-05-04T15:31:54.796263Z","end":"2026-05-04T15:31:55.013918Z","steps":["trace[695787307] 'process raft request'  (duration: 217.345769ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T15:31:55.014568Z","caller":"traceutil/trace.go:171","msg":"trace[1523804600] transaction","detail":"{read_only:false; response_revision:2128; number_of_response:1; }","duration":"214.938892ms","start":"2026-05-04T15:31:54.799591Z","end":"2026-05-04T15:31:55.01453Z","steps":["trace[1523804600] 'process raft request'  (duration: 214.863489ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T15:31:55.014616Z","caller":"traceutil/trace.go:171","msg":"trace[1555787195] transaction","detail":"{read_only:false; response_revision:2124; number_of_response:1; }","duration":"218.110248ms","start":"2026-05-04T15:31:54.796474Z","end":"2026-05-04T15:31:55.014585Z","steps":["trace[1555787195] 'process raft request'  (duration: 217.351799ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T15:31:55.014825Z","caller":"traceutil/trace.go:171","msg":"trace[1145835190] transaction","detail":"{read_only:false; response_revision:2127; number_of_response:1; }","duration":"216.473408ms","start":"2026-05-04T15:31:54.798341Z","end":"2026-05-04T15:31:55.014815Z","steps":["trace[1145835190] 'process raft request'  (duration: 216.070543ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T15:31:55.01481Z","caller":"traceutil/trace.go:171","msg":"trace[249282588] transaction","detail":"{read_only:false; response_revision:2126; number_of_response:1; }","duration":"216.482989ms","start":"2026-05-04T15:31:54.798262Z","end":"2026-05-04T15:31:55.014745Z","steps":["trace[249282588] 'process raft request'  (duration: 216.107554ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T15:31:55.014976Z","caller":"traceutil/trace.go:171","msg":"trace[1185169577] transaction","detail":"{read_only:false; response_revision:2125; number_of_response:1; }","duration":"217.551458ms","start":"2026-05-04T15:31:54.797355Z","end":"2026-05-04T15:31:55.014907Z","steps":["trace[1185169577] 'process raft request'  (duration: 216.833561ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:31:55.763559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"396.799065ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-05-04T15:31:55.764075Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"393.474161ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13305495818720521975 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:2117 > 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\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-04T15:31:55.76431Z","caller":"traceutil/trace.go:171","msg":"trace[1569962243] transaction","detail":"{read_only:false; response_revision:2129; number_of_response:1; }","duration":"723.891476ms","start":"2026-05-04T15:31:55.040397Z","end":"2026-05-04T15:31:55.764288Z","steps":["trace[1569962243] 'process raft request'  (duration: 329.955147ms)","trace[1569962243] 'compare'  (duration: 392.531267ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T15:31:55.763855Z","caller":"traceutil/trace.go:171","msg":"trace[591658747] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:2128; }","duration":"397.110166ms","start":"2026-05-04T15:31:55.366723Z","end":"2026-05-04T15:31:55.763833Z","steps":["trace[591658747] 'range keys from in-memory index tree'  (duration: 396.779694ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T15:31:55.764529Z","caller":"traceutil/trace.go:171","msg":"trace[1136720039] transaction","detail":"{read_only:false; response_revision:2130; number_of_response:1; }","duration":"329.560442ms","start":"2026-05-04T15:31:55.434743Z","end":"2026-05-04T15:31:55.764304Z","steps":["trace[1136720039] 'process raft request'  (duration: 329.481339ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:31:55.764673Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T15:31:55.434718Z","time spent":"329.900325ms","remote":"127.0.0.1:38638","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:2119 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"info","ts":"2026-05-04T15:31:55.764812Z","caller":"traceutil/trace.go:171","msg":"trace[1882778553] linearizableReadLoop","detail":"{readStateIndex:2209; appliedIndex:2208; }","duration":"498.522653ms","start":"2026-05-04T15:31:55.265811Z","end":"2026-05-04T15:31:55.764334Z","steps":["trace[1882778553] 'read index received'  (duration: 104.433649ms)","trace[1882778553] 'applied index is now lower than readState.Index'  (duration: 394.082634ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-04T15:31:55.765103Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"441.073321ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/servicenodeports\" ","response":"range_response_count:1 size:118"}
{"level":"info","ts":"2026-05-04T15:31:55.765398Z","caller":"traceutil/trace.go:171","msg":"trace[408950695] range","detail":"{range_begin:/registry/ranges/servicenodeports; range_end:; response_count:1; response_revision:2130; }","duration":"441.429925ms","start":"2026-05-04T15:31:55.323929Z","end":"2026-05-04T15:31:55.765359Z","steps":["trace[408950695] 'agreement among raft nodes before linearized reading'  (duration: 441.039779ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:31:55.765484Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T15:31:55.323883Z","time spent":"441.589381ms","remote":"127.0.0.1:38416","response type":"/etcdserverpb.KV/Range","request count":0,"request size":35,"response count":1,"response size":141,"request content":"key:\"/registry/ranges/servicenodeports\" "}
{"level":"warn","ts":"2026-05-04T15:31:55.76579Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"417.384651ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12386"}
{"level":"info","ts":"2026-05-04T15:31:55.766277Z","caller":"traceutil/trace.go:171","msg":"trace[746729389] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2130; }","duration":"417.868639ms","start":"2026-05-04T15:31:55.34834Z","end":"2026-05-04T15:31:55.766209Z","steps":["trace[746729389] 'agreement among raft nodes before linearized reading'  (duration: 417.192954ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:31:55.76638Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T15:31:55.040355Z","time spent":"724.203357ms","remote":"127.0.0.1:38638","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:2117 > 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-05-04T15:31:55.766459Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T15:31:55.34833Z","time spent":"418.045065ms","remote":"127.0.0.1:38540","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12409,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "}
{"level":"warn","ts":"2026-05-04T15:31:55.766029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"498.899576ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-04T15:31:55.766655Z","caller":"traceutil/trace.go:171","msg":"trace[1597496765] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2130; }","duration":"500.854449ms","start":"2026-05-04T15:31:55.26576Z","end":"2026-05-04T15:31:55.766615Z","steps":["trace[1597496765] 'agreement among raft nodes before linearized reading'  (duration: 498.889727ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:31:55.766762Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T15:31:55.265736Z","time spent":"501.010704ms","remote":"127.0.0.1:38350","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-05-04T15:31:56.502255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.806674ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-04T15:31:56.502403Z","caller":"traceutil/trace.go:171","msg":"trace[859326846] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2130; }","duration":"237.003692ms","start":"2026-05-04T15:31:56.265363Z","end":"2026-05-04T15:31:56.502367Z","steps":["trace[859326846] 'range keys from in-memory index tree'  (duration: 236.70614ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T15:31:56.954039Z","caller":"traceutil/trace.go:171","msg":"trace[1060332252] transaction","detail":"{read_only:false; response_revision:2133; number_of_response:1; }","duration":"207.223385ms","start":"2026-05-04T15:31:56.746798Z","end":"2026-05-04T15:31:56.954022Z","steps":["trace[1060332252] 'process raft request'  (duration: 207.06874ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T15:31:56.955513Z","caller":"traceutil/trace.go:171","msg":"trace[344765537] linearizableReadLoop","detail":"{readStateIndex:2214; appliedIndex:2213; }","duration":"144.873561ms","start":"2026-05-04T15:31:56.810609Z","end":"2026-05-04T15:31:56.955483Z","steps":["trace[344765537] 'read index received'  (duration: 143.463779ms)","trace[344765537] 'applied index is now lower than readState.Index'  (duration: 1.408611ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T15:31:56.955592Z","caller":"traceutil/trace.go:171","msg":"trace[1063306341] transaction","detail":"{read_only:false; response_revision:2134; number_of_response:1; }","duration":"158.591465ms","start":"2026-05-04T15:31:56.796958Z","end":"2026-05-04T15:31:56.95555Z","steps":["trace[1063306341] 'process raft request'  (duration: 158.366517ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:31:56.955752Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.128939ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"}
{"level":"info","ts":"2026-05-04T15:31:56.955791Z","caller":"traceutil/trace.go:171","msg":"trace[476958406] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2134; }","duration":"145.234613ms","start":"2026-05-04T15:31:56.810546Z","end":"2026-05-04T15:31:56.955781Z","steps":["trace[476958406] 'agreement among raft nodes before linearized reading'  (duration: 145.081768ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:31:56.956559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.407343ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.210\" ","response":"range_response_count:1 size:135"}
{"level":"info","ts":"2026-05-04T15:31:56.956621Z","caller":"traceutil/trace.go:171","msg":"trace[576660678] range","detail":"{range_begin:/registry/masterleases/199.204.45.210; range_end:; response_count:1; response_revision:2134; }","duration":"107.537837ms","start":"2026-05-04T15:31:56.849068Z","end":"2026-05-04T15:31:56.956606Z","steps":["trace[576660678] 'agreement among raft nodes before linearized reading'  (duration: 106.589212ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T15:32:34.574947Z","caller":"traceutil/trace.go:171","msg":"trace[727373936] transaction","detail":"{read_only:false; response_revision:2391; number_of_response:1; }","duration":"119.121227ms","start":"2026-05-04T15:32:34.455792Z","end":"2026-05-04T15:32:34.574913Z","steps":["trace[727373936] 'process raft request'  (duration: 27.488584ms)","trace[727373936] 'compare'  (duration: 91.488698ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T15:32:34.575199Z","caller":"traceutil/trace.go:171","msg":"trace[2122602146] transaction","detail":"{read_only:false; response_revision:2392; number_of_response:1; }","duration":"119.312724ms","start":"2026-05-04T15:32:34.455858Z","end":"2026-05-04T15:32:34.57517Z","steps":["trace[2122602146] 'process raft request'  (duration: 119.124467ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T15:32:34.575353Z","caller":"traceutil/trace.go:171","msg":"trace[1313786208] transaction","detail":"{read_only:false; response_revision:2393; number_of_response:1; }","duration":"118.611667ms","start":"2026-05-04T15:32:34.456729Z","end":"2026-05-04T15:32:34.575341Z","steps":["trace[1313786208] 'process raft request'  (duration: 118.389709ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T15:32:34.575372Z","caller":"traceutil/trace.go:171","msg":"trace[1585681504] transaction","detail":"{read_only:false; response_revision:2394; number_of_response:1; }","duration":"118.075577ms","start":"2026-05-04T15:32:34.457285Z","end":"2026-05-04T15:32:34.575361Z","steps":["trace[1585681504] 'process raft request'  (duration: 117.979743ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:32:43.699538Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13305495818720522786,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-05-04T15:32:43.970394Z","caller":"traceutil/trace.go:171","msg":"trace[277189272] linearizableReadLoop","detail":"{readStateIndex:2585; appliedIndex:2584; }","duration":"772.201852ms","start":"2026-05-04T15:32:43.198162Z","end":"2026-05-04T15:32:43.970363Z","steps":["trace[277189272] 'read index received'  (duration: 771.958432ms)","trace[277189272] 'applied index is now lower than readState.Index'  (duration: 242.22µs)"],"step_count":2}
{"level":"info","ts":"2026-05-04T15:32:43.970466Z","caller":"traceutil/trace.go:171","msg":"trace[1743767651] transaction","detail":"{read_only:false; response_revision:2493; number_of_response:1; }","duration":"784.19243ms","start":"2026-05-04T15:32:43.186227Z","end":"2026-05-04T15:32:43.97042Z","steps":["trace[1743767651] 'process raft request'  (duration: 783.987472ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:32:43.970622Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T15:32:43.18621Z","time spent":"784.327645ms","remote":"127.0.0.1:38638","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:2475 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-05-04T15:32:43.970671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"772.502273ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"}
{"level":"info","ts":"2026-05-04T15:32:43.970995Z","caller":"traceutil/trace.go:171","msg":"trace[333551718] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2493; }","duration":"772.878348ms","start":"2026-05-04T15:32:43.198098Z","end":"2026-05-04T15:32:43.970977Z","steps":["trace[333551718] 'agreement among raft nodes before linearized reading'  (duration: 772.420631ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:32:43.970942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"396.000428ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"}
{"level":"warn","ts":"2026-05-04T15:32:43.971035Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T15:32:43.198078Z","time spent":"772.948531ms","remote":"127.0.0.1:38550","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":1392,"request content":"key:\"/registry/services/specs/auth-system/keycloak-headless\" "}
{"level":"warn","ts":"2026-05-04T15:32:43.971001Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"707.123325ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"}
{"level":"info","ts":"2026-05-04T15:32:43.971073Z","caller":"traceutil/trace.go:171","msg":"trace[2074058373] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2493; }","duration":"396.224608ms","start":"2026-05-04T15:32:43.574821Z","end":"2026-05-04T15:32:43.971046Z","steps":["trace[2074058373] 'agreement among raft nodes before linearized reading'  (duration: 395.862794ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:32:43.970742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"706.258922ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-04T15:32:43.971109Z","caller":"traceutil/trace.go:171","msg":"trace[2092446211] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2493; }","duration":"707.276171ms","start":"2026-05-04T15:32:43.263808Z","end":"2026-05-04T15:32:43.971084Z","steps":["trace[2092446211] 'agreement among raft nodes before linearized reading'  (duration: 706.951179ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:32:43.971141Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T15:32:43.574775Z","time spent":"396.351643ms","remote":"127.0.0.1:38540","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12239,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "}
{"level":"warn","ts":"2026-05-04T15:32:43.971169Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T15:32:43.263801Z","time spent":"707.358334ms","remote":"127.0.0.1:38638","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-05-04T15:32:43.971201Z","caller":"traceutil/trace.go:171","msg":"trace[503157154] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2493; }","duration":"706.715409ms","start":"2026-05-04T15:32:43.264434Z","end":"2026-05-04T15:32:43.971149Z","steps":["trace[503157154] 'agreement among raft nodes before linearized reading'  (duration: 706.275813ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:32:43.971348Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T15:32:43.264423Z","time spent":"706.877905ms","remote":"127.0.0.1:38350","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-05-04T15:32:43.970828Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"701.169968ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"}
{"level":"info","ts":"2026-05-04T15:32:43.971489Z","caller":"traceutil/trace.go:171","msg":"trace[341403136] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2493; }","duration":"701.823813ms","start":"2026-05-04T15:32:43.269648Z","end":"2026-05-04T15:32:43.971472Z","steps":["trace[341403136] 'agreement among raft nodes before linearized reading'  (duration: 701.017852ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:32:43.971546Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T15:32:43.269618Z","time spent":"701.910746ms","remote":"127.0.0.1:38638","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-05-04T15:32:43.970822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"702.25379ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"info","ts":"2026-05-04T15:32:43.97163Z","caller":"traceutil/trace.go:171","msg":"trace[2059511036] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2493; }","duration":"703.05504ms","start":"2026-05-04T15:32:43.26856Z","end":"2026-05-04T15:32:43.971615Z","steps":["trace[2059511036] 'agreement among raft nodes before linearized reading'  (duration: 702.201258ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:32:43.971676Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T15:32:43.268526Z","time spent":"703.138173ms","remote":"127.0.0.1:38638","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-05-04T15:32:43.970877Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"647.693845ms","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-05-04T15:32:43.97193Z","caller":"traceutil/trace.go:171","msg":"trace[43282316] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:2493; }","duration":"648.790886ms","start":"2026-05-04T15:32:43.323122Z","end":"2026-05-04T15:32:43.971913Z","steps":["trace[43282316] 'agreement among raft nodes before linearized reading'  (duration: 647.729776ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:32:43.971981Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T15:32:43.323108Z","time spent":"648.855269ms","remote":"127.0.0.1:47672","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true "}
{"level":"warn","ts":"2026-05-04T15:32:43.970826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"707.127725ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"}
{"level":"info","ts":"2026-05-04T15:32:43.972206Z","caller":"traceutil/trace.go:171","msg":"trace[1671235655] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2493; }","duration":"708.581481ms","start":"2026-05-04T15:32:43.263612Z","end":"2026-05-04T15:32:43.972194Z","steps":["trace[1671235655] 'agreement among raft nodes before linearized reading'  (duration: 707.027701ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:32:43.97225Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T15:32:43.263592Z","time spent":"708.647484ms","remote":"127.0.0.1:38638","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-05-04T15:33:16.444346Z","caller":"traceutil/trace.go:171","msg":"trace[1790086818] linearizableReadLoop","detail":"{readStateIndex:2769; appliedIndex:2768; }","duration":"272.5704ms","start":"2026-05-04T15:33:16.171684Z","end":"2026-05-04T15:33:16.444254Z","steps":["trace[1790086818] 'read index received'  (duration: 272.300129ms)","trace[1790086818] 'applied index is now lower than readState.Index'  (duration: 269.081µs)"],"step_count":2}
{"level":"info","ts":"2026-05-04T15:33:16.444497Z","caller":"traceutil/trace.go:171","msg":"trace[441297741] transaction","detail":"{read_only:false; response_revision:2670; number_of_response:1; }","duration":"284.50731ms","start":"2026-05-04T15:33:16.159786Z","end":"2026-05-04T15:33:16.444294Z","steps":["trace[441297741] 'process raft request'  (duration: 284.287619ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:33:16.444592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.836901ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"}
{"level":"info","ts":"2026-05-04T15:33:16.444687Z","caller":"traceutil/trace.go:171","msg":"trace[2137618580] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2670; }","duration":"273.043921ms","start":"2026-05-04T15:33:16.171628Z","end":"2026-05-04T15:33:16.444672Z","steps":["trace[2137618580] 'agreement among raft nodes before linearized reading'  (duration: 272.74353ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:33:16.468281Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.053553ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-05-04T15:33:16.468348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.552322ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"warn","ts":"2026-05-04T15:33:16.468297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.489507ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"}
{"level":"info","ts":"2026-05-04T15:33:16.468368Z","caller":"traceutil/trace.go:171","msg":"trace[31982963] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2671; }","duration":"293.587107ms","start":"2026-05-04T15:33:16.174777Z","end":"2026-05-04T15:33:16.468364Z","steps":["trace[31982963] 'agreement among raft nodes before linearized reading'  (duration: 293.385116ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T15:33:16.468406Z","caller":"traceutil/trace.go:171","msg":"trace[2068256261] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2671; }","duration":"287.572172ms","start":"2026-05-04T15:33:16.180791Z","end":"2026-05-04T15:33:16.468363Z","steps":["trace[2068256261] 'agreement among raft nodes before linearized reading'  (duration: 287.525462ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:33:16.468511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.742453ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"}
{"level":"info","ts":"2026-05-04T15:33:16.468529Z","caller":"traceutil/trace.go:171","msg":"trace[264905637] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2671; }","duration":"287.819953ms","start":"2026-05-04T15:33:16.180705Z","end":"2026-05-04T15:33:16.468525Z","steps":["trace[264905637] 'agreement among raft nodes before linearized reading'  (duration: 287.755493ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:33:16.468617Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.027634ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-05-04T15:33:16.468652Z","caller":"traceutil/trace.go:171","msg":"trace[1861245359] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2671; }","duration":"288.094514ms","start":"2026-05-04T15:33:16.180554Z","end":"2026-05-04T15:33:16.468648Z","steps":["trace[1861245359] 'agreement among raft nodes before linearized reading'  (duration: 288.030804ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T15:33:16.468697Z","caller":"traceutil/trace.go:171","msg":"trace[1871876571] transaction","detail":"{read_only:false; response_revision:2671; number_of_response:1; }","duration":"277.126799ms","start":"2026-05-04T15:33:16.191563Z","end":"2026-05-04T15:33:16.46869Z","steps":["trace[1871876571] 'process raft request'  (duration: 276.469096ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T15:33:16.468348Z","caller":"traceutil/trace.go:171","msg":"trace[1366137164] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2671; }","duration":"203.162423ms","start":"2026-05-04T15:33:16.265171Z","end":"2026-05-04T15:33:16.468333Z","steps":["trace[1366137164] 'agreement among raft nodes before linearized reading'  (duration: 203.035163ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:33:17.913455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.007091516s","expected-duration":"100ms","prefix":"","request":"header:<ID:13305495818720523284 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/auth-system/keycloak-0.18ac669cc8be246b\" mod_revision:2647 > success:<request_put:<key:\"/registry/events/auth-system/keycloak-0.18ac669cc8be246b\" value_size:692 lease:4082123781865747326 >> failure:<request_range:<key:\"/registry/events/auth-system/keycloak-0.18ac669cc8be246b\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-04T15:33:17.913584Z","caller":"traceutil/trace.go:171","msg":"trace[1108910583] linearizableReadLoop","detail":"{readStateIndex:2776; appliedIndex:2775; }","duration":"1.060253386s","start":"2026-05-04T15:33:16.853312Z","end":"2026-05-04T15:33:17.913566Z","steps":["trace[1108910583] 'read index received'  (duration: 52.820599ms)","trace[1108910583] 'applied index is now lower than readState.Index'  (duration: 1.007430997s)"],"step_count":2}
{"level":"info","ts":"2026-05-04T15:33:17.913644Z","caller":"traceutil/trace.go:171","msg":"trace[1460384397] transaction","detail":"{read_only:false; response_revision:2677; number_of_response:1; }","duration":"1.341883614s","start":"2026-05-04T15:33:16.57171Z","end":"2026-05-04T15:33:17.913593Z","steps":["trace[1460384397] 'process raft request'  (duration: 334.551517ms)","trace[1460384397] 'compare'  (duration: 1.006735535s)"],"step_count":2}
{"level":"warn","ts":"2026-05-04T15:33:17.913827Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T15:33:16.571688Z","time spent":"1.342035817s","remote":"127.0.0.1:38420","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":766,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/events/auth-system/keycloak-0.18ac669cc8be246b\" mod_revision:2647 > success:<request_put:<key:\"/registry/events/auth-system/keycloak-0.18ac669cc8be246b\" value_size:692 lease:4082123781865747326 >> failure:<request_range:<key:\"/registry/events/auth-system/keycloak-0.18ac669cc8be246b\" > >"}
{"level":"warn","ts":"2026-05-04T15:33:17.913878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.060570868s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.210\" ","response":"range_response_count:1 size:135"}
{"level":"info","ts":"2026-05-04T15:33:17.913908Z","caller":"traceutil/trace.go:171","msg":"trace[1020955007] range","detail":"{range_begin:/registry/masterleases/199.204.45.210; range_end:; response_count:1; response_revision:2677; }","duration":"1.060639779s","start":"2026-05-04T15:33:16.853258Z","end":"2026-05-04T15:33:17.913898Z","steps":["trace[1020955007] 'agreement among raft nodes before linearized reading'  (duration: 1.060388428s)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:33:17.913952Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T15:33:16.853235Z","time spent":"1.060708679s","remote":"127.0.0.1:38380","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.204.45.210\" "}
{"level":"info","ts":"2026-05-04T15:33:18.009938Z","caller":"traceutil/trace.go:171","msg":"trace[924093901] transaction","detail":"{read_only:false; response_revision:2678; number_of_response:1; }","duration":"727.862986ms","start":"2026-05-04T15:33:17.282041Z","end":"2026-05-04T15:33:18.009904Z","steps":["trace[924093901] 'process raft request'  (duration: 727.648735ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:33:18.010248Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T15:33:17.281391Z","time spent":"728.648539ms","remote":"127.0.0.1:38638","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:2668 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:478 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-05-04T15:33:18.164364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.434776ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13305495818720523286 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:2669 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:465 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-04T15:33:18.164665Z","caller":"traceutil/trace.go:171","msg":"trace[12764134] linearizableReadLoop","detail":"{readStateIndex:2778; appliedIndex:2776; }","duration":"251.030671ms","start":"2026-05-04T15:33:17.913613Z","end":"2026-05-04T15:33:18.164643Z","steps":["trace[12764134] 'read index received'  (duration: 96.116224ms)","trace[12764134] 'applied index is now lower than readState.Index'  (duration: 154.912537ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-04T15:33:18.164855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"965.112224ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"}
{"level":"info","ts":"2026-05-04T15:33:18.164833Z","caller":"traceutil/trace.go:171","msg":"trace[232138941] transaction","detail":"{read_only:false; response_revision:2679; number_of_response:1; }","duration":"872.90994ms","start":"2026-05-04T15:33:17.291801Z","end":"2026-05-04T15:33:18.164711Z","steps":["trace[232138941] 'process raft request'  (duration: 731.029282ms)","trace[232138941] 'compare'  (duration: 141.289755ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T15:33:18.164894Z","caller":"traceutil/trace.go:171","msg":"trace[1566645255] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2679; }","duration":"965.203075ms","start":"2026-05-04T15:33:17.199679Z","end":"2026-05-04T15:33:18.164882Z","steps":["trace[1566645255] 'agreement among raft nodes before linearized reading'  (duration: 965.030905ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:33:18.164939Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T15:33:17.199652Z","time spent":"965.278336ms","remote":"127.0.0.1:38550","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":1392,"request content":"key:\"/registry/services/specs/auth-system/keycloak-headless\" "}
{"level":"warn","ts":"2026-05-04T15:33:18.165032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"431.727704ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-05-04T15:33:18.1652Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T15:33:17.291775Z","time spent":"873.248351ms","remote":"127.0.0.1:38638","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:2669 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:465 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"info","ts":"2026-05-04T15:33:18.165175Z","caller":"traceutil/trace.go:171","msg":"trace[290592194] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:2679; }","duration":"432.055056ms","start":"2026-05-04T15:33:17.733087Z","end":"2026-05-04T15:33:18.165142Z","steps":["trace[290592194] 'agreement among raft nodes before linearized reading'  (duration: 431.659994ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:33:18.16542Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T15:33:17.733058Z","time spent":"432.347647ms","remote":"127.0.0.1:38672","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":28,"request content":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true "}
{"level":"info","ts":"2026-05-04T15:33:38.703552Z","caller":"traceutil/trace.go:171","msg":"trace[873533865] linearizableReadLoop","detail":"{readStateIndex:2891; appliedIndex:2890; }","duration":"106.814781ms","start":"2026-05-04T15:33:38.596717Z","end":"2026-05-04T15:33:38.703532Z","steps":["trace[873533865] 'read index received'  (duration: 47.796254ms)","trace[873533865] 'applied index is now lower than readState.Index'  (duration: 59.017547ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T15:33:38.703838Z","caller":"traceutil/trace.go:171","msg":"trace[48029136] transaction","detail":"{read_only:false; response_revision:2787; number_of_response:1; }","duration":"146.23992ms","start":"2026-05-04T15:33:38.557582Z","end":"2026-05-04T15:33:38.703822Z","steps":["trace[48029136] 'process raft request'  (duration: 130.156523ms)","trace[48029136] 'compare'  (duration: 15.523482ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-04T15:33:38.704382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.641218ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-05-04T15:33:38.704474Z","caller":"traceutil/trace.go:171","msg":"trace[208119409] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2787; }","duration":"107.78545ms","start":"2026-05-04T15:33:38.596665Z","end":"2026-05-04T15:33:38.70445Z","steps":["trace[208119409] 'agreement among raft nodes before linearized reading'  (duration: 107.453887ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T15:33:43.149957Z","caller":"traceutil/trace.go:171","msg":"trace[1982955921] transaction","detail":"{read_only:false; response_revision:2815; number_of_response:1; }","duration":"201.392023ms","start":"2026-05-04T15:33:42.948537Z","end":"2026-05-04T15:33:43.149929Z","steps":["trace[1982955921] 'process raft request'  (duration: 201.10893ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T15:37:14.067118Z","caller":"traceutil/trace.go:171","msg":"trace[892715083] transaction","detail":"{read_only:false; response_revision:4469; number_of_response:1; }","duration":"110.538065ms","start":"2026-05-04T15:37:13.956556Z","end":"2026-05-04T15:37:14.067094Z","steps":["trace[892715083] 'process raft request'  (duration: 110.409511ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T15:37:14.101161Z","caller":"traceutil/trace.go:171","msg":"trace[581577785] transaction","detail":"{read_only:false; response_revision:4471; number_of_response:1; }","duration":"142.752438ms","start":"2026-05-04T15:37:13.958369Z","end":"2026-05-04T15:37:14.101121Z","steps":["trace[581577785] 'process raft request'  (duration: 142.180981ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T15:37:14.101214Z","caller":"traceutil/trace.go:171","msg":"trace[1323729313] transaction","detail":"{read_only:false; response_revision:4472; number_of_response:1; }","duration":"138.400695ms","start":"2026-05-04T15:37:13.962783Z","end":"2026-05-04T15:37:14.101183Z","steps":["trace[1323729313] 'process raft request'  (duration: 137.809637ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T15:37:14.101429Z","caller":"traceutil/trace.go:171","msg":"trace[1753367764] transaction","detail":"{read_only:false; response_revision:4470; number_of_response:1; }","duration":"143.13742ms","start":"2026-05-04T15:37:13.958279Z","end":"2026-05-04T15:37:14.101417Z","steps":["trace[1753367764] 'process raft request'  (duration: 142.127759ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T15:37:16.867688Z","caller":"traceutil/trace.go:171","msg":"trace[1186914159] transaction","detail":"{read_only:false; response_revision:4569; number_of_response:1; }","duration":"133.401294ms","start":"2026-05-04T15:37:16.734268Z","end":"2026-05-04T15:37:16.86767Z","steps":["trace[1186914159] 'process raft request'  (duration: 133.263799ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T15:37:16.875774Z","caller":"traceutil/trace.go:171","msg":"trace[1283944088] linearizableReadLoop","detail":"{readStateIndex:4744; appliedIndex:4742; }","duration":"120.006633ms","start":"2026-05-04T15:37:16.755755Z","end":"2026-05-04T15:37:16.875762Z","steps":["trace[1283944088] 'read index received'  (duration: 111.698639ms)","trace[1283944088] 'applied index is now lower than readState.Index'  (duration: 8.307614ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T15:37:16.876018Z","caller":"traceutil/trace.go:171","msg":"trace[1241603819] transaction","detail":"{read_only:false; response_revision:4570; number_of_response:1; }","duration":"141.13574ms","start":"2026-05-04T15:37:16.734862Z","end":"2026-05-04T15:37:16.875998Z","steps":["trace[1241603819] 'process raft request'  (duration: 140.784919ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:37:16.876491Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.721555ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-f7508633-c668-4039-9194-a2a1be5e15c9\" ","response":"range_response_count:1 size:3774"}
{"level":"info","ts":"2026-05-04T15:37:16.876529Z","caller":"traceutil/trace.go:171","msg":"trace[282415252] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-f7508633-c668-4039-9194-a2a1be5e15c9; range_end:; response_count:1; response_revision:4571; }","duration":"120.813078ms","start":"2026-05-04T15:37:16.755706Z","end":"2026-05-04T15:37:16.876519Z","steps":["trace[282415252] 'agreement among raft nodes before linearized reading'  (duration: 120.670843ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T15:37:17.101521Z","caller":"traceutil/trace.go:171","msg":"trace[1468077033] transaction","detail":"{read_only:false; response_revision:4572; number_of_response:1; }","duration":"218.753061ms","start":"2026-05-04T15:37:16.882739Z","end":"2026-05-04T15:37:17.101492Z","steps":["trace[1468077033] 'process raft request'  (duration: 218.589046ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T15:37:17.108149Z","caller":"traceutil/trace.go:171","msg":"trace[1310462632] linearizableReadLoop","detail":"{readStateIndex:4747; appliedIndex:4745; }","duration":"223.009691ms","start":"2026-05-04T15:37:16.885123Z","end":"2026-05-04T15:37:17.108133Z","steps":["trace[1310462632] 'read index received'  (duration: 216.269655ms)","trace[1310462632] 'applied index is now lower than readState.Index'  (duration: 6.739186ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T15:37:17.108241Z","caller":"traceutil/trace.go:171","msg":"trace[28759104] transaction","detail":"{read_only:false; response_revision:4573; number_of_response:1; }","duration":"169.687118ms","start":"2026-05-04T15:37:16.938546Z","end":"2026-05-04T15:37:17.108233Z","steps":["trace[28759104] 'process raft request'  (duration: 169.515083ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:37:17.108592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.449025ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/general\" ","response":"range_response_count:1 size:1124"}
{"level":"info","ts":"2026-05-04T15:37:17.108625Z","caller":"traceutil/trace.go:171","msg":"trace[1027703421] range","detail":"{range_begin:/registry/storageclasses/general; range_end:; response_count:1; response_revision:4573; }","duration":"223.538438ms","start":"2026-05-04T15:37:16.885078Z","end":"2026-05-04T15:37:17.108617Z","steps":["trace[1027703421] 'agreement among raft nodes before linearized reading'  (duration: 223.394822ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:37:17.108869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.372923ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/\" range_end:\"/registry/pods/monitoring0\" ","response":"range_response_count:6 size:56147"}
{"level":"info","ts":"2026-05-04T15:37:17.108896Z","caller":"traceutil/trace.go:171","msg":"trace[345110939] range","detail":"{range_begin:/registry/pods/monitoring/; range_end:/registry/pods/monitoring0; response_count:6; response_revision:4573; }","duration":"223.452085ms","start":"2026-05-04T15:37:16.885438Z","end":"2026-05-04T15:37:17.10889Z","steps":["trace[345110939] 'agreement among raft nodes before linearized reading'  (duration: 223.308491ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T15:37:19.524643Z","caller":"traceutil/trace.go:171","msg":"trace[742541380] transaction","detail":"{read_only:false; response_revision:4596; number_of_response:1; }","duration":"164.935657ms","start":"2026-05-04T15:37:19.359663Z","end":"2026-05-04T15:37:19.524598Z","steps":["trace[742541380] 'process raft request'  (duration: 164.466503ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T15:37:21.456363Z","caller":"traceutil/trace.go:171","msg":"trace[998710022] transaction","detail":"{read_only:false; response_revision:4656; number_of_response:1; }","duration":"298.821712ms","start":"2026-05-04T15:37:21.157435Z","end":"2026-05-04T15:37:21.456257Z","steps":["trace[998710022] 'process raft request'  (duration: 298.590295ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T15:37:21.46063Z","caller":"traceutil/trace.go:171","msg":"trace[461683374] transaction","detail":"{read_only:false; response_revision:4657; number_of_response:1; }","duration":"241.781696ms","start":"2026-05-04T15:37:21.218815Z","end":"2026-05-04T15:37:21.460597Z","steps":["trace[461683374] 'process raft request'  (duration: 241.57123ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T15:37:21.460885Z","caller":"traceutil/trace.go:171","msg":"trace[1814696710] transaction","detail":"{read_only:false; response_revision:4658; number_of_response:1; }","duration":"211.75062ms","start":"2026-05-04T15:37:21.249123Z","end":"2026-05-04T15:37:21.460874Z","steps":["trace[1814696710] 'process raft request'  (duration: 211.41694ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T15:37:21.460968Z","caller":"traceutil/trace.go:171","msg":"trace[659950092] linearizableReadLoop","detail":"{readStateIndex:4836; appliedIndex:4833; }","duration":"196.775269ms","start":"2026-05-04T15:37:21.264099Z","end":"2026-05-04T15:37:21.460874Z","steps":["trace[659950092] 'read index received'  (duration: 191.959451ms)","trace[659950092] 'applied index is now lower than readState.Index'  (duration: 4.814028ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-04T15:37:21.461379Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.237683ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-04T15:37:21.46143Z","caller":"traceutil/trace.go:171","msg":"trace[1415948747] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4658; }","duration":"197.367118ms","start":"2026-05-04T15:37:21.264049Z","end":"2026-05-04T15:37:21.461416Z","steps":["trace[1415948747] 'agreement among raft nodes before linearized reading'  (duration: 197.010677ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:37:27.495991Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13305495818720528340,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-05-04T15:37:27.574238Z","caller":"traceutil/trace.go:171","msg":"trace[1265242853] transaction","detail":"{read_only:false; response_revision:4768; number_of_response:1; }","duration":"674.676945ms","start":"2026-05-04T15:37:26.89953Z","end":"2026-05-04T15:37:27.574207Z","steps":["trace[1265242853] 'process raft request'  (duration: 674.466639ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:37:27.574471Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T15:37:26.89949Z","time spent":"674.863561ms","remote":"127.0.0.1:38380","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/masterleases/199.204.45.210\" mod_revision:4574 > success:<request_put:<key:\"/registry/masterleases/199.204.45.210\" value_size:67 lease:4082123781865752533 >> failure:<request_range:<key:\"/registry/masterleases/199.204.45.210\" > >"}
{"level":"info","ts":"2026-05-04T15:37:27.795335Z","caller":"traceutil/trace.go:171","msg":"trace[2057621777] transaction","detail":"{read_only:false; response_revision:4769; number_of_response:1; }","duration":"764.314198ms","start":"2026-05-04T15:37:27.030973Z","end":"2026-05-04T15:37:27.795287Z","steps":["trace[2057621777] 'process raft request'  (duration: 674.013659ms)","trace[2057621777] 'compare'  (duration: 90.089673ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-04T15:37:27.795527Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T15:37:27.030948Z","time spent":"764.483444ms","remote":"127.0.0.1:38638","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":473,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" mod_revision:4596 > success:<request_put:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" value_size:414 >> failure:<request_range:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" > >"}
{"level":"info","ts":"2026-05-04T15:37:27.795704Z","caller":"traceutil/trace.go:171","msg":"trace[1581966083] linearizableReadLoop","detail":"{readStateIndex:4953; appliedIndex:4949; }","duration":"800.128078ms","start":"2026-05-04T15:37:26.99551Z","end":"2026-05-04T15:37:27.795638Z","steps":["trace[1581966083] 'read index received'  (duration: 578.995482ms)","trace[1581966083] 'applied index is now lower than readState.Index'  (duration: 221.130806ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T15:37:27.795839Z","caller":"traceutil/trace.go:171","msg":"trace[2015333334] transaction","detail":"{read_only:false; response_revision:4770; number_of_response:1; }","duration":"529.509288ms","start":"2026-05-04T15:37:27.266317Z","end":"2026-05-04T15:37:27.795827Z","steps":["trace[2015333334] 'process raft request'  (duration: 528.91523ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:37:27.79597Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T15:37:27.266287Z","time spent":"529.579211ms","remote":"127.0.0.1:38638","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:4571 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:599 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"info","ts":"2026-05-04T15:37:27.796009Z","caller":"traceutil/trace.go:171","msg":"trace[84636939] transaction","detail":"{read_only:false; response_revision:4772; number_of_response:1; }","duration":"314.798392ms","start":"2026-05-04T15:37:27.481192Z","end":"2026-05-04T15:37:27.795991Z","steps":["trace[84636939] 'process raft request'  (duration: 314.392318ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:37:27.796111Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T15:37:27.481154Z","time spent":"314.891564ms","remote":"127.0.0.1:38638","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:4690 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:478 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"info","ts":"2026-05-04T15:37:27.796085Z","caller":"traceutil/trace.go:171","msg":"trace[222591107] transaction","detail":"{read_only:false; response_revision:4771; number_of_response:1; }","duration":"314.968366ms","start":"2026-05-04T15:37:27.481071Z","end":"2026-05-04T15:37:27.79604Z","steps":["trace[222591107] 'process raft request'  (duration: 314.402598ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:37:27.796196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"800.670286ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"warn","ts":"2026-05-04T15:37:27.796291Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T15:37:27.481044Z","time spent":"315.133962ms","remote":"127.0.0.1:38638","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:4691 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:465 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"info","ts":"2026-05-04T15:37:27.796312Z","caller":"traceutil/trace.go:171","msg":"trace[1029671743] range","detail":"{range_begin:/registry/ingress/; range_end:/registry/ingress0; response_count:0; response_revision:4772; }","duration":"800.881802ms","start":"2026-05-04T15:37:26.99541Z","end":"2026-05-04T15:37:27.796292Z","steps":["trace[1029671743] 'agreement among raft nodes before linearized reading'  (duration: 800.600463ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:37:27.796385Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T15:37:26.995375Z","time spent":"800.998655ms","remote":"127.0.0.1:38664","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":4,"response size":30,"request content":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true "}
{"level":"info","ts":"2026-05-04T15:37:27.804057Z","caller":"traceutil/trace.go:171","msg":"trace[2033706294] transaction","detail":"{read_only:false; response_revision:4774; number_of_response:1; }","duration":"196.491803ms","start":"2026-05-04T15:37:27.607537Z","end":"2026-05-04T15:37:27.804029Z","steps":["trace[2033706294] 'process raft request'  (duration: 196.450601ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T15:37:27.804261Z","caller":"traceutil/trace.go:171","msg":"trace[2067586750] transaction","detail":"{read_only:false; response_revision:4773; number_of_response:1; }","duration":"223.299793ms","start":"2026-05-04T15:37:27.580954Z","end":"2026-05-04T15:37:27.804254Z","steps":["trace[2067586750] 'process raft request'  (duration: 222.902461ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T15:37:27.820187Z","caller":"traceutil/trace.go:171","msg":"trace[475911327] transaction","detail":"{read_only:false; response_revision:4775; number_of_response:1; }","duration":"103.266573ms","start":"2026-05-04T15:37:27.71689Z","end":"2026-05-04T15:37:27.820157Z","steps":["trace[475911327] 'process raft request'  (duration: 103.064746ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:37:27.820193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"554.872405ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-04T15:37:27.820522Z","caller":"traceutil/trace.go:171","msg":"trace[1817841049] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4775; }","duration":"555.336179ms","start":"2026-05-04T15:37:27.265165Z","end":"2026-05-04T15:37:27.820501Z","steps":["trace[1817841049] 'agreement among raft nodes before linearized reading'  (duration: 554.940977ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:37:27.820633Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T15:37:27.265137Z","time spent":"555.475434ms","remote":"127.0.0.1:38350","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-05-04T15:37:27.820519Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"697.345252ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-295348cc-e7e6-4946-ae08-09d29e6ea7a1\" ","response":"range_response_count:1 size:3646"}
{"level":"info","ts":"2026-05-04T15:37:27.820965Z","caller":"traceutil/trace.go:171","msg":"trace[216413818] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-295348cc-e7e6-4946-ae08-09d29e6ea7a1; range_end:; response_count:1; response_revision:4775; }","duration":"697.644721ms","start":"2026-05-04T15:37:27.123083Z","end":"2026-05-04T15:37:27.820728Z","steps":["trace[216413818] 'agreement among raft nodes before linearized reading'  (duration: 697.177477ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:37:27.82102Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T15:37:27.123062Z","time spent":"697.941491ms","remote":"127.0.0.1:38540","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3669,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-295348cc-e7e6-4946-ae08-09d29e6ea7a1\" "}
{"level":"warn","ts":"2026-05-04T15:37:27.820245Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.279451ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:422"}
{"level":"info","ts":"2026-05-04T15:37:27.821121Z","caller":"traceutil/trace.go:171","msg":"trace[600155998] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:4775; }","duration":"243.234332ms","start":"2026-05-04T15:37:27.577877Z","end":"2026-05-04T15:37:27.821112Z","steps":["trace[600155998] 'agreement among raft nodes before linearized reading'  (duration: 242.24146ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T15:37:27.952838Z","caller":"traceutil/trace.go:171","msg":"trace[1875339440] transaction","detail":"{read_only:false; response_revision:4778; number_of_response:1; }","duration":"100.194267ms","start":"2026-05-04T15:37:27.852593Z","end":"2026-05-04T15:37:27.952788Z","steps":["trace[1875339440] 'process raft request'  (duration: 51.650281ms)","trace[1875339440] 'compare'  (duration: 47.510853ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T15:37:28.397609Z","caller":"traceutil/trace.go:171","msg":"trace[1383184360] linearizableReadLoop","detail":"{readStateIndex:4965; appliedIndex:4964; }","duration":"221.35011ms","start":"2026-05-04T15:37:28.176227Z","end":"2026-05-04T15:37:28.397577Z","steps":["trace[1383184360] 'read index received'  (duration: 221.126733ms)","trace[1383184360] 'applied index is now lower than readState.Index'  (duration: 221.887µs)"],"step_count":2}
{"level":"info","ts":"2026-05-04T15:37:28.397647Z","caller":"traceutil/trace.go:171","msg":"trace[1419628524] transaction","detail":"{read_only:false; response_revision:4784; number_of_response:1; }","duration":"254.706446ms","start":"2026-05-04T15:37:28.142899Z","end":"2026-05-04T15:37:28.397606Z","steps":["trace[1419628524] 'process raft request'  (duration: 254.488249ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:37:28.397952Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.709092ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"}
{"level":"warn","ts":"2026-05-04T15:37:28.398051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.319489ms","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-05-04T15:37:28.398042Z","caller":"traceutil/trace.go:171","msg":"trace[430278737] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4784; }","duration":"221.863816ms","start":"2026-05-04T15:37:28.17616Z","end":"2026-05-04T15:37:28.398024Z","steps":["trace[430278737] 'agreement among raft nodes before linearized reading'  (duration: 221.568947ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T15:37:28.398097Z","caller":"traceutil/trace.go:171","msg":"trace[974525052] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4784; }","duration":"210.438342ms","start":"2026-05-04T15:37:28.187645Z","end":"2026-05-04T15:37:28.398084Z","steps":["trace[974525052] 'agreement among raft nodes before linearized reading'  (duration: 210.195654ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:37:28.398129Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.461538ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/openstack/rabbitmq-keystone-server\" ","response":"range_response_count:1 size:9639"}
{"level":"warn","ts":"2026-05-04T15:37:28.398224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.580034ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-04T15:37:28.398277Z","caller":"traceutil/trace.go:171","msg":"trace[1701589353] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4784; }","duration":"131.645896ms","start":"2026-05-04T15:37:28.266611Z","end":"2026-05-04T15:37:28.398257Z","steps":["trace[1701589353] 'agreement among raft nodes before linearized reading'  (duration: 131.579304ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:37:28.398252Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.738727ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-05-04T15:37:28.398361Z","caller":"traceutil/trace.go:171","msg":"trace[1586205452] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4784; }","duration":"206.925263ms","start":"2026-05-04T15:37:28.191412Z","end":"2026-05-04T15:37:28.398337Z","steps":["trace[1586205452] 'agreement among raft nodes before linearized reading'  (duration: 206.53699ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T15:37:28.398214Z","caller":"traceutil/trace.go:171","msg":"trace[1772467209] range","detail":"{range_begin:/registry/statefulsets/openstack/rabbitmq-keystone-server; range_end:; response_count:1; response_revision:4784; }","duration":"158.557082ms","start":"2026-05-04T15:37:28.239635Z","end":"2026-05-04T15:37:28.398192Z","steps":["trace[1772467209] 'agreement among raft nodes before linearized reading'  (duration: 158.254522ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:37:28.398135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.177005ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"}
{"level":"info","ts":"2026-05-04T15:37:28.39853Z","caller":"traceutil/trace.go:171","msg":"trace[762528333] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4784; }","duration":"202.62507ms","start":"2026-05-04T15:37:28.195886Z","end":"2026-05-04T15:37:28.398511Z","steps":["trace[762528333] 'agreement among raft nodes before linearized reading'  (duration: 202.01957ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T15:37:28.931136Z","caller":"traceutil/trace.go:171","msg":"trace[1120628081] linearizableReadLoop","detail":"{readStateIndex:4973; appliedIndex:4972; }","duration":"103.448321ms","start":"2026-05-04T15:37:28.827665Z","end":"2026-05-04T15:37:28.931114Z","steps":["trace[1120628081] 'read index received'  (duration: 103.149092ms)","trace[1120628081] 'applied index is now lower than readState.Index'  (duration: 297.589µs)"],"step_count":2}
{"level":"info","ts":"2026-05-04T15:37:28.931304Z","caller":"traceutil/trace.go:171","msg":"trace[751761350] transaction","detail":"{read_only:false; response_revision:4792; number_of_response:1; }","duration":"121.640667ms","start":"2026-05-04T15:37:28.809616Z","end":"2026-05-04T15:37:28.931257Z","steps":["trace[751761350] 'process raft request'  (duration: 121.299436ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:37:28.931517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.834263ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-295348cc-e7e6-4946-ae08-09d29e6ea7a1\" ","response":"range_response_count:1 size:3763"}
{"level":"info","ts":"2026-05-04T15:37:28.931801Z","caller":"traceutil/trace.go:171","msg":"trace[1373353121] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-295348cc-e7e6-4946-ae08-09d29e6ea7a1; range_end:; response_count:1; response_revision:4792; }","duration":"104.173973ms","start":"2026-05-04T15:37:28.827593Z","end":"2026-05-04T15:37:28.931767Z","steps":["trace[1373353121] 'agreement among raft nodes before linearized reading'  (duration: 103.714559ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T15:37:30.962287Z","caller":"traceutil/trace.go:171","msg":"trace[2019907303] transaction","detail":"{read_only:false; response_revision:4820; number_of_response:1; }","duration":"146.397594ms","start":"2026-05-04T15:37:30.815849Z","end":"2026-05-04T15:37:30.962247Z","steps":["trace[2019907303] 'process raft request'  (duration: 121.140378ms)","trace[2019907303] 'compare'  (duration: 24.266925ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T15:37:32.11861Z","caller":"traceutil/trace.go:171","msg":"trace[141241240] transaction","detail":"{read_only:false; response_revision:4829; number_of_response:1; }","duration":"330.124274ms","start":"2026-05-04T15:37:31.788444Z","end":"2026-05-04T15:37:32.118568Z","steps":["trace[141241240] 'process raft request'  (duration: 329.850274ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:37:32.118841Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T15:37:31.788427Z","time spent":"330.30315ms","remote":"127.0.0.1:38540","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9630,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/monitoring/kube-prometheus-stack-prometheus-node-exporter-jd5jx\" mod_revision:4670 > success:<request_put:<key:\"/registry/pods/monitoring/kube-prometheus-stack-prometheus-node-exporter-jd5jx\" value_size:9544 >> failure:<request_range:<key:\"/registry/pods/monitoring/kube-prometheus-stack-prometheus-node-exporter-jd5jx\" > >"}
{"level":"info","ts":"2026-05-04T15:37:32.131774Z","caller":"traceutil/trace.go:171","msg":"trace[910513994] transaction","detail":"{read_only:false; response_revision:4831; number_of_response:1; }","duration":"293.032028ms","start":"2026-05-04T15:37:31.838724Z","end":"2026-05-04T15:37:32.131756Z","steps":["trace[910513994] 'process raft request'  (duration: 292.906074ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T15:37:32.131763Z","caller":"traceutil/trace.go:171","msg":"trace[549417332] transaction","detail":"{read_only:false; response_revision:4832; number_of_response:1; }","duration":"293.014658ms","start":"2026-05-04T15:37:31.838735Z","end":"2026-05-04T15:37:32.13175Z","steps":["trace[549417332] 'process raft request'  (duration: 292.941656ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T15:37:32.131763Z","caller":"traceutil/trace.go:171","msg":"trace[741259932] transaction","detail":"{read_only:false; response_revision:4830; number_of_response:1; }","duration":"312.257597ms","start":"2026-05-04T15:37:31.819474Z","end":"2026-05-04T15:37:32.131731Z","steps":["trace[741259932] 'process raft request'  (duration: 312.02934ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:37:32.131896Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T15:37:31.819448Z","time spent":"312.372711ms","remote":"127.0.0.1:38638","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:4803 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:478 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"info","ts":"2026-05-04T15:37:32.132318Z","caller":"traceutil/trace.go:171","msg":"trace[2059006650] transaction","detail":"{read_only:false; response_revision:4833; number_of_response:1; }","duration":"292.474781ms","start":"2026-05-04T15:37:31.839833Z","end":"2026-05-04T15:37:32.132308Z","steps":["trace[2059006650] 'process raft request'  (duration: 291.870663ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T15:37:32.132501Z","caller":"traceutil/trace.go:171","msg":"trace[1289537069] linearizableReadLoop","detail":"{readStateIndex:5015; appliedIndex:5009; }","duration":"158.067957ms","start":"2026-05-04T15:37:31.974422Z","end":"2026-05-04T15:37:32.13249Z","steps":["trace[1289537069] 'read index received'  (duration: 143.888944ms)","trace[1289537069] 'applied index is now lower than readState.Index'  (duration: 14.177873ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T15:37:32.132653Z","caller":"traceutil/trace.go:171","msg":"trace[891758147] transaction","detail":"{read_only:false; response_revision:4834; number_of_response:1; }","duration":"223.442212ms","start":"2026-05-04T15:37:31.909199Z","end":"2026-05-04T15:37:32.132642Z","steps":["trace[891758147] 'process raft request'  (duration: 223.034309ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:37:32.132839Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.419248ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-295348cc-e7e6-4946-ae08-09d29e6ea7a1\" ","response":"range_response_count:1 size:3949"}
{"level":"info","ts":"2026-05-04T15:37:32.132871Z","caller":"traceutil/trace.go:171","msg":"trace[1484977347] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-295348cc-e7e6-4946-ae08-09d29e6ea7a1; range_end:; response_count:1; response_revision:4834; }","duration":"158.50518ms","start":"2026-05-04T15:37:31.974358Z","end":"2026-05-04T15:37:32.132863Z","steps":["trace[1484977347] 'agreement among raft nodes before linearized reading'  (duration: 158.383277ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:37:32.13302Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.878973ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"info","ts":"2026-05-04T15:37:32.133046Z","caller":"traceutil/trace.go:171","msg":"trace[288243644] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4834; }","duration":"115.931375ms","start":"2026-05-04T15:37:32.017108Z","end":"2026-05-04T15:37:32.13304Z","steps":["trace[288243644] 'agreement among raft nodes before linearized reading'  (duration: 115.855922ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:37:43.40826Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13305495818720528801,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-05-04T15:37:43.784623Z","caller":"traceutil/trace.go:171","msg":"trace[1790249776] linearizableReadLoop","detail":"{readStateIndex:5161; appliedIndex:5160; }","duration":"877.100594ms","start":"2026-05-04T15:37:42.90749Z","end":"2026-05-04T15:37:43.78459Z","steps":["trace[1790249776] 'read index received'  (duration: 876.766883ms)","trace[1790249776] 'applied index is now lower than readState.Index'  (duration: 332.281µs)"],"step_count":2}
{"level":"info","ts":"2026-05-04T15:37:43.784699Z","caller":"traceutil/trace.go:171","msg":"trace[1988616863] transaction","detail":"{read_only:false; response_revision:4973; number_of_response:1; }","duration":"950.092882ms","start":"2026-05-04T15:37:42.834566Z","end":"2026-05-04T15:37:43.784659Z","steps":["trace[1988616863] 'process raft request'  (duration: 949.815753ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:37:43.785018Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"877.503507ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:16400"}
{"level":"warn","ts":"2026-05-04T15:37:43.785072Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T15:37:42.834544Z","time spent":"950.419983ms","remote":"127.0.0.1:38638","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" mod_revision:4902 > 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":"warn","ts":"2026-05-04T15:37:43.785233Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"519.526376ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-04T15:37:43.785267Z","caller":"traceutil/trace.go:171","msg":"trace[1956353699] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4973; }","duration":"519.608289ms","start":"2026-05-04T15:37:43.26565Z","end":"2026-05-04T15:37:43.785259Z","steps":["trace[1956353699] 'agreement among raft nodes before linearized reading'  (duration: 519.543357ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:37:43.785304Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T15:37:43.26562Z","time spent":"519.67678ms","remote":"127.0.0.1:38350","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-05-04T15:37:43.785147Z","caller":"traceutil/trace.go:171","msg":"trace[2020880921] range","detail":"{range_begin:/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4973; }","duration":"877.685042ms","start":"2026-05-04T15:37:42.907433Z","end":"2026-05-04T15:37:43.785118Z","steps":["trace[2020880921] 'agreement among raft nodes before linearized reading'  (duration: 877.352872ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:37:43.786133Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T15:37:42.90741Z","time spent":"878.683634ms","remote":"127.0.0.1:38540","response type":"/etcdserverpb.KV/Range","request count":0,"request size":73,"response count":1,"response size":16423,"request content":"key:\"/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0\" "}
{"level":"warn","ts":"2026-05-04T15:37:43.785516Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.838763ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:3316"}
{"level":"info","ts":"2026-05-04T15:37:43.786689Z","caller":"traceutil/trace.go:171","msg":"trace[382578126] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:4973; }","duration":"316.080284ms","start":"2026-05-04T15:37:43.470588Z","end":"2026-05-04T15:37:43.786668Z","steps":["trace[382578126] 'agreement among raft nodes before linearized reading'  (duration: 314.589086ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:37:43.785564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"851.038653ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"}
{"level":"info","ts":"2026-05-04T15:37:43.787848Z","caller":"traceutil/trace.go:171","msg":"trace[595548889] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4973; }","duration":"853.399798ms","start":"2026-05-04T15:37:42.934431Z","end":"2026-05-04T15:37:43.787831Z","steps":["trace[595548889] 'agreement among raft nodes before linearized reading'  (duration: 850.640471ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:37:43.787931Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T15:37:42.934402Z","time spent":"853.511491ms","remote":"127.0.0.1:38506","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":1,"response size":1888,"request content":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" "}
{"level":"warn","ts":"2026-05-04T15:37:43.787996Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T15:37:43.470553Z","time spent":"317.420295ms","remote":"127.0.0.1:41264","response type":"/etcdserverpb.KV/Range","request count":0,"request size":69,"response count":1,"response size":3339,"request content":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" "}
{"level":"info","ts":"2026-05-04T15:37:43.945233Z","caller":"traceutil/trace.go:171","msg":"trace[1954962217] linearizableReadLoop","detail":"{readStateIndex:5162; appliedIndex:5161; }","duration":"121.51111ms","start":"2026-05-04T15:37:43.823696Z","end":"2026-05-04T15:37:43.945207Z","steps":["trace[1954962217] 'read index received'  (duration: 121.248102ms)","trace[1954962217] 'applied index is now lower than readState.Index'  (duration: 261.378µs)"],"step_count":2}
{"level":"warn","ts":"2026-05-04T15:37:43.945464Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.740077ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/rabbitmq-keystone-nodes\" ","response":"range_response_count:1 size:1265"}
{"level":"info","ts":"2026-05-04T15:37:43.945478Z","caller":"traceutil/trace.go:171","msg":"trace[785487437] transaction","detail":"{read_only:false; response_revision:4974; number_of_response:1; }","duration":"125.975131ms","start":"2026-05-04T15:37:43.819446Z","end":"2026-05-04T15:37:43.945421Z","steps":["trace[785487437] 'process raft request'  (duration: 125.544238ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T15:37:43.945558Z","caller":"traceutil/trace.go:171","msg":"trace[1784194387] range","detail":"{range_begin:/registry/services/specs/openstack/rabbitmq-keystone-nodes; range_end:; response_count:1; response_revision:4974; }","duration":"121.898372ms","start":"2026-05-04T15:37:43.823648Z","end":"2026-05-04T15:37:43.945546Z","steps":["trace[1784194387] 'agreement among raft nodes before linearized reading'  (duration: 121.660054ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T15:38:18.76174Z","caller":"traceutil/trace.go:171","msg":"trace[1161087301] transaction","detail":"{read_only:false; response_revision:5284; number_of_response:1; }","duration":"162.537114ms","start":"2026-05-04T15:38:18.599161Z","end":"2026-05-04T15:38:18.761698Z","steps":["trace[1161087301] 'process raft request'  (duration: 162.260155ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T15:38:21.071872Z","caller":"traceutil/trace.go:171","msg":"trace[1080727044] transaction","detail":"{read_only:false; response_revision:5296; number_of_response:1; }","duration":"146.603804ms","start":"2026-05-04T15:38:20.925237Z","end":"2026-05-04T15:38:21.071841Z","steps":["trace[1080727044] 'process raft request'  (duration: 146.46874ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T15:38:21.071952Z","caller":"traceutil/trace.go:171","msg":"trace[1745925192] transaction","detail":"{read_only:false; response_revision:5297; number_of_response:1; }","duration":"146.509051ms","start":"2026-05-04T15:38:20.925413Z","end":"2026-05-04T15:38:21.071922Z","steps":["trace[1745925192] 'process raft request'  (duration: 146.382127ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T15:38:21.072922Z","caller":"traceutil/trace.go:171","msg":"trace[947756525] transaction","detail":"{read_only:false; response_revision:5295; number_of_response:1; }","duration":"146.851462ms","start":"2026-05-04T15:38:20.925217Z","end":"2026-05-04T15:38:21.072069Z","steps":["trace[947756525] 'process raft request'  (duration: 117.327522ms)","trace[947756525] 'compare'  (duration: 28.833367ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T15:38:53.713409Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2867}
{"level":"info","ts":"2026-05-04T15:38:53.820677Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2867,"took":"105.512737ms","hash":2964524322,"current-db-size-bytes":52948992,"current-db-size":"53 MB","current-db-size-in-use-bytes":29024256,"current-db-size-in-use":"29 MB"}
{"level":"info","ts":"2026-05-04T15:38:53.820768Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2964524322,"revision":2867,"compact-revision":-1}
{"level":"info","ts":"2026-05-04T15:41:30.544441Z","caller":"traceutil/trace.go:171","msg":"trace[463907855] linearizableReadLoop","detail":"{readStateIndex:6836; appliedIndex:6835; }","duration":"303.992415ms","start":"2026-05-04T15:41:30.240412Z","end":"2026-05-04T15:41:30.544405Z","steps":["trace[463907855] 'read index received'  (duration: 303.773257ms)","trace[463907855] 'applied index is now lower than readState.Index'  (duration: 217.928µs)"],"step_count":2}
{"level":"info","ts":"2026-05-04T15:41:30.544735Z","caller":"traceutil/trace.go:171","msg":"trace[151777490] transaction","detail":"{read_only:false; response_revision:6596; number_of_response:1; }","duration":"354.246519ms","start":"2026-05-04T15:41:30.190475Z","end":"2026-05-04T15:41:30.544721Z","steps":["trace[151777490] 'process raft request'  (duration: 353.784713ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:41:30.544916Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T15:41:30.190459Z","time spent":"354.363982ms","remote":"127.0.0.1:38638","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:6586 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-05-04T15:41:30.545206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.801132ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"}
{"level":"info","ts":"2026-05-04T15:41:30.54525Z","caller":"traceutil/trace.go:171","msg":"trace[1242677676] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:6596; }","duration":"304.885995ms","start":"2026-05-04T15:41:30.240354Z","end":"2026-05-04T15:41:30.54524Z","steps":["trace[1242677676] 'agreement among raft nodes before linearized reading'  (duration: 304.749321ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:41:30.545279Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T15:41:30.240329Z","time spent":"304.943228ms","remote":"127.0.0.1:38638","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-05-04T15:41:30.545428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.074044ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-04T15:41:30.545461Z","caller":"traceutil/trace.go:171","msg":"trace[717203879] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:6596; }","duration":"280.123575ms","start":"2026-05-04T15:41:30.26533Z","end":"2026-05-04T15:41:30.545453Z","steps":["trace[717203879] 'agreement among raft nodes before linearized reading'  (duration: 280.075973ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:41:30.545672Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.293895ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"}
{"level":"info","ts":"2026-05-04T15:41:30.545709Z","caller":"traceutil/trace.go:171","msg":"trace[2131232963] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:6596; }","duration":"264.361027ms","start":"2026-05-04T15:41:30.281339Z","end":"2026-05-04T15:41:30.5457Z","steps":["trace[2131232963] 'agreement among raft nodes before linearized reading'  (duration: 264.267834ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:41:30.545713Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.662935ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/\" range_end:\"/registry/cert-manager.io/certificates0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-05-04T15:41:30.545817Z","caller":"traceutil/trace.go:171","msg":"trace[1586342547] range","detail":"{range_begin:/registry/cert-manager.io/certificates/; range_end:/registry/cert-manager.io/certificates0; response_count:0; response_revision:6596; }","duration":"149.836821ms","start":"2026-05-04T15:41:30.395957Z","end":"2026-05-04T15:41:30.545794Z","steps":["trace[1586342547] 'agreement among raft nodes before linearized reading'  (duration: 149.649335ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:41:30.545868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.107198ms","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-05-04T15:41:30.545908Z","caller":"traceutil/trace.go:171","msg":"trace[1008034219] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusterbackups/; range_end:/registry/pxc.percona.com/perconaxtradbclusterbackups0; response_count:0; response_revision:6596; }","duration":"266.193141ms","start":"2026-05-04T15:41:30.279704Z","end":"2026-05-04T15:41:30.545897Z","steps":["trace[1008034219] 'agreement among raft nodes before linearized reading'  (duration: 266.125209ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:41:31.669845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.716281ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13305495818720532900 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:6594 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-04T15:41:31.670518Z","caller":"traceutil/trace.go:171","msg":"trace[1846628289] transaction","detail":"{read_only:false; response_revision:6603; number_of_response:1; }","duration":"131.993513ms","start":"2026-05-04T15:41:31.538502Z","end":"2026-05-04T15:41:31.670496Z","steps":["trace[1846628289] 'process raft request'  (duration: 23.556348ms)","trace[1846628289] 'compare'  (duration: 107.613517ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T15:41:49.9012Z","caller":"traceutil/trace.go:171","msg":"trace[1481652764] transaction","detail":"{read_only:false; response_revision:6757; number_of_response:1; }","duration":"100.76335ms","start":"2026-05-04T15:41:49.800405Z","end":"2026-05-04T15:41:49.901169Z","steps":["trace[1481652764] 'process raft request'  (duration: 100.560789ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T15:41:56.13592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.987943ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/ingress-nginx/\" range_end:\"/registry/secrets/ingress-nginx0\" ","response":"range_response_count:2 size:107263"}
{"level":"info","ts":"2026-05-04T15:41:56.136113Z","caller":"traceutil/trace.go:171","msg":"trace[1881497504] range","detail":"{range_begin:/registry/secrets/ingress-nginx/; range_end:/registry/secrets/ingress-nginx0; response_count:2; response_revision:6787; }","duration":"165.240974ms","start":"2026-05-04T15:41:55.970849Z","end":"2026-05-04T15:41:56.136089Z","steps":["trace[1881497504] 'range keys from in-memory index tree'  (duration: 164.762611ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T15:43:53.721645Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5542}
{"level":"info","ts":"2026-05-04T15:43:53.814976Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5542,"took":"91.53601ms","hash":2588853927,"current-db-size-bytes":52948992,"current-db-size":"53 MB","current-db-size-in-use-bytes":18440192,"current-db-size-in-use":"18 MB"}
{"level":"info","ts":"2026-05-04T15:43:53.815035Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2588853927,"revision":5542,"compact-revision":2867}