{"level":"warn","ts":"2026-05-05T10:14:43.908551Z","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-05T10:14:43.908656Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.237: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.19.213.237:2380","--initial-cluster=instance=https://199.19.213.237:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.237:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.237: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-05T10:14:43.908729Z","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-05T10:14:43.908743Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.237:2380"]}
{"level":"info","ts":"2026-05-05T10:14:43.908765Z","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-05T10:14:43.909469Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.237:2379"]}
{"level":"info","ts":"2026-05-05T10:14:43.909549Z","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.19.213.237:2380"],"listen-peer-urls":["https://199.19.213.237:2380"],"advertise-client-urls":["https://199.19.213.237:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.237:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.237: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-05T10:14:43.913378Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.646827ms"}
{"level":"info","ts":"2026-05-05T10:14:43.921295Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"c51d7a9ea5537d6e","cluster-id":"bea7a5ea8f053dc3"}
{"level":"info","ts":"2026-05-05T10:14:43.921576Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c51d7a9ea5537d6e switched to configuration voters=()"}
{"level":"info","ts":"2026-05-05T10:14:43.921608Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c51d7a9ea5537d6e became follower at term 0"}
{"level":"info","ts":"2026-05-05T10:14:43.92162Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft c51d7a9ea5537d6e [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-05-05T10:14:43.921679Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c51d7a9ea5537d6e became follower at term 1"}
{"level":"info","ts":"2026-05-05T10:14:43.921732Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c51d7a9ea5537d6e switched to configuration voters=(14203643621593546094)"}
{"level":"warn","ts":"2026-05-05T10:14:43.930891Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-05-05T10:14:43.932522Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-05-05T10:14:43.934061Z","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-05T10:14:43.936987Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"c51d7a9ea5537d6e","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-05-05T10:14:43.937265Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"c51d7a9ea5537d6e","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-05-05T10:14:43.937363Z","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-05T10:14:43.938023Z","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-05T10:14:43.93804Z","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-05T10:14:43.938701Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c51d7a9ea5537d6e switched to configuration voters=(14203643621593546094)"}
{"level":"info","ts":"2026-05-05T10:14:43.938975Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"bea7a5ea8f053dc3","local-member-id":"c51d7a9ea5537d6e","added-peer-id":"c51d7a9ea5537d6e","added-peer-peer-urls":["https://199.19.213.237:2380"]}
{"level":"info","ts":"2026-05-05T10:14:43.943735Z","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-05T10:14:43.943983Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"c51d7a9ea5537d6e","initial-advertise-peer-urls":["https://199.19.213.237:2380"],"listen-peer-urls":["https://199.19.213.237:2380"],"advertise-client-urls":["https://199.19.213.237:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.237:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-05-05T10:14:43.944013Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-05-05T10:14:43.944106Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.237:2380"}
{"level":"info","ts":"2026-05-05T10:14:43.944125Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.237:2380"}
{"level":"info","ts":"2026-05-05T10:14:44.121962Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c51d7a9ea5537d6e is starting a new election at term 1"}
{"level":"info","ts":"2026-05-05T10:14:44.122056Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c51d7a9ea5537d6e became pre-candidate at term 1"}
{"level":"info","ts":"2026-05-05T10:14:44.122095Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c51d7a9ea5537d6e received MsgPreVoteResp from c51d7a9ea5537d6e at term 1"}
{"level":"info","ts":"2026-05-05T10:14:44.122116Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c51d7a9ea5537d6e became candidate at term 2"}
{"level":"info","ts":"2026-05-05T10:14:44.122127Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c51d7a9ea5537d6e received MsgVoteResp from c51d7a9ea5537d6e at term 2"}
{"level":"info","ts":"2026-05-05T10:14:44.122143Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c51d7a9ea5537d6e became leader at term 2"}
{"level":"info","ts":"2026-05-05T10:14:44.122167Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: c51d7a9ea5537d6e elected leader c51d7a9ea5537d6e at term 2"}
{"level":"info","ts":"2026-05-05T10:14:44.126297Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-05T10:14:44.126886Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"c51d7a9ea5537d6e","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.237:2379]}","request-path":"/0/members/c51d7a9ea5537d6e/attributes","cluster-id":"bea7a5ea8f053dc3","publish-timeout":"7s"}
{"level":"info","ts":"2026-05-05T10:14:44.126896Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-05-05T10:14:44.12731Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-05-05T10:14:44.127399Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-05-05T10:14:44.128851Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"bea7a5ea8f053dc3","local-member-id":"c51d7a9ea5537d6e","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-05T10:14:44.128983Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-05T10:14:44.129027Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-05T10:14:44.130072Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.237:2379"}
{"level":"info","ts":"2026-05-05T10:14:44.130168Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-05-05T10:14:44.13287Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-05-05T10:14:56.792014Z","caller":"traceutil/trace.go:171","msg":"trace[576864619] transaction","detail":"{read_only:false; response_revision:402; number_of_response:1; }","duration":"116.059003ms","start":"2026-05-05T10:14:56.675932Z","end":"2026-05-05T10:14:56.791991Z","steps":["trace[576864619] 'process raft request'  (duration: 115.930142ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T10:15:02.402511Z","caller":"traceutil/trace.go:171","msg":"trace[1735637191] linearizableReadLoop","detail":"{readStateIndex:458; appliedIndex:457; }","duration":"151.179375ms","start":"2026-05-05T10:15:02.251312Z","end":"2026-05-05T10:15:02.402491Z","steps":["trace[1735637191] 'read index received'  (duration: 151.073834ms)","trace[1735637191] 'applied index is now lower than readState.Index'  (duration: 104.381µs)"],"step_count":2}
{"level":"warn","ts":"2026-05-05T10:15:02.402625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.306516ms","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-05T10:15:02.402603Z","caller":"traceutil/trace.go:171","msg":"trace[2115116022] transaction","detail":"{read_only:false; response_revision:447; number_of_response:1; }","duration":"270.2075ms","start":"2026-05-05T10:15:02.132331Z","end":"2026-05-05T10:15:02.402538Z","steps":["trace[2115116022] 'process raft request'  (duration: 270.023239ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T10:15:02.40268Z","caller":"traceutil/trace.go:171","msg":"trace[1435058705] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:447; }","duration":"151.416766ms","start":"2026-05-05T10:15:02.251254Z","end":"2026-05-05T10:15:02.402671Z","steps":["trace[1435058705] 'agreement among raft nodes before linearized reading'  (duration: 151.325776ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T10:15:03.05949Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"326.305056ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9038335189079938247 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:415 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-05T10:15:03.059695Z","caller":"traceutil/trace.go:171","msg":"trace[1799733594] linearizableReadLoop","detail":"{readStateIndex:459; appliedIndex:458; }","duration":"611.828771ms","start":"2026-05-05T10:15:02.447849Z","end":"2026-05-05T10:15:03.059678Z","steps":["trace[1799733594] 'read index received'  (duration: 284.662447ms)","trace[1799733594] 'applied index is now lower than readState.Index'  (duration: 327.164594ms)"],"step_count":2}
{"level":"info","ts":"2026-05-05T10:15:03.05975Z","caller":"traceutil/trace.go:171","msg":"trace[300738261] transaction","detail":"{read_only:false; response_revision:448; number_of_response:1; }","duration":"653.478186ms","start":"2026-05-05T10:15:02.406231Z","end":"2026-05-05T10:15:03.059709Z","steps":["trace[300738261] 'process raft request'  (duration: 326.354373ms)","trace[300738261] 'compare'  (duration: 326.192235ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-05T10:15:03.059875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"612.011722ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"warn","ts":"2026-05-05T10:15:03.059921Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:15:02.406206Z","time spent":"653.624327ms","remote":"127.0.0.1:42624","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:415 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-05-05T10:15:03.059965Z","caller":"traceutil/trace.go:171","msg":"trace[1064662129] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:448; }","duration":"612.130723ms","start":"2026-05-05T10:15:02.447805Z","end":"2026-05-05T10:15:03.059935Z","steps":["trace[1064662129] 'agreement among raft nodes before linearized reading'  (duration: 612.000552ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T10:15:03.060011Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:15:02.447792Z","time spent":"612.211004ms","remote":"127.0.0.1:42624","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-05-05T10:15:03.544076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"447.215327ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9038335189079938248 > lease_revoke:<id:7d6e9df7a205d31e>","response":"size:29"}
{"level":"info","ts":"2026-05-05T10:15:03.544343Z","caller":"traceutil/trace.go:171","msg":"trace[1948766953] linearizableReadLoop","detail":"{readStateIndex:460; appliedIndex:459; }","duration":"484.519934ms","start":"2026-05-05T10:15:03.059793Z","end":"2026-05-05T10:15:03.544313Z","steps":["trace[1948766953] 'read index received'  (duration: 37.084565ms)","trace[1948766953] 'applied index is now lower than readState.Index'  (duration: 447.432319ms)"],"step_count":2}
{"level":"info","ts":"2026-05-05T10:15:03.544378Z","caller":"traceutil/trace.go:171","msg":"trace[1012975686] transaction","detail":"{read_only:false; response_revision:449; number_of_response:1; }","duration":"473.352196ms","start":"2026-05-05T10:15:03.071011Z","end":"2026-05-05T10:15:03.544363Z","steps":["trace[1012975686] 'process raft request'  (duration: 473.228245ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T10:15:03.544466Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.019718179s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-05-05T10:15:03.544478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"731.880917ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-05-05T10:15:03.544521Z","caller":"traceutil/trace.go:171","msg":"trace[1293829909] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:449; }","duration":"1.01981304s","start":"2026-05-05T10:15:02.524694Z","end":"2026-05-05T10:15:03.544507Z","steps":["trace[1293829909] 'agreement among raft nodes before linearized reading'  (duration: 1.019713679s)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T10:15:03.544516Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:15:03.070943Z","time spent":"473.488607ms","remote":"127.0.0.1:42624","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:416 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-05-05T10:15:03.544555Z","caller":"traceutil/trace.go:171","msg":"trace[362997258] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:449; }","duration":"732.005999ms","start":"2026-05-05T10:15:02.812532Z","end":"2026-05-05T10:15:03.544538Z","steps":["trace[362997258] 'agreement among raft nodes before linearized reading'  (duration: 731.801197ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T10:15:03.544823Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:15:02.812509Z","time spent":"732.270281ms","remote":"127.0.0.1:42624","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-05-05T10:15:03.544564Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:15:02.524679Z","time spent":"1.01987863s","remote":"127.0.0.1:45938","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-05-05T10:15:13.272015Z","caller":"traceutil/trace.go:171","msg":"trace[983789643] transaction","detail":"{read_only:false; response_revision:505; number_of_response:1; }","duration":"157.070235ms","start":"2026-05-05T10:15:13.114923Z","end":"2026-05-05T10:15:13.271993Z","steps":["trace[983789643] 'process raft request'  (duration: 156.943364ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T10:15:13.272343Z","caller":"traceutil/trace.go:171","msg":"trace[1383966342] linearizableReadLoop","detail":"{readStateIndex:519; appliedIndex:519; }","duration":"147.944069ms","start":"2026-05-05T10:15:13.124384Z","end":"2026-05-05T10:15:13.272328Z","steps":["trace[1383966342] 'read index received'  (duration: 147.937969ms)","trace[1383966342] 'applied index is now lower than readState.Index'  (duration: 4.87µs)"],"step_count":2}
{"level":"warn","ts":"2026-05-05T10:15:13.272421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.014929ms","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-05T10:15:13.272454Z","caller":"traceutil/trace.go:171","msg":"trace[756988852] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:0; response_revision:505; }","duration":"148.07893ms","start":"2026-05-05T10:15:13.124363Z","end":"2026-05-05T10:15:13.272442Z","steps":["trace[756988852] 'agreement among raft nodes before linearized reading'  (duration: 148.010459ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T10:15:13.751497Z","caller":"traceutil/trace.go:171","msg":"trace[1718943978] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"100.26455ms","start":"2026-05-05T10:15:13.651205Z","end":"2026-05-05T10:15:13.751469Z","steps":["trace[1718943978] 'process raft request'  (duration: 100.164729ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T10:15:13.752274Z","caller":"traceutil/trace.go:171","msg":"trace[374987655] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"147.929489ms","start":"2026-05-05T10:15:13.604278Z","end":"2026-05-05T10:15:13.752208Z","steps":["trace[374987655] 'process raft request'  (duration: 70.979937ms)","trace[374987655] 'compare'  (duration: 75.815443ms)"],"step_count":2}
{"level":"info","ts":"2026-05-05T10:15:13.752548Z","caller":"traceutil/trace.go:171","msg":"trace[1254507969] linearizableReadLoop","detail":"{readStateIndex:552; appliedIndex:551; }","duration":"112.609881ms","start":"2026-05-05T10:15:13.639923Z","end":"2026-05-05T10:15:13.752533Z","steps":["trace[1254507969] 'read index received'  (duration: 35.411998ms)","trace[1254507969] 'applied index is now lower than readState.Index'  (duration: 77.196393ms)"],"step_count":2}
{"level":"info","ts":"2026-05-05T10:15:13.752797Z","caller":"traceutil/trace.go:171","msg":"trace[414933820] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"102.095645ms","start":"2026-05-05T10:15:13.650688Z","end":"2026-05-05T10:15:13.752783Z","steps":["trace[414933820] 'process raft request'  (duration: 100.585873ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T10:15:13.753136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.685552ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-05-05T10:15:13.753213Z","caller":"traceutil/trace.go:171","msg":"trace[2019947601] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:538; }","duration":"108.787933ms","start":"2026-05-05T10:15:13.644406Z","end":"2026-05-05T10:15:13.753194Z","steps":["trace[2019947601] 'agreement among raft nodes before linearized reading'  (duration: 108.655922ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T10:15:13.753419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.492447ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-05-05T10:15:13.753455Z","caller":"traceutil/trace.go:171","msg":"trace[1025102474] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:538; }","duration":"113.565148ms","start":"2026-05-05T10:15:13.639881Z","end":"2026-05-05T10:15:13.753446Z","steps":["trace[1025102474] 'agreement among raft nodes before linearized reading'  (duration: 113.506587ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T10:15:19.054367Z","caller":"traceutil/trace.go:171","msg":"trace[1792187003] transaction","detail":"{read_only:false; response_revision:606; number_of_response:1; }","duration":"118.784932ms","start":"2026-05-05T10:15:18.935553Z","end":"2026-05-05T10:15:19.054338Z","steps":["trace[1792187003] 'process raft request'  (duration: 118.145778ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T10:15:19.884765Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.654077ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9038335189079938547 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/kube-system/cilium-dz6c6.18aca3dc5a14786f\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/cilium-dz6c6.18aca3dc5a14786f\" value_size:612 lease:9038335189079937725 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-05-05T10:15:19.884935Z","caller":"traceutil/trace.go:171","msg":"trace[452363672] transaction","detail":"{read_only:false; response_revision:612; number_of_response:1; }","duration":"178.157194ms","start":"2026-05-05T10:15:19.706736Z","end":"2026-05-05T10:15:19.884894Z","steps":["trace[452363672] 'process raft request'  (duration: 12.299606ms)","trace[452363672] 'compare'  (duration: 165.503986ms)"],"step_count":2}
{"level":"info","ts":"2026-05-05T10:15:19.885203Z","caller":"traceutil/trace.go:171","msg":"trace[2014719221] linearizableReadLoop","detail":"{readStateIndex:629; appliedIndex:628; }","duration":"177.552299ms","start":"2026-05-05T10:15:19.707618Z","end":"2026-05-05T10:15:19.88517Z","steps":["trace[2014719221] 'read index received'  (duration: 11.352369ms)","trace[2014719221] 'applied index is now lower than readState.Index'  (duration: 166.19609ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-05T10:15:19.88537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.73325ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-05T10:15:19.885423Z","caller":"traceutil/trace.go:171","msg":"trace[1938814688] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:613; }","duration":"177.830321ms","start":"2026-05-05T10:15:19.707577Z","end":"2026-05-05T10:15:19.885408Z","steps":["trace[1938814688] 'agreement among raft nodes before linearized reading'  (duration: 177.73353ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T10:15:19.885659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.472092ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"warn","ts":"2026-05-05T10:15:19.88576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.957079ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-05-05T10:15:19.885876Z","caller":"traceutil/trace.go:171","msg":"trace[1322015200] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:613; }","duration":"103.10176ms","start":"2026-05-05T10:15:19.782734Z","end":"2026-05-05T10:15:19.885835Z","steps":["trace[1322015200] 'agreement among raft nodes before linearized reading'  (duration: 102.656438ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T10:15:19.885766Z","caller":"traceutil/trace.go:171","msg":"trace[977828629] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:613; }","duration":"100.617583ms","start":"2026-05-05T10:15:19.785118Z","end":"2026-05-05T10:15:19.885736Z","steps":["trace[977828629] 'agreement among raft nodes before linearized reading'  (duration: 100.342761ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T10:15:20.454185Z","caller":"traceutil/trace.go:171","msg":"trace[1768013548] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"164.350071ms","start":"2026-05-05T10:15:20.289812Z","end":"2026-05-05T10:15:20.454162Z","steps":["trace[1768013548] 'process raft request'  (duration: 163.844757ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T10:15:20.90115Z","caller":"traceutil/trace.go:171","msg":"trace[1481120771] linearizableReadLoop","detail":"{readStateIndex:635; appliedIndex:634; }","duration":"396.035287ms","start":"2026-05-05T10:15:20.505088Z","end":"2026-05-05T10:15:20.901123Z","steps":["trace[1481120771] 'read index received'  (duration: 395.836586ms)","trace[1481120771] 'applied index is now lower than readState.Index'  (duration: 197.401µs)"],"step_count":2}
{"level":"warn","ts":"2026-05-05T10:15:20.901507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"396.39577ms","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-05T10:15:20.901629Z","caller":"traceutil/trace.go:171","msg":"trace[1868978298] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:618; }","duration":"396.570471ms","start":"2026-05-05T10:15:20.505045Z","end":"2026-05-05T10:15:20.901616Z","steps":["trace[1868978298] 'agreement among raft nodes before linearized reading'  (duration: 396.287399ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T10:15:20.901719Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:15:20.505027Z","time spent":"396.677812ms","remote":"127.0.0.1:42624","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-05-05T10:15:20.901866Z","caller":"traceutil/trace.go:171","msg":"trace[57845627] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"604.610203ms","start":"2026-05-05T10:15:20.297094Z","end":"2026-05-05T10:15:20.901704Z","steps":["trace[57845627] 'process raft request'  (duration: 603.820748ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T10:15:20.902204Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:15:20.297061Z","time spent":"604.929676ms","remote":"127.0.0.1:46124","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/cilium-dz6c6\" mod_revision:500 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-dz6c6\" value_size:17085 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-dz6c6\" > >"}
{"level":"info","ts":"2026-05-05T10:15:21.129819Z","caller":"traceutil/trace.go:171","msg":"trace[1920074986] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"222.771118ms","start":"2026-05-05T10:15:20.907022Z","end":"2026-05-05T10:15:21.129793Z","steps":["trace[1920074986] 'process raft request'  (duration: 222.710188ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T10:15:21.129839Z","caller":"traceutil/trace.go:171","msg":"trace[1401322802] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"615.472473ms","start":"2026-05-05T10:15:20.514309Z","end":"2026-05-05T10:15:21.129782Z","steps":["trace[1401322802] 'process raft request'  (duration: 596.717805ms)","trace[1401322802] 'compare'  (duration: 18.531947ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-05T10:15:21.130425Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:15:20.514297Z","time spent":"616.065847ms","remote":"127.0.0.1:42588","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" mod_revision:0 > success:<request_put:<key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" value_size:2525 >> failure:<>"}
{"level":"warn","ts":"2026-05-05T10:15:21.770547Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.890039ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9038335189079938564 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-6tn88\" mod_revision:0 > success:<request_put:<key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-6tn88\" value_size:2651 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-05-05T10:15:21.770674Z","caller":"traceutil/trace.go:171","msg":"trace[2007605712] linearizableReadLoop","detail":"{readStateIndex:638; appliedIndex:637; }","duration":"442.371579ms","start":"2026-05-05T10:15:21.32827Z","end":"2026-05-05T10:15:21.770641Z","steps":["trace[2007605712] 'read index received'  (duration: 252.338149ms)","trace[2007605712] 'applied index is now lower than readState.Index'  (duration: 190.0321ms)"],"step_count":2}
{"level":"info","ts":"2026-05-05T10:15:21.770736Z","caller":"traceutil/trace.go:171","msg":"trace[664164824] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"623.128593ms","start":"2026-05-05T10:15:21.147588Z","end":"2026-05-05T10:15:21.770717Z","steps":["trace[664164824] 'process raft request'  (duration: 433.006903ms)","trace[664164824] 'compare'  (duration: 189.633887ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-05T10:15:21.770838Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:15:21.147577Z","time spent":"623.229694ms","remote":"127.0.0.1:46124","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2735,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-6tn88\" mod_revision:0 > success:<request_put:<key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-6tn88\" value_size:2651 >> failure:<>"}
{"level":"warn","ts":"2026-05-05T10:15:21.770936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"442.65613ms","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-05T10:15:21.77099Z","caller":"traceutil/trace.go:171","msg":"trace[2071049109] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:621; }","duration":"442.753181ms","start":"2026-05-05T10:15:21.328222Z","end":"2026-05-05T10:15:21.770975Z","steps":["trace[2071049109] 'agreement among raft nodes before linearized reading'  (duration: 442.535249ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T10:15:21.771025Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:15:21.3282Z","time spent":"442.815631ms","remote":"127.0.0.1:42624","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-05-05T10:15:21.770932Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.384021ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-05T10:15:21.77116Z","caller":"traceutil/trace.go:171","msg":"trace[2386543] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:621; }","duration":"245.658153ms","start":"2026-05-05T10:15:21.52549Z","end":"2026-05-05T10:15:21.771148Z","steps":["trace[2386543] 'agreement among raft nodes before linearized reading'  (duration: 245.376691ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T10:15:21.935377Z","caller":"traceutil/trace.go:171","msg":"trace[318232917] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"159.842881ms","start":"2026-05-05T10:15:21.775507Z","end":"2026-05-05T10:15:21.93535Z","steps":["trace[318232917] 'process raft request'  (duration: 159.70536ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T10:15:21.942311Z","caller":"traceutil/trace.go:171","msg":"trace[1025782514] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"166.725488ms","start":"2026-05-05T10:15:21.775561Z","end":"2026-05-05T10:15:21.942286Z","steps":["trace[1025782514] 'process raft request'  (duration: 166.565267ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T10:15:21.942367Z","caller":"traceutil/trace.go:171","msg":"trace[1271845764] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"166.722229ms","start":"2026-05-05T10:15:21.775621Z","end":"2026-05-05T10:15:21.942343Z","steps":["trace[1271845764] 'process raft request'  (duration: 166.628248ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T10:15:21.942762Z","caller":"traceutil/trace.go:171","msg":"trace[1248171965] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"167.101971ms","start":"2026-05-05T10:15:21.775651Z","end":"2026-05-05T10:15:21.942753Z","steps":["trace[1248171965] 'process raft request'  (duration: 166.661118ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T10:15:21.942908Z","caller":"traceutil/trace.go:171","msg":"trace[852573301] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"165.775912ms","start":"2026-05-05T10:15:21.77711Z","end":"2026-05-05T10:15:21.942886Z","steps":["trace[852573301] 'process raft request'  (duration: 165.41879ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T10:15:38.110471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"585.167257ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-05T10:15:38.110587Z","caller":"traceutil/trace.go:171","msg":"trace[1428328638] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:781; }","duration":"585.320669ms","start":"2026-05-05T10:15:37.525242Z","end":"2026-05-05T10:15:38.110563Z","steps":["trace[1428328638] 'range keys from in-memory index tree'  (duration: 585.027656ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T10:15:38.110878Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:15:37.525228Z","time spent":"585.63285ms","remote":"127.0.0.1:45938","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-05-05T10:15:38.110434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"601.22513ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.237\" ","response":"range_response_count:1 size:135"}
{"level":"info","ts":"2026-05-05T10:15:38.1114Z","caller":"traceutil/trace.go:171","msg":"trace[159417583] range","detail":"{range_begin:/registry/masterleases/199.19.213.237; range_end:; response_count:1; response_revision:781; }","duration":"602.237626ms","start":"2026-05-05T10:15:37.509144Z","end":"2026-05-05T10:15:38.111381Z","steps":["trace[159417583] 'range keys from in-memory index tree'  (duration: 601.052988ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T10:15:38.111468Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:15:37.509119Z","time spent":"602.334416ms","remote":"127.0.0.1:45978","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":159,"request content":"key:\"/registry/masterleases/199.19.213.237\" "}
{"level":"info","ts":"2026-05-05T10:15:38.253947Z","caller":"traceutil/trace.go:171","msg":"trace[538401019] transaction","detail":"{read_only:false; response_revision:782; number_of_response:1; }","duration":"138.425504ms","start":"2026-05-05T10:15:38.115495Z","end":"2026-05-05T10:15:38.253921Z","steps":["trace[538401019] 'process raft request'  (duration: 138.162693ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T10:15:38.254238Z","caller":"traceutil/trace.go:171","msg":"trace[1869889978] transaction","detail":"{read_only:false; response_revision:784; number_of_response:1; }","duration":"138.002152ms","start":"2026-05-05T10:15:38.116221Z","end":"2026-05-05T10:15:38.254223Z","steps":["trace[1869889978] 'process raft request'  (duration: 137.890791ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T10:15:38.254268Z","caller":"traceutil/trace.go:171","msg":"trace[232128731] transaction","detail":"{read_only:false; response_revision:783; number_of_response:1; }","duration":"138.206643ms","start":"2026-05-05T10:15:38.116031Z","end":"2026-05-05T10:15:38.254238Z","steps":["trace[232128731] 'process raft request'  (duration: 137.839721ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T10:15:40.566892Z","caller":"traceutil/trace.go:171","msg":"trace[1177845240] transaction","detail":"{read_only:false; response_revision:794; number_of_response:1; }","duration":"157.298417ms","start":"2026-05-05T10:15:40.409562Z","end":"2026-05-05T10:15:40.56686Z","steps":["trace[1177845240] 'process raft request'  (duration: 157.114005ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T10:15:42.001364Z","caller":"traceutil/trace.go:171","msg":"trace[991454020] transaction","detail":"{read_only:false; response_revision:803; number_of_response:1; }","duration":"113.325999ms","start":"2026-05-05T10:15:41.888017Z","end":"2026-05-05T10:15:42.001343Z","steps":["trace[991454020] 'process raft request'  (duration: 95.782119ms)","trace[991454020] 'compare'  (duration: 17.441769ms)"],"step_count":2}
{"level":"info","ts":"2026-05-05T10:15:46.579975Z","caller":"traceutil/trace.go:171","msg":"trace[441861334] transaction","detail":"{read_only:false; response_revision:879; number_of_response:1; }","duration":"108.835148ms","start":"2026-05-05T10:15:46.471108Z","end":"2026-05-05T10:15:46.579943Z","steps":["trace[441861334] 'process raft request'  (duration: 90.531866ms)","trace[441861334] 'compare'  (duration: 18.039191ms)"],"step_count":2}
{"level":"info","ts":"2026-05-05T10:15:46.580084Z","caller":"traceutil/trace.go:171","msg":"trace[858368044] transaction","detail":"{read_only:false; response_revision:880; number_of_response:1; }","duration":"107.380519ms","start":"2026-05-05T10:15:46.472681Z","end":"2026-05-05T10:15:46.580062Z","steps":["trace[858368044] 'process raft request'  (duration: 107.138967ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T10:15:46.580305Z","caller":"traceutil/trace.go:171","msg":"trace[1265988703] transaction","detail":"{read_only:false; response_revision:881; number_of_response:1; }","duration":"107.459989ms","start":"2026-05-05T10:15:46.472829Z","end":"2026-05-05T10:15:46.580289Z","steps":["trace[1265988703] 'process raft request'  (duration: 107.087157ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T10:15:56.759663Z","caller":"traceutil/trace.go:171","msg":"trace[1246911168] transaction","detail":"{read_only:false; response_revision:1082; number_of_response:1; }","duration":"156.737995ms","start":"2026-05-05T10:15:56.602899Z","end":"2026-05-05T10:15:56.759637Z","steps":["trace[1246911168] 'process raft request'  (duration: 146.974917ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T10:15:58.971438Z","caller":"traceutil/trace.go:171","msg":"trace[927588478] transaction","detail":"{read_only:false; response_revision:1118; number_of_response:1; }","duration":"139.470339ms","start":"2026-05-05T10:15:58.831949Z","end":"2026-05-05T10:15:58.971419Z","steps":["trace[927588478] 'process raft request'  (duration: 115.165494ms)","trace[927588478] 'compare'  (duration: 24.017573ms)"],"step_count":2}
{"level":"info","ts":"2026-05-05T10:16:07.774959Z","caller":"traceutil/trace.go:171","msg":"trace[2012717614] linearizableReadLoop","detail":"{readStateIndex:1209; appliedIndex:1208; }","duration":"264.305051ms","start":"2026-05-05T10:16:07.510627Z","end":"2026-05-05T10:16:07.774932Z","steps":["trace[2012717614] 'read index received'  (duration: 191.408566ms)","trace[2012717614] 'applied index is now lower than readState.Index'  (duration: 72.895145ms)"],"step_count":2}
{"level":"info","ts":"2026-05-05T10:16:07.775222Z","caller":"traceutil/trace.go:171","msg":"trace[1656835900] transaction","detail":"{read_only:false; response_revision:1180; number_of_response:1; }","duration":"341.808503ms","start":"2026-05-05T10:16:07.433378Z","end":"2026-05-05T10:16:07.775187Z","steps":["trace[1656835900] 'process raft request'  (duration: 268.725277ms)","trace[1656835900] 'compare'  (duration: 72.653933ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-05T10:16:07.775412Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:16:07.433352Z","time spent":"341.965694ms","remote":"127.0.0.1:42624","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:1168 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"warn","ts":"2026-05-05T10:16:07.775576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.345241ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-05T10:16:07.775617Z","caller":"traceutil/trace.go:171","msg":"trace[17102376] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1180; }","duration":"250.409001ms","start":"2026-05-05T10:16:07.525197Z","end":"2026-05-05T10:16:07.775606Z","steps":["trace[17102376] 'agreement among raft nodes before linearized reading'  (duration: 250.3401ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T10:16:07.77583Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.175667ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.237\" ","response":"range_response_count:1 size:135"}
{"level":"info","ts":"2026-05-05T10:16:07.775901Z","caller":"traceutil/trace.go:171","msg":"trace[1141479515] range","detail":"{range_begin:/registry/masterleases/199.19.213.237; range_end:; response_count:1; response_revision:1180; }","duration":"265.313157ms","start":"2026-05-05T10:16:07.510572Z","end":"2026-05-05T10:16:07.775885Z","steps":["trace[1141479515] 'agreement among raft nodes before linearized reading'  (duration: 264.867854ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T10:16:55.054134Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.644242ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"}
{"level":"warn","ts":"2026-05-05T10:16:55.054165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.29763ms","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-05T10:16:55.054193Z","caller":"traceutil/trace.go:171","msg":"trace[1225523499] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:1845; }","duration":"272.702853ms","start":"2026-05-05T10:16:54.781475Z","end":"2026-05-05T10:16:55.054178Z","steps":["trace[1225523499] 'range keys from in-memory index tree'  (duration: 272.484112ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T10:16:55.054226Z","caller":"traceutil/trace.go:171","msg":"trace[1826581088] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1845; }","duration":"100.403961ms","start":"2026-05-05T10:16:54.953807Z","end":"2026-05-05T10:16:55.054211Z","steps":["trace[1826581088] 'range keys from in-memory index tree'  (duration: 100.104409ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T10:16:55.054246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"374.476241ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-d14301f9-ae05-472f-9f28-0198317e7570\" ","response":"range_response_count:1 size:3627"}
{"level":"info","ts":"2026-05-05T10:16:55.054324Z","caller":"traceutil/trace.go:171","msg":"trace[1652561269] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-d14301f9-ae05-472f-9f28-0198317e7570; range_end:; response_count:1; response_revision:1845; }","duration":"374.609131ms","start":"2026-05-05T10:16:54.679695Z","end":"2026-05-05T10:16:55.054304Z","steps":["trace[1652561269] 'range keys from in-memory index tree'  (duration: 374.212909ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T10:16:55.054362Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:16:54.679667Z","time spent":"374.686882ms","remote":"127.0.0.1:46124","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3651,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-d14301f9-ae05-472f-9f28-0198317e7570\" "}
{"level":"warn","ts":"2026-05-05T10:16:55.0545Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"414.532534ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"warn","ts":"2026-05-05T10:16:55.054553Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"414.329694ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-05-05T10:16:55.054605Z","caller":"traceutil/trace.go:171","msg":"trace[271545663] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1845; }","duration":"414.650925ms","start":"2026-05-05T10:16:54.639888Z","end":"2026-05-05T10:16:55.054539Z","steps":["trace[271545663] 'range keys from in-memory index tree'  (duration: 414.331733ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T10:16:55.054613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"367.422901ms","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-05T10:16:55.054633Z","caller":"traceutil/trace.go:171","msg":"trace[37432336] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1845; }","duration":"414.471304ms","start":"2026-05-05T10:16:54.640147Z","end":"2026-05-05T10:16:55.054618Z","steps":["trace[37432336] 'range keys from in-memory index tree'  (duration: 414.162032ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T10:16:55.054642Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:16:54.639866Z","time spent":"414.767175ms","remote":"127.0.0.1:42624","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-05-05T10:16:55.054647Z","caller":"traceutil/trace.go:171","msg":"trace[1529748646] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1845; }","duration":"367.476021ms","start":"2026-05-05T10:16:54.68716Z","end":"2026-05-05T10:16:55.054636Z","steps":["trace[1529748646] 'range keys from in-memory index tree'  (duration: 367.303571ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T10:16:55.054672Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:16:54.640124Z","time spent":"414.540024ms","remote":"127.0.0.1:42624","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-05-05T10:16:55.054676Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:16:54.68715Z","time spent":"367.519811ms","remote":"127.0.0.1:46674","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5436,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "}
{"level":"warn","ts":"2026-05-05T10:16:55.054112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"410.954934ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-05-05T10:16:55.054807Z","caller":"traceutil/trace.go:171","msg":"trace[698311231] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1845; }","duration":"411.728808ms","start":"2026-05-05T10:16:54.643068Z","end":"2026-05-05T10:16:55.054797Z","steps":["trace[698311231] 'range keys from in-memory index tree'  (duration: 410.750014ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T10:16:55.054846Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:16:54.643021Z","time spent":"411.813709ms","remote":"127.0.0.1:42624","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-05-05T10:16:55.055078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.420432ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-d14301f9-ae05-472f-9f28-0198317e7570\" ","response":"range_response_count:1 size:3627"}
{"level":"info","ts":"2026-05-05T10:16:55.055128Z","caller":"traceutil/trace.go:171","msg":"trace[719686403] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-d14301f9-ae05-472f-9f28-0198317e7570; range_end:; response_count:1; response_revision:1845; }","duration":"292.550813ms","start":"2026-05-05T10:16:54.762566Z","end":"2026-05-05T10:16:55.055117Z","steps":["trace[719686403] 'range keys from in-memory index tree'  (duration: 292.285801ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T10:16:55.159536Z","caller":"traceutil/trace.go:171","msg":"trace[1291639222] transaction","detail":"{read_only:false; response_revision:1846; number_of_response:1; }","duration":"101.369035ms","start":"2026-05-05T10:16:55.058142Z","end":"2026-05-05T10:16:55.159511Z","steps":["trace[1291639222] 'process raft request'  (duration: 101.214395ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T10:16:55.627101Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"344.439032ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9038335189079941010 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:1797 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-05T10:16:55.627603Z","caller":"traceutil/trace.go:171","msg":"trace[1279864512] transaction","detail":"{read_only:false; response_revision:1848; number_of_response:1; }","duration":"569.256356ms","start":"2026-05-05T10:16:55.058322Z","end":"2026-05-05T10:16:55.627578Z","steps":["trace[1279864512] 'process raft request'  (duration: 568.873574ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T10:16:55.627717Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:16:55.058317Z","time spent":"569.355277ms","remote":"127.0.0.1:42624","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:1799 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-05-05T10:16:55.627831Z","caller":"traceutil/trace.go:171","msg":"trace[1320804423] transaction","detail":"{read_only:false; response_revision:1849; number_of_response:1; }","duration":"568.510622ms","start":"2026-05-05T10:16:55.059275Z","end":"2026-05-05T10:16:55.627785Z","steps":["trace[1320804423] 'process raft request'  (duration: 567.969058ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T10:16:55.627889Z","caller":"traceutil/trace.go:171","msg":"trace[1087273135] transaction","detail":"{read_only:false; response_revision:1847; number_of_response:1; }","duration":"569.684699ms","start":"2026-05-05T10:16:55.05817Z","end":"2026-05-05T10:16:55.627855Z","steps":["trace[1087273135] 'process raft request'  (duration: 224.382432ms)","trace[1087273135] 'compare'  (duration: 344.339311ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-05T10:16:55.628028Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:16:55.059267Z","time spent":"568.639324ms","remote":"127.0.0.1:42624","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:1819 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:464 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-05-05T10:16:55.628058Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:16:55.058152Z","time spent":"569.8059ms","remote":"127.0.0.1:42624","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:1797 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-05-05T10:16:55.628301Z","caller":"traceutil/trace.go:171","msg":"trace[445552654] transaction","detail":"{read_only:false; response_revision:1850; number_of_response:1; }","duration":"566.33662ms","start":"2026-05-05T10:16:55.061952Z","end":"2026-05-05T10:16:55.628288Z","steps":["trace[445552654] 'process raft request'  (duration: 565.778767ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T10:16:55.62837Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:16:55.061942Z","time spent":"566.39378ms","remote":"127.0.0.1:46124","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3732,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-d14301f9-ae05-472f-9f28-0198317e7570\" mod_revision:1804 > success:<request_put:<key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-d14301f9-ae05-472f-9f28-0198317e7570\" value_size:3632 >> failure:<request_range:<key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-d14301f9-ae05-472f-9f28-0198317e7570\" > >"}
{"level":"info","ts":"2026-05-05T10:16:55.628479Z","caller":"traceutil/trace.go:171","msg":"trace[1225752668] linearizableReadLoop","detail":"{readStateIndex:1915; appliedIndex:1911; }","duration":"102.250441ms","start":"2026-05-05T10:16:55.526214Z","end":"2026-05-05T10:16:55.628464Z","steps":["trace[1225752668] 'read index received'  (duration: 46.54µs)","trace[1225752668] 'applied index is now lower than readState.Index'  (duration: 102.202821ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-05T10:16:55.628597Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.386281ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-05T10:16:55.628635Z","caller":"traceutil/trace.go:171","msg":"trace[978544110] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1851; }","duration":"102.493222ms","start":"2026-05-05T10:16:55.526133Z","end":"2026-05-05T10:16:55.628626Z","steps":["trace[978544110] 'agreement among raft nodes before linearized reading'  (duration: 102.428962ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T10:17:01.06041Z","caller":"traceutil/trace.go:171","msg":"trace[1429691824] linearizableReadLoop","detail":"{readStateIndex:1973; appliedIndex:1972; }","duration":"213.431089ms","start":"2026-05-05T10:17:00.846953Z","end":"2026-05-05T10:17:01.060384Z","steps":["trace[1429691824] 'read index received'  (duration: 213.118177ms)","trace[1429691824] 'applied index is now lower than readState.Index'  (duration: 311.832µs)"],"step_count":2}
{"level":"info","ts":"2026-05-05T10:17:01.060476Z","caller":"traceutil/trace.go:171","msg":"trace[1847502099] transaction","detail":"{read_only:false; response_revision:1906; number_of_response:1; }","duration":"245.691949ms","start":"2026-05-05T10:17:00.814739Z","end":"2026-05-05T10:17:01.06043Z","steps":["trace[1847502099] 'process raft request'  (duration: 245.442298ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T10:17:01.060618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.63518ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:1853"}
{"level":"info","ts":"2026-05-05T10:17:01.060667Z","caller":"traceutil/trace.go:171","msg":"trace[613000155] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:1906; }","duration":"213.73147ms","start":"2026-05-05T10:17:00.846918Z","end":"2026-05-05T10:17:01.060649Z","steps":["trace[613000155] 'agreement among raft nodes before linearized reading'  (duration: 213.566779ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T10:17:02.263589Z","caller":"traceutil/trace.go:171","msg":"trace[76570106] transaction","detail":"{read_only:false; response_revision:1919; number_of_response:1; }","duration":"156.29728ms","start":"2026-05-05T10:17:02.107271Z","end":"2026-05-05T10:17:02.263568Z","steps":["trace[76570106] 'process raft request'  (duration: 156.160789ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T10:17:07.34428Z","caller":"traceutil/trace.go:171","msg":"trace[1333893488] transaction","detail":"{read_only:false; response_revision:1946; number_of_response:1; }","duration":"128.838176ms","start":"2026-05-05T10:17:07.215407Z","end":"2026-05-05T10:17:07.344245Z","steps":["trace[1333893488] 'process raft request'  (duration: 128.585445ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T10:17:18.240591Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9038335189079941366,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-05-05T10:17:18.430138Z","caller":"traceutil/trace.go:171","msg":"trace[1884837979] transaction","detail":"{read_only:false; response_revision:2011; number_of_response:1; }","duration":"732.337911ms","start":"2026-05-05T10:17:17.697771Z","end":"2026-05-05T10:17:18.430109Z","steps":["trace[1884837979] 'process raft request'  (duration: 731.552656ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T10:17:18.430298Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:17:17.697751Z","time spent":"732.466731ms","remote":"127.0.0.1:42624","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:1997 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:459 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"info","ts":"2026-05-05T10:17:18.433303Z","caller":"traceutil/trace.go:171","msg":"trace[710194451] linearizableReadLoop","detail":"{readStateIndex:2083; appliedIndex:2082; }","duration":"692.958452ms","start":"2026-05-05T10:17:17.740301Z","end":"2026-05-05T10:17:18.433259Z","steps":["trace[710194451] 'read index received'  (duration: 689.849755ms)","trace[710194451] 'applied index is now lower than readState.Index'  (duration: 3.107757ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-05T10:17:18.433531Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"693.232515ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-05-05T10:17:18.433579Z","caller":"traceutil/trace.go:171","msg":"trace[962712043] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2013; }","duration":"693.326665ms","start":"2026-05-05T10:17:17.740241Z","end":"2026-05-05T10:17:18.433568Z","steps":["trace[962712043] 'agreement among raft nodes before linearized reading'  (duration: 693.143714ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T10:17:18.433611Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:17:17.740222Z","time spent":"693.380816ms","remote":"127.0.0.1:42624","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-05-05T10:17:18.433757Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"691.194373ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-05-05T10:17:18.433818Z","caller":"traceutil/trace.go:171","msg":"trace[761579972] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2013; }","duration":"691.318714ms","start":"2026-05-05T10:17:17.742482Z","end":"2026-05-05T10:17:18.4338Z","steps":["trace[761579972] 'agreement among raft nodes before linearized reading'  (duration: 691.017872ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T10:17:18.433948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.548709ms","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-05T10:17:18.433987Z","caller":"traceutil/trace.go:171","msg":"trace[1358618878] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2013; }","duration":"102.615169ms","start":"2026-05-05T10:17:18.331362Z","end":"2026-05-05T10:17:18.433977Z","steps":["trace[1358618878] 'agreement among raft nodes before linearized reading'  (duration: 102.478589ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T10:17:18.434004Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"672.62298ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"}
{"level":"info","ts":"2026-05-05T10:17:18.434032Z","caller":"traceutil/trace.go:171","msg":"trace[861156716] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2013; }","duration":"672.67198ms","start":"2026-05-05T10:17:17.76135Z","end":"2026-05-05T10:17:18.434022Z","steps":["trace[861156716] 'agreement among raft nodes before linearized reading'  (duration: 672.607129ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T10:17:18.434053Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:17:17.761339Z","time spent":"672.70929ms","remote":"127.0.0.1:42624","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":579,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "}
{"level":"warn","ts":"2026-05-05T10:17:18.433969Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:17:17.742462Z","time spent":"691.490924ms","remote":"127.0.0.1:42624","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-05-05T10:17:18.434136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"460.813795ms","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-05T10:17:18.434157Z","caller":"traceutil/trace.go:171","msg":"trace[1691761159] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2013; }","duration":"460.870515ms","start":"2026-05-05T10:17:17.973281Z","end":"2026-05-05T10:17:18.434152Z","steps":["trace[1691761159] 'agreement among raft nodes before linearized reading'  (duration: 460.809565ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T10:17:18.434177Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:17:17.97326Z","time spent":"460.908376ms","remote":"127.0.0.1:46124","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12013,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "}
{"level":"warn","ts":"2026-05-05T10:17:18.434321Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.231876ms","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-05T10:17:18.434455Z","caller":"traceutil/trace.go:171","msg":"trace[1368461586] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2013; }","duration":"228.401487ms","start":"2026-05-05T10:17:18.206038Z","end":"2026-05-05T10:17:18.434439Z","steps":["trace[1368461586] 'agreement among raft nodes before linearized reading'  (duration: 227.666713ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T10:17:18.433344Z","caller":"traceutil/trace.go:171","msg":"trace[900131493] transaction","detail":"{read_only:false; response_revision:2012; number_of_response:1; }","duration":"466.992159ms","start":"2026-05-05T10:17:17.966297Z","end":"2026-05-05T10:17:18.43329Z","steps":["trace[900131493] 'process raft request'  (duration: 466.761878ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T10:17:18.43448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"688.733419ms","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-05T10:17:18.434641Z","caller":"traceutil/trace.go:171","msg":"trace[2147391701] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2013; }","duration":"688.9167ms","start":"2026-05-05T10:17:17.745714Z","end":"2026-05-05T10:17:18.434631Z","steps":["trace[2147391701] 'agreement among raft nodes before linearized reading'  (duration: 688.698499ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T10:17:18.434675Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:17:17.745703Z","time spent":"688.96396ms","remote":"127.0.0.1:42624","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-05-05T10:17:18.435388Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:17:17.966279Z","time spent":"468.286796ms","remote":"127.0.0.1:42624","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:2002 > 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-05T10:17:23.160524Z","caller":"traceutil/trace.go:171","msg":"trace[28063916] linearizableReadLoop","detail":"{readStateIndex:2123; appliedIndex:2122; }","duration":"175.664083ms","start":"2026-05-05T10:17:22.98484Z","end":"2026-05-05T10:17:23.160504Z","steps":["trace[28063916] 'read index received'  (duration: 175.469402ms)","trace[28063916] 'applied index is now lower than readState.Index'  (duration: 193.831µs)"],"step_count":2}
{"level":"info","ts":"2026-05-05T10:17:23.160656Z","caller":"traceutil/trace.go:171","msg":"trace[1319303542] transaction","detail":"{read_only:false; response_revision:2051; number_of_response:1; }","duration":"303.22255ms","start":"2026-05-05T10:17:22.857406Z","end":"2026-05-05T10:17:23.160629Z","steps":["trace[1319303542] 'process raft request'  (duration: 302.960109ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T10:17:23.160853Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:17:22.857395Z","time spent":"303.362791ms","remote":"127.0.0.1:46028","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":831,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/events/openstack/percona-xtradb-haproxy-0.18aca3f8588fe047\" mod_revision:2030 > success:<request_put:<key:\"/registry/events/openstack/percona-xtradb-haproxy-0.18aca3f8588fe047\" value_size:745 lease:9038335189079940830 >> failure:<request_range:<key:\"/registry/events/openstack/percona-xtradb-haproxy-0.18aca3f8588fe047\" > >"}
{"level":"warn","ts":"2026-05-05T10:17:23.160916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.055605ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:1853"}
{"level":"info","ts":"2026-05-05T10:17:23.161034Z","caller":"traceutil/trace.go:171","msg":"trace[1416765579] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2051; }","duration":"176.199216ms","start":"2026-05-05T10:17:22.984811Z","end":"2026-05-05T10:17:23.16101Z","steps":["trace[1416765579] 'agreement among raft nodes before linearized reading'  (duration: 175.802544ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T10:17:29.584186Z","caller":"traceutil/trace.go:171","msg":"trace[906425249] transaction","detail":"{read_only:false; response_revision:2084; number_of_response:1; }","duration":"129.790848ms","start":"2026-05-05T10:17:29.454371Z","end":"2026-05-05T10:17:29.584162Z","steps":["trace[906425249] 'process raft request'  (duration: 129.574677ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T10:17:30.837755Z","caller":"traceutil/trace.go:171","msg":"trace[992161200] transaction","detail":"{read_only:false; response_revision:2085; number_of_response:1; }","duration":"358.218963ms","start":"2026-05-05T10:17:30.479511Z","end":"2026-05-05T10:17:30.83773Z","steps":["trace[992161200] 'process raft request'  (duration: 358.058441ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T10:17:30.837912Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:17:30.479496Z","time spent":"358.334303ms","remote":"127.0.0.1:42624","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:2074 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:459 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"warn","ts":"2026-05-05T10:17:31.294815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.787688ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9038335189079941544 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" mod_revision:1996 > 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\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-05T10:17:31.295591Z","caller":"traceutil/trace.go:171","msg":"trace[1560531940] transaction","detail":"{read_only:false; response_revision:2086; number_of_response:1; }","duration":"812.743146ms","start":"2026-05-05T10:17:30.482799Z","end":"2026-05-05T10:17:31.295542Z","steps":["trace[1560531940] 'process raft request'  (duration: 550.144384ms)","trace[1560531940] 'compare'  (duration: 261.322596ms)"],"step_count":2}
{"level":"info","ts":"2026-05-05T10:17:31.295653Z","caller":"traceutil/trace.go:171","msg":"trace[1868465118] transaction","detail":"{read_only:false; response_revision:2087; number_of_response:1; }","duration":"810.305833ms","start":"2026-05-05T10:17:30.485328Z","end":"2026-05-05T10:17:31.295634Z","steps":["trace[1868465118] 'process raft request'  (duration: 809.564079ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T10:17:31.295737Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:17:30.485318Z","time spent":"810.378993ms","remote":"127.0.0.1:42624","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:2075 > 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-05T10:17:31.295749Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:17:30.48277Z","time spent":"812.893288ms","remote":"127.0.0.1:42624","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":544,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" mod_revision:1996 > 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-05T10:17:31.295844Z","caller":"traceutil/trace.go:171","msg":"trace[1489664642] linearizableReadLoop","detail":"{readStateIndex:2160; appliedIndex:2157; }","duration":"802.855193ms","start":"2026-05-05T10:17:30.492967Z","end":"2026-05-05T10:17:31.295822Z","steps":["trace[1489664642] 'read index received'  (duration: 344.654008ms)","trace[1489664642] 'applied index is now lower than readState.Index'  (duration: 458.199865ms)"],"step_count":2}
{"level":"info","ts":"2026-05-05T10:17:31.295954Z","caller":"traceutil/trace.go:171","msg":"trace[1276408766] transaction","detail":"{read_only:false; response_revision:2088; number_of_response:1; }","duration":"687.611654ms","start":"2026-05-05T10:17:30.608328Z","end":"2026-05-05T10:17:31.29594Z","steps":["trace[1276408766] 'process raft request'  (duration: 687.242193ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T10:17:31.296044Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:17:30.608311Z","time spent":"687.675705ms","remote":"127.0.0.1:42624","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:2082 > 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-05T10:17:31.296119Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"793.264959ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"}
{"level":"warn","ts":"2026-05-05T10:17:31.296156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"764.167039ms","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-05T10:17:31.296169Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"729.030194ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-05-05T10:17:31.296195Z","caller":"traceutil/trace.go:171","msg":"trace[1321396651] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2088; }","duration":"764.205089ms","start":"2026-05-05T10:17:30.531978Z","end":"2026-05-05T10:17:31.296183Z","steps":["trace[1321396651] 'agreement among raft nodes before linearized reading'  (duration: 764.079828ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T10:17:31.296191Z","caller":"traceutil/trace.go:171","msg":"trace[724747226] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2088; }","duration":"793.37242ms","start":"2026-05-05T10:17:30.502794Z","end":"2026-05-05T10:17:31.296167Z","steps":["trace[724747226] 'agreement among raft nodes before linearized reading'  (duration: 793.161589ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T10:17:31.296225Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:17:30.531941Z","time spent":"764.276639ms","remote":"127.0.0.1:42624","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-05-05T10:17:31.296206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"676.936885ms","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":"info","ts":"2026-05-05T10:17:31.296222Z","caller":"traceutil/trace.go:171","msg":"trace[1248852447] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2088; }","duration":"729.104644ms","start":"2026-05-05T10:17:30.567102Z","end":"2026-05-05T10:17:31.296207Z","steps":["trace[1248852447] 'agreement among raft nodes before linearized reading'  (duration: 728.946833ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T10:17:31.296266Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:17:30.502774Z","time spent":"793.4753ms","remote":"127.0.0.1:42624","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":579,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "}
{"level":"warn","ts":"2026-05-05T10:17:31.296275Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"729.724937ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"warn","ts":"2026-05-05T10:17:31.296302Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:17:30.567086Z","time spent":"729.209534ms","remote":"127.0.0.1:42624","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-05-05T10:17:31.296312Z","caller":"traceutil/trace.go:171","msg":"trace[531185371] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2088; }","duration":"729.795977ms","start":"2026-05-05T10:17:30.566507Z","end":"2026-05-05T10:17:31.296303Z","steps":["trace[531185371] 'agreement among raft nodes before linearized reading'  (duration: 729.667117ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T10:17:31.296307Z","caller":"traceutil/trace.go:171","msg":"trace[668775035] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:2088; }","duration":"677.100556ms","start":"2026-05-05T10:17:30.619181Z","end":"2026-05-05T10:17:31.296282Z","steps":["trace[668775035] 'agreement among raft nodes before linearized reading'  (duration: 676.884245ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T10:17:31.296338Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:17:30.566491Z","time spent":"729.842327ms","remote":"127.0.0.1:42624","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-05-05T10:17:31.296351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"703.227161ms","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-05T10:17:31.2964Z","caller":"traceutil/trace.go:171","msg":"trace[71726426] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2088; }","duration":"703.294202ms","start":"2026-05-05T10:17:30.593088Z","end":"2026-05-05T10:17:31.296382Z","steps":["trace[71726426] 'agreement among raft nodes before linearized reading'  (duration: 703.159741ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T10:17:31.296409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"803.442296ms","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-05T10:17:31.296438Z","caller":"traceutil/trace.go:171","msg":"trace[247630693] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2088; }","duration":"803.502226ms","start":"2026-05-05T10:17:30.492927Z","end":"2026-05-05T10:17:31.29643Z","steps":["trace[247630693] 'agreement among raft nodes before linearized reading'  (duration: 803.427446ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T10:17:31.29644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"771.625269ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-05-05T10:17:31.296465Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:17:30.492911Z","time spent":"803.546276ms","remote":"127.0.0.1:42624","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-05T10:17:31.296368Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:17:30.619155Z","time spent":"677.201477ms","remote":"127.0.0.1:42666","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":29,"request content":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true "}
{"level":"warn","ts":"2026-05-05T10:17:31.296443Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:17:30.593075Z","time spent":"703.356592ms","remote":"127.0.0.1:46674","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5436,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "}
{"level":"info","ts":"2026-05-05T10:17:31.296499Z","caller":"traceutil/trace.go:171","msg":"trace[1856224000] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2088; }","duration":"771.702689ms","start":"2026-05-05T10:17:30.524771Z","end":"2026-05-05T10:17:31.296474Z","steps":["trace[1856224000] 'agreement among raft nodes before linearized reading'  (duration: 771.627429ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T10:17:31.29654Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:17:30.524755Z","time spent":"771.774049ms","remote":"127.0.0.1:45938","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-05-05T10:17:31.470006Z","caller":"traceutil/trace.go:171","msg":"trace[1727342061] transaction","detail":"{read_only:false; response_revision:2089; number_of_response:1; }","duration":"168.977964ms","start":"2026-05-05T10:17:31.301006Z","end":"2026-05-05T10:17:31.469984Z","steps":["trace[1727342061] 'process raft request'  (duration: 168.820573ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T10:17:31.501792Z","caller":"traceutil/trace.go:171","msg":"trace[958394152] transaction","detail":"{read_only:false; response_revision:2090; number_of_response:1; }","duration":"199.390314ms","start":"2026-05-05T10:17:31.302375Z","end":"2026-05-05T10:17:31.501765Z","steps":["trace[958394152] 'process raft request'  (duration: 199.107751ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T10:17:31.501919Z","caller":"traceutil/trace.go:171","msg":"trace[299391604] transaction","detail":"{read_only:false; response_revision:2092; number_of_response:1; }","duration":"199.277393ms","start":"2026-05-05T10:17:31.302634Z","end":"2026-05-05T10:17:31.501911Z","steps":["trace[299391604] 'process raft request'  (duration: 199.047101ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T10:17:31.501791Z","caller":"traceutil/trace.go:171","msg":"trace[845616022] transaction","detail":"{read_only:false; response_revision:2091; number_of_response:1; }","duration":"199.323094ms","start":"2026-05-05T10:17:31.302449Z","end":"2026-05-05T10:17:31.501772Z","steps":["trace[845616022] 'process raft request'  (duration: 199.177563ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T10:17:31.502049Z","caller":"traceutil/trace.go:171","msg":"trace[1178249382] transaction","detail":"{read_only:false; response_revision:2093; number_of_response:1; }","duration":"198.742399ms","start":"2026-05-05T10:17:31.303286Z","end":"2026-05-05T10:17:31.502029Z","steps":["trace[1178249382] 'process raft request'  (duration: 198.582008ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T10:17:31.788797Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.846586ms","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-05T10:17:31.78889Z","caller":"traceutil/trace.go:171","msg":"trace[1931505010] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2093; }","duration":"200.012576ms","start":"2026-05-05T10:17:31.588856Z","end":"2026-05-05T10:17:31.788869Z","steps":["trace[1931505010] 'range keys from in-memory index tree'  (duration: 199.571364ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T10:18:28.396412Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.252729ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9038335189079942416 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/endpointslices/openstack/memcached-2v5ks\" mod_revision:2407 > success:<request_put:<key:\"/registry/endpointslices/openstack/memcached-2v5ks\" value_size:981 >> failure:<request_range:<key:\"/registry/endpointslices/openstack/memcached-2v5ks\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-05T10:18:28.396654Z","caller":"traceutil/trace.go:171","msg":"trace[421035966] transaction","detail":"{read_only:false; response_revision:2448; number_of_response:1; }","duration":"198.397744ms","start":"2026-05-05T10:18:28.198234Z","end":"2026-05-05T10:18:28.396632Z","steps":["trace[421035966] 'process raft request'  (duration: 198.349924ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T10:18:28.396663Z","caller":"traceutil/trace.go:171","msg":"trace[2082634305] transaction","detail":"{read_only:false; response_revision:2447; number_of_response:1; }","duration":"198.754426ms","start":"2026-05-05T10:18:28.197887Z","end":"2026-05-05T10:18:28.396641Z","steps":["trace[2082634305] 'process raft request'  (duration: 198.632196ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T10:18:28.396662Z","caller":"traceutil/trace.go:171","msg":"trace[972021039] transaction","detail":"{read_only:false; response_revision:2446; number_of_response:1; }","duration":"198.803316ms","start":"2026-05-05T10:18:28.197815Z","end":"2026-05-05T10:18:28.396618Z","steps":["trace[972021039] 'process raft request'  (duration: 95.248955ms)","trace[972021039] 'compare'  (duration: 103.098368ms)"],"step_count":2}
{"level":"info","ts":"2026-05-05T10:19:09.755673Z","caller":"traceutil/trace.go:171","msg":"trace[1700304338] transaction","detail":"{read_only:false; response_revision:2723; number_of_response:1; }","duration":"102.786627ms","start":"2026-05-05T10:19:09.652861Z","end":"2026-05-05T10:19:09.755647Z","steps":["trace[1700304338] 'process raft request'  (duration: 102.648626ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T10:19:09.891551Z","caller":"traceutil/trace.go:171","msg":"trace[536574845] transaction","detail":"{read_only:false; response_revision:2724; number_of_response:1; }","duration":"176.817544ms","start":"2026-05-05T10:19:09.714712Z","end":"2026-05-05T10:19:09.891529Z","steps":["trace[536574845] 'process raft request'  (duration: 141.35229ms)","trace[536574845] 'compare'  (duration: 35.141923ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-05T10:19:10.673453Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"496.942059ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9038335189079943141 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:2716 > 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-05T10:19:10.673609Z","caller":"traceutil/trace.go:171","msg":"trace[1279570872] linearizableReadLoop","detail":"{readStateIndex:2823; appliedIndex:2820; }","duration":"677.076351ms","start":"2026-05-05T10:19:09.996522Z","end":"2026-05-05T10:19:10.673598Z","steps":["trace[1279570872] 'read index received'  (duration: 179.958391ms)","trace[1279570872] 'applied index is now lower than readState.Index'  (duration: 497.11723ms)"],"step_count":2}
{"level":"info","ts":"2026-05-05T10:19:10.673652Z","caller":"traceutil/trace.go:171","msg":"trace[1566934546] transaction","detail":"{read_only:false; response_revision:2726; number_of_response:1; }","duration":"687.64787ms","start":"2026-05-05T10:19:09.985974Z","end":"2026-05-05T10:19:10.673622Z","steps":["trace[1566934546] 'process raft request'  (duration: 687.55299ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T10:19:10.673759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"677.235962ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"}
{"level":"info","ts":"2026-05-05T10:19:10.673777Z","caller":"traceutil/trace.go:171","msg":"trace[1916000290] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2727; }","duration":"677.270032ms","start":"2026-05-05T10:19:09.996502Z","end":"2026-05-05T10:19:10.673772Z","steps":["trace[1916000290] 'agreement among raft nodes before linearized reading'  (duration: 677.197772ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T10:19:10.6738Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:19:09.996493Z","time spent":"677.302812ms","remote":"127.0.0.1:42624","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":463,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-05-05T10:19:10.673799Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:19:09.98595Z","time spent":"687.769901ms","remote":"127.0.0.1:46028","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":766,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/events/auth-system/keycloak-0.18aca40d4f9828eb\" mod_revision:2702 > success:<request_put:<key:\"/registry/events/auth-system/keycloak-0.18aca40d4f9828eb\" value_size:692 lease:9038335189079942908 >> failure:<request_range:<key:\"/registry/events/auth-system/keycloak-0.18aca40d4f9828eb\" > >"}
{"level":"info","ts":"2026-05-05T10:19:10.673865Z","caller":"traceutil/trace.go:171","msg":"trace[433200710] transaction","detail":"{read_only:false; response_revision:2725; number_of_response:1; }","duration":"687.924791ms","start":"2026-05-05T10:19:09.985933Z","end":"2026-05-05T10:19:10.673858Z","steps":["trace[433200710] 'process raft request'  (duration: 190.51912ms)","trace[433200710] 'compare'  (duration: 496.643417ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-05T10:19:10.673892Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:19:09.985914Z","time spent":"687.964832ms","remote":"127.0.0.1:42624","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:2716 > 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-05T10:19:10.673689Z","caller":"traceutil/trace.go:171","msg":"trace[1837700615] transaction","detail":"{read_only:false; response_revision:2727; number_of_response:1; }","duration":"686.135243ms","start":"2026-05-05T10:19:09.987547Z","end":"2026-05-05T10:19:10.673682Z","steps":["trace[1837700615] 'process raft request'  (duration: 686.027932ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T10:19:10.673942Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:19:09.98754Z","time spent":"686.388214ms","remote":"127.0.0.1:42624","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:2717 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-05-05T10:19:10.687538Z","caller":"traceutil/trace.go:171","msg":"trace[837971867] transaction","detail":"{read_only:false; response_revision:2728; number_of_response:1; }","duration":"255.500487ms","start":"2026-05-05T10:19:10.431978Z","end":"2026-05-05T10:19:10.687478Z","steps":["trace[837971867] 'process raft request'  (duration: 255.349497ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T10:19:10.687553Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.091972ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-05T10:19:10.687631Z","caller":"traceutil/trace.go:171","msg":"trace[1729925028] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2728; }","duration":"160.215002ms","start":"2026-05-05T10:19:10.527397Z","end":"2026-05-05T10:19:10.687612Z","steps":["trace[1729925028] 'agreement among raft nodes before linearized reading'  (duration: 160.102882ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T10:19:10.687693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"439.232599ms","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-05T10:19:10.687739Z","caller":"traceutil/trace.go:171","msg":"trace[427178530] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2728; }","duration":"439.302801ms","start":"2026-05-05T10:19:10.248421Z","end":"2026-05-05T10:19:10.687724Z","steps":["trace[427178530] 'agreement among raft nodes before linearized reading'  (duration: 439.18442ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T10:19:10.687768Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:19:10.248406Z","time spent":"439.353231ms","remote":"127.0.0.1:42624","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-05-05T10:19:10.687864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.605314ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-05-05T10:19:10.687891Z","caller":"traceutil/trace.go:171","msg":"trace[1640953938] range","detail":"{range_begin:/registry/deployments/; range_end:/registry/deployments0; response_count:0; response_revision:2728; }","duration":"325.670965ms","start":"2026-05-05T10:19:10.362211Z","end":"2026-05-05T10:19:10.687882Z","steps":["trace[1640953938] 'agreement among raft nodes before linearized reading'  (duration: 325.614064ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T10:19:10.687917Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:19:10.36219Z","time spent":"325.718825ms","remote":"127.0.0.1:42824","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":12,"response size":31,"request content":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true "}
{"level":"warn","ts":"2026-05-05T10:19:10.687949Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"636.238697ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:554"}
{"level":"info","ts":"2026-05-05T10:19:10.68802Z","caller":"traceutil/trace.go:171","msg":"trace[516876535] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2728; }","duration":"636.344978ms","start":"2026-05-05T10:19:10.051663Z","end":"2026-05-05T10:19:10.688008Z","steps":["trace[516876535] 'agreement among raft nodes before linearized reading'  (duration: 636.172886ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T10:19:10.688055Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:19:10.05164Z","time spent":"636.403208ms","remote":"127.0.0.1:42624","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":578,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "}
{"level":"warn","ts":"2026-05-05T10:19:10.688119Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"426.735603ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-05-05T10:19:10.688157Z","caller":"traceutil/trace.go:171","msg":"trace[1088975310] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; response_count:0; response_revision:2728; }","duration":"426.795363ms","start":"2026-05-05T10:19:10.261353Z","end":"2026-05-05T10:19:10.688148Z","steps":["trace[1088975310] 'agreement among raft nodes before linearized reading'  (duration: 426.736993ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T10:19:10.688188Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:19:10.261344Z","time spent":"426.834453ms","remote":"127.0.0.1:42746","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":31,"request content":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true "}
{"level":"warn","ts":"2026-05-05T10:19:10.688198Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"690.853818ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"}
{"level":"info","ts":"2026-05-05T10:19:10.68823Z","caller":"traceutil/trace.go:171","msg":"trace[318698876] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2728; }","duration":"690.895838ms","start":"2026-05-05T10:19:09.997325Z","end":"2026-05-05T10:19:10.688221Z","steps":["trace[318698876] 'agreement among raft nodes before linearized reading'  (duration: 690.809198ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T10:19:10.688262Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:19:09.997321Z","time spent":"690.934129ms","remote":"127.0.0.1:42624","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-05-05T10:19:15.916656Z","caller":"traceutil/trace.go:171","msg":"trace[1830538151] transaction","detail":"{read_only:false; response_revision:2756; number_of_response:1; }","duration":"143.763442ms","start":"2026-05-05T10:19:15.772867Z","end":"2026-05-05T10:19:15.91663Z","steps":["trace[1830538151] 'process raft request'  (duration: 143.609411ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T10:19:56.487613Z","caller":"traceutil/trace.go:171","msg":"trace[315554500] transaction","detail":"{read_only:false; response_revision:2969; number_of_response:1; }","duration":"112.822752ms","start":"2026-05-05T10:19:56.374766Z","end":"2026-05-05T10:19:56.487589Z","steps":["trace[315554500] 'process raft request'  (duration: 112.671222ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T10:20:04.308428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.554814ms","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-05T10:20:04.308509Z","caller":"traceutil/trace.go:171","msg":"trace[1233568912] range","detail":"{range_begin:/registry/cert-manager.io/certificates/; range_end:/registry/cert-manager.io/certificates0; response_count:0; response_revision:3009; }","duration":"205.688964ms","start":"2026-05-05T10:20:04.102801Z","end":"2026-05-05T10:20:04.30849Z","steps":["trace[1233568912] 'count revisions from in-memory index tree'  (duration: 205.471663ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T10:20:04.309121Z","caller":"traceutil/trace.go:171","msg":"trace[31011806] transaction","detail":"{read_only:false; response_revision:3011; number_of_response:1; }","duration":"119.84835ms","start":"2026-05-05T10:20:04.189255Z","end":"2026-05-05T10:20:04.309104Z","steps":["trace[31011806] 'process raft request'  (duration: 119.8057ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T10:20:04.309433Z","caller":"traceutil/trace.go:171","msg":"trace[354292579] transaction","detail":"{read_only:false; response_revision:3010; number_of_response:1; }","duration":"121.131257ms","start":"2026-05-05T10:20:04.18828Z","end":"2026-05-05T10:20:04.309412Z","steps":["trace[354292579] 'process raft request'  (duration: 75.512786ms)","trace[354292579] 'compare'  (duration: 45.133189ms)"],"step_count":2}
{"level":"info","ts":"2026-05-05T10:20:25.356222Z","caller":"traceutil/trace.go:171","msg":"trace[1004328773] linearizableReadLoop","detail":"{readStateIndex:3228; appliedIndex:3227; }","duration":"317.435429ms","start":"2026-05-05T10:20:25.038752Z","end":"2026-05-05T10:20:25.356187Z","steps":["trace[1004328773] 'read index received'  (duration: 317.188198ms)","trace[1004328773] 'applied index is now lower than readState.Index'  (duration: 246.121µs)"],"step_count":2}
{"level":"info","ts":"2026-05-05T10:20:25.356308Z","caller":"traceutil/trace.go:171","msg":"trace[505863477] transaction","detail":"{read_only:false; response_revision:3116; number_of_response:1; }","duration":"370.30572ms","start":"2026-05-05T10:20:24.985949Z","end":"2026-05-05T10:20:25.356255Z","steps":["trace[505863477] 'process raft request'  (duration: 370.076069ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T10:20:25.356485Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:20:24.98589Z","time spent":"370.482401ms","remote":"127.0.0.1:46028","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":766,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/events/auth-system/keycloak-0.18aca40d4f9828eb\" mod_revision:3094 > success:<request_put:<key:\"/registry/events/auth-system/keycloak-0.18aca40d4f9828eb\" value_size:692 lease:9038335189079943901 >> failure:<request_range:<key:\"/registry/events/auth-system/keycloak-0.18aca40d4f9828eb\" > >"}
{"level":"warn","ts":"2026-05-05T10:20:25.356582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.827451ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"}
{"level":"info","ts":"2026-05-05T10:20:25.356642Z","caller":"traceutil/trace.go:171","msg":"trace[1854849632] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:3116; }","duration":"317.934571ms","start":"2026-05-05T10:20:25.038692Z","end":"2026-05-05T10:20:25.356626Z","steps":["trace[1854849632] 'agreement among raft nodes before linearized reading'  (duration: 317.67407ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T10:20:25.356682Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:20:25.038669Z","time spent":"318.002392ms","remote":"127.0.0.1:46124","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12240,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "}
{"level":"warn","ts":"2026-05-05T10:20:25.356832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.406345ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-05-05T10:20:25.357142Z","caller":"traceutil/trace.go:171","msg":"trace[1291932408] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:3116; }","duration":"162.737467ms","start":"2026-05-05T10:20:25.194379Z","end":"2026-05-05T10:20:25.357116Z","steps":["trace[1291932408] 'agreement among raft nodes before linearized reading'  (duration: 162.321665ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T10:20:25.357243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.815431ms","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-05T10:20:25.357704Z","caller":"traceutil/trace.go:171","msg":"trace[455617666] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:3116; }","duration":"171.312366ms","start":"2026-05-05T10:20:25.186344Z","end":"2026-05-05T10:20:25.357657Z","steps":["trace[455617666] 'agreement among raft nodes before linearized reading'  (duration: 170.34877ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T10:20:25.581109Z","caller":"traceutil/trace.go:171","msg":"trace[1850176896] transaction","detail":"{read_only:false; response_revision:3120; number_of_response:1; }","duration":"184.803258ms","start":"2026-05-05T10:20:25.396275Z","end":"2026-05-05T10:20:25.581078Z","steps":["trace[1850176896] 'process raft request'  (duration: 181.701651ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T10:20:25.581218Z","caller":"traceutil/trace.go:171","msg":"trace[1273292569] linearizableReadLoop","detail":"{readStateIndex:3232; appliedIndex:3231; }","duration":"184.804019ms","start":"2026-05-05T10:20:25.396392Z","end":"2026-05-05T10:20:25.581195Z","steps":["trace[1273292569] 'read index received'  (duration: 181.529951ms)","trace[1273292569] 'applied index is now lower than readState.Index'  (duration: 3.272488ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-05T10:20:25.581478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.064831ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"}
{"level":"info","ts":"2026-05-05T10:20:25.581525Z","caller":"traceutil/trace.go:171","msg":"trace[1255711692] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:3121; }","duration":"185.160471ms","start":"2026-05-05T10:20:25.39635Z","end":"2026-05-05T10:20:25.581511Z","steps":["trace[1255711692] 'agreement among raft nodes before linearized reading'  (duration: 184.962399ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T10:20:25.581566Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.477466ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-05-05T10:20:25.581627Z","caller":"traceutil/trace.go:171","msg":"trace[1920254789] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:3121; }","duration":"184.639228ms","start":"2026-05-05T10:20:25.396977Z","end":"2026-05-05T10:20:25.581616Z","steps":["trace[1920254789] 'agreement among raft nodes before linearized reading'  (duration: 184.394046ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T10:20:25.581765Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.031153ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-05T10:20:25.581858Z","caller":"traceutil/trace.go:171","msg":"trace[586277147] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:3121; }","duration":"169.162903ms","start":"2026-05-05T10:20:25.412676Z","end":"2026-05-05T10:20:25.581839Z","steps":["trace[586277147] 'agreement among raft nodes before linearized reading'  (duration: 169.002222ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T10:20:26.681229Z","caller":"traceutil/trace.go:171","msg":"trace[1419009350] transaction","detail":"{read_only:false; response_revision:3127; number_of_response:1; }","duration":"154.794943ms","start":"2026-05-05T10:20:26.526412Z","end":"2026-05-05T10:20:26.681207Z","steps":["trace[1419009350] 'process raft request'  (duration: 154.660662ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T10:20:59.218305Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.071413ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9038335189079944825 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/auth-system/keycloak.199-19-213-237.nip.io-tls.18aca42b5eef0381\" mod_revision:0 > success:<request_put:<key:\"/registry/events/auth-system/keycloak.199-19-213-237.nip.io-tls.18aca42b5eef0381\" value_size:764 lease:9038335189079943901 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-05-05T10:20:59.218425Z","caller":"traceutil/trace.go:171","msg":"trace[1710129942] transaction","detail":"{read_only:false; response_revision:3312; number_of_response:1; }","duration":"126.882355ms","start":"2026-05-05T10:20:59.091523Z","end":"2026-05-05T10:20:59.218405Z","steps":["trace[1710129942] 'process raft request'  (duration: 19.655912ms)","trace[1710129942] 'compare'  (duration: 106.783133ms)"],"step_count":2}
{"level":"info","ts":"2026-05-05T10:20:59.21872Z","caller":"traceutil/trace.go:171","msg":"trace[77985042] transaction","detail":"{read_only:false; response_revision:3313; number_of_response:1; }","duration":"126.633237ms","start":"2026-05-05T10:20:59.09206Z","end":"2026-05-05T10:20:59.218694Z","steps":["trace[77985042] 'process raft request'  (duration: 126.510709ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T10:20:59.218791Z","caller":"traceutil/trace.go:171","msg":"trace[616230093] transaction","detail":"{read_only:false; response_revision:3314; number_of_response:1; }","duration":"126.634777ms","start":"2026-05-05T10:20:59.092125Z","end":"2026-05-05T10:20:59.218759Z","steps":["trace[616230093] 'process raft request'  (duration: 126.510538ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T10:20:59.218884Z","caller":"traceutil/trace.go:171","msg":"trace[222798304] transaction","detail":"{read_only:false; response_revision:3316; number_of_response:1; }","duration":"124.93534ms","start":"2026-05-05T10:20:59.093917Z","end":"2026-05-05T10:20:59.218853Z","steps":["trace[222798304] 'process raft request'  (duration: 124.773988ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T10:20:59.218838Z","caller":"traceutil/trace.go:171","msg":"trace[154265282] transaction","detail":"{read_only:false; response_revision:3315; number_of_response:1; }","duration":"124.972261ms","start":"2026-05-05T10:20:59.09385Z","end":"2026-05-05T10:20:59.218823Z","steps":["trace[154265282] 'process raft request'  (duration: 124.81352ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T10:20:59.21882Z","caller":"traceutil/trace.go:171","msg":"trace[1113908278] transaction","detail":"{read_only:false; response_revision:3317; number_of_response:1; }","duration":"122.08417ms","start":"2026-05-05T10:20:59.096694Z","end":"2026-05-05T10:20:59.218778Z","steps":["trace[1113908278] 'process raft request'  (duration: 122.051208ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T10:20:59.26856Z","caller":"traceutil/trace.go:171","msg":"trace[1504907032] transaction","detail":"{read_only:false; response_revision:3318; number_of_response:1; }","duration":"156.890269ms","start":"2026-05-05T10:20:59.111632Z","end":"2026-05-05T10:20:59.268522Z","steps":["trace[1504907032] 'process raft request'  (duration: 156.718326ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T10:22:23.466323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.990955ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-05T10:22:23.466422Z","caller":"traceutil/trace.go:171","msg":"trace[1588296432] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:3910; }","duration":"280.133243ms","start":"2026-05-05T10:22:23.18627Z","end":"2026-05-05T10:22:23.466403Z","steps":["trace[1588296432] 'range keys from in-memory index tree'  (duration: 279.903671ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T10:22:24.30368Z","caller":"traceutil/trace.go:171","msg":"trace[622648844] transaction","detail":"{read_only:false; response_revision:3911; number_of_response:1; }","duration":"211.878476ms","start":"2026-05-05T10:22:24.091776Z","end":"2026-05-05T10:22:24.303654Z","steps":["trace[622648844] 'process raft request'  (duration: 211.72363ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T10:22:24.306217Z","caller":"traceutil/trace.go:171","msg":"trace[1666266150] linearizableReadLoop","detail":"{readStateIndex:4056; appliedIndex:4054; }","duration":"212.069834ms","start":"2026-05-05T10:22:24.094127Z","end":"2026-05-05T10:22:24.306197Z","steps":["trace[1666266150] 'read index received'  (duration: 209.446513ms)","trace[1666266150] 'applied index is now lower than readState.Index'  (duration: 2.622501ms)"],"step_count":2}
{"level":"info","ts":"2026-05-05T10:22:24.30633Z","caller":"traceutil/trace.go:171","msg":"trace[813787131] transaction","detail":"{read_only:false; response_revision:3912; number_of_response:1; }","duration":"212.503563ms","start":"2026-05-05T10:22:24.093814Z","end":"2026-05-05T10:22:24.306317Z","steps":["trace[813787131] 'process raft request'  (duration: 212.19643ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T10:22:24.306519Z","caller":"traceutil/trace.go:171","msg":"trace[1880923504] transaction","detail":"{read_only:false; response_revision:3913; number_of_response:1; }","duration":"167.206493ms","start":"2026-05-05T10:22:24.139302Z","end":"2026-05-05T10:22:24.306509Z","steps":["trace[1880923504] 'process raft request'  (duration: 166.818747ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T10:22:24.306711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.501981ms","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-05T10:22:24.306748Z","caller":"traceutil/trace.go:171","msg":"trace[1680806905] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:3914; }","duration":"114.635666ms","start":"2026-05-05T10:22:24.192102Z","end":"2026-05-05T10:22:24.306738Z","steps":["trace[1680806905] 'agreement among raft nodes before linearized reading'  (duration: 114.49342ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T10:22:24.306828Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.6582ms","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-05T10:22:24.306943Z","caller":"traceutil/trace.go:171","msg":"trace[1810869369] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:3914; }","duration":"212.812387ms","start":"2026-05-05T10:22:24.094104Z","end":"2026-05-05T10:22:24.306916Z","steps":["trace[1810869369] 'agreement among raft nodes before linearized reading'  (duration: 212.44483ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T10:22:25.382037Z","caller":"traceutil/trace.go:171","msg":"trace[248244533] transaction","detail":"{read_only:false; response_revision:3920; number_of_response:1; }","duration":"258.686631ms","start":"2026-05-05T10:22:25.123321Z","end":"2026-05-05T10:22:25.382008Z","steps":["trace[248244533] 'process raft request'  (duration: 258.527745ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T10:22:25.702242Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.611033ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-05T10:22:25.702517Z","caller":"traceutil/trace.go:171","msg":"trace[714336069] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:3920; }","duration":"176.895145ms","start":"2026-05-05T10:22:25.525603Z","end":"2026-05-05T10:22:25.702498Z","steps":["trace[714336069] 'range keys from in-memory index tree'  (duration: 176.519028ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T10:22:28.015933Z","caller":"traceutil/trace.go:171","msg":"trace[724361390] linearizableReadLoop","detail":"{readStateIndex:4084; appliedIndex:4083; }","duration":"492.710552ms","start":"2026-05-05T10:22:27.523205Z","end":"2026-05-05T10:22:28.015915Z","steps":["trace[724361390] 'read index received'  (duration: 492.519603ms)","trace[724361390] 'applied index is now lower than readState.Index'  (duration: 190.269µs)"],"step_count":2}
{"level":"warn","ts":"2026-05-05T10:22:28.016164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"492.91801ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-05T10:22:28.016204Z","caller":"traceutil/trace.go:171","msg":"trace[966302944] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:3930; }","duration":"493.030545ms","start":"2026-05-05T10:22:27.523165Z","end":"2026-05-05T10:22:28.016195Z","steps":["trace[966302944] 'agreement among raft nodes before linearized reading'  (duration: 492.929621ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T10:22:28.016231Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:22:27.523147Z","time spent":"493.076666ms","remote":"127.0.0.1:45938","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-05-05T10:22:28.016458Z","caller":"traceutil/trace.go:171","msg":"trace[1257940266] transaction","detail":"{read_only:false; response_revision:3930; number_of_response:1; }","duration":"629.096639ms","start":"2026-05-05T10:22:27.387352Z","end":"2026-05-05T10:22:28.016448Z","steps":["trace[1257940266] 'process raft request'  (duration: 628.452451ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T10:22:28.016536Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:22:27.387329Z","time spent":"629.152651ms","remote":"127.0.0.1:42624","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:3920 > 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-05T10:22:28.016744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"489.592361ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.237\" ","response":"range_response_count:1 size:135"}
{"level":"info","ts":"2026-05-05T10:22:28.016881Z","caller":"traceutil/trace.go:171","msg":"trace[254920945] range","detail":"{range_begin:/registry/masterleases/199.19.213.237; range_end:; response_count:1; response_revision:3930; }","duration":"489.78019ms","start":"2026-05-05T10:22:27.527079Z","end":"2026-05-05T10:22:28.016859Z","steps":["trace[254920945] 'agreement among raft nodes before linearized reading'  (duration: 489.107462ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T10:22:28.017003Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:22:27.527073Z","time spent":"489.916845ms","remote":"127.0.0.1:45978","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":159,"request content":"key:\"/registry/masterleases/199.19.213.237\" "}
{"level":"warn","ts":"2026-05-05T10:22:28.017039Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"406.745217ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"}
{"level":"info","ts":"2026-05-05T10:22:28.017262Z","caller":"traceutil/trace.go:171","msg":"trace[1363822617] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:3930; }","duration":"407.009998ms","start":"2026-05-05T10:22:27.610245Z","end":"2026-05-05T10:22:28.017255Z","steps":["trace[1363822617] 'agreement among raft nodes before linearized reading'  (duration: 406.738927ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T10:22:28.017282Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:22:27.610227Z","time spent":"407.04996ms","remote":"127.0.0.1:46124","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12240,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "}
{"level":"info","ts":"2026-05-05T10:22:29.071411Z","caller":"traceutil/trace.go:171","msg":"trace[710563850] transaction","detail":"{read_only:false; response_revision:3940; number_of_response:1; }","duration":"108.064157ms","start":"2026-05-05T10:22:28.963325Z","end":"2026-05-05T10:22:29.071389Z","steps":["trace[710563850] 'process raft request'  (duration: 107.973864ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T10:22:29.744276Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.720943ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-05T10:22:29.744342Z","caller":"traceutil/trace.go:171","msg":"trace[484575988] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:3941; }","duration":"218.841518ms","start":"2026-05-05T10:22:29.525485Z","end":"2026-05-05T10:22:29.744327Z","steps":["trace[484575988] 'range keys from in-memory index tree'  (duration: 218.583808ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T10:22:32.313075Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.223093ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/sshkeys/\" range_end:\"/registry/secretgen.k14s.io/sshkeys0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-05T10:22:32.313172Z","caller":"traceutil/trace.go:171","msg":"trace[1574294011] range","detail":"{range_begin:/registry/secretgen.k14s.io/sshkeys/; range_end:/registry/secretgen.k14s.io/sshkeys0; response_count:0; response_revision:3952; }","duration":"155.373399ms","start":"2026-05-05T10:22:32.15777Z","end":"2026-05-05T10:22:32.313143Z","steps":["trace[1574294011] 'count revisions from in-memory index tree'  (duration: 155.13947ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T10:22:52.605974Z","caller":"traceutil/trace.go:171","msg":"trace[1161955878] transaction","detail":"{read_only:false; response_revision:4479; number_of_response:1; }","duration":"152.75006ms","start":"2026-05-05T10:22:52.453204Z","end":"2026-05-05T10:22:52.605954Z","steps":["trace[1161955878] 'process raft request'  (duration: 106.067499ms)","trace[1161955878] 'compare'  (duration: 46.251085ms)"],"step_count":2}
{"level":"info","ts":"2026-05-05T10:22:52.606014Z","caller":"traceutil/trace.go:171","msg":"trace[959558364] transaction","detail":"{read_only:false; number_of_response:1; response_revision:4480; }","duration":"152.237891ms","start":"2026-05-05T10:22:52.453755Z","end":"2026-05-05T10:22:52.605992Z","steps":["trace[959558364] 'process raft request'  (duration: 152.013493ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T10:22:52.606259Z","caller":"traceutil/trace.go:171","msg":"trace[1928086050] linearizableReadLoop","detail":"{readStateIndex:4645; appliedIndex:4643; }","duration":"132.460607ms","start":"2026-05-05T10:22:52.473789Z","end":"2026-05-05T10:22:52.606249Z","steps":["trace[1928086050] 'read index received'  (duration: 85.492195ms)","trace[1928086050] 'applied index is now lower than readState.Index'  (duration: 46.966902ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-05T10:22:52.611175Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.372277ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-05-05T10:22:52.611232Z","caller":"traceutil/trace.go:171","msg":"trace[1542694041] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4480; }","duration":"137.47198ms","start":"2026-05-05T10:22:52.473747Z","end":"2026-05-05T10:22:52.611219Z","steps":["trace[1542694041] 'agreement among raft nodes before linearized reading'  (duration: 132.634472ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T10:22:52.61123Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.762658ms","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-05T10:22:52.611289Z","caller":"traceutil/trace.go:171","msg":"trace[1073207443] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4480; }","duration":"105.833021ms","start":"2026-05-05T10:22:52.505427Z","end":"2026-05-05T10:22:52.61126Z","steps":["trace[1073207443] 'agreement among raft nodes before linearized reading'  (duration: 105.692216ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T10:22:52.61131Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.360716ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"}
{"level":"info","ts":"2026-05-05T10:22:52.611372Z","caller":"traceutil/trace.go:171","msg":"trace[1227679838] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4480; }","duration":"113.451909ms","start":"2026-05-05T10:22:52.497905Z","end":"2026-05-05T10:22:52.611357Z","steps":["trace[1227679838] 'agreement among raft nodes before linearized reading'  (duration: 113.264072ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T10:22:52.611428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.008183ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"}
{"level":"warn","ts":"2026-05-05T10:22:52.611528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.29579ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"}
{"level":"info","ts":"2026-05-05T10:22:52.611555Z","caller":"traceutil/trace.go:171","msg":"trace[752504017] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4480; }","duration":"134.376787ms","start":"2026-05-05T10:22:52.477168Z","end":"2026-05-05T10:22:52.611545Z","steps":["trace[752504017] 'agreement among raft nodes before linearized reading'  (duration: 133.934431ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T10:22:52.611614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.409868ms","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-05T10:22:52.611666Z","caller":"traceutil/trace.go:171","msg":"trace[1886686384] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4480; }","duration":"134.47007ms","start":"2026-05-05T10:22:52.477189Z","end":"2026-05-05T10:22:52.611659Z","steps":["trace[1886686384] 'agreement among raft nodes before linearized reading'  (duration: 134.380987ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T10:22:52.611584Z","caller":"traceutil/trace.go:171","msg":"trace[190745570] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4480; }","duration":"102.378623ms","start":"2026-05-05T10:22:52.509198Z","end":"2026-05-05T10:22:52.611577Z","steps":["trace[190745570] 'agreement among raft nodes before linearized reading'  (duration: 102.277979ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T10:22:53.28231Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.360349ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/monitoring/prometheus-kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:15301"}
{"level":"info","ts":"2026-05-05T10:22:53.282389Z","caller":"traceutil/trace.go:171","msg":"trace[1887208055] range","detail":"{range_begin:/registry/statefulsets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:4517; }","duration":"152.477403ms","start":"2026-05-05T10:22:53.129895Z","end":"2026-05-05T10:22:53.282372Z","steps":["trace[1887208055] 'range keys from in-memory index tree'  (duration: 152.190583ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T10:22:53.28247Z","caller":"traceutil/trace.go:171","msg":"trace[1009659566] transaction","detail":"{read_only:false; response_revision:4518; number_of_response:1; }","duration":"138.353308ms","start":"2026-05-05T10:22:53.144095Z","end":"2026-05-05T10:22:53.282448Z","steps":["trace[1009659566] 'process raft request'  (duration: 130.765501ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T10:22:55.674601Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.817673ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-05T10:22:55.674717Z","caller":"traceutil/trace.go:171","msg":"trace[1780285070] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4574; }","duration":"150.00318ms","start":"2026-05-05T10:22:55.524694Z","end":"2026-05-05T10:22:55.674697Z","steps":["trace[1780285070] 'range keys from in-memory index tree'  (duration: 149.74197ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T10:23:01.081383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.068395ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9038335189079947967 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/monitoring.coreos.com/alertmanagers/monitoring/kube-prometheus-stack-alertmanager\" mod_revision:4461 > success:<request_put:<key:\"/registry/monitoring.coreos.com/alertmanagers/monitoring/kube-prometheus-stack-alertmanager\" value_size:4735 >> failure:<request_range:<key:\"/registry/monitoring.coreos.com/alertmanagers/monitoring/kube-prometheus-stack-alertmanager\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-05T10:23:01.081489Z","caller":"traceutil/trace.go:171","msg":"trace[352206280] transaction","detail":"{read_only:false; response_revision:4683; number_of_response:1; }","duration":"200.132822ms","start":"2026-05-05T10:23:00.881338Z","end":"2026-05-05T10:23:01.081471Z","steps":["trace[352206280] 'process raft request'  (duration: 80.904791ms)","trace[352206280] 'compare'  (duration: 118.970462ms)"],"step_count":2}
{"level":"info","ts":"2026-05-05T10:23:01.091656Z","caller":"traceutil/trace.go:171","msg":"trace[468499656] transaction","detail":"{read_only:false; response_revision:4684; number_of_response:1; }","duration":"208.749923ms","start":"2026-05-05T10:23:00.882899Z","end":"2026-05-05T10:23:01.091649Z","steps":["trace[468499656] 'process raft request'  (duration: 208.614168ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T10:23:01.091603Z","caller":"traceutil/trace.go:171","msg":"trace[790649907] linearizableReadLoop","detail":"{readStateIndex:4853; appliedIndex:4851; }","duration":"206.322687ms","start":"2026-05-05T10:23:00.885269Z","end":"2026-05-05T10:23:01.091591Z","steps":["trace[790649907] 'read index received'  (duration: 76.961242ms)","trace[790649907] 'applied index is now lower than readState.Index'  (duration: 129.360705ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-05T10:23:01.092078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.775944ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated\" ","response":"range_response_count:1 size:1131"}
{"level":"info","ts":"2026-05-05T10:23:01.092149Z","caller":"traceutil/trace.go:171","msg":"trace[858344947] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated; range_end:; response_count:1; response_revision:4684; }","duration":"206.887567ms","start":"2026-05-05T10:23:00.885243Z","end":"2026-05-05T10:23:01.092131Z","steps":["trace[858344947] 'agreement among raft nodes before linearized reading'  (duration: 206.655829ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T10:23:01.450324Z","caller":"traceutil/trace.go:171","msg":"trace[1020207083] transaction","detail":"{read_only:false; response_revision:4685; number_of_response:1; }","duration":"352.678242ms","start":"2026-05-05T10:23:01.097624Z","end":"2026-05-05T10:23:01.450302Z","steps":["trace[1020207083] 'process raft request'  (duration: 306.577625ms)","trace[1020207083] 'compare'  (duration: 45.982803ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-05T10:23:01.450426Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:23:01.097613Z","time spent":"352.768775ms","remote":"127.0.0.1:42856","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6109,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/controllerrevisions/openstack/rabbitmq-keystone-server-7fd5796d8d\" mod_revision:0 > success:<request_put:<key:\"/registry/controllerrevisions/openstack/rabbitmq-keystone-server-7fd5796d8d\" value_size:6026 >> failure:<>"}
{"level":"info","ts":"2026-05-05T10:23:01.458845Z","caller":"traceutil/trace.go:171","msg":"trace[1994586719] transaction","detail":"{read_only:false; response_revision:4687; number_of_response:1; }","duration":"356.789806ms","start":"2026-05-05T10:23:01.102034Z","end":"2026-05-05T10:23:01.458823Z","steps":["trace[1994586719] 'process raft request'  (duration: 356.63626ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T10:23:01.458836Z","caller":"traceutil/trace.go:171","msg":"trace[251626079] linearizableReadLoop","detail":"{readStateIndex:4856; appliedIndex:4853; }","duration":"351.453989ms","start":"2026-05-05T10:23:01.107359Z","end":"2026-05-05T10:23:01.458813Z","steps":["trace[251626079] 'read index received'  (duration: 296.920237ms)","trace[251626079] 'applied index is now lower than readState.Index'  (duration: 54.532652ms)"],"step_count":2}
{"level":"info","ts":"2026-05-05T10:23:01.458958Z","caller":"traceutil/trace.go:171","msg":"trace[299836633] transaction","detail":"{read_only:false; response_revision:4688; number_of_response:1; }","duration":"351.118897ms","start":"2026-05-05T10:23:01.10783Z","end":"2026-05-05T10:23:01.458949Z","steps":["trace[299836633] 'process raft request'  (duration: 350.898039ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T10:23:01.458962Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:23:01.102015Z","time spent":"356.874989ms","remote":"127.0.0.1:42830","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9301,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/statefulsets/openstack/rabbitmq-keystone-server\" mod_revision:4684 > success:<request_put:<key:\"/registry/statefulsets/openstack/rabbitmq-keystone-server\" value_size:9236 >> failure:<request_range:<key:\"/registry/statefulsets/openstack/rabbitmq-keystone-server\" > >"}
{"level":"warn","ts":"2026-05-05T10:23:01.459031Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:23:01.107818Z","time spent":"351.161879ms","remote":"127.0.0.1:46028","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":826,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/events/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0.18aca447c70e9eb3\" mod_revision:0 > success:<request_put:<key:\"/registry/events/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0.18aca447c70e9eb3\" value_size:714 lease:9038335189079945944 >> failure:<>"}
{"level":"info","ts":"2026-05-05T10:23:01.459082Z","caller":"traceutil/trace.go:171","msg":"trace[1903727848] transaction","detail":"{read_only:false; response_revision:4686; number_of_response:1; }","duration":"361.331846ms","start":"2026-05-05T10:23:01.097695Z","end":"2026-05-05T10:23:01.459027Z","steps":["trace[1903727848] 'process raft request'  (duration: 360.855119ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T10:23:01.459142Z","caller":"traceutil/trace.go:171","msg":"trace[600660058] transaction","detail":"{read_only:false; response_revision:4689; number_of_response:1; }","duration":"140.970885ms","start":"2026-05-05T10:23:01.318156Z","end":"2026-05-05T10:23:01.459127Z","steps":["trace[600660058] 'process raft request'  (duration: 140.608903ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T10:23:01.459248Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:23:01.097684Z","time spent":"361.508272ms","remote":"127.0.0.1:46028","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":716,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/events/openstack/rabbitmq-keystone.18aca447c7269bf9\" mod_revision:0 > success:<request_put:<key:\"/registry/events/openstack/rabbitmq-keystone.18aca447c7269bf9\" value_size:637 lease:9038335189079945944 >> failure:<>"}
{"level":"warn","ts":"2026-05-05T10:23:01.459676Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.854487ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1821"}
{"level":"info","ts":"2026-05-05T10:23:01.459729Z","caller":"traceutil/trace.go:171","msg":"trace[619480750] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:4689; }","duration":"279.941971ms","start":"2026-05-05T10:23:01.179773Z","end":"2026-05-05T10:23:01.459715Z","steps":["trace[619480750] 'agreement among raft nodes before linearized reading'  (duration: 279.828607ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T10:23:01.459752Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"352.377032ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-0\" ","response":"range_response_count:1 size:650"}
{"level":"info","ts":"2026-05-05T10:23:01.459803Z","caller":"traceutil/trace.go:171","msg":"trace[911002195] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-0; range_end:; response_count:1; response_revision:4689; }","duration":"352.435344ms","start":"2026-05-05T10:23:01.107355Z","end":"2026-05-05T10:23:01.45979Z","steps":["trace[911002195] 'agreement among raft nodes before linearized reading'  (duration: 352.251238ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T10:23:01.459846Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:23:01.107311Z","time spent":"352.524007ms","remote":"127.0.0.1:46046","response type":"/etcdserverpb.KV/Range","request count":0,"request size":91,"response count":1,"response size":674,"request content":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-0\" "}
{"level":"warn","ts":"2026-05-05T10:23:02.060984Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.860305ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9038335189079948024 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/openstack/rabbitmq-keystone.18aca447ee369ed3\" mod_revision:0 > success:<request_put:<key:\"/registry/events/openstack/rabbitmq-keystone.18aca447ee369ed3\" value_size:652 lease:9038335189079945944 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-05-05T10:23:02.061119Z","caller":"traceutil/trace.go:171","msg":"trace[720508678] linearizableReadLoop","detail":"{readStateIndex:4884; appliedIndex:4883; }","duration":"307.781987ms","start":"2026-05-05T10:23:01.753314Z","end":"2026-05-05T10:23:02.061096Z","steps":["trace[720508678] 'read index received'  (duration: 169.675682ms)","trace[720508678] 'applied index is now lower than readState.Index'  (duration: 138.104274ms)"],"step_count":2}
{"level":"info","ts":"2026-05-05T10:23:02.061467Z","caller":"traceutil/trace.go:171","msg":"trace[2016759599] transaction","detail":"{read_only:false; response_revision:4715; number_of_response:1; }","duration":"308.219593ms","start":"2026-05-05T10:23:01.753204Z","end":"2026-05-05T10:23:02.061423Z","steps":["trace[2016759599] 'process raft request'  (duration: 169.774677ms)","trace[2016759599] 'compare'  (duration: 137.610817ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-05T10:23:02.061625Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:23:01.753192Z","time spent":"308.362728ms","remote":"127.0.0.1:46028","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":731,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/events/openstack/rabbitmq-keystone.18aca447ee369ed3\" mod_revision:0 > success:<request_put:<key:\"/registry/events/openstack/rabbitmq-keystone.18aca447ee369ed3\" value_size:652 lease:9038335189079945944 >> failure:<>"}
{"level":"warn","ts":"2026-05-05T10:23:02.061924Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.591606ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/monitoring/prometheus-operated\" ","response":"range_response_count:1 size:993"}
{"level":"info","ts":"2026-05-05T10:23:02.061997Z","caller":"traceutil/trace.go:171","msg":"trace[1945990061] range","detail":"{range_begin:/registry/services/specs/monitoring/prometheus-operated; range_end:; response_count:1; response_revision:4715; }","duration":"308.69258ms","start":"2026-05-05T10:23:01.753285Z","end":"2026-05-05T10:23:02.061978Z","steps":["trace[1945990061] 'agreement among raft nodes before linearized reading'  (duration: 308.211983ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T10:23:02.062079Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:23:01.753273Z","time spent":"308.786093ms","remote":"127.0.0.1:46128","response type":"/etcdserverpb.KV/Range","request count":0,"request size":57,"response count":1,"response size":1017,"request content":"key:\"/registry/services/specs/monitoring/prometheus-operated\" "}
{"level":"info","ts":"2026-05-05T10:23:02.069425Z","caller":"traceutil/trace.go:171","msg":"trace[1676618483] transaction","detail":"{read_only:false; response_revision:4716; number_of_response:1; }","duration":"316.072476ms","start":"2026-05-05T10:23:01.753337Z","end":"2026-05-05T10:23:02.06941Z","steps":["trace[1676618483] 'process raft request'  (duration: 315.546748ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T10:23:02.069574Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:23:01.753328Z","time spent":"316.19102ms","remote":"127.0.0.1:46124","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3631,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-f112c067-8ce6-4c63-81e6-170e6c0827ca\" mod_revision:4713 > success:<request_put:<key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-f112c067-8ce6-4c63-81e6-170e6c0827ca\" value_size:3531 >> failure:<request_range:<key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-f112c067-8ce6-4c63-81e6-170e6c0827ca\" > >"}
{"level":"info","ts":"2026-05-05T10:23:02.06959Z","caller":"traceutil/trace.go:171","msg":"trace[325917242] transaction","detail":"{read_only:false; response_revision:4717; number_of_response:1; }","duration":"304.335934ms","start":"2026-05-05T10:23:01.765232Z","end":"2026-05-05T10:23:02.069568Z","steps":["trace[325917242] 'process raft request'  (duration: 304.078615ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T10:23:02.069693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.302319ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-05-05T10:23:02.069757Z","caller":"traceutil/trace.go:171","msg":"trace[1945961229] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:4717; }","duration":"189.413492ms","start":"2026-05-05T10:23:01.88033Z","end":"2026-05-05T10:23:02.069743Z","steps":["trace[1945961229] 'agreement among raft nodes before linearized reading'  (duration: 189.203265ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T10:23:02.069817Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.551118ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:1451"}
{"level":"info","ts":"2026-05-05T10:23:02.06985Z","caller":"traceutil/trace.go:171","msg":"trace[881596009] range","detail":"{range_begin:/registry/services/specs/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:4717; }","duration":"315.60121ms","start":"2026-05-05T10:23:01.754237Z","end":"2026-05-05T10:23:02.069838Z","steps":["trace[881596009] 'agreement among raft nodes before linearized reading'  (duration: 315.505776ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T10:23:02.069884Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:23:01.754225Z","time spent":"315.651332ms","remote":"127.0.0.1:46128","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":1475,"request content":"key:\"/registry/services/specs/openstack/rabbitmq-keystone\" "}
{"level":"warn","ts":"2026-05-05T10:23:02.069701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.192856ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/local-path-storage/local-path-provisioner\" ","response":"range_response_count:1 size:897"}
{"level":"info","ts":"2026-05-05T10:23:02.069928Z","caller":"traceutil/trace.go:171","msg":"trace[2046428301] range","detail":"{range_begin:/registry/serviceaccounts/local-path-storage/local-path-provisioner; range_end:; response_count:1; response_revision:4717; }","duration":"148.450306ms","start":"2026-05-05T10:23:01.921464Z","end":"2026-05-05T10:23:02.069914Z","steps":["trace[2046428301] 'agreement among raft nodes before linearized reading'  (duration: 148.115364ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T10:23:02.069965Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:23:01.765216Z","time spent":"304.498509ms","remote":"127.0.0.1:42830","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9622,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/statefulsets/openstack/rabbitmq-keystone-server\" mod_revision:4707 > success:<request_put:<key:\"/registry/statefulsets/openstack/rabbitmq-keystone-server\" value_size:9557 >> failure:<request_range:<key:\"/registry/statefulsets/openstack/rabbitmq-keystone-server\" > >"}
{"level":"info","ts":"2026-05-05T10:23:02.245359Z","caller":"traceutil/trace.go:171","msg":"trace[1740043682] linearizableReadLoop","detail":"{readStateIndex:4889; appliedIndex:4888; }","duration":"126.680113ms","start":"2026-05-05T10:23:02.11865Z","end":"2026-05-05T10:23:02.24533Z","steps":["trace[1740043682] 'read index received'  (duration: 14.685643ms)","trace[1740043682] 'applied index is now lower than readState.Index'  (duration: 111.992849ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-05T10:23:02.245748Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.009614ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:3243"}
{"level":"info","ts":"2026-05-05T10:23:02.245824Z","caller":"traceutil/trace.go:171","msg":"trace[1899125217] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:4720; }","duration":"127.147869ms","start":"2026-05-05T10:23:02.118645Z","end":"2026-05-05T10:23:02.245793Z","steps":["trace[1899125217] 'agreement among raft nodes before linearized reading'  (duration: 126.788606ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T10:23:02.246562Z","caller":"traceutil/trace.go:171","msg":"trace[623488686] transaction","detail":"{read_only:false; response_revision:4720; number_of_response:1; }","duration":"130.360452ms","start":"2026-05-05T10:23:02.116186Z","end":"2026-05-05T10:23:02.246546Z","steps":["trace[623488686] 'process raft request'  (duration: 122.208277ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T10:23:04.816764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.420812ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"warn","ts":"2026-05-05T10:23:04.816799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.995968ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"}
{"level":"info","ts":"2026-05-05T10:23:04.816918Z","caller":"traceutil/trace.go:171","msg":"trace[832955479] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4745; }","duration":"133.112243ms","start":"2026-05-05T10:23:04.683746Z","end":"2026-05-05T10:23:04.816858Z","steps":["trace[832955479] 'range keys from in-memory index tree'  (duration: 132.831523ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T10:23:04.817009Z","caller":"traceutil/trace.go:171","msg":"trace[911899570] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4745; }","duration":"159.562358ms","start":"2026-05-05T10:23:04.657266Z","end":"2026-05-05T10:23:04.816829Z","steps":["trace[911899570] 'range keys from in-memory index tree'  (duration: 159.223096ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T10:23:04.817178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.768016ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"}
{"level":"info","ts":"2026-05-05T10:23:04.81729Z","caller":"traceutil/trace.go:171","msg":"trace[1362379002] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4745; }","duration":"133.896061ms","start":"2026-05-05T10:23:04.683372Z","end":"2026-05-05T10:23:04.817268Z","steps":["trace[1362379002] 'range keys from in-memory index tree'  (duration: 133.229708ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T10:23:04.817327Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.377092ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"}
{"level":"warn","ts":"2026-05-05T10:23:04.817422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.055115ms","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-05T10:23:04.817471Z","caller":"traceutil/trace.go:171","msg":"trace[448454393] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4745; }","duration":"134.127608ms","start":"2026-05-05T10:23:04.683328Z","end":"2026-05-05T10:23:04.817456Z","steps":["trace[448454393] 'range keys from in-memory index tree'  (duration: 133.198367ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T10:23:04.817464Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.679571ms","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-05T10:23:04.817521Z","caller":"traceutil/trace.go:171","msg":"trace[1914403483] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4745; }","duration":"137.768284ms","start":"2026-05-05T10:23:04.679739Z","end":"2026-05-05T10:23:04.817508Z","steps":["trace[1914403483] 'range keys from in-memory index tree'  (duration: 136.819041ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T10:23:04.817749Z","caller":"traceutil/trace.go:171","msg":"trace[2083602279] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4745; }","duration":"146.514076ms","start":"2026-05-05T10:23:04.670876Z","end":"2026-05-05T10:23:04.81739Z","steps":["trace[2083602279] 'range keys from in-memory index tree'  (duration: 145.649706ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T10:23:09.719697Z","caller":"traceutil/trace.go:171","msg":"trace[1146064901] linearizableReadLoop","detail":"{readStateIndex:5015; appliedIndex:5014; }","duration":"195.502071ms","start":"2026-05-05T10:23:09.524168Z","end":"2026-05-05T10:23:09.71967Z","steps":["trace[1146064901] 'read index received'  (duration: 195.233002ms)","trace[1146064901] 'applied index is now lower than readState.Index'  (duration: 267.899µs)"],"step_count":2}
{"level":"info","ts":"2026-05-05T10:23:09.719745Z","caller":"traceutil/trace.go:171","msg":"trace[1524995345] transaction","detail":"{read_only:false; response_revision:4840; number_of_response:1; }","duration":"236.755104ms","start":"2026-05-05T10:23:09.482953Z","end":"2026-05-05T10:23:09.719708Z","steps":["trace[1524995345] 'process raft request'  (duration: 236.550187ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T10:23:09.719938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.670131ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/superstreams/\" range_end:\"/registry/rabbitmq.com/superstreams0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-05T10:23:09.719993Z","caller":"traceutil/trace.go:171","msg":"trace[1806152029] range","detail":"{range_begin:/registry/rabbitmq.com/superstreams/; range_end:/registry/rabbitmq.com/superstreams0; response_count:0; response_revision:4840; }","duration":"106.761185ms","start":"2026-05-05T10:23:09.613217Z","end":"2026-05-05T10:23:09.719979Z","steps":["trace[1806152029] 'agreement among raft nodes before linearized reading'  (duration: 106.665611ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T10:23:09.720025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.657408ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:16549"}
{"level":"info","ts":"2026-05-05T10:23:09.72008Z","caller":"traceutil/trace.go:171","msg":"trace[1718457691] range","detail":"{range_begin:/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4840; }","duration":"193.755492ms","start":"2026-05-05T10:23:09.526311Z","end":"2026-05-05T10:23:09.720066Z","steps":["trace[1718457691] 'agreement among raft nodes before linearized reading'  (duration: 193.564865ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T10:23:09.720321Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.830048ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2082"}
{"level":"info","ts":"2026-05-05T10:23:09.720373Z","caller":"traceutil/trace.go:171","msg":"trace[1275079506] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4840; }","duration":"109.920211ms","start":"2026-05-05T10:23:09.610439Z","end":"2026-05-05T10:23:09.720359Z","steps":["trace[1275079506] 'agreement among raft nodes before linearized reading'  (duration: 109.796167ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T10:23:09.720485Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.278647ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-05T10:23:09.720774Z","caller":"traceutil/trace.go:171","msg":"trace[1647574254] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4840; }","duration":"196.62804ms","start":"2026-05-05T10:23:09.524128Z","end":"2026-05-05T10:23:09.720756Z","steps":["trace[1647574254] 'agreement among raft nodes before linearized reading'  (duration: 195.696547ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T10:23:13.36965Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.853803ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2082"}
{"level":"info","ts":"2026-05-05T10:23:13.370052Z","caller":"traceutil/trace.go:171","msg":"trace[921544685] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4864; }","duration":"197.292467ms","start":"2026-05-05T10:23:13.172739Z","end":"2026-05-05T10:23:13.370032Z","steps":["trace[921544685] 'range keys from in-memory index tree'  (duration: 196.690088ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T10:23:13.369725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.74934ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-8gtsg.18aca44635f4518a\" ","response":"range_response_count:1 size:906"}
{"level":"info","ts":"2026-05-05T10:23:13.370488Z","caller":"traceutil/trace.go:171","msg":"trace[977727182] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-8gtsg.18aca44635f4518a; range_end:; response_count:1; response_revision:4864; }","duration":"162.525865ms","start":"2026-05-05T10:23:13.207931Z","end":"2026-05-05T10:23:13.370457Z","steps":["trace[977727182] 'range keys from in-memory index tree'  (duration: 161.616236ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T10:23:13.583365Z","caller":"traceutil/trace.go:171","msg":"trace[1613619802] linearizableReadLoop","detail":"{readStateIndex:5041; appliedIndex:5040; }","duration":"210.137173ms","start":"2026-05-05T10:23:13.37321Z","end":"2026-05-05T10:23:13.583347Z","steps":["trace[1613619802] 'read index received'  (duration: 209.968828ms)","trace[1613619802] 'applied index is now lower than readState.Index'  (duration: 167.715µs)"],"step_count":2}
{"level":"info","ts":"2026-05-05T10:23:13.583392Z","caller":"traceutil/trace.go:171","msg":"trace[24910164] transaction","detail":"{read_only:false; response_revision:4865; number_of_response:1; }","duration":"210.188025ms","start":"2026-05-05T10:23:13.37318Z","end":"2026-05-05T10:23:13.583368Z","steps":["trace[24910164] 'process raft request'  (duration: 210.03902ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T10:23:13.58354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.317889ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-f5d14631-0886-4d84-975a-6d8d8125872c\" ","response":"range_response_count:1 size:1435"}
{"level":"info","ts":"2026-05-05T10:23:13.58357Z","caller":"traceutil/trace.go:171","msg":"trace[1205238840] range","detail":"{range_begin:/registry/persistentvolumes/pvc-f5d14631-0886-4d84-975a-6d8d8125872c; range_end:; response_count:1; response_revision:4865; }","duration":"210.398041ms","start":"2026-05-05T10:23:13.373164Z","end":"2026-05-05T10:23:13.583562Z","steps":["trace[1205238840] 'agreement among raft nodes before linearized reading'  (duration: 210.273927ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T10:23:13.805209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.555433ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9038335189079948413 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/services/endpoints/openstack/rabbitmq-keystone\" mod_revision:4667 > success:<request_put:<key:\"/registry/services/endpoints/openstack/rabbitmq-keystone\" value_size:829 >> failure:<request_range:<key:\"/registry/services/endpoints/openstack/rabbitmq-keystone\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-05T10:23:13.805417Z","caller":"traceutil/trace.go:171","msg":"trace[1686543284] transaction","detail":"{read_only:false; response_revision:4867; number_of_response:1; }","duration":"197.331449ms","start":"2026-05-05T10:23:13.608065Z","end":"2026-05-05T10:23:13.805396Z","steps":["trace[1686543284] 'process raft request'  (duration: 96.496077ms)","trace[1686543284] 'compare'  (duration: 100.391446ms)"],"step_count":2}
{"level":"info","ts":"2026-05-05T10:23:13.805927Z","caller":"traceutil/trace.go:171","msg":"trace[444345092] transaction","detail":"{read_only:false; response_revision:4869; number_of_response:1; }","duration":"193.372028ms","start":"2026-05-05T10:23:13.61254Z","end":"2026-05-05T10:23:13.805912Z","steps":["trace[444345092] 'process raft request'  (duration: 193.204712ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T10:23:13.805917Z","caller":"traceutil/trace.go:171","msg":"trace[912186956] transaction","detail":"{read_only:false; response_revision:4868; number_of_response:1; }","duration":"197.426742ms","start":"2026-05-05T10:23:13.608459Z","end":"2026-05-05T10:23:13.805886Z","steps":["trace[912186956] 'process raft request'  (duration: 196.857383ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T10:23:13.806194Z","caller":"traceutil/trace.go:171","msg":"trace[2112662096] linearizableReadLoop","detail":"{readStateIndex:5044; appliedIndex:5042; }","duration":"197.410972ms","start":"2026-05-05T10:23:13.608751Z","end":"2026-05-05T10:23:13.806162Z","steps":["trace[2112662096] 'read index received'  (duration: 95.820906ms)","trace[2112662096] 'applied index is now lower than readState.Index'  (duration: 101.586936ms)"],"step_count":2}
{"level":"info","ts":"2026-05-05T10:23:13.806291Z","caller":"traceutil/trace.go:171","msg":"trace[2137371509] transaction","detail":"{read_only:false; response_revision:4870; number_of_response:1; }","duration":"192.141327ms","start":"2026-05-05T10:23:13.614139Z","end":"2026-05-05T10:23:13.80628Z","steps":["trace[2137371509] 'process raft request'  (duration: 191.705963ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T10:23:13.806463Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.177249ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"}
{"level":"warn","ts":"2026-05-05T10:23:13.806506Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.733963ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:17206"}
{"level":"info","ts":"2026-05-05T10:23:13.806522Z","caller":"traceutil/trace.go:171","msg":"trace[1566796194] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4871; }","duration":"119.241531ms","start":"2026-05-05T10:23:13.687262Z","end":"2026-05-05T10:23:13.806504Z","steps":["trace[1566796194] 'agreement among raft nodes before linearized reading'  (duration: 119.100067ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T10:23:13.806551Z","caller":"traceutil/trace.go:171","msg":"trace[615754141] range","detail":"{range_begin:/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4871; }","duration":"197.807745ms","start":"2026-05-05T10:23:13.60873Z","end":"2026-05-05T10:23:13.806538Z","steps":["trace[615754141] 'agreement among raft nodes before linearized reading'  (duration: 197.618589ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T10:23:14.035345Z","caller":"traceutil/trace.go:171","msg":"trace[1472133988] transaction","detail":"{read_only:false; response_revision:4877; number_of_response:1; }","duration":"116.352682ms","start":"2026-05-05T10:23:13.918966Z","end":"2026-05-05T10:23:14.035318Z","steps":["trace[1472133988] 'process raft request'  (duration: 110.503159ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T10:23:14.225262Z","caller":"traceutil/trace.go:171","msg":"trace[1093110107] transaction","detail":"{read_only:false; response_revision:4878; number_of_response:1; }","duration":"220.803503ms","start":"2026-05-05T10:23:14.004429Z","end":"2026-05-05T10:23:14.225232Z","steps":["trace[1093110107] 'process raft request'  (duration: 171.594489ms)","trace[1093110107] 'compare'  (duration: 48.916243ms)"],"step_count":2}
{"level":"info","ts":"2026-05-05T10:23:14.225254Z","caller":"traceutil/trace.go:171","msg":"trace[902188878] linearizableReadLoop","detail":"{readStateIndex:5054; appliedIndex:5053; }","duration":"188.051194ms","start":"2026-05-05T10:23:14.037177Z","end":"2026-05-05T10:23:14.225228Z","steps":["trace[902188878] 'read index received'  (duration: 138.779118ms)","trace[902188878] 'applied index is now lower than readState.Index'  (duration: 49.270266ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-05T10:23:14.225484Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.292641ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:9896"}
{"level":"info","ts":"2026-05-05T10:23:14.225568Z","caller":"traceutil/trace.go:171","msg":"trace[333713270] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:4878; }","duration":"188.370063ms","start":"2026-05-05T10:23:14.037154Z","end":"2026-05-05T10:23:14.225524Z","steps":["trace[333713270] 'agreement among raft nodes before linearized reading'  (duration: 188.160516ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T10:23:14.22602Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.601245ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/\" range_end:\"/registry/pods/monitoring0\" ","response":"range_response_count:6 size:61941"}
{"level":"info","ts":"2026-05-05T10:23:14.226087Z","caller":"traceutil/trace.go:171","msg":"trace[1602950376] range","detail":"{range_begin:/registry/pods/monitoring/; range_end:/registry/pods/monitoring0; response_count:6; response_revision:4878; }","duration":"176.701378ms","start":"2026-05-05T10:23:14.049369Z","end":"2026-05-05T10:23:14.226071Z","steps":["trace[1602950376] 'agreement among raft nodes before linearized reading'  (duration: 176.14368ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T10:24:44.463336Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2905}
{"level":"info","ts":"2026-05-05T10:24:44.555736Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2905,"took":"90.825096ms","hash":1604361418,"current-db-size-bytes":54439936,"current-db-size":"54 MB","current-db-size-in-use-bytes":29519872,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-05-05T10:24:44.55601Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1604361418,"revision":2905,"compact-revision":-1}
{"level":"info","ts":"2026-05-05T10:28:47.234772Z","caller":"traceutil/trace.go:171","msg":"trace[407926869] linearizableReadLoop","detail":"{readStateIndex:7387; appliedIndex:7386; }","duration":"378.187755ms","start":"2026-05-05T10:28:46.856543Z","end":"2026-05-05T10:28:47.234731Z","steps":["trace[407926869] 'read index received'  (duration: 377.951992ms)","trace[407926869] 'applied index is now lower than readState.Index'  (duration: 233.793µs)"],"step_count":2}
{"level":"info","ts":"2026-05-05T10:28:47.234817Z","caller":"traceutil/trace.go:171","msg":"trace[268008718] transaction","detail":"{read_only:false; response_revision:7134; number_of_response:1; }","duration":"378.48189ms","start":"2026-05-05T10:28:46.85629Z","end":"2026-05-05T10:28:47.234772Z","steps":["trace[268008718] 'process raft request'  (duration: 378.179255ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T10:28:47.235165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"378.590572ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"}
{"level":"info","ts":"2026-05-05T10:28:47.235228Z","caller":"traceutil/trace.go:171","msg":"trace[1142700900] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:7134; }","duration":"378.686333ms","start":"2026-05-05T10:28:46.856523Z","end":"2026-05-05T10:28:47.23521Z","steps":["trace[1142700900] 'agreement among raft nodes before linearized reading'  (duration: 378.407019ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T10:28:47.235266Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:28:46.85651Z","time spent":"378.746295ms","remote":"127.0.0.1:42624","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":580,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "}
{"level":"warn","ts":"2026-05-05T10:28:47.235311Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:28:46.856264Z","time spent":"378.854906ms","remote":"127.0.0.1:42624","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:7124 > 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-05T10:28:47.284786Z","caller":"traceutil/trace.go:171","msg":"trace[1858952527] transaction","detail":"{read_only:false; response_revision:7135; number_of_response:1; }","duration":"208.701233ms","start":"2026-05-05T10:28:47.076055Z","end":"2026-05-05T10:28:47.284756Z","steps":["trace[1858952527] 'process raft request'  (duration: 208.341918ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T10:28:47.284866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"421.529449ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"}
{"level":"info","ts":"2026-05-05T10:28:47.284951Z","caller":"traceutil/trace.go:171","msg":"trace[1943649360] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:7135; }","duration":"421.630051ms","start":"2026-05-05T10:28:46.863298Z","end":"2026-05-05T10:28:47.284928Z","steps":["trace[1943649360] 'agreement among raft nodes before linearized reading'  (duration: 421.382387ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T10:28:47.284962Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"417.671902ms","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-05T10:28:47.285083Z","caller":"traceutil/trace.go:171","msg":"trace[2028751708] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:7135; }","duration":"417.852475ms","start":"2026-05-05T10:28:46.867205Z","end":"2026-05-05T10:28:47.285057Z","steps":["trace[2028751708] 'agreement among raft nodes before linearized reading'  (duration: 417.514451ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T10:28:47.28511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"421.55008ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"warn","ts":"2026-05-05T10:28:47.285071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.357925ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/issuers/\" range_end:\"/registry/cert-manager.io/issuers0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-05-05T10:28:47.285148Z","caller":"traceutil/trace.go:171","msg":"trace[849237768] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:7135; }","duration":"421.598161ms","start":"2026-05-05T10:28:46.863541Z","end":"2026-05-05T10:28:47.285139Z","steps":["trace[849237768] 'agreement among raft nodes before linearized reading'  (duration: 421.503969ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T10:28:47.285159Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:28:46.86718Z","time spent":"417.964027ms","remote":"127.0.0.1:42624","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-05-05T10:28:47.285188Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:28:46.863535Z","time spent":"421.646311ms","remote":"127.0.0.1:42624","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-05-05T10:28:47.28521Z","caller":"traceutil/trace.go:171","msg":"trace[434197433] range","detail":"{range_begin:/registry/cert-manager.io/issuers/; range_end:/registry/cert-manager.io/issuers0; response_count:0; response_revision:7135; }","duration":"310.552307ms","start":"2026-05-05T10:28:46.974621Z","end":"2026-05-05T10:28:47.285173Z","steps":["trace[434197433] 'agreement among raft nodes before linearized reading'  (duration: 310.343694ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T10:28:47.285299Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:28:46.974598Z","time spent":"310.682731ms","remote":"127.0.0.1:44248","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":31,"request content":"key:\"/registry/cert-manager.io/issuers/\" range_end:\"/registry/cert-manager.io/issuers0\" count_only:true "}
{"level":"warn","ts":"2026-05-05T10:28:47.285387Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"419.443489ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"}
{"level":"warn","ts":"2026-05-05T10:28:47.285019Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:28:46.86329Z","time spent":"421.713053ms","remote":"127.0.0.1:42624","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":463,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-05-05T10:28:47.285464Z","caller":"traceutil/trace.go:171","msg":"trace[523313818] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:7135; }","duration":"419.649892ms","start":"2026-05-05T10:28:46.865795Z","end":"2026-05-05T10:28:47.285444Z","steps":["trace[523313818] 'agreement among raft nodes before linearized reading'  (duration: 419.302946ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T10:28:47.285544Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:28:46.86577Z","time spent":"419.761483ms","remote":"127.0.0.1:42624","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-05-05T10:28:47.285741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"420.20684ms","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-05T10:28:47.285877Z","caller":"traceutil/trace.go:171","msg":"trace[1875523540] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:7135; }","duration":"420.369403ms","start":"2026-05-05T10:28:46.865481Z","end":"2026-05-05T10:28:47.28585Z","steps":["trace[1875523540] 'agreement among raft nodes before linearized reading'  (duration: 419.55984ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T10:28:47.285999Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:28:46.865474Z","time spent":"420.510795ms","remote":"127.0.0.1:42624","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":583,"request content":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" "}
{"level":"warn","ts":"2026-05-05T10:28:48.084677Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:28:47.676706Z","time spent":"407.962736ms","remote":"127.0.0.1:56040","response type":"/etcdserverpb.Maintenance/Status","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"info","ts":"2026-05-05T10:28:48.086147Z","caller":"traceutil/trace.go:171","msg":"trace[476329489] transaction","detail":"{read_only:false; response_revision:7143; number_of_response:1; }","duration":"419.79338ms","start":"2026-05-05T10:28:47.666328Z","end":"2026-05-05T10:28:48.086121Z","steps":["trace[476329489] 'process raft request'  (duration: 419.610718ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T10:28:48.086317Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:28:47.666311Z","time spent":"419.917393ms","remote":"127.0.0.1:42624","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:7131 > 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-05T10:28:48.087016Z","caller":"traceutil/trace.go:171","msg":"trace[235199557] transaction","detail":"{read_only:false; response_revision:7144; number_of_response:1; }","duration":"342.590334ms","start":"2026-05-05T10:28:47.744402Z","end":"2026-05-05T10:28:48.086993Z","steps":["trace[235199557] 'process raft request'  (duration: 342.457662ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T10:28:48.087198Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:28:47.744381Z","time spent":"342.730936ms","remote":"127.0.0.1:42624","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:7132 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:459 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"info","ts":"2026-05-05T10:29:44.470118Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5628}
{"level":"info","ts":"2026-05-05T10:29:44.559849Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5628,"took":"86.91288ms","hash":3683016521,"current-db-size-bytes":54439936,"current-db-size":"54 MB","current-db-size-in-use-bytes":18313216,"current-db-size-in-use":"18 MB"}
{"level":"info","ts":"2026-05-05T10:29:44.559905Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3683016521,"revision":5628,"compact-revision":2905}