{"level":"warn","ts":"2026-05-08T23:10:53.739218Z","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-08T23:10:53.739306Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.238:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.238:2380","--initial-cluster=instance=https://199.204.45.238:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.238:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.238: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-08T23:10:53.739378Z","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-08T23:10:53.739391Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.238:2380"]}
{"level":"info","ts":"2026-05-08T23:10:53.739407Z","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-08T23:10:53.740054Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.238:2379"]}
{"level":"info","ts":"2026-05-08T23:10:53.740128Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.238:2380"],"listen-peer-urls":["https://199.204.45.238:2380"],"advertise-client-urls":["https://199.204.45.238:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.238:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.238: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-08T23:10:53.744384Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.024811ms"}
{"level":"info","ts":"2026-05-08T23:10:53.751073Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"d7dbc9f5893cc1f6","cluster-id":"823d1d08ab21430c"}
{"level":"info","ts":"2026-05-08T23:10:53.75118Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 switched to configuration voters=()"}
{"level":"info","ts":"2026-05-08T23:10:53.751214Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 became follower at term 0"}
{"level":"info","ts":"2026-05-08T23:10:53.751232Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft d7dbc9f5893cc1f6 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-05-08T23:10:53.751255Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 became follower at term 1"}
{"level":"info","ts":"2026-05-08T23:10:53.751305Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 switched to configuration voters=(15554247794460770806)"}
{"level":"warn","ts":"2026-05-08T23:10:53.759081Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-05-08T23:10:53.76117Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-05-08T23:10:53.763258Z","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-08T23:10:53.765659Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"d7dbc9f5893cc1f6","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-05-08T23:10:53.766387Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"d7dbc9f5893cc1f6","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-05-08T23:10:53.766557Z","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-08T23:10:53.766754Z","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-08T23:10:53.766794Z","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-08T23:10:53.767353Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 switched to configuration voters=(15554247794460770806)"}
{"level":"info","ts":"2026-05-08T23:10:53.768783Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"823d1d08ab21430c","local-member-id":"d7dbc9f5893cc1f6","added-peer-id":"d7dbc9f5893cc1f6","added-peer-peer-urls":["https://199.204.45.238:2380"]}
{"level":"info","ts":"2026-05-08T23:10:53.773476Z","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-08T23:10:53.773778Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"d7dbc9f5893cc1f6","initial-advertise-peer-urls":["https://199.204.45.238:2380"],"listen-peer-urls":["https://199.204.45.238:2380"],"advertise-client-urls":["https://199.204.45.238:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.238:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-05-08T23:10:53.773829Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-05-08T23:10:53.773995Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.238:2380"}
{"level":"info","ts":"2026-05-08T23:10:53.774023Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.238:2380"}
{"level":"info","ts":"2026-05-08T23:10:54.452175Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 is starting a new election at term 1"}
{"level":"info","ts":"2026-05-08T23:10:54.452243Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 became pre-candidate at term 1"}
{"level":"info","ts":"2026-05-08T23:10:54.452285Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 received MsgPreVoteResp from d7dbc9f5893cc1f6 at term 1"}
{"level":"info","ts":"2026-05-08T23:10:54.452305Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 became candidate at term 2"}
{"level":"info","ts":"2026-05-08T23:10:54.452328Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 received MsgVoteResp from d7dbc9f5893cc1f6 at term 2"}
{"level":"info","ts":"2026-05-08T23:10:54.452344Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 became leader at term 2"}
{"level":"info","ts":"2026-05-08T23:10:54.452357Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: d7dbc9f5893cc1f6 elected leader d7dbc9f5893cc1f6 at term 2"}
{"level":"info","ts":"2026-05-08T23:10:54.466026Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"d7dbc9f5893cc1f6","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.238:2379]}","request-path":"/0/members/d7dbc9f5893cc1f6/attributes","cluster-id":"823d1d08ab21430c","publish-timeout":"7s"}
{"level":"info","ts":"2026-05-08T23:10:54.466149Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-05-08T23:10:54.466276Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-08T23:10:54.466251Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-05-08T23:10:54.467919Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-05-08T23:10:54.469334Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.238:2379"}
{"level":"info","ts":"2026-05-08T23:10:54.469356Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"823d1d08ab21430c","local-member-id":"d7dbc9f5893cc1f6","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-08T23:10:54.469413Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-05-08T23:10:54.469545Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-08T23:10:54.46954Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-05-08T23:10:54.469599Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-08T23:11:30.835449Z","caller":"traceutil/trace.go:171","msg":"trace[1385160261] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"242.453693ms","start":"2026-05-08T23:11:30.592974Z","end":"2026-05-08T23:11:30.835428Z","steps":["trace[1385160261] 'process raft request'  (duration: 211.783966ms)","trace[1385160261] 'compare'  (duration: 30.339579ms)"],"step_count":2}
{"level":"info","ts":"2026-05-08T23:11:30.835442Z","caller":"traceutil/trace.go:171","msg":"trace[1515232654] linearizableReadLoop","detail":"{readStateIndex:634; appliedIndex:633; }","duration":"114.375337ms","start":"2026-05-08T23:11:30.721015Z","end":"2026-05-08T23:11:30.835391Z","steps":["trace[1515232654] 'read index received'  (duration: 83.736251ms)","trace[1515232654] 'applied index is now lower than readState.Index'  (duration: 30.637476ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-08T23:11:30.835723Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.689034ms","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-08T23:11:30.835793Z","caller":"traceutil/trace.go:171","msg":"trace[1883865671] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:613; }","duration":"114.827838ms","start":"2026-05-08T23:11:30.720951Z","end":"2026-05-08T23:11:30.835779Z","steps":["trace[1883865671] 'agreement among raft nodes before linearized reading'  (duration: 114.565541ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:11:31.251275Z","caller":"traceutil/trace.go:171","msg":"trace[202895903] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"112.137924ms","start":"2026-05-08T23:11:31.139116Z","end":"2026-05-08T23:11:31.251254Z","steps":["trace[202895903] 'process raft request'  (duration: 111.624092ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:11:31.756521Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:11:31.418698Z","time spent":"337.812964ms","remote":"127.0.0.1:32852","response type":"/etcdserverpb.Maintenance/Status","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"info","ts":"2026-05-08T23:11:31.760365Z","caller":"traceutil/trace.go:171","msg":"trace[1448004183] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"448.73876ms","start":"2026-05-08T23:11:31.311594Z","end":"2026-05-08T23:11:31.760333Z","steps":["trace[1448004183] 'process raft request'  (duration: 427.699014ms)","trace[1448004183] 'compare'  (duration: 16.738572ms)"],"step_count":2}
{"level":"info","ts":"2026-05-08T23:11:31.761139Z","caller":"traceutil/trace.go:171","msg":"trace[1638356298] linearizableReadLoop","detail":"{readStateIndex:637; appliedIndex:636; }","duration":"293.699394ms","start":"2026-05-08T23:11:31.466442Z","end":"2026-05-08T23:11:31.760141Z","steps":["trace[1638356298] 'read index received'  (duration: 272.575947ms)","trace[1638356298] 'applied index is now lower than readState.Index'  (duration: 21.121807ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-08T23:11:31.761177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.726009ms","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-08T23:11:31.761233Z","caller":"traceutil/trace.go:171","msg":"trace[87080902] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:616; }","duration":"294.793471ms","start":"2026-05-08T23:11:31.46642Z","end":"2026-05-08T23:11:31.761213Z","steps":["trace[87080902] 'agreement among raft nodes before linearized reading'  (duration: 293.741085ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:11:31.761871Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:11:31.311558Z","time spent":"449.635991ms","remote":"127.0.0.1:51594","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036285,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" mod_revision:612 > success:<request_put:<key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" value_size:1036201 >> failure:<request_range:<key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" > >"}
{"level":"info","ts":"2026-05-08T23:11:32.390691Z","caller":"traceutil/trace.go:171","msg":"trace[1748824946] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"135.653479ms","start":"2026-05-08T23:11:32.255009Z","end":"2026-05-08T23:11:32.390663Z","steps":["trace[1748824946] 'process raft request'  (duration: 131.645262ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:11:46.401812Z","caller":"traceutil/trace.go:171","msg":"trace[1391600714] transaction","detail":"{read_only:false; response_revision:777; number_of_response:1; }","duration":"174.88481ms","start":"2026-05-08T23:11:46.226896Z","end":"2026-05-08T23:11:46.401781Z","steps":["trace[1391600714] 'process raft request'  (duration: 174.682135ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:12:14.171464Z","caller":"traceutil/trace.go:171","msg":"trace[2071867999] linearizableReadLoop","detail":"{readStateIndex:1202; appliedIndex:1201; }","duration":"134.018869ms","start":"2026-05-08T23:12:14.037417Z","end":"2026-05-08T23:12:14.171436Z","steps":["trace[2071867999] 'read index received'  (duration: 133.859825ms)","trace[2071867999] 'applied index is now lower than readState.Index'  (duration: 157.804µs)"],"step_count":2}
{"level":"info","ts":"2026-05-08T23:12:14.171528Z","caller":"traceutil/trace.go:171","msg":"trace[1765696268] transaction","detail":"{read_only:false; response_revision:1170; number_of_response:1; }","duration":"142.522653ms","start":"2026-05-08T23:12:14.028967Z","end":"2026-05-08T23:12:14.171489Z","steps":["trace[1765696268] 'process raft request'  (duration: 142.246527ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:12:14.17173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.263486ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-05-08T23:12:14.172683Z","caller":"traceutil/trace.go:171","msg":"trace[1459452926] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; response_count:0; response_revision:1170; }","duration":"135.280239ms","start":"2026-05-08T23:12:14.037376Z","end":"2026-05-08T23:12:14.172656Z","steps":["trace[1459452926] 'agreement among raft nodes before linearized reading'  (duration: 134.207634ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:13:02.590329Z","caller":"traceutil/trace.go:171","msg":"trace[71903346] transaction","detail":"{read_only:false; response_revision:1845; number_of_response:1; }","duration":"218.345352ms","start":"2026-05-08T23:13:02.371949Z","end":"2026-05-08T23:13:02.590294Z","steps":["trace[71903346] 'process raft request'  (duration: 218.111966ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:13:02.893263Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.495366ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13976532258768766385 > lease_revoke:<id:41f69e09dbb343fe>","response":"size:29"}
{"level":"info","ts":"2026-05-08T23:13:02.893754Z","caller":"traceutil/trace.go:171","msg":"trace[1345149853] linearizableReadLoop","detail":"{readStateIndex:1913; appliedIndex:1911; }","duration":"470.979332ms","start":"2026-05-08T23:13:02.422548Z","end":"2026-05-08T23:13:02.893527Z","steps":["trace[1345149853] 'read index received'  (duration: 167.545083ms)","trace[1345149853] 'applied index is now lower than readState.Index'  (duration: 303.431749ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-08T23:13:02.89404Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"471.475875ms","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-08T23:13:02.89425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.758845ms","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-08T23:13:02.894225Z","caller":"traceutil/trace.go:171","msg":"trace[2052135056] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1845; }","duration":"471.642929ms","start":"2026-05-08T23:13:02.422492Z","end":"2026-05-08T23:13:02.894135Z","steps":["trace[2052135056] 'agreement among raft nodes before linearized reading'  (duration: 471.2886ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:13:02.894342Z","caller":"traceutil/trace.go:171","msg":"trace[693510656] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1845; }","duration":"300.909198ms","start":"2026-05-08T23:13:02.593416Z","end":"2026-05-08T23:13:02.894325Z","steps":["trace[693510656] 'agreement among raft nodes before linearized reading'  (duration: 300.586881ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:13:02.89436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.259649ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-16dc2048-85c3-4f4e-bb7e-f6a3fda09815\" ","response":"range_response_count:1 size:3627"}
{"level":"warn","ts":"2026-05-08T23:13:02.894249Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.334188ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-16dc2048-85c3-4f4e-bb7e-f6a3fda09815\" ","response":"range_response_count:1 size:3627"}
{"level":"warn","ts":"2026-05-08T23:13:02.894448Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:13:02.593392Z","time spent":"301.042071ms","remote":"127.0.0.1:46098","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-08T23:13:02.894508Z","caller":"traceutil/trace.go:171","msg":"trace[1468513997] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-16dc2048-85c3-4f4e-bb7e-f6a3fda09815; range_end:; response_count:1; response_revision:1845; }","duration":"261.454934ms","start":"2026-05-08T23:13:02.633014Z","end":"2026-05-08T23:13:02.894469Z","steps":["trace[1468513997] 'agreement among raft nodes before linearized reading'  (duration: 261.093665ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:13:02.894524Z","caller":"traceutil/trace.go:171","msg":"trace[945557116] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-16dc2048-85c3-4f4e-bb7e-f6a3fda09815; range_end:; response_count:1; response_revision:1845; }","duration":"148.618015ms","start":"2026-05-08T23:13:02.745857Z","end":"2026-05-08T23:13:02.894475Z","steps":["trace[945557116] 'agreement among raft nodes before linearized reading'  (duration: 148.260376ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:13:02.894383Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:13:02.422468Z","time spent":"471.896954ms","remote":"127.0.0.1:51812","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-08T23:13:03.016478Z","caller":"traceutil/trace.go:171","msg":"trace[718719410] transaction","detail":"{read_only:false; response_revision:1847; number_of_response:1; }","duration":"116.690393ms","start":"2026-05-08T23:13:02.899752Z","end":"2026-05-08T23:13:03.016443Z","steps":["trace[718719410] 'process raft request'  (duration: 116.15654ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:13:03.016848Z","caller":"traceutil/trace.go:171","msg":"trace[161258354] transaction","detail":"{read_only:false; response_revision:1848; number_of_response:1; }","duration":"113.045205ms","start":"2026-05-08T23:13:02.903763Z","end":"2026-05-08T23:13:03.016808Z","steps":["trace[161258354] 'process raft request'  (duration: 112.606014ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:13:47.353982Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.629191ms","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-08T23:13:47.354144Z","caller":"traceutil/trace.go:171","msg":"trace[1606892899] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2143; }","duration":"112.853316ms","start":"2026-05-08T23:13:47.24127Z","end":"2026-05-08T23:13:47.354123Z","steps":["trace[1606892899] 'range keys from in-memory index tree'  (duration: 112.263702ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:13:47.354144Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.256139ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"info","ts":"2026-05-08T23:13:47.35428Z","caller":"traceutil/trace.go:171","msg":"trace[242586655] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2143; }","duration":"111.464084ms","start":"2026-05-08T23:13:47.242779Z","end":"2026-05-08T23:13:47.354243Z","steps":["trace[242586655] 'range keys from in-memory index tree'  (duration: 110.86554ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:13:53.431895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.09497ms","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-08T23:13:53.432001Z","caller":"traceutil/trace.go:171","msg":"trace[1101896550] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2176; }","duration":"161.267814ms","start":"2026-05-08T23:13:53.27071Z","end":"2026-05-08T23:13:53.431978Z","steps":["trace[1101896550] 'range keys from in-memory index tree'  (duration: 160.907245ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:13:53.432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.855643ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"}
{"level":"info","ts":"2026-05-08T23:13:53.432067Z","caller":"traceutil/trace.go:171","msg":"trace[330321933] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2176; }","duration":"207.013607ms","start":"2026-05-08T23:13:53.225039Z","end":"2026-05-08T23:13:53.432053Z","steps":["trace[330321933] 'range keys from in-memory index tree'  (duration: 206.463804ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:13:53.653197Z","caller":"traceutil/trace.go:171","msg":"trace[1430108843] transaction","detail":"{read_only:false; response_revision:2178; number_of_response:1; }","duration":"216.749721ms","start":"2026-05-08T23:13:53.436424Z","end":"2026-05-08T23:13:53.653173Z","steps":["trace[1430108843] 'process raft request'  (duration: 216.558897ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:13:53.653469Z","caller":"traceutil/trace.go:171","msg":"trace[1378931336] transaction","detail":"{read_only:false; response_revision:2179; number_of_response:1; }","duration":"216.859253ms","start":"2026-05-08T23:13:53.436562Z","end":"2026-05-08T23:13:53.653421Z","steps":["trace[1378931336] 'process raft request'  (duration: 216.574097ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:15:16.056963Z","caller":"traceutil/trace.go:171","msg":"trace[1081407454] transaction","detail":"{read_only:false; response_revision:2816; number_of_response:1; }","duration":"118.32906ms","start":"2026-05-08T23:15:15.938601Z","end":"2026-05-08T23:15:16.05693Z","steps":["trace[1081407454] 'process raft request'  (duration: 118.108775ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:15:16.291364Z","caller":"traceutil/trace.go:171","msg":"trace[974248597] linearizableReadLoop","detail":"{readStateIndex:2921; appliedIndex:2920; }","duration":"189.494283ms","start":"2026-05-08T23:15:16.101841Z","end":"2026-05-08T23:15:16.291335Z","steps":["trace[974248597] 'read index received'  (duration: 189.284648ms)","trace[974248597] 'applied index is now lower than readState.Index'  (duration: 208.015µs)"],"step_count":2}
{"level":"info","ts":"2026-05-08T23:15:16.291475Z","caller":"traceutil/trace.go:171","msg":"trace[311057987] transaction","detail":"{read_only:false; response_revision:2818; number_of_response:1; }","duration":"197.971315ms","start":"2026-05-08T23:15:16.093468Z","end":"2026-05-08T23:15:16.291439Z","steps":["trace[311057987] 'process raft request'  (duration: 197.669488ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:15:16.29169Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.475317ms","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-08T23:15:16.291705Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.552167ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-08T23:15:16.291764Z","caller":"traceutil/trace.go:171","msg":"trace[1192446212] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2818; }","duration":"188.58188ms","start":"2026-05-08T23:15:16.103166Z","end":"2026-05-08T23:15:16.291748Z","steps":["trace[1192446212] 'agreement among raft nodes before linearized reading'  (duration: 188.371755ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:15:16.2918Z","caller":"traceutil/trace.go:171","msg":"trace[2075689954] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2818; }","duration":"108.71631ms","start":"2026-05-08T23:15:16.183062Z","end":"2026-05-08T23:15:16.291778Z","steps":["trace[2075689954] 'agreement among raft nodes before linearized reading'  (duration: 108.546676ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:15:16.29169Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.83526ms","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-08T23:15:16.291973Z","caller":"traceutil/trace.go:171","msg":"trace[2127950848] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2818; }","duration":"190.149728ms","start":"2026-05-08T23:15:16.101777Z","end":"2026-05-08T23:15:16.291927Z","steps":["trace[2127950848] 'agreement among raft nodes before linearized reading'  (duration: 189.725198ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:15:16.421995Z","caller":"traceutil/trace.go:171","msg":"trace[1045229490] transaction","detail":"{read_only:false; response_revision:2819; number_of_response:1; }","duration":"126.157717ms","start":"2026-05-08T23:15:16.295801Z","end":"2026-05-08T23:15:16.421959Z","steps":["trace[1045229490] 'process raft request'  (duration: 33.091501ms)","trace[1045229490] 'compare'  (duration: 92.82178ms)"],"step_count":2}
{"level":"info","ts":"2026-05-08T23:15:16.422334Z","caller":"traceutil/trace.go:171","msg":"trace[107448855] transaction","detail":"{read_only:false; response_revision:2820; number_of_response:1; }","duration":"124.55701ms","start":"2026-05-08T23:15:16.297734Z","end":"2026-05-08T23:15:16.422291Z","steps":["trace[107448855] 'process raft request'  (duration: 124.16568ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:19:25.640026Z","caller":"traceutil/trace.go:171","msg":"trace[462017931] transaction","detail":"{read_only:false; response_revision:5068; number_of_response:1; }","duration":"144.964778ms","start":"2026-05-08T23:19:25.495039Z","end":"2026-05-08T23:19:25.640004Z","steps":["trace[462017931] 'process raft request'  (duration: 144.819414ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:19:25.819811Z","caller":"traceutil/trace.go:171","msg":"trace[595719145] linearizableReadLoop","detail":"{readStateIndex:5260; appliedIndex:5256; }","duration":"251.613843ms","start":"2026-05-08T23:19:25.568167Z","end":"2026-05-08T23:19:25.819781Z","steps":["trace[595719145] 'read index received'  (duration: 71.748706ms)","trace[595719145] 'applied index is now lower than readState.Index'  (duration: 179.864227ms)"],"step_count":2}
{"level":"info","ts":"2026-05-08T23:19:25.819968Z","caller":"traceutil/trace.go:171","msg":"trace[1482842743] transaction","detail":"{read_only:false; response_revision:5070; number_of_response:1; }","duration":"280.834908ms","start":"2026-05-08T23:19:25.539119Z","end":"2026-05-08T23:19:25.819954Z","steps":["trace[1482842743] 'process raft request'  (duration: 280.575532ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:19:25.819985Z","caller":"traceutil/trace.go:171","msg":"trace[1182103631] transaction","detail":"{read_only:false; response_revision:5069; number_of_response:1; }","duration":"313.654538ms","start":"2026-05-08T23:19:25.50629Z","end":"2026-05-08T23:19:25.819944Z","steps":["trace[1182103631] 'process raft request'  (duration: 280.628984ms)","trace[1182103631] 'compare'  (duration: 32.633295ms)"],"step_count":2}
{"level":"info","ts":"2026-05-08T23:19:25.820083Z","caller":"traceutil/trace.go:171","msg":"trace[962124198] transaction","detail":"{read_only:false; response_revision:5071; number_of_response:1; }","duration":"276.112045ms","start":"2026-05-08T23:19:25.543944Z","end":"2026-05-08T23:19:25.820056Z","steps":["trace[962124198] 'process raft request'  (duration: 275.798908ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:19:25.820109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.9193ms","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-08T23:19:25.820165Z","caller":"traceutil/trace.go:171","msg":"trace[181371544] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5071; }","duration":"252.036403ms","start":"2026-05-08T23:19:25.568115Z","end":"2026-05-08T23:19:25.820151Z","steps":["trace[181371544] 'agreement among raft nodes before linearized reading'  (duration: 251.857199ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:19:25.820171Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:19:25.506274Z","time spent":"313.789611ms","remote":"127.0.0.1:51812","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" mod_revision:4832 > success:<request_put:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" value_size:416 >> failure:<request_range:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" > >"}
{"level":"warn","ts":"2026-05-08T23:19:25.820724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.749015ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-e866bf2f-147f-48a8-b683-96f06c9c5898\" ","response":"range_response_count:1 size:3601"}
{"level":"info","ts":"2026-05-08T23:19:25.820812Z","caller":"traceutil/trace.go:171","msg":"trace[1745473271] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-e866bf2f-147f-48a8-b683-96f06c9c5898; range_end:; response_count:1; response_revision:5071; }","duration":"203.885908ms","start":"2026-05-08T23:19:25.616911Z","end":"2026-05-08T23:19:25.820797Z","steps":["trace[1745473271] 'agreement among raft nodes before linearized reading'  (duration: 203.354575ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:19:35.938462Z","caller":"traceutil/trace.go:171","msg":"trace[764242867] transaction","detail":"{read_only:false; response_revision:5271; number_of_response:1; }","duration":"103.662785ms","start":"2026-05-08T23:19:35.834765Z","end":"2026-05-08T23:19:35.938428Z","steps":["trace[764242867] 'process raft request'  (duration: 13.904911ms)","trace[764242867] 'compare'  (duration: 89.278543ms)"],"step_count":2}
{"level":"info","ts":"2026-05-08T23:19:35.938689Z","caller":"traceutil/trace.go:171","msg":"trace[1371078353] transaction","detail":"{read_only:false; response_revision:5272; number_of_response:1; }","duration":"101.066393ms","start":"2026-05-08T23:19:35.837533Z","end":"2026-05-08T23:19:35.938599Z","steps":["trace[1371078353] 'process raft request'  (duration: 100.722185ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:19:36.14962Z","caller":"traceutil/trace.go:171","msg":"trace[474355168] transaction","detail":"{read_only:false; response_revision:5282; number_of_response:1; }","duration":"142.481338ms","start":"2026-05-08T23:19:36.007108Z","end":"2026-05-08T23:19:36.14959Z","steps":["trace[474355168] 'process raft request'  (duration: 70.736082ms)","trace[474355168] 'compare'  (duration: 71.584112ms)"],"step_count":2}
{"level":"info","ts":"2026-05-08T23:19:36.300126Z","caller":"traceutil/trace.go:171","msg":"trace[564663876] transaction","detail":"{read_only:false; response_revision:5283; number_of_response:1; }","duration":"133.069504ms","start":"2026-05-08T23:19:36.167015Z","end":"2026-05-08T23:19:36.300085Z","steps":["trace[564663876] 'process raft request'  (duration: 104.155787ms)","trace[564663876] 'compare'  (duration: 28.763984ms)"],"step_count":2}
{"level":"info","ts":"2026-05-08T23:19:36.30311Z","caller":"traceutil/trace.go:171","msg":"trace[1102437970] linearizableReadLoop","detail":"{readStateIndex:5481; appliedIndex:5477; }","duration":"128.771282ms","start":"2026-05-08T23:19:36.174316Z","end":"2026-05-08T23:19:36.303087Z","steps":["trace[1102437970] 'read index received'  (duration: 96.865783ms)","trace[1102437970] 'applied index is now lower than readState.Index'  (duration: 31.904049ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-08T23:19:36.303337Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.009638ms","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-08T23:19:36.303386Z","caller":"traceutil/trace.go:171","msg":"trace[665648842] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5286; }","duration":"129.12995ms","start":"2026-05-08T23:19:36.174245Z","end":"2026-05-08T23:19:36.303375Z","steps":["trace[665648842] 'agreement among raft nodes before linearized reading'  (duration: 128.931536ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:19:36.3038Z","caller":"traceutil/trace.go:171","msg":"trace[1432778840] transaction","detail":"{read_only:false; response_revision:5286; number_of_response:1; }","duration":"132.130932ms","start":"2026-05-08T23:19:36.171652Z","end":"2026-05-08T23:19:36.303783Z","steps":["trace[1432778840] 'process raft request'  (duration: 131.319922ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:19:36.303901Z","caller":"traceutil/trace.go:171","msg":"trace[1895950553] transaction","detail":"{read_only:false; response_revision:5284; number_of_response:1; }","duration":"136.24788ms","start":"2026-05-08T23:19:36.167634Z","end":"2026-05-08T23:19:36.303882Z","steps":["trace[1895950553] 'process raft request'  (duration: 135.161184ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:19:36.304315Z","caller":"traceutil/trace.go:171","msg":"trace[640592833] transaction","detail":"{read_only:false; response_revision:5285; number_of_response:1; }","duration":"135.588914ms","start":"2026-05-08T23:19:36.168708Z","end":"2026-05-08T23:19:36.304297Z","steps":["trace[640592833] 'process raft request'  (duration: 134.19917ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:19:44.236626Z","caller":"traceutil/trace.go:171","msg":"trace[1644790998] linearizableReadLoop","detail":"{readStateIndex:5652; appliedIndex:5651; }","duration":"242.585528ms","start":"2026-05-08T23:19:43.994014Z","end":"2026-05-08T23:19:44.2366Z","steps":["trace[1644790998] 'read index received'  (duration: 152.528766ms)","trace[1644790998] 'applied index is now lower than readState.Index'  (duration: 90.055402ms)"],"step_count":2}
{"level":"info","ts":"2026-05-08T23:19:44.236749Z","caller":"traceutil/trace.go:171","msg":"trace[1525500500] transaction","detail":"{read_only:false; response_revision:5450; number_of_response:1; }","duration":"251.549242ms","start":"2026-05-08T23:19:43.985158Z","end":"2026-05-08T23:19:44.236707Z","steps":["trace[1525500500] 'process raft request'  (duration: 161.372257ms)","trace[1525500500] 'compare'  (duration: 89.844216ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-08T23:19:44.236952Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.918426ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/storage-loki-0\" ","response":"range_response_count:1 size:1781"}
{"level":"info","ts":"2026-05-08T23:19:44.237002Z","caller":"traceutil/trace.go:171","msg":"trace[358962654] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/storage-loki-0; range_end:; response_count:1; response_revision:5450; }","duration":"243.019688ms","start":"2026-05-08T23:19:43.993969Z","end":"2026-05-08T23:19:44.236989Z","steps":["trace[358962654] 'agreement among raft nodes before linearized reading'  (duration: 242.758542ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:19:44.302545Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.206466ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-08T23:19:44.302534Z","caller":"traceutil/trace.go:171","msg":"trace[351508417] transaction","detail":"{read_only:false; response_revision:5451; number_of_response:1; }","duration":"291.648205ms","start":"2026-05-08T23:19:44.010846Z","end":"2026-05-08T23:19:44.302482Z","steps":["trace[351508417] 'process raft request'  (duration: 291.43419ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:19:44.302619Z","caller":"traceutil/trace.go:171","msg":"trace[1829875155] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5451; }","duration":"122.326919ms","start":"2026-05-08T23:19:44.180274Z","end":"2026-05-08T23:19:44.302601Z","steps":["trace[1829875155] 'agreement among raft nodes before linearized reading'  (duration: 122.215817ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:19:44.302617Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.382ms","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-08T23:19:44.302699Z","caller":"traceutil/trace.go:171","msg":"trace[898964590] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5451; }","duration":"262.548833ms","start":"2026-05-08T23:19:44.040135Z","end":"2026-05-08T23:19:44.302684Z","steps":["trace[898964590] 'agreement among raft nodes before linearized reading'  (duration: 262.291477ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:19:44.302768Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.160824ms","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-08T23:19:44.302835Z","caller":"traceutil/trace.go:171","msg":"trace[1461078239] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5451; }","duration":"307.266536ms","start":"2026-05-08T23:19:43.99555Z","end":"2026-05-08T23:19:44.302816Z","steps":["trace[1461078239] 'agreement among raft nodes before linearized reading'  (duration: 307.072332ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:19:44.302873Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:19:43.995529Z","time spent":"307.335709ms","remote":"127.0.0.1:51812","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-05-08T23:19:44.303055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.654649ms","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-08T23:19:44.303124Z","caller":"traceutil/trace.go:171","msg":"trace[1499018007] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5451; }","duration":"268.75491ms","start":"2026-05-08T23:19:44.034355Z","end":"2026-05-08T23:19:44.30311Z","steps":["trace[1499018007] 'agreement among raft nodes before linearized reading'  (duration: 268.100205ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:19:44.433343Z","caller":"traceutil/trace.go:171","msg":"trace[322743449] transaction","detail":"{read_only:false; response_revision:5453; number_of_response:1; }","duration":"124.89114ms","start":"2026-05-08T23:19:44.308414Z","end":"2026-05-08T23:19:44.433305Z","steps":["trace[322743449] 'process raft request'  (duration: 116.568402ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:19:44.433678Z","caller":"traceutil/trace.go:171","msg":"trace[1717641585] transaction","detail":"{read_only:false; response_revision:5454; number_of_response:1; }","duration":"124.010549ms","start":"2026-05-08T23:19:44.309631Z","end":"2026-05-08T23:19:44.433642Z","steps":["trace[1717641585] 'process raft request'  (duration: 123.561758ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:19:44.434119Z","caller":"traceutil/trace.go:171","msg":"trace[1443840532] transaction","detail":"{read_only:false; response_revision:5460; number_of_response:1; }","duration":"123.078536ms","start":"2026-05-08T23:19:44.311027Z","end":"2026-05-08T23:19:44.434105Z","steps":["trace[1443840532] 'process raft request'  (duration: 122.882142ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:19:44.434128Z","caller":"traceutil/trace.go:171","msg":"trace[1672536996] transaction","detail":"{read_only:false; response_revision:5457; number_of_response:1; }","duration":"124.202783ms","start":"2026-05-08T23:19:44.309899Z","end":"2026-05-08T23:19:44.434102Z","steps":["trace[1672536996] 'process raft request'  (duration: 123.842975ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:19:44.434233Z","caller":"traceutil/trace.go:171","msg":"trace[342245554] transaction","detail":"{read_only:false; response_revision:5461; number_of_response:1; }","duration":"111.492862ms","start":"2026-05-08T23:19:44.322703Z","end":"2026-05-08T23:19:44.434195Z","steps":["trace[342245554] 'process raft request'  (duration: 111.273576ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:19:44.434314Z","caller":"traceutil/trace.go:171","msg":"trace[695280759] transaction","detail":"{read_only:false; response_revision:5458; number_of_response:1; }","duration":"124.316366ms","start":"2026-05-08T23:19:44.309986Z","end":"2026-05-08T23:19:44.434302Z","steps":["trace[695280759] 'process raft request'  (duration: 123.815924ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:19:44.434316Z","caller":"traceutil/trace.go:171","msg":"trace[449192039] transaction","detail":"{read_only:false; response_revision:5456; number_of_response:1; }","duration":"124.48164ms","start":"2026-05-08T23:19:44.309818Z","end":"2026-05-08T23:19:44.4343Z","steps":["trace[449192039] 'process raft request'  (duration: 123.846095ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:19:44.434411Z","caller":"traceutil/trace.go:171","msg":"trace[29651974] transaction","detail":"{read_only:false; response_revision:5459; number_of_response:1; }","duration":"123.948997ms","start":"2026-05-08T23:19:44.31045Z","end":"2026-05-08T23:19:44.434399Z","steps":["trace[29651974] 'process raft request'  (duration: 123.403035ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:19:44.434602Z","caller":"traceutil/trace.go:171","msg":"trace[531362361] transaction","detail":"{read_only:false; response_revision:5455; number_of_response:1; }","duration":"124.772596ms","start":"2026-05-08T23:19:44.309799Z","end":"2026-05-08T23:19:44.434572Z","steps":["trace[531362361] 'process raft request'  (duration: 123.705881ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:20:54.493545Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3027}
{"level":"info","ts":"2026-05-08T23:20:54.577848Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3027,"took":"82.5983ms","hash":1139091851,"current-db-size-bytes":57024512,"current-db-size":"57 MB","current-db-size-in-use-bytes":31477760,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-05-08T23:20:54.577974Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1139091851,"revision":3027,"compact-revision":-1}
{"level":"info","ts":"2026-05-08T23:25:54.506319Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6104}
{"level":"info","ts":"2026-05-08T23:25:54.604446Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6104,"took":"95.877726ms","hash":3064396340,"current-db-size-bytes":57024512,"current-db-size":"57 MB","current-db-size-in-use-bytes":21708800,"current-db-size-in-use":"22 MB"}
{"level":"info","ts":"2026-05-08T23:25:54.60478Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3064396340,"revision":6104,"compact-revision":3027}
{"level":"info","ts":"2026-05-08T23:26:00.859423Z","caller":"traceutil/trace.go:171","msg":"trace[632322979] transaction","detail":"{read_only:false; response_revision:8330; number_of_response:1; }","duration":"359.930808ms","start":"2026-05-08T23:26:00.499452Z","end":"2026-05-08T23:26:00.859383Z","steps":["trace[632322979] 'process raft request'  (duration: 359.691452ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:26:00.859653Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:26:00.499438Z","time spent":"360.091091ms","remote":"127.0.0.1:51812","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:8321 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-05-08T23:26:00.977461Z","caller":"traceutil/trace.go:171","msg":"trace[1184263088] transaction","detail":"{read_only:false; response_revision:8331; number_of_response:1; }","duration":"475.887121ms","start":"2026-05-08T23:26:00.501553Z","end":"2026-05-08T23:26:00.97744Z","steps":["trace[1184263088] 'process raft request'  (duration: 475.708237ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:26:00.977601Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:26:00.501523Z","time spent":"476.003733ms","remote":"127.0.0.1:51812","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:8322 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-05-08T23:26:00.97775Z","caller":"traceutil/trace.go:171","msg":"trace[1571825074] transaction","detail":"{read_only:false; response_revision:8332; number_of_response:1; }","duration":"358.630606ms","start":"2026-05-08T23:26:00.619097Z","end":"2026-05-08T23:26:00.977727Z","steps":["trace[1571825074] 'process raft request'  (duration: 358.308248ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:26:00.977762Z","caller":"traceutil/trace.go:171","msg":"trace[1255560743] linearizableReadLoop","detail":"{readStateIndex:8624; appliedIndex:8622; }","duration":"468.912796ms","start":"2026-05-08T23:26:00.508784Z","end":"2026-05-08T23:26:00.977696Z","steps":["trace[1255560743] 'read index received'  (duration: 350.465534ms)","trace[1255560743] 'applied index is now lower than readState.Index'  (duration: 118.443562ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-08T23:26:00.977877Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"469.09486ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-05-08T23:26:00.977823Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:26:00.619067Z","time spent":"358.720598ms","remote":"127.0.0.1:51812","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:8324 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:458 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"info","ts":"2026-05-08T23:26:00.977913Z","caller":"traceutil/trace.go:171","msg":"trace[884189771] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:8332; }","duration":"469.149521ms","start":"2026-05-08T23:26:00.508756Z","end":"2026-05-08T23:26:00.977905Z","steps":["trace[884189771] 'agreement among raft nodes before linearized reading'  (duration: 469.09097ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:26:00.977944Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:26:00.508729Z","time spent":"469.210173ms","remote":"127.0.0.1:60740","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "}
{"level":"warn","ts":"2026-05-08T23:26:00.979376Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"462.142474ms","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-08T23:26:00.979475Z","caller":"traceutil/trace.go:171","msg":"trace[1332182993] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8333; }","duration":"462.296428ms","start":"2026-05-08T23:26:00.517154Z","end":"2026-05-08T23:26:00.979451Z","steps":["trace[1332182993] 'agreement among raft nodes before linearized reading'  (duration: 462.014142ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:26:00.979624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.435804ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/nfd.k8s-sigs.io/nodefeatures/\" range_end:\"/registry/nfd.k8s-sigs.io/nodefeatures0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-05-08T23:26:00.979669Z","caller":"traceutil/trace.go:171","msg":"trace[1455717980] range","detail":"{range_begin:/registry/nfd.k8s-sigs.io/nodefeatures/; range_end:/registry/nfd.k8s-sigs.io/nodefeatures0; response_count:0; response_revision:8333; }","duration":"316.522276ms","start":"2026-05-08T23:26:00.663134Z","end":"2026-05-08T23:26:00.979657Z","steps":["trace[1455717980] 'agreement among raft nodes before linearized reading'  (duration: 316.442434ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:26:00.979661Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.892253ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"warn","ts":"2026-05-08T23:26:00.979706Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:26:00.663103Z","time spent":"316.594868ms","remote":"127.0.0.1:55950","response type":"/etcdserverpb.KV/Range","request count":0,"request size":84,"response count":1,"response size":31,"request content":"key:\"/registry/nfd.k8s-sigs.io/nodefeatures/\" range_end:\"/registry/nfd.k8s-sigs.io/nodefeatures0\" count_only:true "}
{"level":"info","ts":"2026-05-08T23:26:00.979705Z","caller":"traceutil/trace.go:171","msg":"trace[1141126374] transaction","detail":"{read_only:false; response_revision:8333; number_of_response:1; }","duration":"119.399055ms","start":"2026-05-08T23:26:00.860266Z","end":"2026-05-08T23:26:00.979665Z","steps":["trace[1141126374] 'process raft request'  (duration: 118.734349ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:26:00.979758Z","caller":"traceutil/trace.go:171","msg":"trace[1897896225] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:8333; }","duration":"143.050497ms","start":"2026-05-08T23:26:00.836689Z","end":"2026-05-08T23:26:00.979739Z","steps":["trace[1897896225] 'agreement among raft nodes before linearized reading'  (duration: 142.859882ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:26:00.979534Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:26:00.51713Z","time spent":"462.393231ms","remote":"127.0.0.1:51812","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-08T23:26:13.261064Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.505972ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13976532258768782577 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:8384 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:457 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-08T23:26:13.261196Z","caller":"traceutil/trace.go:171","msg":"trace[39118117] transaction","detail":"{read_only:false; response_revision:8395; number_of_response:1; }","duration":"237.597732ms","start":"2026-05-08T23:26:13.023576Z","end":"2026-05-08T23:26:13.261174Z","steps":["trace[39118117] 'process raft request'  (duration: 49.852554ms)","trace[39118117] 'compare'  (duration: 187.214995ms)"],"step_count":2}
{"level":"info","ts":"2026-05-08T23:26:13.263025Z","caller":"traceutil/trace.go:171","msg":"trace[1219280349] linearizableReadLoop","detail":"{readStateIndex:8692; appliedIndex:8690; }","duration":"221.558671ms","start":"2026-05-08T23:26:13.041443Z","end":"2026-05-08T23:26:13.263001Z","steps":["trace[1219280349] 'read index received'  (duration: 32.106883ms)","trace[1219280349] 'applied index is now lower than readState.Index'  (duration: 189.450928ms)"],"step_count":2}
{"level":"info","ts":"2026-05-08T23:26:13.263139Z","caller":"traceutil/trace.go:171","msg":"trace[548466664] transaction","detail":"{read_only:false; response_revision:8396; number_of_response:1; }","duration":"238.951714ms","start":"2026-05-08T23:26:13.024178Z","end":"2026-05-08T23:26:13.26313Z","steps":["trace[548466664] 'process raft request'  (duration: 238.732699ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:26:13.26333Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.898599ms","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-08T23:26:13.263365Z","caller":"traceutil/trace.go:171","msg":"trace[291717398] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8396; }","duration":"222.027322ms","start":"2026-05-08T23:26:13.04133Z","end":"2026-05-08T23:26:13.263357Z","steps":["trace[291717398] 'agreement among raft nodes before linearized reading'  (duration: 221.896739ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:26:13.263708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.524681ms","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-08T23:26:13.263794Z","caller":"traceutil/trace.go:171","msg":"trace[1521429003] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8396; }","duration":"221.648834ms","start":"2026-05-08T23:26:13.042126Z","end":"2026-05-08T23:26:13.263775Z","steps":["trace[1521429003] 'agreement among raft nodes before linearized reading'  (duration: 221.368716ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:26:14.180239Z","caller":"traceutil/trace.go:171","msg":"trace[1568280606] transaction","detail":"{read_only:false; response_revision:8401; number_of_response:1; }","duration":"140.23602ms","start":"2026-05-08T23:26:14.039966Z","end":"2026-05-08T23:26:14.180202Z","steps":["trace[1568280606] 'process raft request'  (duration: 139.837521ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:26:42.169214Z","caller":"traceutil/trace.go:171","msg":"trace[1168412974] transaction","detail":"{read_only:false; response_revision:8607; number_of_response:1; }","duration":"235.526981ms","start":"2026-05-08T23:26:41.933665Z","end":"2026-05-08T23:26:42.169192Z","steps":["trace[1168412974] 'process raft request'  (duration: 235.200414ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:26:45.489267Z","caller":"traceutil/trace.go:171","msg":"trace[917247909] transaction","detail":"{read_only:false; response_revision:8622; number_of_response:1; }","duration":"107.643101ms","start":"2026-05-08T23:26:45.381577Z","end":"2026-05-08T23:26:45.48922Z","steps":["trace[917247909] 'process raft request'  (duration: 107.301333ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:26:55.862664Z","caller":"traceutil/trace.go:171","msg":"trace[352701161] linearizableReadLoop","detail":"{readStateIndex:9034; appliedIndex:9033; }","duration":"148.962428ms","start":"2026-05-08T23:26:55.713666Z","end":"2026-05-08T23:26:55.862629Z","steps":["trace[352701161] 'read index received'  (duration: 148.824535ms)","trace[352701161] 'applied index is now lower than readState.Index'  (duration: 136.693µs)"],"step_count":2}
{"level":"info","ts":"2026-05-08T23:26:55.862822Z","caller":"traceutil/trace.go:171","msg":"trace[223893999] transaction","detail":"{read_only:false; response_revision:8724; number_of_response:1; }","duration":"152.322987ms","start":"2026-05-08T23:26:55.710448Z","end":"2026-05-08T23:26:55.862771Z","steps":["trace[223893999] 'process raft request'  (duration: 151.962589ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:26:55.862974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.274365ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-bz4v7\" ","response":"range_response_count:1 size:6451"}
{"level":"info","ts":"2026-05-08T23:26:55.863019Z","caller":"traceutil/trace.go:171","msg":"trace[114305565] range","detail":"{range_begin:/registry/pods/openstack/keepalived-bz4v7; range_end:; response_count:1; response_revision:8724; }","duration":"149.392818ms","start":"2026-05-08T23:26:55.713615Z","end":"2026-05-08T23:26:55.863008Z","steps":["trace[114305565] 'agreement among raft nodes before linearized reading'  (duration: 149.145752ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:26:55.882247Z","caller":"traceutil/trace.go:171","msg":"trace[1385655460] transaction","detail":"{read_only:false; response_revision:8725; number_of_response:1; }","duration":"121.54905ms","start":"2026-05-08T23:26:55.760654Z","end":"2026-05-08T23:26:55.882203Z","steps":["trace[1385655460] 'process raft request'  (duration: 121.287654ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:27:14.570958Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-000000000000242d.wal"}
{"level":"info","ts":"2026-05-08T23:28:38.07125Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"d7dbc9f5893cc1f6","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-05-08T23:28:38.077857Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001}
{"level":"info","ts":"2026-05-08T23:28:38.078018Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001}
{"level":"info","ts":"2026-05-08T23:30:54.521815Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8171}
{"level":"info","ts":"2026-05-08T23:30:54.593428Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8171,"took":"69.077095ms","hash":1972049455,"current-db-size-bytes":57024512,"current-db-size":"57 MB","current-db-size-in-use-bytes":29655040,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-05-08T23:30:54.593491Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1972049455,"revision":8171,"compact-revision":6104}
{"level":"info","ts":"2026-05-08T23:31:59.675245Z","caller":"traceutil/trace.go:171","msg":"trace[433004616] transaction","detail":"{read_only:false; response_revision:11339; number_of_response:1; }","duration":"151.372999ms","start":"2026-05-08T23:31:59.523821Z","end":"2026-05-08T23:31:59.675194Z","steps":["trace[433004616] 'process raft request'  (duration: 151.118193ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:35:54.531679Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10774}
{"level":"info","ts":"2026-05-08T23:35:54.620765Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10774,"took":"79.154342ms","hash":1158140742,"current-db-size-bytes":57024512,"current-db-size":"57 MB","current-db-size-in-use-bytes":27041792,"current-db-size-in-use":"27 MB"}
{"level":"info","ts":"2026-05-08T23:35:54.62083Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1158140742,"revision":10774,"compact-revision":8171}
{"level":"info","ts":"2026-05-08T23:38:31.481275Z","caller":"traceutil/trace.go:171","msg":"trace[1969839267] transaction","detail":"{read_only:false; response_revision:13962; number_of_response:1; }","duration":"152.922581ms","start":"2026-05-08T23:38:31.328315Z","end":"2026-05-08T23:38:31.481237Z","steps":["trace[1969839267] 'process raft request'  (duration: 152.643995ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:38:32.336371Z","caller":"traceutil/trace.go:171","msg":"trace[562793713] linearizableReadLoop","detail":"{readStateIndex:14445; appliedIndex:14444; }","duration":"125.015108ms","start":"2026-05-08T23:38:32.21132Z","end":"2026-05-08T23:38:32.336335Z","steps":["trace[562793713] 'read index received'  (duration: 124.68822ms)","trace[562793713] 'applied index is now lower than readState.Index'  (duration: 325.068µs)"],"step_count":2}
{"level":"info","ts":"2026-05-08T23:38:32.336443Z","caller":"traceutil/trace.go:171","msg":"trace[1572915140] transaction","detail":"{read_only:false; response_revision:13964; number_of_response:1; }","duration":"221.683354ms","start":"2026-05-08T23:38:32.114726Z","end":"2026-05-08T23:38:32.336409Z","steps":["trace[1572915140] 'process raft request'  (duration: 221.321275ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:38:32.33673Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.388067ms","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-08T23:38:32.336841Z","caller":"traceutil/trace.go:171","msg":"trace[2120444971] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:13964; }","duration":"125.558281ms","start":"2026-05-08T23:38:32.211262Z","end":"2026-05-08T23:38:32.33682Z","steps":["trace[2120444971] 'agreement among raft nodes before linearized reading'  (duration: 125.256344ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:38:55.020649Z","caller":"traceutil/trace.go:171","msg":"trace[612174658] linearizableReadLoop","detail":"{readStateIndex:14773; appliedIndex:14772; }","duration":"113.367251ms","start":"2026-05-08T23:38:54.907251Z","end":"2026-05-08T23:38:55.020618Z","steps":["trace[612174658] 'read index received'  (duration: 113.103105ms)","trace[612174658] 'applied index is now lower than readState.Index'  (duration: 263.226µs)"],"step_count":2}
{"level":"info","ts":"2026-05-08T23:38:55.020813Z","caller":"traceutil/trace.go:171","msg":"trace[322886872] transaction","detail":"{read_only:false; response_revision:14277; number_of_response:1; }","duration":"144.418088ms","start":"2026-05-08T23:38:54.876344Z","end":"2026-05-08T23:38:55.020762Z","steps":["trace[322886872] 'process raft request'  (duration: 144.108401ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:38:55.020882Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.611567ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-4a7685db-202a-4f19-93b4-67d52b35d86b\" ","response":"range_response_count:1 size:3637"}
{"level":"info","ts":"2026-05-08T23:38:55.020923Z","caller":"traceutil/trace.go:171","msg":"trace[120159543] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-4a7685db-202a-4f19-93b4-67d52b35d86b; range_end:; response_count:1; response_revision:14277; }","duration":"113.698889ms","start":"2026-05-08T23:38:54.907213Z","end":"2026-05-08T23:38:55.020912Z","steps":["trace[120159543] 'agreement among raft nodes before linearized reading'  (duration: 113.523645ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:38:55.315961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.922456ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-08T23:38:55.316087Z","caller":"traceutil/trace.go:171","msg":"trace[1590580380] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:14277; }","duration":"133.10406ms","start":"2026-05-08T23:38:55.182959Z","end":"2026-05-08T23:38:55.316063Z","steps":["trace[1590580380] 'range keys from in-memory index tree'  (duration: 132.830313ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:38:55.316557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.744756ms","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-08T23:38:55.316601Z","caller":"traceutil/trace.go:171","msg":"trace[1341508817] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:14277; }","duration":"120.826228ms","start":"2026-05-08T23:38:55.195764Z","end":"2026-05-08T23:38:55.31659Z","steps":["trace[1341508817] 'range keys from in-memory index tree'  (duration: 120.479531ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:40:11.525512Z","caller":"traceutil/trace.go:171","msg":"trace[265730917] transaction","detail":"{read_only:false; response_revision:15039; number_of_response:1; }","duration":"104.134192ms","start":"2026-05-08T23:40:11.421349Z","end":"2026-05-08T23:40:11.525483Z","steps":["trace[265730917] 'process raft request'  (duration: 103.906397ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:40:54.537079Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12861}
{"level":"info","ts":"2026-05-08T23:40:54.615081Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12861,"took":"74.073829ms","hash":4171712467,"current-db-size-bytes":57024512,"current-db-size":"57 MB","current-db-size-in-use-bytes":29700096,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-05-08T23:40:54.615155Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4171712467,"revision":12861,"compact-revision":10774}
{"level":"info","ts":"2026-05-08T23:45:54.544119Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":15276}
{"level":"info","ts":"2026-05-08T23:45:54.637675Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":15276,"took":"90.250898ms","hash":2590731992,"current-db-size-bytes":57024512,"current-db-size":"57 MB","current-db-size-in-use-bytes":31662080,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-05-08T23:45:54.637745Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2590731992,"revision":15276,"compact-revision":12861}
{"level":"warn","ts":"2026-05-08T23:46:10.267085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.387135ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/neutron-metadata-agent-default-644hd\" ","response":"range_response_count:1 size:14198"}
{"level":"info","ts":"2026-05-08T23:46:10.267163Z","caller":"traceutil/trace.go:171","msg":"trace[1190634561] transaction","detail":"{read_only:false; response_revision:17644; number_of_response:1; }","duration":"134.132927ms","start":"2026-05-08T23:46:10.133002Z","end":"2026-05-08T23:46:10.267135Z","steps":["trace[1190634561] 'process raft request'  (duration: 133.682366ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:46:10.267217Z","caller":"traceutil/trace.go:171","msg":"trace[1716514030] range","detail":"{range_begin:/registry/pods/openstack/neutron-metadata-agent-default-644hd; range_end:; response_count:1; response_revision:17643; }","duration":"135.603622ms","start":"2026-05-08T23:46:10.131585Z","end":"2026-05-08T23:46:10.267189Z","steps":["trace[1716514030] 'range keys from in-memory index tree'  (duration: 135.065928ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:46:10.268688Z","caller":"traceutil/trace.go:171","msg":"trace[1767794626] transaction","detail":"{read_only:false; response_revision:17645; number_of_response:1; }","duration":"107.192044ms","start":"2026-05-08T23:46:10.161466Z","end":"2026-05-08T23:46:10.268658Z","steps":["trace[1767794626] 'process raft request'  (duration: 107.03514ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:46:16.191376Z","caller":"traceutil/trace.go:171","msg":"trace[369876297] transaction","detail":"{read_only:false; response_revision:17703; number_of_response:1; }","duration":"138.607732ms","start":"2026-05-08T23:46:16.052739Z","end":"2026-05-08T23:46:16.191347Z","steps":["trace[369876297] 'process raft request'  (duration: 138.423557ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:46:16.219423Z","caller":"traceutil/trace.go:171","msg":"trace[1389116504] linearizableReadLoop","detail":"{readStateIndex:18309; appliedIndex:18307; }","duration":"123.300612ms","start":"2026-05-08T23:46:16.096094Z","end":"2026-05-08T23:46:16.219394Z","steps":["trace[1389116504] 'read index received'  (duration: 95.07834ms)","trace[1389116504] 'applied index is now lower than readState.Index'  (duration: 28.220642ms)"],"step_count":2}
{"level":"info","ts":"2026-05-08T23:46:16.219597Z","caller":"traceutil/trace.go:171","msg":"trace[183353351] transaction","detail":"{read_only:false; response_revision:17704; number_of_response:1; }","duration":"164.883618ms","start":"2026-05-08T23:46:16.054657Z","end":"2026-05-08T23:46:16.219541Z","steps":["trace[183353351] 'process raft request'  (duration: 164.566591ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:46:16.219799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.678391ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-nova-server-0\" ","response":"range_response_count:1 size:1850"}
{"level":"info","ts":"2026-05-08T23:46:16.219847Z","caller":"traceutil/trace.go:171","msg":"trace[1741087006] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-nova-server-0; range_end:; response_count:1; response_revision:17704; }","duration":"123.810964ms","start":"2026-05-08T23:46:16.096019Z","end":"2026-05-08T23:46:16.21983Z","steps":["trace[1741087006] 'agreement among raft nodes before linearized reading'  (duration: 123.564209ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:46:16.620083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.427475ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-75qbv\" ","response":"range_response_count:1 size:22022"}
{"level":"info","ts":"2026-05-08T23:46:16.620194Z","caller":"traceutil/trace.go:171","msg":"trace[944245667] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-75qbv; range_end:; response_count:1; response_revision:17708; }","duration":"250.607659ms","start":"2026-05-08T23:46:16.369561Z","end":"2026-05-08T23:46:16.620169Z","steps":["trace[944245667] 'range keys from in-memory index tree'  (duration: 250.186099ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:46:17.153584Z","caller":"traceutil/trace.go:171","msg":"trace[1929033869] transaction","detail":"{read_only:false; response_revision:17709; number_of_response:1; }","duration":"199.9598ms","start":"2026-05-08T23:46:16.953596Z","end":"2026-05-08T23:46:17.153556Z","steps":["trace[1929033869] 'process raft request'  (duration: 199.668113ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:49:37.169603Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"d7dbc9f5893cc1f6","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-05-08T23:49:37.175534Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002}
{"level":"info","ts":"2026-05-08T23:49:37.17565Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002}
{"level":"info","ts":"2026-05-08T23:50:54.552077Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17558}
{"level":"info","ts":"2026-05-08T23:50:54.649871Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17558,"took":"92.879424ms","hash":3244904652,"current-db-size-bytes":57024512,"current-db-size":"57 MB","current-db-size-in-use-bytes":34398208,"current-db-size-in-use":"34 MB"}
{"level":"info","ts":"2026-05-08T23:50:54.650135Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3244904652,"revision":17558,"compact-revision":15276}
{"level":"warn","ts":"2026-05-08T23:52:14.536778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.608172ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"warn","ts":"2026-05-08T23:52:14.536798Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.973371ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/shovels/\" range_end:\"/registry/rabbitmq.com/shovels0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-08T23:52:14.536858Z","caller":"traceutil/trace.go:171","msg":"trace[1507360429] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:20453; }","duration":"153.699034ms","start":"2026-05-08T23:52:14.383138Z","end":"2026-05-08T23:52:14.536837Z","steps":["trace[1507360429] 'count revisions from in-memory index tree'  (duration: 153.514079ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:52:14.53691Z","caller":"traceutil/trace.go:171","msg":"trace[1066216252] range","detail":"{range_begin:/registry/rabbitmq.com/shovels/; range_end:/registry/rabbitmq.com/shovels0; response_count:0; response_revision:20453; }","duration":"262.158676ms","start":"2026-05-08T23:52:14.274727Z","end":"2026-05-08T23:52:14.536885Z","steps":["trace[1066216252] 'count revisions from in-memory index tree'  (duration: 261.860798ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:52:15.367319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.142604ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-08T23:52:15.36742Z","caller":"traceutil/trace.go:171","msg":"trace[2141025657] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:20456; }","duration":"185.308729ms","start":"2026-05-08T23:52:15.182089Z","end":"2026-05-08T23:52:15.367398Z","steps":["trace[2141025657] 'range keys from in-memory index tree'  (duration: 185.009661ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:52:15.367985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.684789ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:9"}
{"level":"info","ts":"2026-05-08T23:52:15.36807Z","caller":"traceutil/trace.go:171","msg":"trace[48369975] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:20456; }","duration":"160.833973ms","start":"2026-05-08T23:52:15.207217Z","end":"2026-05-08T23:52:15.368051Z","steps":["trace[48369975] 'count revisions from in-memory index tree'  (duration: 160.585806ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:55:54.56004Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":20011}
{"level":"info","ts":"2026-05-08T23:55:54.670777Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":20011,"took":"106.252769ms","hash":4781726,"current-db-size-bytes":57024512,"current-db-size":"57 MB","current-db-size-in-use-bytes":30539776,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-05-08T23:55:54.670851Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4781726,"revision":20011,"compact-revision":17558}
{"level":"info","ts":"2026-05-08T23:56:17.70733Z","caller":"traceutil/trace.go:171","msg":"trace[1962987640] linearizableReadLoop","detail":"{readStateIndex:23716; appliedIndex:23715; }","duration":"123.542555ms","start":"2026-05-08T23:56:17.58376Z","end":"2026-05-08T23:56:17.707302Z","steps":["trace[1962987640] 'read index received'  (duration: 123.392352ms)","trace[1962987640] 'applied index is now lower than readState.Index'  (duration: 148.303µs)"],"step_count":2}
{"level":"warn","ts":"2026-05-08T23:56:17.707792Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.022257ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"}
{"level":"info","ts":"2026-05-08T23:56:17.707826Z","caller":"traceutil/trace.go:171","msg":"trace[1128569043] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:22941; }","duration":"124.123479ms","start":"2026-05-08T23:56:17.583693Z","end":"2026-05-08T23:56:17.707817Z","steps":["trace[1128569043] 'agreement among raft nodes before linearized reading'  (duration: 123.961576ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:56:17.708119Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.985927ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"}
{"level":"info","ts":"2026-05-08T23:56:17.708151Z","caller":"traceutil/trace.go:171","msg":"trace[1805856499] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:22941; }","duration":"124.052039ms","start":"2026-05-08T23:56:17.58409Z","end":"2026-05-08T23:56:17.708142Z","steps":["trace[1805856499] 'agreement among raft nodes before linearized reading'  (duration: 123.941066ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:59:43.734593Z","caller":"traceutil/trace.go:171","msg":"trace[1351859090] transaction","detail":"{read_only:false; response_revision:25028; number_of_response:1; }","duration":"199.701386ms","start":"2026-05-08T23:59:43.534862Z","end":"2026-05-08T23:59:43.734563Z","steps":["trace[1351859090] 'process raft request'  (duration: 102.22033ms)","trace[1351859090] 'compare'  (duration: 97.341943ms)"],"step_count":2}
{"level":"info","ts":"2026-05-08T23:59:43.948825Z","caller":"traceutil/trace.go:171","msg":"trace[581235908] transaction","detail":"{read_only:false; response_revision:25029; number_of_response:1; }","duration":"374.129565ms","start":"2026-05-08T23:59:43.574647Z","end":"2026-05-08T23:59:43.948776Z","steps":["trace[581235908] 'process raft request'  (duration: 308.720636ms)","trace[581235908] 'compare'  (duration: 65.237125ms)"],"step_count":2}
{"level":"info","ts":"2026-05-08T23:59:43.94892Z","caller":"traceutil/trace.go:171","msg":"trace[438749097] transaction","detail":"{read_only:false; response_revision:25030; number_of_response:1; }","duration":"221.333518ms","start":"2026-05-08T23:59:43.727553Z","end":"2026-05-08T23:59:43.948887Z","steps":["trace[438749097] 'process raft request'  (duration: 221.220036ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:59:43.949314Z","caller":"traceutil/trace.go:171","msg":"trace[1373828739] transaction","detail":"{read_only:false; response_revision:25031; number_of_response:1; }","duration":"220.97685ms","start":"2026-05-08T23:59:43.728317Z","end":"2026-05-08T23:59:43.949294Z","steps":["trace[1373828739] 'process raft request'  (duration: 220.524539ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:59:43.948991Z","caller":"traceutil/trace.go:171","msg":"trace[1440059694] linearizableReadLoop","detail":"{readStateIndex:25860; appliedIndex:25859; }","duration":"292.596755ms","start":"2026-05-08T23:59:43.656383Z","end":"2026-05-08T23:59:43.94898Z","steps":["trace[1440059694] 'read index received'  (duration: 227.090486ms)","trace[1440059694] 'applied index is now lower than readState.Index'  (duration: 65.505329ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-08T23:59:43.949169Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.760319ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-05-08T23:59:43.949523Z","caller":"traceutil/trace.go:171","msg":"trace[1230075889] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25031; }","duration":"293.153098ms","start":"2026-05-08T23:59:43.656341Z","end":"2026-05-08T23:59:43.949494Z","steps":["trace[1230075889] 'agreement among raft nodes before linearized reading'  (duration: 292.668857ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:59:43.949669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.998602ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true ","response":"range_response_count:0 size:9"}
{"level":"info","ts":"2026-05-08T23:59:43.949713Z","caller":"traceutil/trace.go:171","msg":"trace[39129239] range","detail":"{range_begin:/registry/roles/; range_end:/registry/roles0; response_count:0; response_revision:25032; }","duration":"145.103174ms","start":"2026-05-08T23:59:43.804598Z","end":"2026-05-08T23:59:43.949702Z","steps":["trace[39129239] 'agreement among raft nodes before linearized reading'  (duration: 144.90872ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:59:43.949868Z","caller":"traceutil/trace.go:171","msg":"trace[1058499578] transaction","detail":"{read_only:false; response_revision:25032; number_of_response:1; }","duration":"221.432681ms","start":"2026-05-08T23:59:43.728421Z","end":"2026-05-08T23:59:43.949854Z","steps":["trace[1058499578] 'process raft request'  (duration: 220.54544ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:59:43.949935Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:59:43.574621Z","time spent":"374.620517ms","remote":"127.0.0.1:51812","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" mod_revision:24963 > success:<request_put:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" value_size:416 >> failure:<request_range:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" > >"}
{"level":"info","ts":"2026-05-08T23:59:44.171566Z","caller":"traceutil/trace.go:171","msg":"trace[56967345] linearizableReadLoop","detail":"{readStateIndex:25864; appliedIndex:25863; }","duration":"131.211924ms","start":"2026-05-08T23:59:44.040327Z","end":"2026-05-08T23:59:44.171539Z","steps":["trace[56967345] 'read index received'  (duration: 128.937801ms)","trace[56967345] 'applied index is now lower than readState.Index'  (duration: 2.272743ms)"],"step_count":2}
{"level":"info","ts":"2026-05-08T23:59:44.171789Z","caller":"traceutil/trace.go:171","msg":"trace[1696860601] transaction","detail":"{read_only:false; response_revision:25033; number_of_response:1; }","duration":"216.933034ms","start":"2026-05-08T23:59:43.954845Z","end":"2026-05-08T23:59:44.171778Z","steps":["trace[1696860601] 'process raft request'  (duration: 214.398365ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:59:44.171813Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.467191ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-barbican-server-0\" ","response":"range_response_count:1 size:1866"}
{"level":"info","ts":"2026-05-08T23:59:44.172096Z","caller":"traceutil/trace.go:171","msg":"trace[1923136478] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-barbican-server-0; range_end:; response_count:1; response_revision:25033; }","duration":"131.633335ms","start":"2026-05-08T23:59:44.040279Z","end":"2026-05-08T23:59:44.171913Z","steps":["trace[1923136478] 'agreement among raft nodes before linearized reading'  (duration: 131.364599ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:59:48.541253Z","caller":"traceutil/trace.go:171","msg":"trace[1734633255] linearizableReadLoop","detail":"{readStateIndex:25894; appliedIndex:25893; }","duration":"190.685073ms","start":"2026-05-08T23:59:48.35053Z","end":"2026-05-08T23:59:48.541215Z","steps":["trace[1734633255] 'read index received'  (duration: 190.468958ms)","trace[1734633255] 'applied index is now lower than readState.Index'  (duration: 214.305µs)"],"step_count":2}
{"level":"warn","ts":"2026-05-08T23:59:48.541766Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.190155ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"}
{"level":"info","ts":"2026-05-08T23:59:48.541818Z","caller":"traceutil/trace.go:171","msg":"trace[1324479118] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25062; }","duration":"191.309278ms","start":"2026-05-08T23:59:48.350497Z","end":"2026-05-08T23:59:48.541806Z","steps":["trace[1324479118] 'agreement among raft nodes before linearized reading'  (duration: 190.848907ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:59:48.542237Z","caller":"traceutil/trace.go:171","msg":"trace[204741621] transaction","detail":"{read_only:false; response_revision:25062; number_of_response:1; }","duration":"196.04366ms","start":"2026-05-08T23:59:48.346181Z","end":"2026-05-08T23:59:48.542224Z","steps":["trace[204741621] 'process raft request'  (duration: 194.82881ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:59:48.586151Z","caller":"traceutil/trace.go:171","msg":"trace[1422785945] transaction","detail":"{read_only:false; response_revision:25063; number_of_response:1; }","duration":"176.983409ms","start":"2026-05-08T23:59:48.409138Z","end":"2026-05-08T23:59:48.586121Z","steps":["trace[1422785945] 'process raft request'  (duration: 176.825595ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:59:48.714569Z","caller":"traceutil/trace.go:171","msg":"trace[1363116647] transaction","detail":"{read_only:false; response_revision:25064; number_of_response:1; }","duration":"167.815192ms","start":"2026-05-08T23:59:48.546717Z","end":"2026-05-08T23:59:48.714532Z","steps":["trace[1363116647] 'process raft request'  (duration: 138.433697ms)","trace[1363116647] 'compare'  (duration: 29.035127ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-08T23:59:49.000331Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.309864ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13976532258768832036 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" mod_revision:25028 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" value_size:517 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-08T23:59:49.000977Z","caller":"traceutil/trace.go:171","msg":"trace[1918723279] transaction","detail":"{read_only:false; response_revision:25065; number_of_response:1; }","duration":"260.373102ms","start":"2026-05-08T23:59:48.740581Z","end":"2026-05-08T23:59:49.000954Z","steps":["trace[1918723279] 'process raft request'  (duration: 118.304571ms)","trace[1918723279] 'compare'  (duration: 140.855873ms)"],"step_count":2}
{"level":"info","ts":"2026-05-08T23:59:49.001139Z","caller":"traceutil/trace.go:171","msg":"trace[1518852057] transaction","detail":"{read_only:false; response_revision:25066; number_of_response:1; }","duration":"177.603842ms","start":"2026-05-08T23:59:48.823524Z","end":"2026-05-08T23:59:49.001128Z","steps":["trace[1518852057] 'process raft request'  (duration: 176.937337ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:59:49.444113Z","caller":"traceutil/trace.go:171","msg":"trace[1865684126] transaction","detail":"{read_only:false; response_revision:25067; number_of_response:1; }","duration":"346.114851ms","start":"2026-05-08T23:59:49.097966Z","end":"2026-05-08T23:59:49.444081Z","steps":["trace[1865684126] 'process raft request'  (duration: 345.932437ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:59:49.444294Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:59:49.097949Z","time spent":"346.257425ms","remote":"127.0.0.1:51812","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:25052 > 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-08T23:59:49.460721Z","caller":"traceutil/trace.go:171","msg":"trace[1263808927] transaction","detail":"{read_only:false; response_revision:25068; number_of_response:1; }","duration":"362.248763ms","start":"2026-05-08T23:59:49.098435Z","end":"2026-05-08T23:59:49.460684Z","steps":["trace[1263808927] 'process raft request'  (duration: 361.929136ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:59:49.461061Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:59:49.098418Z","time spent":"362.411896ms","remote":"127.0.0.1:51812","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:25053 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-05-08T23:59:49.461792Z","caller":"traceutil/trace.go:171","msg":"trace[620952694] linearizableReadLoop","detail":"{readStateIndex:25900; appliedIndex:25898; }","duration":"280.209601ms","start":"2026-05-08T23:59:49.181558Z","end":"2026-05-08T23:59:49.461768Z","steps":["trace[620952694] 'read index received'  (duration: 262.346968ms)","trace[620952694] 'applied index is now lower than readState.Index'  (duration: 17.860943ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-08T23:59:49.461975Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.405607ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-08T23:59:49.462021Z","caller":"traceutil/trace.go:171","msg":"trace[874547888] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25071; }","duration":"280.518729ms","start":"2026-05-08T23:59:49.181489Z","end":"2026-05-08T23:59:49.462008Z","steps":["trace[874547888] 'agreement among raft nodes before linearized reading'  (duration: 280.404946ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:59:49.46215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.50588ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/neutron-l3-agent-default-hfs54.18adbbf047082bbf\" ","response":"range_response_count:1 size:949"}
{"level":"info","ts":"2026-05-08T23:59:49.462465Z","caller":"traceutil/trace.go:171","msg":"trace[53410003] range","detail":"{range_begin:/registry/events/openstack/neutron-l3-agent-default-hfs54.18adbbf047082bbf; range_end:; response_count:1; response_revision:25071; }","duration":"174.880718ms","start":"2026-05-08T23:59:49.28756Z","end":"2026-05-08T23:59:49.462441Z","steps":["trace[53410003] 'agreement among raft nodes before linearized reading'  (duration: 174.356156ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:59:49.462126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.151337ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephblockpools/\" range_end:\"/registry/ceph.rook.io/cephblockpools0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-08T23:59:49.462668Z","caller":"traceutil/trace.go:171","msg":"trace[1910357848] range","detail":"{range_begin:/registry/ceph.rook.io/cephblockpools/; range_end:/registry/ceph.rook.io/cephblockpools0; response_count:0; response_revision:25071; }","duration":"170.721381ms","start":"2026-05-08T23:59:49.291925Z","end":"2026-05-08T23:59:49.462646Z","steps":["trace[1910357848] 'agreement among raft nodes before linearized reading'  (duration: 170.053955ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:59:49.773884Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.736278ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13976532258768832049 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/openstack/neutron-l3-agent-default-hfs54.18adbbf047082bbf\" mod_revision:24634 > success:<request_put:<key:\"/registry/events/openstack/neutron-l3-agent-default-hfs54.18adbbf047082bbf\" value_size:839 lease:4753160221914056067 >> failure:<request_range:<key:\"/registry/events/openstack/neutron-l3-agent-default-hfs54.18adbbf047082bbf\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-08T23:59:49.774035Z","caller":"traceutil/trace.go:171","msg":"trace[1940292631] transaction","detail":"{read_only:false; response_revision:25072; number_of_response:1; }","duration":"306.187087ms","start":"2026-05-08T23:59:49.467824Z","end":"2026-05-08T23:59:49.774011Z","steps":["trace[1940292631] 'process raft request'  (duration: 152.215403ms)","trace[1940292631] 'compare'  (duration: 153.38044ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-08T23:59:49.774116Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:59:49.46781Z","time spent":"306.265068ms","remote":"127.0.0.1:51564","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":931,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/events/openstack/neutron-l3-agent-default-hfs54.18adbbf047082bbf\" mod_revision:24634 > success:<request_put:<key:\"/registry/events/openstack/neutron-l3-agent-default-hfs54.18adbbf047082bbf\" value_size:839 lease:4753160221914056067 >> failure:<request_range:<key:\"/registry/events/openstack/neutron-l3-agent-default-hfs54.18adbbf047082bbf\" > >"}
{"level":"warn","ts":"2026-05-08T23:59:50.151023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.725518ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-08T23:59:50.151099Z","caller":"traceutil/trace.go:171","msg":"trace[1565103345] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:25072; }","duration":"213.858972ms","start":"2026-05-08T23:59:49.937223Z","end":"2026-05-08T23:59:50.151082Z","steps":["trace[1565103345] 'count revisions from in-memory index tree'  (duration: 213.630486ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:59:50.151233Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.982628ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13976532258768832053 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:25058 > 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\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-08T23:59:50.151402Z","caller":"traceutil/trace.go:171","msg":"trace[1405115971] transaction","detail":"{read_only:false; response_revision:25075; number_of_response:1; }","duration":"178.946346ms","start":"2026-05-08T23:59:49.972446Z","end":"2026-05-08T23:59:50.151392Z","steps":["trace[1405115971] 'process raft request'  (duration: 178.908515ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:59:50.151429Z","caller":"traceutil/trace.go:171","msg":"trace[1629451448] transaction","detail":"{read_only:false; response_revision:25074; number_of_response:1; }","duration":"179.839406ms","start":"2026-05-08T23:59:49.971583Z","end":"2026-05-08T23:59:50.151422Z","steps":["trace[1629451448] 'process raft request'  (duration: 179.718464ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:59:50.151461Z","caller":"traceutil/trace.go:171","msg":"trace[1126102534] transaction","detail":"{read_only:false; response_revision:25073; number_of_response:1; }","duration":"182.587781ms","start":"2026-05-08T23:59:49.968841Z","end":"2026-05-08T23:59:50.151429Z","steps":["trace[1126102534] 'process raft request'  (duration: 79.330686ms)","trace[1126102534] 'compare'  (duration: 102.853225ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-08T23:59:50.450454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.707916ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13976532258768832058 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:25061 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-08T23:59:50.450579Z","caller":"traceutil/trace.go:171","msg":"trace[179909088] transaction","detail":"{read_only:false; response_revision:25076; number_of_response:1; }","duration":"212.459999ms","start":"2026-05-08T23:59:50.238101Z","end":"2026-05-08T23:59:50.450561Z","steps":["trace[179909088] 'process raft request'  (duration: 75.528657ms)","trace[179909088] 'compare'  (duration: 136.373978ms)"],"step_count":2}
{"level":"info","ts":"2026-05-08T23:59:50.961692Z","caller":"traceutil/trace.go:171","msg":"trace[120361326] transaction","detail":"{read_only:false; response_revision:25077; number_of_response:1; }","duration":"413.380483ms","start":"2026-05-08T23:59:50.54828Z","end":"2026-05-08T23:59:50.96166Z","steps":["trace[120361326] 'process raft request'  (duration: 412.974754ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:59:50.961867Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:59:50.548251Z","time spent":"413.520296ms","remote":"127.0.0.1:51812","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/capo-system/controller-leader-election-capo\" mod_revision:25062 > success:<request_put:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" > >"}
{"level":"info","ts":"2026-05-08T23:59:50.961897Z","caller":"traceutil/trace.go:171","msg":"trace[1329155055] linearizableReadLoop","detail":"{readStateIndex:25909; appliedIndex:25908; }","duration":"389.122759ms","start":"2026-05-08T23:59:50.572742Z","end":"2026-05-08T23:59:50.961865Z","steps":["trace[1329155055] 'read index received'  (duration: 388.443803ms)","trace[1329155055] 'applied index is now lower than readState.Index'  (duration: 672.966µs)"],"step_count":2}
{"level":"warn","ts":"2026-05-08T23:59:51.007111Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"434.33903ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ipam.cluster.x-k8s.io/ipaddressclaims/\" range_end:\"/registry/ipam.cluster.x-k8s.io/ipaddressclaims0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-08T23:59:51.007203Z","caller":"traceutil/trace.go:171","msg":"trace[1857079809] range","detail":"{range_begin:/registry/ipam.cluster.x-k8s.io/ipaddressclaims/; range_end:/registry/ipam.cluster.x-k8s.io/ipaddressclaims0; response_count:0; response_revision:25077; }","duration":"434.509363ms","start":"2026-05-08T23:59:50.572672Z","end":"2026-05-08T23:59:51.007181Z","steps":["trace[1857079809] 'agreement among raft nodes before linearized reading'  (duration: 389.343705ms)","trace[1857079809] 'count revisions from in-memory index tree'  (duration: 45.017025ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-08T23:59:51.007246Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:59:50.572647Z","time spent":"434.586356ms","remote":"127.0.0.1:53160","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":0,"response size":30,"request content":"key:\"/registry/ipam.cluster.x-k8s.io/ipaddressclaims/\" range_end:\"/registry/ipam.cluster.x-k8s.io/ipaddressclaims0\" count_only:true "}
{"level":"warn","ts":"2026-05-08T23:59:51.007533Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"416.291362ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"}
{"level":"info","ts":"2026-05-08T23:59:51.007556Z","caller":"traceutil/trace.go:171","msg":"trace[1938332543] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25077; }","duration":"416.348394ms","start":"2026-05-08T23:59:50.591198Z","end":"2026-05-08T23:59:51.007546Z","steps":["trace[1938332543] 'agreement among raft nodes before linearized reading'  (duration: 370.846506ms)","trace[1938332543] 'range keys from in-memory index tree'  (duration: 45.391565ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-08T23:59:51.007574Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:59:50.591156Z","time spent":"416.414045ms","remote":"127.0.0.1:51812","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":532,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-05-08T23:59:51.007642Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.589348ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusterrestores/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusterrestores0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-08T23:59:51.007662Z","caller":"traceutil/trace.go:171","msg":"trace[480206418] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusterrestores/; range_end:/registry/pxc.percona.com/perconaxtradbclusterrestores0; response_count:0; response_revision:25077; }","duration":"192.652709ms","start":"2026-05-08T23:59:50.814999Z","end":"2026-05-08T23:59:51.007652Z","steps":["trace[480206418] 'agreement among raft nodes before linearized reading'  (duration: 147.06634ms)","trace[480206418] 'count revisions from in-memory index tree'  (duration: 45.556019ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-08T23:59:51.007842Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.972686ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"}
{"level":"info","ts":"2026-05-08T23:59:51.007868Z","caller":"traceutil/trace.go:171","msg":"trace[605817835] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25077; }","duration":"288.035667ms","start":"2026-05-08T23:59:50.719824Z","end":"2026-05-08T23:59:51.00786Z","steps":["trace[605817835] 'agreement among raft nodes before linearized reading'  (duration: 242.253243ms)","trace[605817835] 'range keys from in-memory index tree'  (duration: 45.719123ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-08T23:59:51.267787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.387039ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-08T23:59:51.268023Z","caller":"traceutil/trace.go:171","msg":"trace[254967510] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:25080; }","duration":"150.688066ms","start":"2026-05-08T23:59:51.117312Z","end":"2026-05-08T23:59:51.268Z","steps":["trace[254967510] 'range keys from in-memory index tree'  (duration: 149.955449ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:59:51.586438Z","caller":"traceutil/trace.go:171","msg":"trace[2053081488] transaction","detail":"{read_only:false; response_revision:25081; number_of_response:1; }","duration":"133.207272ms","start":"2026-05-08T23:59:51.453197Z","end":"2026-05-08T23:59:51.586404Z","steps":["trace[2053081488] 'process raft request'  (duration: 132.499396ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:59:51.924299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.908139ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13976532258768832079 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" mod_revision:25029 > success:<request_put:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" value_size:416 >> failure:<request_range:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-08T23:59:51.925101Z","caller":"traceutil/trace.go:171","msg":"trace[1147804326] transaction","detail":"{read_only:false; response_revision:25082; number_of_response:1; }","duration":"469.340527ms","start":"2026-05-08T23:59:51.45571Z","end":"2026-05-08T23:59:51.92505Z","steps":["trace[1147804326] 'process raft request'  (duration: 364.421295ms)","trace[1147804326] 'compare'  (duration: 103.52044ms)"],"step_count":2}
{"level":"info","ts":"2026-05-08T23:59:51.925207Z","caller":"traceutil/trace.go:171","msg":"trace[6604508] transaction","detail":"{read_only:false; response_revision:25083; number_of_response:1; }","duration":"457.081468ms","start":"2026-05-08T23:59:51.468073Z","end":"2026-05-08T23:59:51.925154Z","steps":["trace[6604508] 'process raft request'  (duration: 456.902973ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:59:51.925326Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:59:51.455703Z","time spent":"469.496051ms","remote":"127.0.0.1:51812","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" mod_revision:25029 > success:<request_put:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" value_size:416 >> failure:<request_range:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" > >"}
{"level":"warn","ts":"2026-05-08T23:59:51.925334Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:59:51.468058Z","time spent":"457.21783ms","remote":"127.0.0.1:51812","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":498,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" mod_revision:25069 > success:<request_put:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" value_size:442 >> failure:<request_range:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" > >"}
{"level":"info","ts":"2026-05-08T23:59:51.925644Z","caller":"traceutil/trace.go:171","msg":"trace[1617616307] linearizableReadLoop","detail":"{readStateIndex:25914; appliedIndex:25912; }","duration":"459.600227ms","start":"2026-05-08T23:59:51.466017Z","end":"2026-05-08T23:59:51.925617Z","steps":["trace[1617616307] 'read index received'  (duration: 119.597411ms)","trace[1617616307] 'applied index is now lower than readState.Index'  (duration: 340.001746ms)"],"step_count":2}
{"level":"info","ts":"2026-05-08T23:59:51.92571Z","caller":"traceutil/trace.go:171","msg":"trace[546402821] transaction","detail":"{read_only:false; response_revision:25085; number_of_response:1; }","duration":"457.250871ms","start":"2026-05-08T23:59:51.46844Z","end":"2026-05-08T23:59:51.925691Z","steps":["trace[546402821] 'process raft request'  (duration: 457.003815ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:59:51.925718Z","caller":"traceutil/trace.go:171","msg":"trace[529216285] transaction","detail":"{read_only:false; response_revision:25084; number_of_response:1; }","duration":"457.392134ms","start":"2026-05-08T23:59:51.468312Z","end":"2026-05-08T23:59:51.925704Z","steps":["trace[529216285] 'process raft request'  (duration: 456.7732ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:59:51.925799Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:59:51.468274Z","time spent":"457.482887ms","remote":"127.0.0.1:51812","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/capi-system/controller-leader-election-capi\" mod_revision:25071 > success:<request_put:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" > >"}
{"level":"warn","ts":"2026-05-08T23:59:51.925805Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:59:51.468429Z","time spent":"457.323304ms","remote":"127.0.0.1:51812","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":608,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" mod_revision:25070 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" value_size:507 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" > >"}
{"level":"warn","ts":"2026-05-08T23:59:51.925894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"459.863753ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"}
{"level":"warn","ts":"2026-05-08T23:59:51.925896Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"361.117316ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-08T23:59:51.92593Z","caller":"traceutil/trace.go:171","msg":"trace[1435154655] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25085; }","duration":"459.925314ms","start":"2026-05-08T23:59:51.465995Z","end":"2026-05-08T23:59:51.925921Z","steps":["trace[1435154655] 'agreement among raft nodes before linearized reading'  (duration: 459.772491ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:59:51.925958Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:59:51.465986Z","time spent":"459.966366ms","remote":"127.0.0.1:51812","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":464,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-05-08T23:59:51.925965Z","caller":"traceutil/trace.go:171","msg":"trace[1509826608] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0; response_count:0; response_revision:25085; }","duration":"361.172708ms","start":"2026-05-08T23:59:51.564752Z","end":"2026-05-08T23:59:51.925925Z","steps":["trace[1509826608] 'agreement among raft nodes before linearized reading'  (duration: 361.092586ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:59:51.925996Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:59:51.56468Z","time spent":"361.307421ms","remote":"127.0.0.1:53240","response type":"/etcdserverpb.KV/Range","request count":0,"request size":152,"response count":0,"response size":30,"request content":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0\" "}
{"level":"info","ts":"2026-05-08T23:59:52.497101Z","caller":"traceutil/trace.go:171","msg":"trace[1429863017] transaction","detail":"{read_only:false; response_revision:25088; number_of_response:1; }","duration":"340.376875ms","start":"2026-05-08T23:59:52.156703Z","end":"2026-05-08T23:59:52.49708Z","steps":["trace[1429863017] 'process raft request'  (duration: 293.65535ms)","trace[1429863017] 'compare'  (duration: 46.49288ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-08T23:59:52.497224Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:59:52.156673Z","time spent":"340.481088ms","remote":"127.0.0.1:51812","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":508,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:25075 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:453 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"info","ts":"2026-05-08T23:59:52.497442Z","caller":"traceutil/trace.go:171","msg":"trace[1437603950] transaction","detail":"{read_only:false; response_revision:25089; number_of_response:1; }","duration":"340.608651ms","start":"2026-05-08T23:59:52.156802Z","end":"2026-05-08T23:59:52.497411Z","steps":["trace[1437603950] 'process raft request'  (duration: 340.205042ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:59:52.497489Z","caller":"traceutil/trace.go:171","msg":"trace[2105707491] transaction","detail":"{read_only:false; response_revision:25090; number_of_response:1; }","duration":"339.715509ms","start":"2026-05-08T23:59:52.157757Z","end":"2026-05-08T23:59:52.497473Z","steps":["trace[2105707491] 'process raft request'  (duration: 339.541915ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:59:52.497542Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:59:52.157743Z","time spent":"339.769371ms","remote":"127.0.0.1:51812","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:25073 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:477 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-05-08T23:59:52.497803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"332.12748ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-operator-869df985b8-lqjhm\" ","response":"range_response_count:1 size:4695"}
{"level":"info","ts":"2026-05-08T23:59:52.497495Z","caller":"traceutil/trace.go:171","msg":"trace[1191312931] linearizableReadLoop","detail":"{readStateIndex:25922; appliedIndex:25919; }","duration":"331.801252ms","start":"2026-05-08T23:59:52.165662Z","end":"2026-05-08T23:59:52.497464Z","steps":["trace[1191312931] 'read index received'  (duration: 284.596656ms)","trace[1191312931] 'applied index is now lower than readState.Index'  (duration: 47.203536ms)"],"step_count":2}
{"level":"info","ts":"2026-05-08T23:59:52.497872Z","caller":"traceutil/trace.go:171","msg":"trace[1987486207] range","detail":"{range_begin:/registry/pods/kube-system/cilium-operator-869df985b8-lqjhm; range_end:; response_count:1; response_revision:25090; }","duration":"332.246123ms","start":"2026-05-08T23:59:52.165603Z","end":"2026-05-08T23:59:52.497849Z","steps":["trace[1987486207] 'agreement among raft nodes before linearized reading'  (duration: 332.019107ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:59:52.497917Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:59:52.165583Z","time spent":"332.325006ms","remote":"127.0.0.1:51722","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":4719,"request content":"key:\"/registry/pods/kube-system/cilium-operator-869df985b8-lqjhm\" "}
{"level":"warn","ts":"2026-05-08T23:59:52.497595Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:59:52.156755Z","time spent":"340.757144ms","remote":"127.0.0.1:51812","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:25074 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:457 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"warn","ts":"2026-05-08T23:59:52.49804Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.895287ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-08T23:59:52.498114Z","caller":"traceutil/trace.go:171","msg":"trace[901713474] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25090; }","duration":"316.03668ms","start":"2026-05-08T23:59:52.182057Z","end":"2026-05-08T23:59:52.498093Z","steps":["trace[901713474] 'agreement among raft nodes before linearized reading'  (duration: 315.914997ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:59:52.498184Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:59:52.182038Z","time spent":"316.136292ms","remote":"127.0.0.1:51484","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":30,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-05-08T23:59:52.670678Z","caller":"traceutil/trace.go:171","msg":"trace[262237872] transaction","detail":"{read_only:false; response_revision:25091; number_of_response:1; }","duration":"169.101552ms","start":"2026-05-08T23:59:52.501533Z","end":"2026-05-08T23:59:52.670635Z","steps":["trace[262237872] 'process raft request'  (duration: 150.878241ms)","trace[262237872] 'compare'  (duration: 17.801601ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-08T23:59:53.463566Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.422262ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13976532258768832102 > lease_revoke:<id:41f69e09dbb44555>","response":"size:30"}
{"level":"info","ts":"2026-05-08T23:59:53.463922Z","caller":"traceutil/trace.go:171","msg":"trace[1503692266] transaction","detail":"{read_only:false; response_revision:25093; number_of_response:1; }","duration":"448.795681ms","start":"2026-05-08T23:59:53.015108Z","end":"2026-05-08T23:59:53.463904Z","steps":["trace[1503692266] 'process raft request'  (duration: 448.564506ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:59:53.463926Z","caller":"traceutil/trace.go:171","msg":"trace[1068477823] linearizableReadLoop","detail":"{readStateIndex:25926; appliedIndex:25923; }","duration":"433.243713ms","start":"2026-05-08T23:59:53.030659Z","end":"2026-05-08T23:59:53.463902Z","steps":["trace[1068477823] 'read index received'  (duration: 2.166422ms)","trace[1068477823] 'applied index is now lower than readState.Index'  (duration: 431.075441ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-08T23:59:53.464043Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:59:53.015068Z","time spent":"448.894254ms","remote":"127.0.0.1:51812","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":539,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:25078 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:463 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-05-08T23:59:53.738555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"702.413864ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"}
{"level":"info","ts":"2026-05-08T23:59:53.73865Z","caller":"traceutil/trace.go:171","msg":"trace[1089691280] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25093; }","duration":"702.547057ms","start":"2026-05-08T23:59:53.036065Z","end":"2026-05-08T23:59:53.738612Z","steps":["trace[1089691280] 'agreement among raft nodes before linearized reading'  (duration: 427.980119ms)","trace[1089691280] 'range keys from in-memory index tree'  (duration: 274.357863ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-08T23:59:53.738638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"707.949134ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1936"}
{"level":"warn","ts":"2026-05-08T23:59:53.738683Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:59:53.036039Z","time spent":"702.636318ms","remote":"127.0.0.1:51812","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":505,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-05-08T23:59:53.73872Z","caller":"traceutil/trace.go:171","msg":"trace[1103867061] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:25093; }","duration":"708.100699ms","start":"2026-05-08T23:59:53.030593Z","end":"2026-05-08T23:59:53.738694Z","steps":["trace[1103867061] 'agreement among raft nodes before linearized reading'  (duration: 433.423777ms)","trace[1103867061] 'range keys from in-memory index tree'  (duration: 274.466936ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-08T23:59:53.738782Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:59:53.030562Z","time spent":"708.211921ms","remote":"127.0.0.1:51688","response type":"/etcdserverpb.KV/Range","request count":0,"request size":147,"response count":1,"response size":1960,"request content":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" "}
{"level":"warn","ts":"2026-05-08T23:59:53.738899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"700.770116ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"}
{"level":"info","ts":"2026-05-08T23:59:53.73892Z","caller":"traceutil/trace.go:171","msg":"trace[988315122] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25093; }","duration":"700.812377ms","start":"2026-05-08T23:59:53.0381Z","end":"2026-05-08T23:59:53.738913Z","steps":["trace[988315122] 'agreement among raft nodes before linearized reading'  (duration: 425.950851ms)","trace[988315122] 'range keys from in-memory index tree'  (duration: 274.799084ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-08T23:59:53.738937Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:59:53.038088Z","time spent":"700.845788ms","remote":"127.0.0.1:51812","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":532,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-05-08T23:59:53.739287Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.51814ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"}
{"level":"info","ts":"2026-05-08T23:59:53.739379Z","caller":"traceutil/trace.go:171","msg":"trace[2110029746] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25093; }","duration":"141.662493ms","start":"2026-05-08T23:59:53.597692Z","end":"2026-05-08T23:59:53.739354Z","steps":["trace[2110029746] 'range keys from in-memory index tree'  (duration: 141.307315ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:59:54.113258Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.041631ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephblockpoolradosnamespaces/\" range_end:\"/registry/ceph.rook.io/cephblockpoolradosnamespaces0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-08T23:59:54.113331Z","caller":"traceutil/trace.go:171","msg":"trace[188985429] range","detail":"{range_begin:/registry/ceph.rook.io/cephblockpoolradosnamespaces/; range_end:/registry/ceph.rook.io/cephblockpoolradosnamespaces0; response_count:0; response_revision:25096; }","duration":"183.182495ms","start":"2026-05-08T23:59:53.93013Z","end":"2026-05-08T23:59:54.113313Z","steps":["trace[188985429] 'count revisions from in-memory index tree'  (duration: 182.893638ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:59:54.113486Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.923942ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13976532258768832112 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" mod_revision:25083 > success:<request_put:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" value_size:442 >> failure:<request_range:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-08T23:59:54.113553Z","caller":"traceutil/trace.go:171","msg":"trace[570004663] transaction","detail":"{read_only:false; response_revision:25097; number_of_response:1; }","duration":"182.760426ms","start":"2026-05-08T23:59:53.930782Z","end":"2026-05-08T23:59:54.113542Z","steps":["trace[570004663] 'process raft request'  (duration: 31.721901ms)","trace[570004663] 'compare'  (duration: 150.793549ms)"],"step_count":2}
{"level":"info","ts":"2026-05-08T23:59:54.476044Z","caller":"traceutil/trace.go:171","msg":"trace[414304172] transaction","detail":"{read_only:false; response_revision:25099; number_of_response:1; }","duration":"544.500908ms","start":"2026-05-08T23:59:53.931506Z","end":"2026-05-08T23:59:54.476006Z","steps":["trace[414304172] 'process raft request'  (duration: 544.335574ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:59:54.476284Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:59:53.931476Z","time spent":"544.673771ms","remote":"127.0.0.1:51812","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":608,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" mod_revision:25085 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" value_size:507 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" > >"}
{"level":"info","ts":"2026-05-08T23:59:54.476285Z","caller":"traceutil/trace.go:171","msg":"trace[1261394633] transaction","detail":"{read_only:false; response_revision:25098; number_of_response:1; }","duration":"545.248944ms","start":"2026-05-08T23:59:53.931009Z","end":"2026-05-08T23:59:54.476258Z","steps":["trace[1261394633] 'process raft request'  (duration: 527.7202ms)","trace[1261394633] 'compare'  (duration: 16.697094ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-08T23:59:54.47656Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:59:53.930971Z","time spent":"545.4635ms","remote":"127.0.0.1:51812","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/capi-system/controller-leader-election-capi\" mod_revision:25084 > success:<request_put:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" > >"}
{"level":"info","ts":"2026-05-08T23:59:54.480303Z","caller":"traceutil/trace.go:171","msg":"trace[702328850] linearizableReadLoop","detail":"{readStateIndex:25933; appliedIndex:25930; }","duration":"463.603761ms","start":"2026-05-08T23:59:54.016674Z","end":"2026-05-08T23:59:54.480278Z","steps":["trace[702328850] 'read index received'  (duration: 442.119204ms)","trace[702328850] 'applied index is now lower than readState.Index'  (duration: 21.482877ms)"],"step_count":2}
{"level":"info","ts":"2026-05-08T23:59:54.480359Z","caller":"traceutil/trace.go:171","msg":"trace[138524927] transaction","detail":"{read_only:false; response_revision:25100; number_of_response:1; }","duration":"473.479555ms","start":"2026-05-08T23:59:54.006847Z","end":"2026-05-08T23:59:54.480326Z","steps":["trace[138524927] 'process raft request'  (duration: 473.26862ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:59:54.480511Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:59:54.006811Z","time spent":"473.639419ms","remote":"127.0.0.1:51812","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":625,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" mod_revision:25065 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" value_size:516 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" > >"}
{"level":"warn","ts":"2026-05-08T23:59:54.480544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"463.861188ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"}
{"level":"warn","ts":"2026-05-08T23:59:54.480565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"378.549649ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:532"}
{"level":"info","ts":"2026-05-08T23:59:54.480592Z","caller":"traceutil/trace.go:171","msg":"trace[1605657792] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25100; }","duration":"463.95639ms","start":"2026-05-08T23:59:54.016623Z","end":"2026-05-08T23:59:54.48058Z","steps":["trace[1605657792] 'agreement among raft nodes before linearized reading'  (duration: 463.785176ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:59:54.48061Z","caller":"traceutil/trace.go:171","msg":"trace[1014211437] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:25100; }","duration":"378.653402ms","start":"2026-05-08T23:59:54.101941Z","end":"2026-05-08T23:59:54.480594Z","steps":["trace[1014211437] 'agreement among raft nodes before linearized reading'  (duration: 378.491158ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:59:54.480623Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:59:54.016602Z","time spent":"464.014831ms","remote":"127.0.0.1:51812","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":465,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-05-08T23:59:54.48065Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:59:54.101917Z","time spent":"378.725163ms","remote":"127.0.0.1:51812","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":556,"request content":"key:\"/registry/leases/cert-manager/cert-manager-controller\" "}
{"level":"warn","ts":"2026-05-08T23:59:54.480558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.293637ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-08T23:59:54.480807Z","caller":"traceutil/trace.go:171","msg":"trace[130068967] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25100; }","duration":"300.598544ms","start":"2026-05-08T23:59:54.180184Z","end":"2026-05-08T23:59:54.480783Z","steps":["trace[130068967] 'agreement among raft nodes before linearized reading'  (duration: 300.316667ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:59:54.480872Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:59:54.180056Z","time spent":"300.800929ms","remote":"127.0.0.1:51484","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":30,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-05-08T23:59:54.764897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.6574ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13976532258768832119 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:25086 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-08T23:59:54.765031Z","caller":"traceutil/trace.go:171","msg":"trace[89604015] transaction","detail":"{read_only:false; response_revision:25101; number_of_response:1; }","duration":"279.884094ms","start":"2026-05-08T23:59:54.48512Z","end":"2026-05-08T23:59:54.765004Z","steps":["trace[89604015] 'process raft request'  (duration: 95.017379ms)","trace[89604015] 'compare'  (duration: 184.477976ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-08T23:59:55.05577Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.755811ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13976532258768832120 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/cert-manager/cert-manager-controller\" mod_revision:24985 > success:<request_put:<key:\"/registry/leases/cert-manager/cert-manager-controller\" value_size:453 >> failure:<request_range:<key:\"/registry/leases/cert-manager/cert-manager-controller\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-08T23:59:55.056093Z","caller":"traceutil/trace.go:171","msg":"trace[1386412049] transaction","detail":"{read_only:false; response_revision:25104; number_of_response:1; }","duration":"553.05469ms","start":"2026-05-08T23:59:54.503017Z","end":"2026-05-08T23:59:55.056072Z","steps":["trace[1386412049] 'process raft request'  (duration: 552.960758ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:59:55.05617Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:59:54.503003Z","time spent":"553.125922ms","remote":"127.0.0.1:51812","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:25089 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:458 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"info","ts":"2026-05-08T23:59:55.056232Z","caller":"traceutil/trace.go:171","msg":"trace[1174499331] transaction","detail":"{read_only:false; response_revision:25102; number_of_response:1; }","duration":"569.093199ms","start":"2026-05-08T23:59:54.487098Z","end":"2026-05-08T23:59:55.056192Z","steps":["trace[1174499331] 'process raft request'  (duration: 430.812755ms)","trace[1174499331] 'compare'  (duration: 137.435684ms)"],"step_count":2}
{"level":"info","ts":"2026-05-08T23:59:55.056407Z","caller":"traceutil/trace.go:171","msg":"trace[1784516332] transaction","detail":"{read_only:false; response_revision:25103; number_of_response:1; }","duration":"553.387857ms","start":"2026-05-08T23:59:54.502986Z","end":"2026-05-08T23:59:55.056374Z","steps":["trace[1784516332] 'process raft request'  (duration: 552.891536ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:59:55.056441Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:59:54.487077Z","time spent":"569.256073ms","remote":"127.0.0.1:51812","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":514,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/cert-manager/cert-manager-controller\" mod_revision:24985 > success:<request_put:<key:\"/registry/leases/cert-manager/cert-manager-controller\" value_size:453 >> failure:<request_range:<key:\"/registry/leases/cert-manager/cert-manager-controller\" > >"}
{"level":"warn","ts":"2026-05-08T23:59:55.056544Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:59:54.502973Z","time spent":"553.506981ms","remote":"127.0.0.1:51812","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:25088 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"info","ts":"2026-05-08T23:59:55.056656Z","caller":"traceutil/trace.go:171","msg":"trace[1610182126] linearizableReadLoop","detail":"{readStateIndex:25938; appliedIndex:25934; }","duration":"476.512058ms","start":"2026-05-08T23:59:54.580131Z","end":"2026-05-08T23:59:55.056644Z","steps":["trace[1610182126] 'read index received'  (duration: 337.774023ms)","trace[1610182126] 'applied index is now lower than readState.Index'  (duration: 138.736735ms)"],"step_count":2}
{"level":"info","ts":"2026-05-08T23:59:55.056932Z","caller":"traceutil/trace.go:171","msg":"trace[1700133928] transaction","detail":"{read_only:false; response_revision:25105; number_of_response:1; }","duration":"553.578702ms","start":"2026-05-08T23:59:54.503342Z","end":"2026-05-08T23:59:55.056921Z","steps":["trace[1700133928] 'process raft request'  (duration: 552.674841ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:59:55.057013Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:59:54.503332Z","time spent":"553.640223ms","remote":"127.0.0.1:51812","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:25090 > 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-08T23:59:55.057148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"477.012059ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-08T23:59:55.057192Z","caller":"traceutil/trace.go:171","msg":"trace[1409795279] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:25105; }","duration":"477.087641ms","start":"2026-05-08T23:59:54.580093Z","end":"2026-05-08T23:59:55.05718Z","steps":["trace[1409795279] 'agreement among raft nodes before linearized reading'  (duration: 477.006089ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:59:55.057224Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:59:54.580084Z","time spent":"477.132312ms","remote":"127.0.0.1:60830","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":30,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "}
{"level":"warn","ts":"2026-05-08T23:59:55.139658Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"427.56512ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/rsakeys/\" range_end:\"/registry/secretgen.k14s.io/rsakeys0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-08T23:59:55.139745Z","caller":"traceutil/trace.go:171","msg":"trace[599579190] range","detail":"{range_begin:/registry/secretgen.k14s.io/rsakeys/; range_end:/registry/secretgen.k14s.io/rsakeys0; response_count:0; response_revision:25106; }","duration":"427.706183ms","start":"2026-05-08T23:59:54.712014Z","end":"2026-05-08T23:59:55.13972Z","steps":["trace[599579190] 'agreement among raft nodes before linearized reading'  (duration: 427.535859ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:59:55.139661Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"463.793347ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"}
{"level":"warn","ts":"2026-05-08T23:59:55.139801Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:59:54.711994Z","time spent":"427.798145ms","remote":"127.0.0.1:56020","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":30,"request content":"key:\"/registry/secretgen.k14s.io/rsakeys/\" range_end:\"/registry/secretgen.k14s.io/rsakeys0\" count_only:true "}
{"level":"info","ts":"2026-05-08T23:59:55.139835Z","caller":"traceutil/trace.go:171","msg":"trace[1230107439] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25106; }","duration":"464.025322ms","start":"2026-05-08T23:59:54.67579Z","end":"2026-05-08T23:59:55.139815Z","steps":["trace[1230107439] 'agreement among raft nodes before linearized reading'  (duration: 463.709655ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:59:55.139883Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:59:54.675765Z","time spent":"464.110215ms","remote":"127.0.0.1:51812","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-05-08T23:59:55.348726Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.280235ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-08T23:59:55.348843Z","caller":"traceutil/trace.go:171","msg":"trace[641206320] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25107; }","duration":"166.451989ms","start":"2026-05-08T23:59:55.182364Z","end":"2026-05-08T23:59:55.348816Z","steps":["trace[641206320] 'range keys from in-memory index tree'  (duration: 166.202683ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:59:55.660719Z","caller":"traceutil/trace.go:171","msg":"trace[1620630067] transaction","detail":"{read_only:false; response_revision:25109; number_of_response:1; }","duration":"191.37988ms","start":"2026-05-08T23:59:55.469308Z","end":"2026-05-08T23:59:55.660688Z","steps":["trace[1620630067] 'process raft request'  (duration: 191.197366ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:59:56.239753Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.230486ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13976532258768832138 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:25095 > 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:18"}
{"level":"info","ts":"2026-05-08T23:59:56.240028Z","caller":"traceutil/trace.go:171","msg":"trace[317626872] transaction","detail":"{read_only:false; response_revision:25112; number_of_response:1; }","duration":"404.652066ms","start":"2026-05-08T23:59:55.835328Z","end":"2026-05-08T23:59:56.23998Z","steps":["trace[317626872] 'process raft request'  (duration: 210.098972ms)","trace[317626872] 'compare'  (duration: 193.621263ms)"],"step_count":2}
{"level":"info","ts":"2026-05-08T23:59:56.240648Z","caller":"traceutil/trace.go:171","msg":"trace[1039213280] transaction","detail":"{read_only:false; response_revision:25113; number_of_response:1; }","duration":"404.32955ms","start":"2026-05-08T23:59:55.836289Z","end":"2026-05-08T23:59:56.240618Z","steps":["trace[1039213280] 'process raft request'  (duration: 403.596242ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:59:56.240682Z","caller":"traceutil/trace.go:171","msg":"trace[737470470] transaction","detail":"{read_only:false; response_revision:25114; number_of_response:1; }","duration":"121.149148ms","start":"2026-05-08T23:59:56.11951Z","end":"2026-05-08T23:59:56.24066Z","steps":["trace[737470470] 'process raft request'  (duration: 120.454831ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:59:56.240805Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:59:55.836284Z","time spent":"404.428043ms","remote":"127.0.0.1:51812","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:25096 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-05-08T23:59:56.241209Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:59:55.835304Z","time spent":"404.834611ms","remote":"127.0.0.1:51812","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:25095 > 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-08T23:59:59.124104Z","caller":"traceutil/trace.go:171","msg":"trace[1075241409] transaction","detail":"{read_only:false; response_revision:25131; number_of_response:1; }","duration":"340.904739ms","start":"2026-05-08T23:59:58.783173Z","end":"2026-05-08T23:59:59.124077Z","steps":["trace[1075241409] 'process raft request'  (duration: 340.698324ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:59:59.124319Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:59:58.783144Z","time spent":"341.048212ms","remote":"127.0.0.1:51812","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:25117 > 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-08T23:59:59.488004Z","caller":"traceutil/trace.go:171","msg":"trace[603636289] transaction","detail":"{read_only:false; response_revision:25135; number_of_response:1; }","duration":"334.379315ms","start":"2026-05-08T23:59:59.153585Z","end":"2026-05-08T23:59:59.487965Z","steps":["trace[603636289] 'process raft request'  (duration: 283.610714ms)","trace[603636289] 'compare'  (duration: 50.522675ms)"],"step_count":2}
{"level":"info","ts":"2026-05-08T23:59:59.488085Z","caller":"traceutil/trace.go:171","msg":"trace[1147010135] linearizableReadLoop","detail":"{readStateIndex:25969; appliedIndex:25968; }","duration":"324.298796ms","start":"2026-05-08T23:59:59.16374Z","end":"2026-05-08T23:59:59.488039Z","steps":["trace[1147010135] 'read index received'  (duration: 273.464993ms)","trace[1147010135] 'applied index is now lower than readState.Index'  (duration: 50.832123ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-08T23:59:59.488192Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:59:59.153551Z","time spent":"334.547668ms","remote":"127.0.0.1:51812","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/capo-system/controller-leader-election-capo\" mod_revision:25121 > success:<request_put:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" > >"}
{"level":"warn","ts":"2026-05-08T23:59:59.488525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.754176ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-a1e91db5-6e2b-41cd-aa7e-c32a4838507d\" ","response":"range_response_count:1 size:1436"}
{"level":"info","ts":"2026-05-08T23:59:59.488634Z","caller":"traceutil/trace.go:171","msg":"trace[806693231] range","detail":"{range_begin:/registry/persistentvolumes/pvc-a1e91db5-6e2b-41cd-aa7e-c32a4838507d; range_end:; response_count:1; response_revision:25135; }","duration":"324.91969ms","start":"2026-05-08T23:59:59.16368Z","end":"2026-05-08T23:59:59.4886Z","steps":["trace[806693231] 'agreement among raft nodes before linearized reading'  (duration: 324.555581ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:59:59.488696Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:59:59.163663Z","time spent":"325.020113ms","remote":"127.0.0.1:51674","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":1460,"request content":"key:\"/registry/persistentvolumes/pvc-a1e91db5-6e2b-41cd-aa7e-c32a4838507d\" "}
{"level":"info","ts":"2026-05-08T23:59:59.985864Z","caller":"traceutil/trace.go:171","msg":"trace[1154808941] linearizableReadLoop","detail":"{readStateIndex:25971; appliedIndex:25970; }","duration":"497.650949ms","start":"2026-05-08T23:59:59.488185Z","end":"2026-05-08T23:59:59.985836Z","steps":["trace[1154808941] 'read index received'  (duration: 497.491764ms)","trace[1154808941] 'applied index is now lower than readState.Index'  (duration: 158.145µs)"],"step_count":2}
{"level":"info","ts":"2026-05-08T23:59:59.985935Z","caller":"traceutil/trace.go:171","msg":"trace[748209467] transaction","detail":"{read_only:false; response_revision:25137; number_of_response:1; }","duration":"497.881543ms","start":"2026-05-08T23:59:59.48803Z","end":"2026-05-08T23:59:59.985911Z","steps":["trace[748209467] 'process raft request'  (duration: 497.557775ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:59:59.986272Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:59:59.487999Z","time spent":"497.987886ms","remote":"127.0.0.1:51812","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":626,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" mod_revision:25100 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" value_size:517 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" > >"}
{"level":"warn","ts":"2026-05-08T23:59:59.986387Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"816.431443ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-05-08T23:59:59.986482Z","caller":"traceutil/trace.go:171","msg":"trace[753257926] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25137; }","duration":"816.644468ms","start":"2026-05-08T23:59:59.169815Z","end":"2026-05-08T23:59:59.98646Z","steps":["trace[753257926] 'agreement among raft nodes before linearized reading'  (duration: 816.134816ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:59:59.986538Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:59:59.169791Z","time spent":"816.737241ms","remote":"127.0.0.1:51812","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-05-08T23:59:59.986865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"320.087345ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/addons.cluster.x-k8s.io/clusterresourcesetbindings/\" range_end:\"/registry/addons.cluster.x-k8s.io/clusterresourcesetbindings0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-08T23:59:59.986925Z","caller":"traceutil/trace.go:171","msg":"trace[1791512751] range","detail":"{range_begin:/registry/addons.cluster.x-k8s.io/clusterresourcesetbindings/; range_end:/registry/addons.cluster.x-k8s.io/clusterresourcesetbindings0; response_count:0; response_revision:25138; }","duration":"320.186108ms","start":"2026-05-08T23:59:59.666723Z","end":"2026-05-08T23:59:59.986909Z","steps":["trace[1791512751] 'agreement among raft nodes before linearized reading'  (duration: 320.062865ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:59:59.986886Z","caller":"traceutil/trace.go:171","msg":"trace[742364653] transaction","detail":"{read_only:false; response_revision:25138; number_of_response:1; }","duration":"313.09558ms","start":"2026-05-08T23:59:59.673757Z","end":"2026-05-08T23:59:59.986853Z","steps":["trace[742364653] 'process raft request'  (duration: 312.939947ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:59:59.986965Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:59:59.666703Z","time spent":"320.252619ms","remote":"127.0.0.1:52902","response type":"/etcdserverpb.KV/Range","request count":0,"request size":128,"response count":0,"response size":30,"request content":"key:\"/registry/addons.cluster.x-k8s.io/clusterresourcesetbindings/\" range_end:\"/registry/addons.cluster.x-k8s.io/clusterresourcesetbindings0\" count_only:true "}
{"level":"warn","ts":"2026-05-08T23:59:59.987061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.284902ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"}
{"level":"warn","ts":"2026-05-08T23:59:59.987089Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:59:59.673739Z","time spent":"313.234354ms","remote":"127.0.0.1:51812","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:25124 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:464 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"info","ts":"2026-05-08T23:59:59.98711Z","caller":"traceutil/trace.go:171","msg":"trace[525193867] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25138; }","duration":"154.377904ms","start":"2026-05-08T23:59:59.83272Z","end":"2026-05-08T23:59:59.987098Z","steps":["trace[525193867] 'agreement among raft nodes before linearized reading'  (duration: 154.242801ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T00:00:04.415447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.98146ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13976532258768832362 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:25209 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-09T00:00:04.415724Z","caller":"traceutil/trace.go:171","msg":"trace[1639233119] transaction","detail":"{read_only:false; response_revision:25228; number_of_response:1; }","duration":"126.015072ms","start":"2026-05-09T00:00:04.289689Z","end":"2026-05-09T00:00:04.415705Z","steps":["trace[1639233119] 'process raft request'  (duration: 125.971861ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T00:00:04.41594Z","caller":"traceutil/trace.go:171","msg":"trace[1612126592] transaction","detail":"{read_only:false; response_revision:25226; number_of_response:1; }","duration":"305.758116ms","start":"2026-05-09T00:00:04.11017Z","end":"2026-05-09T00:00:04.415928Z","steps":["trace[1612126592] 'process raft request'  (duration: 84.195133ms)","trace[1612126592] 'compare'  (duration: 220.745344ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T00:00:04.415997Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T00:00:04.110145Z","time spent":"305.818268ms","remote":"127.0.0.1:51812","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:25209 > 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-09T00:00:04.41624Z","caller":"traceutil/trace.go:171","msg":"trace[1232644141] linearizableReadLoop","detail":"{readStateIndex:26062; appliedIndex:26060; }","duration":"291.194502ms","start":"2026-05-09T00:00:04.124987Z","end":"2026-05-09T00:00:04.416182Z","steps":["trace[1232644141] 'read index received'  (duration: 69.487055ms)","trace[1232644141] 'applied index is now lower than readState.Index'  (duration: 221.684937ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T00:00:04.416471Z","caller":"traceutil/trace.go:171","msg":"trace[767335308] transaction","detail":"{read_only:false; response_revision:25227; number_of_response:1; }","duration":"293.374274ms","start":"2026-05-09T00:00:04.123075Z","end":"2026-05-09T00:00:04.416449Z","steps":["trace[767335308] 'process raft request'  (duration: 292.491583ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T00:00:04.416647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.772243ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"}
{"level":"info","ts":"2026-05-09T00:00:04.416694Z","caller":"traceutil/trace.go:171","msg":"trace[1295451983] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25228; }","duration":"124.846514ms","start":"2026-05-09T00:00:04.291834Z","end":"2026-05-09T00:00:04.416681Z","steps":["trace[1295451983] 'agreement among raft nodes before linearized reading'  (duration: 124.707511ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T00:00:04.417313Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.21494ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"}
{"level":"info","ts":"2026-05-09T00:00:04.417367Z","caller":"traceutil/trace.go:171","msg":"trace[627354025] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25228; }","duration":"124.319582ms","start":"2026-05-09T00:00:04.293031Z","end":"2026-05-09T00:00:04.417351Z","steps":["trace[627354025] 'agreement among raft nodes before linearized reading'  (duration: 124.112417ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T00:00:04.418569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.582519ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:9"}
{"level":"info","ts":"2026-05-09T00:00:04.418613Z","caller":"traceutil/trace.go:171","msg":"trace[1283715450] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:25228; }","duration":"293.677491ms","start":"2026-05-09T00:00:04.124925Z","end":"2026-05-09T00:00:04.418603Z","steps":["trace[1283715450] 'agreement among raft nodes before linearized reading'  (duration: 291.855977ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T00:00:10.26439Z","caller":"traceutil/trace.go:171","msg":"trace[140257456] transaction","detail":"{read_only:false; response_revision:25292; number_of_response:1; }","duration":"263.990928ms","start":"2026-05-09T00:00:10.000379Z","end":"2026-05-09T00:00:10.26437Z","steps":["trace[140257456] 'process raft request'  (duration: 263.749763ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T00:00:10.264325Z","caller":"traceutil/trace.go:171","msg":"trace[71058343] linearizableReadLoop","detail":"{readStateIndex:26128; appliedIndex:26127; }","duration":"202.252938ms","start":"2026-05-09T00:00:10.062045Z","end":"2026-05-09T00:00:10.264298Z","steps":["trace[71058343] 'read index received'  (duration: 201.981651ms)","trace[71058343] 'applied index is now lower than readState.Index'  (duration: 270.167µs)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T00:00:10.264679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.602826ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:532"}
{"level":"info","ts":"2026-05-09T00:00:10.264787Z","caller":"traceutil/trace.go:171","msg":"trace[1492681291] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:25292; }","duration":"202.76933ms","start":"2026-05-09T00:00:10.061994Z","end":"2026-05-09T00:00:10.264763Z","steps":["trace[1492681291] 'agreement among raft nodes before linearized reading'  (duration: 202.482723ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T00:00:10.403895Z","caller":"traceutil/trace.go:171","msg":"trace[314668362] transaction","detail":"{read_only:false; response_revision:25294; number_of_response:1; }","duration":"123.341239ms","start":"2026-05-09T00:00:10.280523Z","end":"2026-05-09T00:00:10.403864Z","steps":["trace[314668362] 'process raft request'  (duration: 123.285238ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T00:00:10.404259Z","caller":"traceutil/trace.go:171","msg":"trace[1614809270] transaction","detail":"{read_only:false; response_revision:25293; number_of_response:1; }","duration":"277.933829ms","start":"2026-05-09T00:00:10.126312Z","end":"2026-05-09T00:00:10.404245Z","steps":["trace[1614809270] 'process raft request'  (duration: 180.032462ms)","trace[1614809270] 'compare'  (duration: 96.895522ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T00:00:10.404368Z","caller":"traceutil/trace.go:171","msg":"trace[298728703] linearizableReadLoop","detail":"{readStateIndex:26129; appliedIndex:26128; }","duration":"139.730228ms","start":"2026-05-09T00:00:10.264627Z","end":"2026-05-09T00:00:10.404358Z","steps":["trace[298728703] 'read index received'  (duration: 41.699987ms)","trace[298728703] 'applied index is now lower than readState.Index'  (duration: 98.029161ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T00:00:10.404451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.316599ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/nfd.k8s-sigs.io/nodefeatures/\" range_end:\"/registry/nfd.k8s-sigs.io/nodefeatures0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-05-09T00:00:10.404483Z","caller":"traceutil/trace.go:171","msg":"trace[1706279309] range","detail":"{range_begin:/registry/nfd.k8s-sigs.io/nodefeatures/; range_end:/registry/nfd.k8s-sigs.io/nodefeatures0; response_count:0; response_revision:25294; }","duration":"224.409011ms","start":"2026-05-09T00:00:10.180066Z","end":"2026-05-09T00:00:10.404475Z","steps":["trace[1706279309] 'agreement among raft nodes before linearized reading'  (duration: 224.325359ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T00:00:10.404755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.149239ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rook-ceph-pdbstatemap\" ","response":"range_response_count:1 size:357"}
{"level":"info","ts":"2026-05-09T00:00:10.40478Z","caller":"traceutil/trace.go:171","msg":"trace[1416995079] range","detail":"{range_begin:/registry/configmaps/openstack/rook-ceph-pdbstatemap; range_end:; response_count:1; response_revision:25294; }","duration":"195.21875ms","start":"2026-05-09T00:00:10.209555Z","end":"2026-05-09T00:00:10.404774Z","steps":["trace[1416995079] 'agreement among raft nodes before linearized reading'  (duration: 195.102118ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T00:00:10.404905Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.083282ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-09T00:00:10.404929Z","caller":"traceutil/trace.go:171","msg":"trace[379112078] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25294; }","duration":"221.150754ms","start":"2026-05-09T00:00:10.183773Z","end":"2026-05-09T00:00:10.404923Z","steps":["trace[379112078] 'agreement among raft nodes before linearized reading'  (duration: 221.108703ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T00:00:10.825152Z","caller":"traceutil/trace.go:171","msg":"trace[1099166990] linearizableReadLoop","detail":"{readStateIndex:26141; appliedIndex:26140; }","duration":"106.282965ms","start":"2026-05-09T00:00:10.718846Z","end":"2026-05-09T00:00:10.825129Z","steps":["trace[1099166990] 'read index received'  (duration: 106.07026ms)","trace[1099166990] 'applied index is now lower than readState.Index'  (duration: 212.075µs)"],"step_count":2}
{"level":"info","ts":"2026-05-09T00:00:10.825522Z","caller":"traceutil/trace.go:171","msg":"trace[834193012] transaction","detail":"{read_only:false; response_revision:25305; number_of_response:1; }","duration":"120.121833ms","start":"2026-05-09T00:00:10.705391Z","end":"2026-05-09T00:00:10.825513Z","steps":["trace[834193012] 'process raft request'  (duration: 119.603131ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T00:00:10.825937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.073954ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/\" range_end:\"/registry/pods/monitoring0\" ","response":"range_response_count:16 size:112041"}
{"level":"info","ts":"2026-05-09T00:00:10.82597Z","caller":"traceutil/trace.go:171","msg":"trace[1096568400] range","detail":"{range_begin:/registry/pods/monitoring/; range_end:/registry/pods/monitoring0; response_count:16; response_revision:25305; }","duration":"107.159005ms","start":"2026-05-09T00:00:10.718803Z","end":"2026-05-09T00:00:10.825962Z","steps":["trace[1096568400] 'agreement among raft nodes before linearized reading'  (duration: 106.873549ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T00:00:14.812357Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.009144ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13976532258768832781 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:25376 > 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:18"}
{"level":"info","ts":"2026-05-09T00:00:14.812636Z","caller":"traceutil/trace.go:171","msg":"trace[2046267694] linearizableReadLoop","detail":"{readStateIndex:26242; appliedIndex:26239; }","duration":"231.149279ms","start":"2026-05-09T00:00:14.581467Z","end":"2026-05-09T00:00:14.812616Z","steps":["trace[2046267694] 'read index received'  (duration: 87.772817ms)","trace[2046267694] 'applied index is now lower than readState.Index'  (duration: 143.375422ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T00:00:14.81262Z","caller":"traceutil/trace.go:171","msg":"trace[900180957] transaction","detail":"{read_only:false; response_revision:25403; number_of_response:1; }","duration":"271.566958ms","start":"2026-05-09T00:00:14.54102Z","end":"2026-05-09T00:00:14.812587Z","steps":["trace[900180957] 'process raft request'  (duration: 128.203845ms)","trace[900180957] 'compare'  (duration: 142.861151ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T00:00:14.812682Z","caller":"traceutil/trace.go:171","msg":"trace[1138134579] transaction","detail":"{read_only:false; response_revision:25404; number_of_response:1; }","duration":"235.837171ms","start":"2026-05-09T00:00:14.576807Z","end":"2026-05-09T00:00:14.812644Z","steps":["trace[1138134579] 'process raft request'  (duration: 235.686858ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T00:00:14.812743Z","caller":"traceutil/trace.go:171","msg":"trace[1177063006] transaction","detail":"{read_only:false; response_revision:25405; number_of_response:1; }","duration":"235.822131ms","start":"2026-05-09T00:00:14.576909Z","end":"2026-05-09T00:00:14.812731Z","steps":["trace[1177063006] 'process raft request'  (duration: 235.659467ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T00:00:14.81298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.503548ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"}
{"level":"info","ts":"2026-05-09T00:00:14.813031Z","caller":"traceutil/trace.go:171","msg":"trace[1869416939] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25405; }","duration":"231.599801ms","start":"2026-05-09T00:00:14.58142Z","end":"2026-05-09T00:00:14.813019Z","steps":["trace[1869416939] 'agreement among raft nodes before linearized reading'  (duration: 231.425297ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T00:00:15.02548Z","caller":"traceutil/trace.go:171","msg":"trace[936209861] transaction","detail":"{read_only:false; response_revision:25407; number_of_response:1; }","duration":"207.776427ms","start":"2026-05-09T00:00:14.817675Z","end":"2026-05-09T00:00:15.025452Z","steps":["trace[936209861] 'process raft request'  (duration: 207.717855ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T00:00:15.025604Z","caller":"traceutil/trace.go:171","msg":"trace[1346288613] transaction","detail":"{read_only:false; response_revision:25406; number_of_response:1; }","duration":"289.070501ms","start":"2026-05-09T00:00:14.736495Z","end":"2026-05-09T00:00:15.025565Z","steps":["trace[1346288613] 'process raft request'  (duration: 272.258494ms)","trace[1346288613] 'compare'  (duration: 16.456719ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T00:00:15.025761Z","caller":"traceutil/trace.go:171","msg":"trace[2088712056] linearizableReadLoop","detail":"{readStateIndex:26243; appliedIndex:26242; }","duration":"213.068113ms","start":"2026-05-09T00:00:14.812679Z","end":"2026-05-09T00:00:15.025747Z","steps":["trace[2088712056] 'read index received'  (duration: 195.894626ms)","trace[2088712056] 'applied index is now lower than readState.Index'  (duration: 17.172007ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T00:00:15.025886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.865213ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/domains/\" range_end:\"/registry/openstack.k-orc.cloud/domains0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-09T00:00:15.025923Z","caller":"traceutil/trace.go:171","msg":"trace[797696510] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/domains/; range_end:/registry/openstack.k-orc.cloud/domains0; response_count:0; response_revision:25407; }","duration":"230.957745ms","start":"2026-05-09T00:00:14.794952Z","end":"2026-05-09T00:00:15.02591Z","steps":["trace[797696510] 'agreement among raft nodes before linearized reading'  (duration: 230.842303ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T00:00:18.835811Z","caller":"traceutil/trace.go:171","msg":"trace[1989508490] transaction","detail":"{read_only:false; response_revision:25453; number_of_response:1; }","duration":"267.429798ms","start":"2026-05-09T00:00:18.568331Z","end":"2026-05-09T00:00:18.835761Z","steps":["trace[1989508490] 'process raft request'  (duration: 226.759256ms)","trace[1989508490] 'compare'  (duration: 40.471598ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T00:00:19.045791Z","caller":"traceutil/trace.go:171","msg":"trace[1865561762] linearizableReadLoop","detail":"{readStateIndex:26293; appliedIndex:26290; }","duration":"371.965512ms","start":"2026-05-09T00:00:18.673797Z","end":"2026-05-09T00:00:19.045762Z","steps":["trace[1865561762] 'read index received'  (duration: 121.313351ms)","trace[1865561762] 'applied index is now lower than readState.Index'  (duration: 250.650741ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T00:00:19.045922Z","caller":"traceutil/trace.go:171","msg":"trace[230059620] transaction","detail":"{read_only:false; response_revision:25455; number_of_response:1; }","duration":"385.543124ms","start":"2026-05-09T00:00:18.660321Z","end":"2026-05-09T00:00:19.045864Z","steps":["trace[230059620] 'process raft request'  (duration: 385.364259ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T00:00:19.046061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"372.242469ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rabbitmq-manila-server-0\" ","response":"range_response_count:1 size:10359"}
{"level":"info","ts":"2026-05-09T00:00:19.046012Z","caller":"traceutil/trace.go:171","msg":"trace[542773627] transaction","detail":"{read_only:false; response_revision:25454; number_of_response:1; }","duration":"476.689302ms","start":"2026-05-09T00:00:18.569262Z","end":"2026-05-09T00:00:19.045951Z","steps":["trace[542773627] 'process raft request'  (duration: 476.21079ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T00:00:19.046127Z","caller":"traceutil/trace.go:171","msg":"trace[1409125842] range","detail":"{range_begin:/registry/pods/openstack/rabbitmq-manila-server-0; range_end:; response_count:1; response_revision:25455; }","duration":"372.328491ms","start":"2026-05-09T00:00:18.673787Z","end":"2026-05-09T00:00:19.046115Z","steps":["trace[1409125842] 'agreement among raft nodes before linearized reading'  (duration: 372.113575ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T00:00:19.046127Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T00:00:18.660288Z","time spent":"385.743689ms","remote":"127.0.0.1:51564","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":739,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/events/openstack/rabbitmq-manila-server-0.18adbc9eed84d8fa\" mod_revision:0 > success:<request_put:<key:\"/registry/events/openstack/rabbitmq-manila-server-0.18adbc9eed84d8fa\" value_size:653 lease:4753160221914056067 >> failure:<>"}
{"level":"warn","ts":"2026-05-09T00:00:19.046171Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T00:00:18.67375Z","time spent":"372.412813ms","remote":"127.0.0.1:51722","response type":"/etcdserverpb.KV/Range","request count":0,"request size":51,"response count":1,"response size":10383,"request content":"key:\"/registry/pods/openstack/rabbitmq-manila-server-0\" "}
{"level":"warn","ts":"2026-05-09T00:00:19.046248Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T00:00:18.569244Z","time spent":"476.904346ms","remote":"127.0.0.1:51812","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:25433 > 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-09T00:00:19.05438Z","caller":"traceutil/trace.go:171","msg":"trace[2136630645] transaction","detail":"{read_only:false; response_revision:25457; number_of_response:1; }","duration":"225.859325ms","start":"2026-05-09T00:00:18.828486Z","end":"2026-05-09T00:00:19.054345Z","steps":["trace[2136630645] 'process raft request'  (duration: 225.781093ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T00:00:19.054448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.718502ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanetemplates/\" range_end:\"/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanetemplates0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-09T00:00:19.054492Z","caller":"traceutil/trace.go:171","msg":"trace[192860839] range","detail":"{range_begin:/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanetemplates/; range_end:/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanetemplates0; response_count:0; response_revision:25457; }","duration":"154.775183ms","start":"2026-05-09T00:00:18.899706Z","end":"2026-05-09T00:00:19.054481Z","steps":["trace[192860839] 'agreement among raft nodes before linearized reading'  (duration: 154.64709ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T00:00:19.054704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.469714ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"}
{"level":"info","ts":"2026-05-09T00:00:19.054733Z","caller":"traceutil/trace.go:171","msg":"trace[244301861] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25457; }","duration":"227.546057ms","start":"2026-05-09T00:00:18.827179Z","end":"2026-05-09T00:00:19.054725Z","steps":["trace[244301861] 'agreement among raft nodes before linearized reading'  (duration: 227.460564ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T00:00:19.05477Z","caller":"traceutil/trace.go:171","msg":"trace[328222237] transaction","detail":"{read_only:false; response_revision:25456; number_of_response:1; }","duration":"226.90923ms","start":"2026-05-09T00:00:18.827849Z","end":"2026-05-09T00:00:19.054758Z","steps":["trace[328222237] 'process raft request'  (duration: 226.335346ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T00:00:19.054887Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.853057ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-manila-server-0\" ","response":"range_response_count:1 size:1860"}
{"level":"info","ts":"2026-05-09T00:00:19.054919Z","caller":"traceutil/trace.go:171","msg":"trace[487163306] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-manila-server-0; range_end:; response_count:1; response_revision:25457; }","duration":"310.925349ms","start":"2026-05-09T00:00:18.743983Z","end":"2026-05-09T00:00:19.054908Z","steps":["trace[487163306] 'agreement among raft nodes before linearized reading'  (duration: 310.852967ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T00:00:19.054961Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T00:00:18.74396Z","time spent":"310.98059ms","remote":"127.0.0.1:51688","response type":"/etcdserverpb.KV/Range","request count":0,"request size":81,"response count":1,"response size":1884,"request content":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-manila-server-0\" "}
{"level":"info","ts":"2026-05-09T00:00:23.852431Z","caller":"traceutil/trace.go:171","msg":"trace[1748684201] transaction","detail":"{read_only:false; response_revision:25514; number_of_response:1; }","duration":"173.389384ms","start":"2026-05-09T00:00:23.679013Z","end":"2026-05-09T00:00:23.852403Z","steps":["trace[1748684201] 'process raft request'  (duration: 173.163328ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T00:00:25.972968Z","caller":"traceutil/trace.go:171","msg":"trace[1883059] transaction","detail":"{read_only:false; response_revision:25532; number_of_response:1; }","duration":"112.039552ms","start":"2026-05-09T00:00:25.860906Z","end":"2026-05-09T00:00:25.972946Z","steps":["trace[1883059] 'process raft request'  (duration: 111.880588ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T00:00:26.087847Z","caller":"traceutil/trace.go:171","msg":"trace[97890888] linearizableReadLoop","detail":"{readStateIndex:26372; appliedIndex:26370; }","duration":"182.51991ms","start":"2026-05-09T00:00:25.905297Z","end":"2026-05-09T00:00:26.087817Z","steps":["trace[97890888] 'read index received'  (duration: 67.545739ms)","trace[97890888] 'applied index is now lower than readState.Index'  (duration: 114.971861ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T00:00:26.088181Z","caller":"traceutil/trace.go:171","msg":"trace[1710486484] transaction","detail":"{read_only:false; response_revision:25533; number_of_response:1; }","duration":"221.743258ms","start":"2026-05-09T00:00:25.866421Z","end":"2026-05-09T00:00:26.088164Z","steps":["trace[1710486484] 'process raft request'  (duration: 210.776758ms)","trace[1710486484] 'compare'  (duration: 10.237363ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T00:00:26.088349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.030702ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/objectbucket.io/objectbucketclaims/\" range_end:\"/registry/objectbucket.io/objectbucketclaims0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-09T00:00:26.088383Z","caller":"traceutil/trace.go:171","msg":"trace[835564055] range","detail":"{range_begin:/registry/objectbucket.io/objectbucketclaims/; range_end:/registry/objectbucket.io/objectbucketclaims0; response_count:0; response_revision:25533; }","duration":"183.121494ms","start":"2026-05-09T00:00:25.905252Z","end":"2026-05-09T00:00:26.088374Z","steps":["trace[835564055] 'agreement among raft nodes before linearized reading'  (duration: 183.031102ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T00:00:29.339563Z","caller":"traceutil/trace.go:171","msg":"trace[913864276] transaction","detail":"{read_only:false; response_revision:25564; number_of_response:1; }","duration":"127.228632ms","start":"2026-05-09T00:00:29.2123Z","end":"2026-05-09T00:00:29.339528Z","steps":["trace[913864276] 'process raft request'  (duration: 127.002977ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T00:00:29.386894Z","caller":"traceutil/trace.go:171","msg":"trace[672814227] transaction","detail":"{read_only:false; response_revision:25565; number_of_response:1; }","duration":"168.909929ms","start":"2026-05-09T00:00:29.217963Z","end":"2026-05-09T00:00:29.386873Z","steps":["trace[672814227] 'process raft request'  (duration: 168.708534ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T00:00:29.387478Z","caller":"traceutil/trace.go:171","msg":"trace[531904940] transaction","detail":"{read_only:false; response_revision:25566; number_of_response:1; }","duration":"104.286078ms","start":"2026-05-09T00:00:29.283125Z","end":"2026-05-09T00:00:29.387411Z","steps":["trace[531904940] 'process raft request'  (duration: 103.684474ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T00:00:29.387814Z","caller":"traceutil/trace.go:171","msg":"trace[1774939755] linearizableReadLoop","detail":"{readStateIndex:26405; appliedIndex:26403; }","duration":"162.834514ms","start":"2026-05-09T00:00:29.224953Z","end":"2026-05-09T00:00:29.387787Z","steps":["trace[1774939755] 'read index received'  (duration: 114.421669ms)","trace[1774939755] 'applied index is now lower than readState.Index'  (duration: 48.410805ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T00:00:29.387848Z","caller":"traceutil/trace.go:171","msg":"trace[1152678902] transaction","detail":"{read_only:false; response_revision:25567; number_of_response:1; }","duration":"104.644286ms","start":"2026-05-09T00:00:29.283158Z","end":"2026-05-09T00:00:29.387803Z","steps":["trace[1152678902] 'process raft request'  (duration: 104.031032ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T00:00:29.387924Z","caller":"traceutil/trace.go:171","msg":"trace[1640694864] transaction","detail":"{read_only:false; response_revision:25568; number_of_response:1; }","duration":"104.648596ms","start":"2026-05-09T00:00:29.283213Z","end":"2026-05-09T00:00:29.387861Z","steps":["trace[1640694864] 'process raft request'  (duration: 104.469012ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T00:00:29.388077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.205371ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-05-09T00:00:29.388147Z","caller":"traceutil/trace.go:171","msg":"trace[1327498432] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25568; }","duration":"160.289683ms","start":"2026-05-09T00:00:29.227836Z","end":"2026-05-09T00:00:29.388126Z","steps":["trace[1327498432] 'agreement among raft nodes before linearized reading'  (duration: 160.112669ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T00:00:29.388076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.09344ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"}
{"level":"warn","ts":"2026-05-09T00:00:29.388221Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.289773ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"}
{"level":"info","ts":"2026-05-09T00:00:29.388262Z","caller":"traceutil/trace.go:171","msg":"trace[1143035095] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25568; }","duration":"160.367205ms","start":"2026-05-09T00:00:29.227882Z","end":"2026-05-09T00:00:29.388249Z","steps":["trace[1143035095] 'agreement among raft nodes before linearized reading'  (duration: 160.279993ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T00:00:29.388262Z","caller":"traceutil/trace.go:171","msg":"trace[941204734] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25568; }","duration":"163.338976ms","start":"2026-05-09T00:00:29.224903Z","end":"2026-05-09T00:00:29.388242Z","steps":["trace[941204734] 'agreement among raft nodes before linearized reading'  (duration: 163.016108ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T00:00:29.388236Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.880119ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"}
{"level":"info","ts":"2026-05-09T00:00:29.388389Z","caller":"traceutil/trace.go:171","msg":"trace[1749928409] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25568; }","duration":"107.091164ms","start":"2026-05-09T00:00:29.281282Z","end":"2026-05-09T00:00:29.388373Z","steps":["trace[1749928409] 'agreement among raft nodes before linearized reading'  (duration: 106.751666ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T00:00:36.767086Z","caller":"traceutil/trace.go:171","msg":"trace[233902817] transaction","detail":"{read_only:false; response_revision:25619; number_of_response:1; }","duration":"128.818439ms","start":"2026-05-09T00:00:36.638239Z","end":"2026-05-09T00:00:36.767057Z","steps":["trace[233902817] 'process raft request'  (duration: 128.611324ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T00:00:43.21147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.734819ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13976532258768833430 > lease_revoke:<id:41f69e09dbb44a52>","response":"size:30"}
{"level":"info","ts":"2026-05-09T00:00:43.211652Z","caller":"traceutil/trace.go:171","msg":"trace[334817474] linearizableReadLoop","detail":"{readStateIndex:26523; appliedIndex:26522; }","duration":"153.763379ms","start":"2026-05-09T00:00:43.057815Z","end":"2026-05-09T00:00:43.211579Z","steps":["trace[334817474] 'read index received'  (duration: 7.876156ms)","trace[334817474] 'applied index is now lower than readState.Index'  (duration: 145.885483ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T00:00:43.212278Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.438765ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"}
{"level":"info","ts":"2026-05-09T00:00:43.212381Z","caller":"traceutil/trace.go:171","msg":"trace[312812004] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25679; }","duration":"154.610429ms","start":"2026-05-09T00:00:43.057743Z","end":"2026-05-09T00:00:43.212354Z","steps":["trace[312812004] 'agreement among raft nodes before linearized reading'  (duration: 154.264411ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T00:00:54.569882Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":22213}
{"level":"info","ts":"2026-05-09T00:00:54.67943Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":22213,"took":"104.867732ms","hash":1076830086,"current-db-size-bytes":58298368,"current-db-size":"58 MB","current-db-size-in-use-bytes":43970560,"current-db-size-in-use":"44 MB"}
{"level":"info","ts":"2026-05-09T00:00:54.679497Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1076830086,"revision":22213,"compact-revision":20011}
{"level":"info","ts":"2026-05-09T00:00:56.243446Z","caller":"traceutil/trace.go:171","msg":"trace[1251974069] transaction","detail":"{read_only:false; response_revision:25791; number_of_response:1; }","duration":"101.613846ms","start":"2026-05-09T00:00:56.141795Z","end":"2026-05-09T00:00:56.243408Z","steps":["trace[1251974069] 'process raft request'  (duration: 100.871148ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T00:00:56.745894Z","caller":"traceutil/trace.go:171","msg":"trace[355659964] transaction","detail":"{read_only:false; response_revision:25792; number_of_response:1; }","duration":"153.316299ms","start":"2026-05-09T00:00:56.592538Z","end":"2026-05-09T00:00:56.745854Z","steps":["trace[355659964] 'process raft request'  (duration: 153.029973ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T00:00:56.961475Z","caller":"traceutil/trace.go:171","msg":"trace[1363644909] transaction","detail":"{read_only:false; response_revision:25794; number_of_response:1; }","duration":"121.28524ms","start":"2026-05-09T00:00:56.840157Z","end":"2026-05-09T00:00:56.961442Z","steps":["trace[1363644909] 'process raft request'  (duration: 79.234354ms)","trace[1363644909] 'compare'  (duration: 41.888982ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T00:01:02.576106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.428668ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-09T00:01:02.576213Z","caller":"traceutil/trace.go:171","msg":"trace[1175251802] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:25835; }","duration":"103.54651ms","start":"2026-05-09T00:01:02.47265Z","end":"2026-05-09T00:01:02.576196Z","steps":["trace[1175251802] 'range keys from in-memory index tree'  (duration: 103.418287ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T00:01:24.102088Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-0000000000006973.wal"}
{"level":"info","ts":"2026-05-09T00:05:54.582096Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":25775}
{"level":"info","ts":"2026-05-09T00:05:54.744686Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":25775,"took":"157.492137ms","hash":1804742766,"current-db-size-bytes":60026880,"current-db-size":"60 MB","current-db-size-in-use-bytes":36495360,"current-db-size-in-use":"36 MB"}
{"level":"info","ts":"2026-05-09T00:05:54.744777Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1804742766,"revision":25775,"compact-revision":22213}
{"level":"info","ts":"2026-05-09T00:06:46.998234Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"d7dbc9f5893cc1f6","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-05-09T00:06:47.00502Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003}
{"level":"info","ts":"2026-05-09T00:06:47.005134Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003}
{"level":"info","ts":"2026-05-09T00:10:54.59112Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":28685}
{"level":"info","ts":"2026-05-09T00:10:54.738204Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":28685,"took":"140.373259ms","hash":3935656610,"current-db-size-bytes":60026880,"current-db-size":"60 MB","current-db-size-in-use-bytes":30711808,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-05-09T00:10:54.738314Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3935656610,"revision":28685,"compact-revision":25775}
{"level":"info","ts":"2026-05-09T00:15:54.599876Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":30910}
{"level":"info","ts":"2026-05-09T00:15:54.720489Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":30910,"took":"114.637161ms","hash":113636126,"current-db-size-bytes":60026880,"current-db-size":"60 MB","current-db-size-in-use-bytes":31191040,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-05-09T00:15:54.720767Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":113636126,"revision":30910,"compact-revision":28685}
{"level":"info","ts":"2026-05-09T00:20:54.609761Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":33176}
{"level":"info","ts":"2026-05-09T00:20:54.769307Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":33176,"took":"154.811115ms","hash":3519756829,"current-db-size-bytes":61071360,"current-db-size":"61 MB","current-db-size-in-use-bytes":31526912,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-05-09T00:20:54.769456Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3519756829,"revision":33176,"compact-revision":30910}
{"level":"info","ts":"2026-05-09T00:25:54.618936Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":35507}
{"level":"info","ts":"2026-05-09T00:25:54.764006Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":35507,"took":"139.141624ms","hash":3515053911,"current-db-size-bytes":61538304,"current-db-size":"62 MB","current-db-size-in-use-bytes":31879168,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-05-09T00:25:54.764099Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3515053911,"revision":35507,"compact-revision":33176}
{"level":"info","ts":"2026-05-09T00:28:13.158168Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"d7dbc9f5893cc1f6","local-member-applied-index":40004,"local-member-snapshot-index":30003,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-05-09T00:28:13.16251Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40004}
{"level":"info","ts":"2026-05-09T00:28:13.162592Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35004}
{"level":"info","ts":"2026-05-09T00:30:54.626626Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":37734}
{"level":"info","ts":"2026-05-09T00:30:54.746595Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":37734,"took":"116.144329ms","hash":1193605474,"current-db-size-bytes":62803968,"current-db-size":"63 MB","current-db-size-in-use-bytes":32362496,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-05-09T00:30:54.746669Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1193605474,"revision":37734,"compact-revision":35507}