{"level":"warn","ts":"2026-04-22T00:29:22.784479Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-04-22T00:29:22.784559Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.248: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.248:2380","--initial-cluster=instance=https://199.204.45.248:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.248:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.248:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]}
{"level":"warn","ts":"2026-04-22T00:29:22.784624Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-04-22T00:29:22.784635Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.248:2380"]}
{"level":"info","ts":"2026-04-22T00:29:22.784652Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-04-22T00:29:22.785318Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.248:2379"]}
{"level":"info","ts":"2026-04-22T00:29:22.785389Z","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.248:2380"],"listen-peer-urls":["https://199.204.45.248:2380"],"advertise-client-urls":["https://199.204.45.248:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.248:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.248:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"}
{"level":"info","ts":"2026-04-22T00:29:22.791222Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.63819ms"}
{"level":"info","ts":"2026-04-22T00:29:22.798513Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"39582465ceaa2f67","cluster-id":"87fd8ddedde3be45"}
{"level":"info","ts":"2026-04-22T00:29:22.7986Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 switched to configuration voters=()"}
{"level":"info","ts":"2026-04-22T00:29:22.798622Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became follower at term 0"}
{"level":"info","ts":"2026-04-22T00:29:22.798637Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 39582465ceaa2f67 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-04-22T00:29:22.798648Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became follower at term 1"}
{"level":"info","ts":"2026-04-22T00:29:22.798686Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 switched to configuration voters=(4132092677789986663)"}
{"level":"warn","ts":"2026-04-22T00:29:22.89989Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-04-22T00:29:22.906005Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-04-22T00:29:22.910293Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"}
{"level":"info","ts":"2026-04-22T00:29:22.912923Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"39582465ceaa2f67","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-04-22T00:29:22.913295Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"39582465ceaa2f67","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-04-22T00:29:22.913519Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"}
{"level":"info","ts":"2026-04-22T00:29:22.913703Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"}
{"level":"info","ts":"2026-04-22T00:29:22.913721Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"}
{"level":"info","ts":"2026-04-22T00:29:22.915022Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 switched to configuration voters=(4132092677789986663)"}
{"level":"info","ts":"2026-04-22T00:29:22.915693Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"87fd8ddedde3be45","local-member-id":"39582465ceaa2f67","added-peer-id":"39582465ceaa2f67","added-peer-peer-urls":["https://199.204.45.248:2380"]}
{"level":"info","ts":"2026-04-22T00:29:22.917591Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-04-22T00:29:22.917673Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.248:2380"}
{"level":"info","ts":"2026-04-22T00:29:22.917716Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.248:2380"}
{"level":"info","ts":"2026-04-22T00:29:22.917859Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"39582465ceaa2f67","initial-advertise-peer-urls":["https://199.204.45.248:2380"],"listen-peer-urls":["https://199.204.45.248:2380"],"advertise-client-urls":["https://199.204.45.248:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.248:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-04-22T00:29:22.917923Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-04-22T00:29:23.399407Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 is starting a new election at term 1"}
{"level":"info","ts":"2026-04-22T00:29:23.399472Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became pre-candidate at term 1"}
{"level":"info","ts":"2026-04-22T00:29:23.399495Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 received MsgPreVoteResp from 39582465ceaa2f67 at term 1"}
{"level":"info","ts":"2026-04-22T00:29:23.399515Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became candidate at term 2"}
{"level":"info","ts":"2026-04-22T00:29:23.399527Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 received MsgVoteResp from 39582465ceaa2f67 at term 2"}
{"level":"info","ts":"2026-04-22T00:29:23.399544Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became leader at term 2"}
{"level":"info","ts":"2026-04-22T00:29:23.399563Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 39582465ceaa2f67 elected leader 39582465ceaa2f67 at term 2"}
{"level":"info","ts":"2026-04-22T00:29:23.410167Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"39582465ceaa2f67","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.248:2379]}","request-path":"/0/members/39582465ceaa2f67/attributes","cluster-id":"87fd8ddedde3be45","publish-timeout":"7s"}
{"level":"info","ts":"2026-04-22T00:29:23.410233Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-22T00:29:23.410458Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-04-22T00:29:23.410443Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-04-22T00:29:23.41057Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-04-22T00:29:23.410649Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-04-22T00:29:23.41414Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-04-22T00:29:23.414147Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.248:2379"}
{"level":"info","ts":"2026-04-22T00:29:23.419303Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"87fd8ddedde3be45","local-member-id":"39582465ceaa2f67","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-22T00:29:23.419443Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-22T00:29:23.419475Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-22T00:29:42.679214Z","caller":"traceutil/trace.go:171","msg":"trace[1327704594] transaction","detail":"{read_only:false; response_revision:410; number_of_response:1; }","duration":"148.243747ms","start":"2026-04-22T00:29:42.530948Z","end":"2026-04-22T00:29:42.679192Z","steps":["trace[1327704594] 'process raft request'  (duration: 148.089663ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:29:54.069715Z","caller":"traceutil/trace.go:171","msg":"trace[2078097274] transaction","detail":"{read_only:false; response_revision:484; number_of_response:1; }","duration":"143.17802ms","start":"2026-04-22T00:29:53.926507Z","end":"2026-04-22T00:29:54.069685Z","steps":["trace[2078097274] 'process raft request'  (duration: 143.037296ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:29:54.069687Z","caller":"traceutil/trace.go:171","msg":"trace[837380702] transaction","detail":"{read_only:false; response_revision:483; number_of_response:1; }","duration":"144.091435ms","start":"2026-04-22T00:29:53.925553Z","end":"2026-04-22T00:29:54.069645Z","steps":["trace[837380702] 'process raft request'  (duration: 143.752575ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:29:54.07012Z","caller":"traceutil/trace.go:171","msg":"trace[687174240] transaction","detail":"{read_only:false; response_revision:485; number_of_response:1; }","duration":"140.584157ms","start":"2026-04-22T00:29:53.929526Z","end":"2026-04-22T00:29:54.070111Z","steps":["trace[687174240] 'process raft request'  (duration: 140.065762ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:29:54.070207Z","caller":"traceutil/trace.go:171","msg":"trace[1192580218] transaction","detail":"{read_only:false; response_revision:486; number_of_response:1; }","duration":"140.31963ms","start":"2026-04-22T00:29:53.929882Z","end":"2026-04-22T00:29:54.070202Z","steps":["trace[1192580218] 'process raft request'  (duration: 139.774334ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:29:54.070328Z","caller":"traceutil/trace.go:171","msg":"trace[815620025] transaction","detail":"{read_only:false; response_revision:487; number_of_response:1; }","duration":"135.352299ms","start":"2026-04-22T00:29:53.93496Z","end":"2026-04-22T00:29:54.070312Z","steps":["trace[815620025] 'process raft request'  (duration: 134.813183ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:29:54.070354Z","caller":"traceutil/trace.go:171","msg":"trace[45241321] transaction","detail":"{read_only:false; response_revision:488; number_of_response:1; }","duration":"132.319335ms","start":"2026-04-22T00:29:53.937998Z","end":"2026-04-22T00:29:54.070317Z","steps":["trace[45241321] 'process raft request'  (duration: 131.900332ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:29:54.24999Z","caller":"traceutil/trace.go:171","msg":"trace[377813152] transaction","detail":"{read_only:false; response_revision:489; number_of_response:1; }","duration":"301.651432ms","start":"2026-04-22T00:29:53.948285Z","end":"2026-04-22T00:29:54.249936Z","steps":["trace[377813152] 'process raft request'  (duration: 301.288441ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:29:54.250101Z","caller":"traceutil/trace.go:171","msg":"trace[1726220237] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"292.081632ms","start":"2026-04-22T00:29:53.958006Z","end":"2026-04-22T00:29:54.250087Z","steps":["trace[1726220237] 'process raft request'  (duration: 291.925747ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:29:54.250142Z","caller":"traceutil/trace.go:171","msg":"trace[1973190911] transaction","detail":"{read_only:false; response_revision:490; number_of_response:1; }","duration":"297.34354ms","start":"2026-04-22T00:29:53.952738Z","end":"2026-04-22T00:29:54.250082Z","steps":["trace[1973190911] 'process raft request'  (duration: 297.133384ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:29:54.250225Z","caller":"traceutil/trace.go:171","msg":"trace[438874618] transaction","detail":"{read_only:false; number_of_response:1; response_revision:491; }","duration":"291.993008ms","start":"2026-04-22T00:29:53.958184Z","end":"2026-04-22T00:29:54.250177Z","steps":["trace[438874618] 'process raft request'  (duration: 291.801943ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:29:54.25032Z","caller":"traceutil/trace.go:171","msg":"trace[1894762574] transaction","detail":"{read_only:false; response_revision:492; number_of_response:1; }","duration":"292.03965ms","start":"2026-04-22T00:29:53.958233Z","end":"2026-04-22T00:29:54.250272Z","steps":["trace[1894762574] 'process raft request'  (duration: 291.790983ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:29:54.250012Z","caller":"traceutil/trace.go:171","msg":"trace[185336328] transaction","detail":"{read_only:false; number_of_response:0; response_revision:489; }","duration":"301.273611ms","start":"2026-04-22T00:29:53.948698Z","end":"2026-04-22T00:29:54.249972Z","steps":["trace[185336328] 'process raft request'  (duration: 301.137347ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:29:54.250902Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:29:53.948276Z","time spent":"301.837636ms","remote":"127.0.0.1:43816","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/grpcroutes.gateway.networking.k8s.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/grpcroutes.gateway.networking.k8s.io\" value_size:79271 >> failure:<>"}
{"level":"warn","ts":"2026-04-22T00:29:54.251309Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:29:53.948693Z","time spent":"301.767075ms","remote":"127.0.0.1:45062","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare:<target:MOD key:\"/registry/apiregistration.k8s.io/apiservices/v1beta1.gateway.networking.k8s.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiregistration.k8s.io/apiservices/v1beta1.gateway.networking.k8s.io\" value_size:909 >> failure:<>"}
{"level":"info","ts":"2026-04-22T00:29:54.251568Z","caller":"traceutil/trace.go:171","msg":"trace[1630085881] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"288.967483ms","start":"2026-04-22T00:29:53.962578Z","end":"2026-04-22T00:29:54.251545Z","steps":["trace[1630085881] 'process raft request'  (duration: 287.540054ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:29:54.251699Z","caller":"traceutil/trace.go:171","msg":"trace[629670718] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"197.306177ms","start":"2026-04-22T00:29:54.054361Z","end":"2026-04-22T00:29:54.251667Z","steps":["trace[629670718] 'process raft request'  (duration: 197.131882ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:29:54.259913Z","caller":"traceutil/trace.go:171","msg":"trace[1000038731] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"155.446935ms","start":"2026-04-22T00:29:54.104453Z","end":"2026-04-22T00:29:54.2599Z","steps":["trace[1000038731] 'process raft request'  (duration: 155.233879ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:29:54.259905Z","caller":"traceutil/trace.go:171","msg":"trace[1639598822] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"171.688594ms","start":"2026-04-22T00:29:54.088186Z","end":"2026-04-22T00:29:54.259875Z","steps":["trace[1639598822] 'process raft request'  (duration: 171.378956ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:30:00.85088Z","caller":"traceutil/trace.go:171","msg":"trace[1198818947] linearizableReadLoop","detail":"{readStateIndex:604; appliedIndex:603; }","duration":"122.497846ms","start":"2026-04-22T00:30:00.728351Z","end":"2026-04-22T00:30:00.850849Z","steps":["trace[1198818947] 'read index received'  (duration: 111.64419ms)","trace[1198818947] 'applied index is now lower than readState.Index'  (duration: 10.852536ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T00:30:00.850893Z","caller":"traceutil/trace.go:171","msg":"trace[1313419305] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"152.954886ms","start":"2026-04-22T00:30:00.697911Z","end":"2026-04-22T00:30:00.850866Z","steps":["trace[1313419305] 'process raft request'  (duration: 142.12784ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:30:00.851097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.708542ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-dklqp\" ","response":"range_response_count:1 size:16965"}
{"level":"info","ts":"2026-04-22T00:30:00.851384Z","caller":"traceutil/trace.go:171","msg":"trace[1756874341] range","detail":"{range_begin:/registry/pods/kube-system/cilium-dklqp; range_end:; response_count:1; response_revision:581; }","duration":"123.060182ms","start":"2026-04-22T00:30:00.728303Z","end":"2026-04-22T00:30:00.851363Z","steps":["trace[1756874341] 'agreement among raft nodes before linearized reading'  (duration: 122.672131ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:30:01.357411Z","caller":"traceutil/trace.go:171","msg":"trace[1407209380] linearizableReadLoop","detail":"{readStateIndex:606; appliedIndex:605; }","duration":"463.851768ms","start":"2026-04-22T00:30:00.893531Z","end":"2026-04-22T00:30:01.357383Z","steps":["trace[1407209380] 'read index received'  (duration: 436.101985ms)","trace[1407209380] 'applied index is now lower than readState.Index'  (duration: 27.748572ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T00:30:01.357588Z","caller":"traceutil/trace.go:171","msg":"trace[2111166645] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"493.70705ms","start":"2026-04-22T00:30:00.863834Z","end":"2026-04-22T00:30:01.357541Z","steps":["trace[2111166645] 'process raft request'  (duration: 465.867355ms)","trace[2111166645] 'compare'  (duration: 27.560397ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-22T00:30:01.35758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"464.033353ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/envoy-gateway-system/\" range_end:\"/registry/limitranges/envoy-gateway-system0\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-22T00:30:01.357697Z","caller":"traceutil/trace.go:171","msg":"trace[1970455619] range","detail":"{range_begin:/registry/limitranges/envoy-gateway-system/; range_end:/registry/limitranges/envoy-gateway-system0; response_count:0; response_revision:583; }","duration":"464.197998ms","start":"2026-04-22T00:30:00.893479Z","end":"2026-04-22T00:30:01.357677Z","steps":["trace[1970455619] 'agreement among raft nodes before linearized reading'  (duration: 464.040353ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:30:01.357758Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:30:00.893458Z","time spent":"464.28412ms","remote":"127.0.0.1:43926","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":28,"request content":"key:\"/registry/limitranges/envoy-gateway-system/\" range_end:\"/registry/limitranges/envoy-gateway-system0\" "}
{"level":"warn","ts":"2026-04-22T00:30:01.357636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.858776ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-22T00:30:01.357846Z","caller":"traceutil/trace.go:171","msg":"trace[1842510183] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:583; }","duration":"258.092322ms","start":"2026-04-22T00:30:01.099722Z","end":"2026-04-22T00:30:01.357814Z","steps":["trace[1842510183] 'agreement among raft nodes before linearized reading'  (duration: 257.865476ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:30:01.357968Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:30:00.86382Z","time spent":"493.830783ms","remote":"127.0.0.1:43970","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/cilium-dklqp\" mod_revision:461 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-dklqp\" value_size:17085 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-dklqp\" > >"}
{"level":"warn","ts":"2026-04-22T00:30:01.358058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.832149ms","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-04-22T00:30:01.358114Z","caller":"traceutil/trace.go:171","msg":"trace[1244771307] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:583; }","duration":"120.932801ms","start":"2026-04-22T00:30:01.237165Z","end":"2026-04-22T00:30:01.358098Z","steps":["trace[1244771307] 'agreement among raft nodes before linearized reading'  (duration: 120.781117ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:30:16.932388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.423862ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-gxwhf\" ","response":"range_response_count:1 size:3965"}
{"level":"info","ts":"2026-04-22T00:30:16.932508Z","caller":"traceutil/trace.go:171","msg":"trace[291273631] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-gxwhf; range_end:; response_count:1; response_revision:742; }","duration":"102.561205ms","start":"2026-04-22T00:30:16.829921Z","end":"2026-04-22T00:30:16.932483Z","steps":["trace[291273631] 'range keys from in-memory index tree'  (duration: 102.177004ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:30:45.263216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.875092ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"warn","ts":"2026-04-22T00:30:45.262991Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.592947ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-22T00:30:45.263357Z","caller":"traceutil/trace.go:171","msg":"trace[1426380293] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1134; }","duration":"164.005548ms","start":"2026-04-22T00:30:45.09933Z","end":"2026-04-22T00:30:45.263336Z","steps":["trace[1426380293] 'range keys from in-memory index tree'  (duration: 163.525514ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:30:45.263777Z","caller":"traceutil/trace.go:171","msg":"trace[85342794] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1134; }","duration":"148.053197ms","start":"2026-04-22T00:30:45.11527Z","end":"2026-04-22T00:30:45.263323Z","steps":["trace[85342794] 'range keys from in-memory index tree'  (duration: 147.683967ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:31:00.98709Z","caller":"traceutil/trace.go:171","msg":"trace[1141731448] transaction","detail":"{read_only:false; response_revision:1273; number_of_response:1; }","duration":"106.895305ms","start":"2026-04-22T00:31:00.880165Z","end":"2026-04-22T00:31:00.98706Z","steps":["trace[1141731448] 'process raft request'  (duration: 106.715019ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:31:21.773642Z","caller":"traceutil/trace.go:171","msg":"trace[1269695092] transaction","detail":"{read_only:false; response_revision:1650; number_of_response:1; }","duration":"124.289584ms","start":"2026-04-22T00:31:21.649327Z","end":"2026-04-22T00:31:21.773616Z","steps":["trace[1269695092] 'process raft request'  (duration: 124.120179ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:31:32.261372Z","caller":"traceutil/trace.go:171","msg":"trace[252675561] transaction","detail":"{read_only:false; response_revision:1801; number_of_response:1; }","duration":"237.843798ms","start":"2026-04-22T00:31:32.023499Z","end":"2026-04-22T00:31:32.261342Z","steps":["trace[252675561] 'process raft request'  (duration: 237.705685ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:31:32.352927Z","caller":"traceutil/trace.go:171","msg":"trace[51542305] linearizableReadLoop","detail":"{readStateIndex:1874; appliedIndex:1872; }","duration":"250.11379ms","start":"2026-04-22T00:31:32.102781Z","end":"2026-04-22T00:31:32.352895Z","steps":["trace[51542305] 'read index received'  (duration: 158.535395ms)","trace[51542305] 'applied index is now lower than readState.Index'  (duration: 91.577315ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T00:31:32.35307Z","caller":"traceutil/trace.go:171","msg":"trace[2137952994] transaction","detail":"{read_only:false; response_revision:1802; number_of_response:1; }","duration":"128.917056ms","start":"2026-04-22T00:31:32.224111Z","end":"2026-04-22T00:31:32.353029Z","steps":["trace[2137952994] 'process raft request'  (duration: 128.634028ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:31:32.353188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.388828ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-22T00:31:32.353252Z","caller":"traceutil/trace.go:171","msg":"trace[236766665] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1802; }","duration":"250.517721ms","start":"2026-04-22T00:31:32.102721Z","end":"2026-04-22T00:31:32.353239Z","steps":["trace[236766665] 'agreement among raft nodes before linearized reading'  (duration: 250.378257ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:31:32.353302Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.138108ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"}
{"level":"warn","ts":"2026-04-22T00:31:32.353322Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.258539ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-22T00:31:32.353423Z","caller":"traceutil/trace.go:171","msg":"trace[1326336675] range","detail":"{range_begin:/registry/ingress/; range_end:/registry/ingress0; response_count:0; response_revision:1802; }","duration":"141.492726ms","start":"2026-04-22T00:31:32.211917Z","end":"2026-04-22T00:31:32.35341Z","steps":["trace[1326336675] 'agreement among raft nodes before linearized reading'  (duration: 141.27605ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:31:32.353404Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.975922ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-22T00:31:32.353372Z","caller":"traceutil/trace.go:171","msg":"trace[794345112] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1802; }","duration":"207.257891ms","start":"2026-04-22T00:31:32.146096Z","end":"2026-04-22T00:31:32.353353Z","steps":["trace[794345112] 'agreement among raft nodes before linearized reading'  (duration: 207.062296ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:31:32.353471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.452906ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-ad1dbc6c-0708-45c9-9252-5861be136ad5\" ","response":"range_response_count:1 size:3627"}
{"level":"info","ts":"2026-04-22T00:31:32.353539Z","caller":"traceutil/trace.go:171","msg":"trace[884539661] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:1802; }","duration":"110.138697ms","start":"2026-04-22T00:31:32.243371Z","end":"2026-04-22T00:31:32.353509Z","steps":["trace[884539661] 'agreement among raft nodes before linearized reading'  (duration: 109.90392ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:31:32.353571Z","caller":"traceutil/trace.go:171","msg":"trace[1743478125] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-ad1dbc6c-0708-45c9-9252-5861be136ad5; range_end:; response_count:1; response_revision:1802; }","duration":"132.597001ms","start":"2026-04-22T00:31:32.220951Z","end":"2026-04-22T00:31:32.353548Z","steps":["trace[1743478125] 'agreement among raft nodes before linearized reading'  (duration: 132.242311ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:31:32.933314Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3415872232754379900,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-04-22T00:31:33.037056Z","caller":"traceutil/trace.go:171","msg":"trace[967832584] linearizableReadLoop","detail":"{readStateIndex:1877; appliedIndex:1876; }","duration":"604.243942ms","start":"2026-04-22T00:31:32.432782Z","end":"2026-04-22T00:31:33.037026Z","steps":["trace[967832584] 'read index received'  (duration: 524.97729ms)","trace[967832584] 'applied index is now lower than readState.Index'  (duration: 79.265462ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T00:31:33.037079Z","caller":"traceutil/trace.go:171","msg":"trace[1010701314] transaction","detail":"{read_only:false; response_revision:1804; number_of_response:1; }","duration":"617.08198ms","start":"2026-04-22T00:31:32.419963Z","end":"2026-04-22T00:31:33.037045Z","steps":["trace[1010701314] 'process raft request'  (duration: 537.803558ms)","trace[1010701314] 'compare'  (duration: 78.83788ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-22T00:31:33.037269Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:31:32.419931Z","time spent":"617.223994ms","remote":"127.0.0.1:43970","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10964,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/openstack/percona-xtradb-haproxy-0\" mod_revision:1751 > success:<request_put:<key:\"/registry/pods/openstack/percona-xtradb-haproxy-0\" value_size:10907 >> failure:<request_range:<key:\"/registry/pods/openstack/percona-xtradb-haproxy-0\" > >"}
{"level":"warn","ts":"2026-04-22T00:31:33.037322Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"604.522089ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-04-22T00:31:33.037387Z","caller":"traceutil/trace.go:171","msg":"trace[196415026] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:1804; }","duration":"604.643203ms","start":"2026-04-22T00:31:32.432733Z","end":"2026-04-22T00:31:33.037376Z","steps":["trace[196415026] 'agreement among raft nodes before linearized reading'  (duration: 604.430197ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:31:33.037419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"565.195452ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-22T00:31:33.037493Z","caller":"traceutil/trace.go:171","msg":"trace[1377488380] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:1804; }","duration":"565.305146ms","start":"2026-04-22T00:31:32.472169Z","end":"2026-04-22T00:31:33.037474Z","steps":["trace[1377488380] 'agreement among raft nodes before linearized reading'  (duration: 565.201573ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:31:33.037539Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:31:32.472152Z","time spent":"565.376327ms","remote":"127.0.0.1:49918","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true "}
{"level":"warn","ts":"2026-04-22T00:31:33.037447Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:31:32.432713Z","time spent":"604.697105ms","remote":"127.0.0.1:44132","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":90,"response size":30,"request content":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true "}
{"level":"warn","ts":"2026-04-22T00:31:33.037755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.523818ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"warn","ts":"2026-04-22T00:31:33.037829Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"476.637525ms","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-04-22T00:31:33.037835Z","caller":"traceutil/trace.go:171","msg":"trace[408118740] range","detail":"{range_begin:/registry/networkpolicies/; range_end:/registry/networkpolicies0; response_count:0; response_revision:1804; }","duration":"194.61115ms","start":"2026-04-22T00:31:32.843204Z","end":"2026-04-22T00:31:33.037815Z","steps":["trace[408118740] 'agreement among raft nodes before linearized reading'  (duration: 194.471476ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:31:33.037819Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.25408ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-ad1dbc6c-0708-45c9-9252-5861be136ad5\" ","response":"range_response_count:1 size:3747"}
{"level":"info","ts":"2026-04-22T00:31:33.037876Z","caller":"traceutil/trace.go:171","msg":"trace[1338041821] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1804; }","duration":"476.713328ms","start":"2026-04-22T00:31:32.561151Z","end":"2026-04-22T00:31:33.037864Z","steps":["trace[1338041821] 'agreement among raft nodes before linearized reading'  (duration: 476.574714ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:31:33.037906Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:31:32.561129Z","time spent":"476.770099ms","remote":"127.0.0.1:56080","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "}
{"level":"info","ts":"2026-04-22T00:31:33.037929Z","caller":"traceutil/trace.go:171","msg":"trace[1239661629] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-ad1dbc6c-0708-45c9-9252-5861be136ad5; range_end:; response_count:1; response_revision:1804; }","duration":"276.381013ms","start":"2026-04-22T00:31:32.761507Z","end":"2026-04-22T00:31:33.037888Z","steps":["trace[1239661629] 'agreement among raft nodes before linearized reading'  (duration: 276.161687ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:31:49.372916Z","caller":"traceutil/trace.go:171","msg":"trace[2053181306] transaction","detail":"{read_only:false; response_revision:1942; number_of_response:1; }","duration":"129.562055ms","start":"2026-04-22T00:31:49.243301Z","end":"2026-04-22T00:31:49.372863Z","steps":["trace[2053181306] 'process raft request'  (duration: 129.250756ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:31:49.877076Z","caller":"traceutil/trace.go:171","msg":"trace[947224593] linearizableReadLoop","detail":"{readStateIndex:2020; appliedIndex:2019; }","duration":"460.929844ms","start":"2026-04-22T00:31:49.416118Z","end":"2026-04-22T00:31:49.877048Z","steps":["trace[947224593] 'read index received'  (duration: 459.290087ms)","trace[947224593] 'applied index is now lower than readState.Index'  (duration: 1.638327ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T00:31:49.87713Z","caller":"traceutil/trace.go:171","msg":"trace[2118234637] transaction","detail":"{read_only:false; response_revision:1943; number_of_response:1; }","duration":"498.685146ms","start":"2026-04-22T00:31:49.378418Z","end":"2026-04-22T00:31:49.877103Z","steps":["trace[2118234637] 'process raft request'  (duration: 497.013628ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:31:49.877273Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:31:49.37839Z","time spent":"498.80557ms","remote":"127.0.0.1:44058","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:1932 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"warn","ts":"2026-04-22T00:31:49.87735Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"461.203822ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-04-22T00:31:49.877468Z","caller":"traceutil/trace.go:171","msg":"trace[913625940] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:1943; }","duration":"461.394898ms","start":"2026-04-22T00:31:49.416045Z","end":"2026-04-22T00:31:49.87744Z","steps":["trace[913625940] 'agreement among raft nodes before linearized reading'  (duration: 461.098059ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:31:49.87753Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:31:49.416019Z","time spent":"461.48884ms","remote":"127.0.0.1:43816","response type":"/etcdserverpb.KV/Range","request count":0,"request size":120,"response count":54,"response size":30,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true "}
{"level":"warn","ts":"2026-04-22T00:31:49.878693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.721704ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"warn","ts":"2026-04-22T00:31:49.878715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.449203ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/acme.cert-manager.io/challenges/\" range_end:\"/registry/acme.cert-manager.io/challenges0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-22T00:31:49.878735Z","caller":"traceutil/trace.go:171","msg":"trace[1130286492] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1944; }","duration":"230.797316ms","start":"2026-04-22T00:31:49.647928Z","end":"2026-04-22T00:31:49.878726Z","steps":["trace[1130286492] 'agreement among raft nodes before linearized reading'  (duration: 230.668872ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:31:49.878757Z","caller":"traceutil/trace.go:171","msg":"trace[843599579] range","detail":"{range_begin:/registry/acme.cert-manager.io/challenges/; range_end:/registry/acme.cert-manager.io/challenges0; response_count:0; response_revision:1944; }","duration":"119.533965ms","start":"2026-04-22T00:31:49.75921Z","end":"2026-04-22T00:31:49.878744Z","steps":["trace[843599579] 'agreement among raft nodes before linearized reading'  (duration: 119.417302ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:31:49.878713Z","caller":"traceutil/trace.go:171","msg":"trace[555211994] transaction","detail":"{read_only:false; response_revision:1944; number_of_response:1; }","duration":"308.457013ms","start":"2026-04-22T00:31:49.570225Z","end":"2026-04-22T00:31:49.878682Z","steps":["trace[555211994] 'process raft request'  (duration: 308.264567ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:31:49.878874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.149042ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"}
{"level":"info","ts":"2026-04-22T00:31:49.879052Z","caller":"traceutil/trace.go:171","msg":"trace[646658130] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:1944; }","duration":"211.363499ms","start":"2026-04-22T00:31:49.667676Z","end":"2026-04-22T00:31:49.87904Z","steps":["trace[646658130] 'agreement among raft nodes before linearized reading'  (duration: 211.05578ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:31:49.879143Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:31:49.570202Z","time spent":"308.729971ms","remote":"127.0.0.1:44058","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:1933 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:477 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"info","ts":"2026-04-22T00:32:27.724038Z","caller":"traceutil/trace.go:171","msg":"trace[1877658687] transaction","detail":"{read_only:false; response_revision:2151; number_of_response:1; }","duration":"164.464369ms","start":"2026-04-22T00:32:27.559544Z","end":"2026-04-22T00:32:27.724008Z","steps":["trace[1877658687] 'process raft request'  (duration: 164.243223ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:33:40.162109Z","caller":"traceutil/trace.go:171","msg":"trace[1657597606] transaction","detail":"{read_only:false; response_revision:2740; number_of_response:1; }","duration":"147.53771ms","start":"2026-04-22T00:33:40.014521Z","end":"2026-04-22T00:33:40.162059Z","steps":["trace[1657597606] 'process raft request'  (duration: 147.22749ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:36:22.0248Z","caller":"traceutil/trace.go:171","msg":"trace[1014547739] linearizableReadLoop","detail":"{readStateIndex:3941; appliedIndex:3940; }","duration":"213.165986ms","start":"2026-04-22T00:36:21.811607Z","end":"2026-04-22T00:36:22.024773Z","steps":["trace[1014547739] 'read index received'  (duration: 126.846768ms)","trace[1014547739] 'applied index is now lower than readState.Index'  (duration: 86.317918ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T00:36:22.024919Z","caller":"traceutil/trace.go:171","msg":"trace[402199026] transaction","detail":"{read_only:false; response_revision:3794; number_of_response:1; }","duration":"219.71702ms","start":"2026-04-22T00:36:21.805187Z","end":"2026-04-22T00:36:22.024904Z","steps":["trace[402199026] 'process raft request'  (duration: 133.247957ms)","trace[402199026] 'compare'  (duration: 86.159664ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-22T00:36:22.025243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.531396ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-22T00:36:22.025333Z","caller":"traceutil/trace.go:171","msg":"trace[1982917260] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:3794; }","duration":"213.734862ms","start":"2026-04-22T00:36:21.811579Z","end":"2026-04-22T00:36:22.025314Z","steps":["trace[1982917260] 'agreement among raft nodes before linearized reading'  (duration: 213.30223ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:37:48.598311Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.803306ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-bdd37856-3464-4b46-8813-c7ab7454ca39\" ","response":"range_response_count:1 size:3601"}
{"level":"info","ts":"2026-04-22T00:37:48.598452Z","caller":"traceutil/trace.go:171","msg":"trace[594252349] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-bdd37856-3464-4b46-8813-c7ab7454ca39; range_end:; response_count:1; response_revision:4987; }","duration":"162.980991ms","start":"2026-04-22T00:37:48.435446Z","end":"2026-04-22T00:37:48.598427Z","steps":["trace[594252349] 'range keys from in-memory index tree'  (duration: 162.647041ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:37:48.59869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.228045ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:25 size:778249"}
{"level":"info","ts":"2026-04-22T00:37:48.598784Z","caller":"traceutil/trace.go:171","msg":"trace[1305220451] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:25; response_revision:4987; }","duration":"289.336448ms","start":"2026-04-22T00:37:48.309428Z","end":"2026-04-22T00:37:48.598765Z","steps":["trace[1305220451] 'range keys from in-memory index tree'  (duration: 288.746261ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:37:48.671761Z","caller":"traceutil/trace.go:171","msg":"trace[241815792] transaction","detail":"{read_only:false; response_revision:4988; number_of_response:1; }","duration":"203.190295ms","start":"2026-04-22T00:37:48.468523Z","end":"2026-04-22T00:37:48.671714Z","steps":["trace[241815792] 'process raft request'  (duration: 202.899277ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:37:48.671921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.523043ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/storage-loki-0.18a886ccdc055405\" ","response":"range_response_count:1 size:943"}
{"level":"info","ts":"2026-04-22T00:37:48.672046Z","caller":"traceutil/trace.go:171","msg":"trace[1542472109] range","detail":"{range_begin:/registry/events/monitoring/storage-loki-0.18a886ccdc055405; range_end:; response_count:1; response_revision:4988; }","duration":"171.701708ms","start":"2026-04-22T00:37:48.500326Z","end":"2026-04-22T00:37:48.672028Z","steps":["trace[1542472109] 'agreement among raft nodes before linearized reading'  (duration: 171.426931ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:37:48.67167Z","caller":"traceutil/trace.go:171","msg":"trace[767493377] linearizableReadLoop","detail":"{readStateIndex:5179; appliedIndex:5178; }","duration":"171.269666ms","start":"2026-04-22T00:37:48.500372Z","end":"2026-04-22T00:37:48.671642Z","steps":["trace[767493377] 'read index received'  (duration: 171.072611ms)","trace[767493377] 'applied index is now lower than readState.Index'  (duration: 196.105µs)"],"step_count":2}
{"level":"warn","ts":"2026-04-22T00:37:48.673367Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.638162ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/monitoring/kube-prometheus-stack-prometheus-node-exporter-m9crg-tls\" ","response":"range_response_count:1 size:2184"}
{"level":"info","ts":"2026-04-22T00:37:48.673433Z","caller":"traceutil/trace.go:171","msg":"trace[402512278] range","detail":"{range_begin:/registry/cert-manager.io/certificates/monitoring/kube-prometheus-stack-prometheus-node-exporter-m9crg-tls; range_end:; response_count:1; response_revision:4988; }","duration":"129.736774ms","start":"2026-04-22T00:37:48.543677Z","end":"2026-04-22T00:37:48.673413Z","steps":["trace[402512278] 'agreement among raft nodes before linearized reading'  (duration: 129.045684ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:37:58.166744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.988956ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5651"}
{"level":"info","ts":"2026-04-22T00:37:58.16686Z","caller":"traceutil/trace.go:171","msg":"trace[1966621506] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:5191; }","duration":"140.1405ms","start":"2026-04-22T00:37:58.026695Z","end":"2026-04-22T00:37:58.166836Z","steps":["trace[1966621506] 'range keys from in-memory index tree'  (duration: 139.79614ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:38:06.087182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.874361ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"}
{"level":"info","ts":"2026-04-22T00:38:06.087284Z","caller":"traceutil/trace.go:171","msg":"trace[1552842556] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5346; }","duration":"161.015735ms","start":"2026-04-22T00:38:05.926248Z","end":"2026-04-22T00:38:06.087263Z","steps":["trace[1552842556] 'range keys from in-memory index tree'  (duration: 160.695186ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:38:06.087372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.885647ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"}
{"level":"warn","ts":"2026-04-22T00:38:06.087413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.600066ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-04-22T00:38:06.087532Z","caller":"traceutil/trace.go:171","msg":"trace[1933071488] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5346; }","duration":"178.736099ms","start":"2026-04-22T00:38:05.908775Z","end":"2026-04-22T00:38:06.087511Z","steps":["trace[1933071488] 'range keys from in-memory index tree'  (duration: 178.348338ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:38:06.087518Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.485043ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-04-22T00:38:06.087634Z","caller":"traceutil/trace.go:171","msg":"trace[1310708040] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5346; }","duration":"157.640378ms","start":"2026-04-22T00:38:05.929968Z","end":"2026-04-22T00:38:06.087609Z","steps":["trace[1310708040] 'range keys from in-memory index tree'  (duration: 157.323579ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:38:06.08746Z","caller":"traceutil/trace.go:171","msg":"trace[26037828] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5346; }","duration":"163.024852ms","start":"2026-04-22T00:38:05.924411Z","end":"2026-04-22T00:38:06.087436Z","steps":["trace[26037828] 'range keys from in-memory index tree'  (duration: 162.691132ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:38:06.087372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.59723ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"}
{"level":"info","ts":"2026-04-22T00:38:06.087952Z","caller":"traceutil/trace.go:171","msg":"trace[14150259] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5346; }","duration":"182.199238ms","start":"2026-04-22T00:38:05.905729Z","end":"2026-04-22T00:38:06.087928Z","steps":["trace[14150259] 'range keys from in-memory index tree'  (duration: 181.492398ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:38:06.087372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.959938ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-2499a157-d805-4c0c-8076-25927695abd3\" ","response":"range_response_count:1 size:3646"}
{"level":"info","ts":"2026-04-22T00:38:06.088244Z","caller":"traceutil/trace.go:171","msg":"trace[53611756] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-2499a157-d805-4c0c-8076-25927695abd3; range_end:; response_count:1; response_revision:5346; }","duration":"158.822482ms","start":"2026-04-22T00:38:05.929344Z","end":"2026-04-22T00:38:06.088166Z","steps":["trace[53611756] 'range keys from in-memory index tree'  (duration: 157.781653ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:38:08.526176Z","caller":"traceutil/trace.go:171","msg":"trace[778605892] transaction","detail":"{read_only:false; response_revision:5380; number_of_response:1; }","duration":"150.889486ms","start":"2026-04-22T00:38:08.375252Z","end":"2026-04-22T00:38:08.526141Z","steps":["trace[778605892] 'process raft request'  (duration: 150.586987ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:38:17.283124Z","caller":"traceutil/trace.go:171","msg":"trace[1287272063] transaction","detail":"{read_only:false; response_revision:5522; number_of_response:1; }","duration":"145.093861ms","start":"2026-04-22T00:38:17.137993Z","end":"2026-04-22T00:38:17.283086Z","steps":["trace[1287272063] 'process raft request'  (duration: 144.774572ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:38:17.352726Z","caller":"traceutil/trace.go:171","msg":"trace[859978116] transaction","detail":"{read_only:false; response_revision:5523; number_of_response:1; }","duration":"118.581276ms","start":"2026-04-22T00:38:17.234118Z","end":"2026-04-22T00:38:17.3527Z","steps":["trace[859978116] 'process raft request'  (duration: 54.016927ms)","trace[859978116] 'compare'  (duration: 64.411214ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T00:38:17.711104Z","caller":"traceutil/trace.go:171","msg":"trace[400768302] transaction","detail":"{read_only:false; response_revision:5535; number_of_response:1; }","duration":"127.394346ms","start":"2026-04-22T00:38:17.583675Z","end":"2026-04-22T00:38:17.711069Z","steps":["trace[400768302] 'process raft request'  (duration: 83.213808ms)","trace[400768302] 'compare'  (duration: 44.060795ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T00:39:23.669811Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2978}
{"level":"info","ts":"2026-04-22T00:39:23.74247Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2978,"took":"71.179688ms","hash":2453598321,"current-db-size-bytes":58204160,"current-db-size":"58 MB","current-db-size-in-use-bytes":33591296,"current-db-size-in-use":"34 MB"}
{"level":"info","ts":"2026-04-22T00:39:23.742531Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2453598321,"revision":2978,"compact-revision":-1}
{"level":"info","ts":"2026-04-22T00:44:11.166023Z","caller":"traceutil/trace.go:171","msg":"trace[1093556638] transaction","detail":"{read_only:false; response_revision:8195; number_of_response:1; }","duration":"303.253471ms","start":"2026-04-22T00:44:10.862743Z","end":"2026-04-22T00:44:11.165997Z","steps":["trace[1093556638] 'process raft request'  (duration: 303.086036ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:44:11.166191Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:44:10.862723Z","time spent":"303.384615ms","remote":"127.0.0.1:44058","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:8183 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:477 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"info","ts":"2026-04-22T00:44:11.312Z","caller":"traceutil/trace.go:171","msg":"trace[1300573188] transaction","detail":"{read_only:false; response_revision:8196; number_of_response:1; }","duration":"210.934797ms","start":"2026-04-22T00:44:11.101021Z","end":"2026-04-22T00:44:11.311956Z","steps":["trace[1300573188] 'process raft request'  (duration: 196.564883ms)","trace[1300573188] 'compare'  (duration: 14.2407ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-22T00:44:23.041109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.594073ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-c4tqx\" ","response":"range_response_count:1 size:6530"}
{"level":"info","ts":"2026-04-22T00:44:23.041177Z","caller":"traceutil/trace.go:171","msg":"trace[35540991] range","detail":"{range_begin:/registry/pods/openstack/keepalived-c4tqx; range_end:; response_count:1; response_revision:8257; }","duration":"149.713976ms","start":"2026-04-22T00:44:22.891449Z","end":"2026-04-22T00:44:23.041163Z","steps":["trace[35540991] 'range keys from in-memory index tree'  (duration: 149.397577ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:44:23.846215Z","caller":"traceutil/trace.go:171","msg":"trace[1815379556] transaction","detail":"{read_only:false; response_revision:8260; number_of_response:1; }","duration":"174.057571ms","start":"2026-04-22T00:44:23.672132Z","end":"2026-04-22T00:44:23.84619Z","steps":["trace[1815379556] 'process raft request'  (duration: 173.848975ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:44:23.889452Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6070}
{"level":"info","ts":"2026-04-22T00:44:24.230452Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6070,"took":"338.887193ms","hash":2531886051,"current-db-size-bytes":58204160,"current-db-size":"58 MB","current-db-size-in-use-bytes":22708224,"current-db-size-in-use":"23 MB"}
{"level":"info","ts":"2026-04-22T00:44:24.230527Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2531886051,"revision":6070,"compact-revision":2978}
{"level":"info","ts":"2026-04-22T00:44:24.359883Z","caller":"traceutil/trace.go:171","msg":"trace[1954759042] transaction","detail":"{read_only:false; response_revision:8266; number_of_response:1; }","duration":"188.466176ms","start":"2026-04-22T00:44:24.171347Z","end":"2026-04-22T00:44:24.359813Z","steps":["trace[1954759042] 'process raft request'  (duration: 188.282321ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:44:52.387954Z","caller":"traceutil/trace.go:171","msg":"trace[43333267] transaction","detail":"{read_only:false; response_revision:8464; number_of_response:1; }","duration":"440.898228ms","start":"2026-04-22T00:44:51.947035Z","end":"2026-04-22T00:44:52.387933Z","steps":["trace[43333267] 'process raft request'  (duration: 440.501997ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:44:52.388089Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:44:51.947024Z","time spent":"441.000091ms","remote":"127.0.0.1:43860","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1120,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/events/openstack/barbican-api-6845ffd9f8-8ps67.18a887240f3c1e8f\" mod_revision:8362 > success:<request_put:<key:\"/registry/events/openstack/barbican-api-6845ffd9f8-8ps67.18a887240f3c1e8f\" value_size:1029 lease:3415872232754395538 >> failure:<request_range:<key:\"/registry/events/openstack/barbican-api-6845ffd9f8-8ps67.18a887240f3c1e8f\" > >"}
{"level":"info","ts":"2026-04-22T00:44:52.392054Z","caller":"traceutil/trace.go:171","msg":"trace[1842127460] linearizableReadLoop","detail":"{readStateIndex:8764; appliedIndex:8762; }","duration":"386.769267ms","start":"2026-04-22T00:44:52.005268Z","end":"2026-04-22T00:44:52.392037Z","steps":["trace[1842127460] 'read index received'  (duration: 382.499667ms)","trace[1842127460] 'applied index is now lower than readState.Index'  (duration: 4.26888ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-22T00:44:52.392211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"386.925252ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:19384"}
{"level":"info","ts":"2026-04-22T00:44:52.392235Z","caller":"traceutil/trace.go:171","msg":"trace[1213937466] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:8464; }","duration":"386.966583ms","start":"2026-04-22T00:44:52.005263Z","end":"2026-04-22T00:44:52.392229Z","steps":["trace[1213937466] 'agreement among raft nodes before linearized reading'  (duration: 386.85439ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:44:52.392253Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:44:52.005223Z","time spent":"387.026255ms","remote":"127.0.0.1:43958","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":19407,"request content":"key:\"/registry/minions/instance\" "}
{"level":"warn","ts":"2026-04-22T00:44:52.392271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.376924ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"info","ts":"2026-04-22T00:44:52.392335Z","caller":"traceutil/trace.go:171","msg":"trace[1813497199] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8464; }","duration":"224.481807ms","start":"2026-04-22T00:44:52.167839Z","end":"2026-04-22T00:44:52.392321Z","steps":["trace[1813497199] 'agreement among raft nodes before linearized reading'  (duration: 224.318053ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:44:52.392536Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.935015ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-04-22T00:44:52.39256Z","caller":"traceutil/trace.go:171","msg":"trace[731101587] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8464; }","duration":"153.985007ms","start":"2026-04-22T00:44:52.238569Z","end":"2026-04-22T00:44:52.392554Z","steps":["trace[731101587] 'agreement among raft nodes before linearized reading'  (duration: 153.925715ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:44:52.392631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.145515ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"info","ts":"2026-04-22T00:44:52.392654Z","caller":"traceutil/trace.go:171","msg":"trace[1634032876] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8464; }","duration":"158.209466ms","start":"2026-04-22T00:44:52.234439Z","end":"2026-04-22T00:44:52.392648Z","steps":["trace[1634032876] 'agreement among raft nodes before linearized reading'  (duration: 158.153655ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:44:52.39275Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.790565ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-04-22T00:44:52.392785Z","caller":"traceutil/trace.go:171","msg":"trace[1993006362] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:8464; }","duration":"193.863467ms","start":"2026-04-22T00:44:52.198914Z","end":"2026-04-22T00:44:52.392777Z","steps":["trace[1993006362] 'agreement among raft nodes before linearized reading'  (duration: 193.797555ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:44:55.75452Z","caller":"traceutil/trace.go:171","msg":"trace[1252879202] transaction","detail":"{read_only:false; response_revision:8485; number_of_response:1; }","duration":"269.004188ms","start":"2026-04-22T00:44:55.485473Z","end":"2026-04-22T00:44:55.754477Z","steps":["trace[1252879202] 'process raft request'  (duration: 268.739441ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:45:06.068257Z","caller":"traceutil/trace.go:171","msg":"trace[356239472] linearizableReadLoop","detail":"{readStateIndex:8889; appliedIndex:8888; }","duration":"103.370785ms","start":"2026-04-22T00:45:05.96486Z","end":"2026-04-22T00:45:06.06823Z","steps":["trace[356239472] 'read index received'  (duration: 103.103477ms)","trace[356239472] 'applied index is now lower than readState.Index'  (duration: 266.358µs)"],"step_count":2}
{"level":"info","ts":"2026-04-22T00:45:06.068361Z","caller":"traceutil/trace.go:171","msg":"trace[92725450] transaction","detail":"{read_only:false; response_revision:8584; number_of_response:1; }","duration":"263.514044ms","start":"2026-04-22T00:45:05.8048Z","end":"2026-04-22T00:45:06.068314Z","steps":["trace[92725450] 'process raft request'  (duration: 263.257416ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:45:06.068451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.56439ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-04-22T00:45:06.068518Z","caller":"traceutil/trace.go:171","msg":"trace[552852654] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:8584; }","duration":"103.682043ms","start":"2026-04-22T00:45:05.96482Z","end":"2026-04-22T00:45:06.068502Z","steps":["trace[552852654] 'agreement among raft nodes before linearized reading'  (duration: 103.515049ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:45:50.272489Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3415872232754398407,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-04-22T00:45:50.773216Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3415872232754398407,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-04-22T00:45:51.553818Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3415872232754398407,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-04-22T00:45:52.017812Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.295526s","expected-duration":"1s"}
{"level":"info","ts":"2026-04-22T00:45:52.018238Z","caller":"traceutil/trace.go:171","msg":"trace[1023265962] transaction","detail":"{read_only:false; response_revision:8980; number_of_response:1; }","duration":"2.296005513s","start":"2026-04-22T00:45:49.72221Z","end":"2026-04-22T00:45:52.018215Z","steps":["trace[1023265962] 'process raft request'  (duration: 2.295862069s)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:45:52.018407Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:45:49.722186Z","time spent":"2.296147547s","remote":"127.0.0.1:44058","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:8956 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:477 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-04-22T00:45:52.099019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000188973s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"}
{"level":"info","ts":"2026-04-22T00:45:52.099103Z","caller":"traceutil/trace.go:171","msg":"trace[641053244] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000325477s","start":"2026-04-22T00:45:50.098757Z","end":"2026-04-22T00:45:52.099083Z","steps":["trace[641053244] 'agreement among raft nodes before linearized reading'  (duration: 2.000224214s)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:45:52.09914Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:45:50.098734Z","time spent":"2.000398039s","remote":"127.0.0.1:43770","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
2026/04/22 00:45:52 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"info","ts":"2026-04-22T00:45:52.132508Z","caller":"traceutil/trace.go:171","msg":"trace[660294063] transaction","detail":"{read_only:false; response_revision:8981; number_of_response:1; }","duration":"2.174646833s","start":"2026-04-22T00:45:49.957842Z","end":"2026-04-22T00:45:52.132488Z","steps":["trace[660294063] 'process raft request'  (duration: 2.15923182s)","trace[660294063] 'compare'  (duration: 15.29138ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-22T00:45:52.132624Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:45:49.957814Z","time spent":"2.174750777s","remote":"127.0.0.1:44058","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:8966 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:459 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"info","ts":"2026-04-22T00:45:52.132738Z","caller":"traceutil/trace.go:171","msg":"trace[957379685] linearizableReadLoop","detail":"{readStateIndex:9298; appliedIndex:9296; }","duration":"2.360298501s","start":"2026-04-22T00:45:49.772412Z","end":"2026-04-22T00:45:52.13271Z","steps":["trace[957379685] 'read index received'  (duration: 2.245725371s)","trace[957379685] 'applied index is now lower than readState.Index'  (duration: 114.57157ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T00:45:52.132786Z","caller":"traceutil/trace.go:171","msg":"trace[1155070355] transaction","detail":"{read_only:false; response_revision:8982; number_of_response:1; }","duration":"576.744223ms","start":"2026-04-22T00:45:51.556034Z","end":"2026-04-22T00:45:52.132778Z","steps":["trace[1155070355] 'process raft request'  (duration: 576.416864ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:45:52.132829Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:45:51.556013Z","time spent":"576.792804ms","remote":"127.0.0.1:44058","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:8978 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"warn","ts":"2026-04-22T00:45:52.132898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.360466415s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/issuers/\" range_end:\"/registry/cert-manager.io/issuers0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-04-22T00:45:52.133059Z","caller":"traceutil/trace.go:171","msg":"trace[1505496770] range","detail":"{range_begin:/registry/cert-manager.io/issuers/; range_end:/registry/cert-manager.io/issuers0; response_count:0; response_revision:8982; }","duration":"2.360665911s","start":"2026-04-22T00:45:49.772382Z","end":"2026-04-22T00:45:52.133048Z","steps":["trace[1505496770] 'agreement among raft nodes before linearized reading'  (duration: 2.360443965s)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:45:52.133117Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:45:49.77237Z","time spent":"2.360708962s","remote":"127.0.0.1:34328","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":2,"response size":30,"request content":"key:\"/registry/cert-manager.io/issuers/\" range_end:\"/registry/cert-manager.io/issuers0\" count_only:true "}
{"level":"info","ts":"2026-04-22T00:45:52.236014Z","caller":"traceutil/trace.go:171","msg":"trace[2061061076] linearizableReadLoop","detail":"{readStateIndex:9300; appliedIndex:9299; }","duration":"103.202919ms","start":"2026-04-22T00:45:52.132785Z","end":"2026-04-22T00:45:52.235988Z","steps":["trace[2061061076] 'read index received'  (duration: 15.009911ms)","trace[2061061076] 'applied index is now lower than readState.Index'  (duration: 88.191718ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-22T00:45:52.236243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.35061861s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"}
{"level":"info","ts":"2026-04-22T00:45:52.236276Z","caller":"traceutil/trace.go:171","msg":"trace[588434762] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8982; }","duration":"1.350691652s","start":"2026-04-22T00:45:50.885576Z","end":"2026-04-22T00:45:52.236268Z","steps":["trace[588434762] 'agreement among raft nodes before linearized reading'  (duration: 1.350537188s)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:45:52.236245Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.637396ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/barbican-api-6845ffd9f8-8ps67.18a887240f3c1e8f\" ","response":"range_response_count:1 size:1135"}
{"level":"warn","ts":"2026-04-22T00:45:52.236262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.517399546s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-04-22T00:45:52.236328Z","caller":"traceutil/trace.go:171","msg":"trace[1998113878] range","detail":"{range_begin:/registry/events/openstack/barbican-api-6845ffd9f8-8ps67.18a887240f3c1e8f; range_end:; response_count:1; response_revision:8982; }","duration":"290.792061ms","start":"2026-04-22T00:45:51.945512Z","end":"2026-04-22T00:45:52.236304Z","steps":["trace[1998113878] 'agreement among raft nodes before linearized reading'  (duration: 290.546844ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:45:52.236329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.492826596s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"}
{"level":"warn","ts":"2026-04-22T00:45:52.236329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.463735806s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-04-22T00:45:52.236382Z","caller":"traceutil/trace.go:171","msg":"trace[7643888] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8982; }","duration":"1.492907378s","start":"2026-04-22T00:45:50.743461Z","end":"2026-04-22T00:45:52.236369Z","steps":["trace[7643888] 'agreement among raft nodes before linearized reading'  (duration: 1.492738073s)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:45:52.236406Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"346.064794ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/nfd.k8s-sigs.io/nodefeatures/monitoring/instance\" ","response":"range_response_count:1 size:414544"}
{"level":"warn","ts":"2026-04-22T00:45:52.236244Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.349621992s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"}
{"level":"info","ts":"2026-04-22T00:45:52.236454Z","caller":"traceutil/trace.go:171","msg":"trace[13693954] range","detail":"{range_begin:/registry/nfd.k8s-sigs.io/nodefeatures/monitoring/instance; range_end:; response_count:1; response_revision:8982; }","duration":"346.139276ms","start":"2026-04-22T00:45:51.890291Z","end":"2026-04-22T00:45:52.23643Z","steps":["trace[13693954] 'agreement among raft nodes before linearized reading'  (duration: 345.814677ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:45:52.236462Z","caller":"traceutil/trace.go:171","msg":"trace[1001791900] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:8982; }","duration":"2.46389781s","start":"2026-04-22T00:45:49.772547Z","end":"2026-04-22T00:45:52.236445Z","steps":["trace[1001791900] 'agreement among raft nodes before linearized reading'  (duration: 2.463630903s)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:45:52.236484Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:45:51.890273Z","time spent":"346.202828ms","remote":"127.0.0.1:32796","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":414567,"request content":"key:\"/registry/nfd.k8s-sigs.io/nodefeatures/monitoring/instance\" "}
{"level":"warn","ts":"2026-04-22T00:45:52.236497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.488432572s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"}
{"level":"info","ts":"2026-04-22T00:45:52.236338Z","caller":"traceutil/trace.go:171","msg":"trace[1013811163] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8982; }","duration":"1.517527641s","start":"2026-04-22T00:45:50.718794Z","end":"2026-04-22T00:45:52.236321Z","steps":["trace[1013811163] 'agreement among raft nodes before linearized reading'  (duration: 1.517329245s)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:45:52.236516Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:45:49.772544Z","time spent":"2.463960342s","remote":"127.0.0.1:44126","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":64,"response size":30,"request content":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true "}
{"level":"info","ts":"2026-04-22T00:45:52.236542Z","caller":"traceutil/trace.go:171","msg":"trace[1789350371] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8982; }","duration":"1.488505614s","start":"2026-04-22T00:45:50.748025Z","end":"2026-04-22T00:45:52.23653Z","steps":["trace[1789350371] 'agreement among raft nodes before linearized reading'  (duration: 1.488375031s)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:45:52.236537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.070300522s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-c4tqx\" ","response":"range_response_count:1 size:6530"}
{"level":"warn","ts":"2026-04-22T00:45:52.236573Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:45:50.748013Z","time spent":"1.488552845s","remote":"127.0.0.1:44058","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"info","ts":"2026-04-22T00:45:52.236587Z","caller":"traceutil/trace.go:171","msg":"trace[1260649071] range","detail":"{range_begin:/registry/pods/openstack/keepalived-c4tqx; range_end:; response_count:1; response_revision:8982; }","duration":"2.070369504s","start":"2026-04-22T00:45:50.166204Z","end":"2026-04-22T00:45:52.236573Z","steps":["trace[1260649071] 'agreement among raft nodes before linearized reading'  (duration: 2.07024068s)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:45:52.236557Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:45:50.718763Z","time spent":"1.517779038s","remote":"127.0.0.1:44058","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-04-22T00:45:52.236623Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:45:50.166194Z","time spent":"2.070422146s","remote":"127.0.0.1:43970","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6553,"request content":"key:\"/registry/pods/openstack/keepalived-c4tqx\" "}
{"level":"info","ts":"2026-04-22T00:45:52.236554Z","caller":"traceutil/trace.go:171","msg":"trace[1680979116] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8982; }","duration":"1.34987241s","start":"2026-04-22T00:45:50.886596Z","end":"2026-04-22T00:45:52.236469Z","steps":["trace[1680979116] 'agreement among raft nodes before linearized reading'  (duration: 1.349403617s)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:45:52.236435Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:45:50.743452Z","time spent":"1.492972911s","remote":"127.0.0.1:44058","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":579,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "}
{"level":"warn","ts":"2026-04-22T00:45:52.236723Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:45:50.886592Z","time spent":"1.350088326s","remote":"127.0.0.1:44058","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-04-22T00:45:52.236304Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:45:50.885563Z","time spent":"1.350734143s","remote":"127.0.0.1:44058","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-04-22T00:45:52.236749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"357.107554ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/prometheusrules/\" range_end:\"/registry/monitoring.coreos.com/prometheusrules0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-04-22T00:45:52.237006Z","caller":"traceutil/trace.go:171","msg":"trace[1129105348] range","detail":"{range_begin:/registry/monitoring.coreos.com/prometheusrules/; range_end:/registry/monitoring.coreos.com/prometheusrules0; response_count:0; response_revision:8982; }","duration":"357.971038ms","start":"2026-04-22T00:45:51.879022Z","end":"2026-04-22T00:45:52.236993Z","steps":["trace[1129105348] 'agreement among raft nodes before linearized reading'  (duration: 357.087484ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:45:52.237009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.497680382s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"warn","ts":"2026-04-22T00:45:52.23704Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:45:51.879003Z","time spent":"358.02496ms","remote":"127.0.0.1:44908","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":29,"response size":30,"request content":"key:\"/registry/monitoring.coreos.com/prometheusrules/\" range_end:\"/registry/monitoring.coreos.com/prometheusrules0\" count_only:true "}
{"level":"info","ts":"2026-04-22T00:45:52.237053Z","caller":"traceutil/trace.go:171","msg":"trace[45341173] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8982; }","duration":"1.497764275s","start":"2026-04-22T00:45:50.739276Z","end":"2026-04-22T00:45:52.237041Z","steps":["trace[45341173] 'agreement among raft nodes before linearized reading'  (duration: 1.49760687s)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:45:52.23709Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:45:50.739251Z","time spent":"1.497827216s","remote":"127.0.0.1:44058","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-04-22T00:45:52.237413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.09941ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-22T00:45:52.237457Z","caller":"traceutil/trace.go:171","msg":"trace[851091594] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8982; }","duration":"138.181492ms","start":"2026-04-22T00:45:52.099264Z","end":"2026-04-22T00:45:52.237445Z","steps":["trace[851091594] 'agreement among raft nodes before linearized reading'  (duration: 137.115042ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:45:52.398683Z","caller":"traceutil/trace.go:171","msg":"trace[94530347] transaction","detail":"{read_only:false; response_revision:8984; number_of_response:1; }","duration":"158.489093ms","start":"2026-04-22T00:45:52.240171Z","end":"2026-04-22T00:45:52.39866Z","steps":["trace[94530347] 'process raft request'  (duration: 158.295138ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:45:52.399005Z","caller":"traceutil/trace.go:171","msg":"trace[2055089890] transaction","detail":"{read_only:false; response_revision:8985; number_of_response:1; }","duration":"158.520835ms","start":"2026-04-22T00:45:52.24045Z","end":"2026-04-22T00:45:52.398971Z","steps":["trace[2055089890] 'process raft request'  (duration: 158.163025ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:45:52.399053Z","caller":"traceutil/trace.go:171","msg":"trace[1752470695] transaction","detail":"{read_only:false; response_revision:8987; number_of_response:1; }","duration":"158.02957ms","start":"2026-04-22T00:45:52.241003Z","end":"2026-04-22T00:45:52.399032Z","steps":["trace[1752470695] 'process raft request'  (duration: 157.965158ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:45:52.399108Z","caller":"traceutil/trace.go:171","msg":"trace[704854398] transaction","detail":"{read_only:false; response_revision:8986; number_of_response:1; }","duration":"158.535185ms","start":"2026-04-22T00:45:52.240563Z","end":"2026-04-22T00:45:52.399099Z","steps":["trace[704854398] 'process raft request'  (duration: 158.284248ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:45:52.399209Z","caller":"traceutil/trace.go:171","msg":"trace[872758700] transaction","detail":"{read_only:false; response_revision:8988; number_of_response:1; }","duration":"158.138883ms","start":"2026-04-22T00:45:52.24106Z","end":"2026-04-22T00:45:52.399199Z","steps":["trace[872758700] 'process raft request'  (duration: 157.939708ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:45:52.399215Z","caller":"traceutil/trace.go:171","msg":"trace[2057824326] linearizableReadLoop","detail":"{readStateIndex:9304; appliedIndex:9301; }","duration":"158.39749ms","start":"2026-04-22T00:45:52.240788Z","end":"2026-04-22T00:45:52.399186Z","steps":["trace[2057824326] 'read index received'  (duration: 59.619365ms)","trace[2057824326] 'applied index is now lower than readState.Index'  (duration: 98.777245ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T00:45:52.399224Z","caller":"traceutil/trace.go:171","msg":"trace[2122211424] transaction","detail":"{read_only:false; response_revision:8989; number_of_response:1; }","duration":"157.961968ms","start":"2026-04-22T00:45:52.241253Z","end":"2026-04-22T00:45:52.399215Z","steps":["trace[2122211424] 'process raft request'  (duration: 157.851255ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:45:52.399664Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.858323ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:26 size:234509"}
{"level":"info","ts":"2026-04-22T00:45:52.399763Z","caller":"traceutil/trace.go:171","msg":"trace[1106623182] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:26; response_revision:8989; }","duration":"158.937365ms","start":"2026-04-22T00:45:52.240756Z","end":"2026-04-22T00:45:52.399694Z","steps":["trace[1106623182] 'agreement among raft nodes before linearized reading'  (duration: 158.551254ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:45:52.438642Z","caller":"traceutil/trace.go:171","msg":"trace[376395496] transaction","detail":"{read_only:false; response_revision:8990; number_of_response:1; }","duration":"133.247614ms","start":"2026-04-22T00:45:52.305362Z","end":"2026-04-22T00:45:52.43861Z","steps":["trace[376395496] 'process raft request'  (duration: 133.072429ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:45:52.438719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.662952ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-22T00:45:52.438792Z","caller":"traceutil/trace.go:171","msg":"trace[494021378] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8990; }","duration":"193.803805ms","start":"2026-04-22T00:45:52.244971Z","end":"2026-04-22T00:45:52.438774Z","steps":["trace[494021378] 'agreement among raft nodes before linearized reading'  (duration: 193.665611ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:45:52.438805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.049094ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-22T00:45:52.438896Z","caller":"traceutil/trace.go:171","msg":"trace[697130459] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:8990; }","duration":"104.184727ms","start":"2026-04-22T00:45:52.334689Z","end":"2026-04-22T00:45:52.438874Z","steps":["trace[697130459] 'agreement among raft nodes before linearized reading'  (duration: 104.010672ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:45:52.587964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.518895ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/openstack/rabbitmq-glance-server\" ","response":"range_response_count:1 size:9542"}
{"level":"info","ts":"2026-04-22T00:45:52.588044Z","caller":"traceutil/trace.go:171","msg":"trace[1025784840] range","detail":"{range_begin:/registry/statefulsets/openstack/rabbitmq-glance-server; range_end:; response_count:1; response_revision:8991; }","duration":"105.644799ms","start":"2026-04-22T00:45:52.482382Z","end":"2026-04-22T00:45:52.588027Z","steps":["trace[1025784840] 'range keys from in-memory index tree'  (duration: 105.34447ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:45:52.838921Z","caller":"traceutil/trace.go:171","msg":"trace[307316063] transaction","detail":"{read_only:false; response_revision:8992; number_of_response:1; }","duration":"139.344365ms","start":"2026-04-22T00:45:52.69955Z","end":"2026-04-22T00:45:52.838894Z","steps":["trace[307316063] 'process raft request'  (duration: 139.091938ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:45:54.258253Z","caller":"traceutil/trace.go:171","msg":"trace[665864792] transaction","detail":"{read_only:false; response_revision:8993; number_of_response:1; }","duration":"121.148634ms","start":"2026-04-22T00:45:54.137082Z","end":"2026-04-22T00:45:54.25823Z","steps":["trace[665864792] 'process raft request'  (duration: 120.981759ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:45:54.286008Z","caller":"traceutil/trace.go:171","msg":"trace[215959995] transaction","detail":"{read_only:false; response_revision:8994; number_of_response:1; }","duration":"147.735121ms","start":"2026-04-22T00:45:54.138246Z","end":"2026-04-22T00:45:54.285981Z","steps":["trace[215959995] 'process raft request'  (duration: 147.570457ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:45:54.59876Z","caller":"traceutil/trace.go:171","msg":"trace[294059716] linearizableReadLoop","detail":"{readStateIndex:9317; appliedIndex:9313; }","duration":"190.692788ms","start":"2026-04-22T00:45:54.40805Z","end":"2026-04-22T00:45:54.598743Z","steps":["trace[294059716] 'read index received'  (duration: 21.894365ms)","trace[294059716] 'applied index is now lower than readState.Index'  (duration: 168.797603ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-22T00:45:54.598939Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.873273ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-c4tqx\" ","response":"range_response_count:1 size:6530"}
{"level":"info","ts":"2026-04-22T00:45:54.598891Z","caller":"traceutil/trace.go:171","msg":"trace[7410852] transaction","detail":"{read_only:false; response_revision:8998; number_of_response:1; }","duration":"190.876754ms","start":"2026-04-22T00:45:54.407955Z","end":"2026-04-22T00:45:54.598832Z","steps":["trace[7410852] 'process raft request'  (duration: 190.678238ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:45:54.598992Z","caller":"traceutil/trace.go:171","msg":"trace[15475609] transaction","detail":"{read_only:false; response_revision:8999; number_of_response:1; }","duration":"191.013057ms","start":"2026-04-22T00:45:54.40797Z","end":"2026-04-22T00:45:54.598983Z","steps":["trace[15475609] 'process raft request'  (duration: 190.690448ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:45:54.598965Z","caller":"traceutil/trace.go:171","msg":"trace[470305388] range","detail":"{range_begin:/registry/pods/openstack/keepalived-c4tqx; range_end:; response_count:1; response_revision:9001; }","duration":"190.914244ms","start":"2026-04-22T00:45:54.408044Z","end":"2026-04-22T00:45:54.598958Z","steps":["trace[470305388] 'agreement among raft nodes before linearized reading'  (duration: 190.784801ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:45:54.59935Z","caller":"traceutil/trace.go:171","msg":"trace[1782795014] transaction","detail":"{read_only:false; response_revision:8997; number_of_response:1; }","duration":"191.40845ms","start":"2026-04-22T00:45:54.407923Z","end":"2026-04-22T00:45:54.599331Z","steps":["trace[1782795014] 'process raft request'  (duration: 116.71983ms)","trace[1782795014] 'compare'  (duration: 73.892776ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T00:45:54.599465Z","caller":"traceutil/trace.go:171","msg":"trace[902869047] transaction","detail":"{read_only:false; response_revision:9000; number_of_response:1; }","duration":"190.020359ms","start":"2026-04-22T00:45:54.409413Z","end":"2026-04-22T00:45:54.599434Z","steps":["trace[902869047] 'process raft request'  (duration: 189.276728ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:45:54.599596Z","caller":"traceutil/trace.go:171","msg":"trace[129144042] transaction","detail":"{read_only:false; response_revision:9001; number_of_response:1; }","duration":"188.805356ms","start":"2026-04-22T00:45:54.410726Z","end":"2026-04-22T00:45:54.599531Z","steps":["trace[129144042] 'process raft request'  (duration: 187.987092ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:46:05.123776Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002503.wal"}
{"level":"info","ts":"2026-04-22T00:46:09.34104Z","caller":"traceutil/trace.go:171","msg":"trace[609357472] linearizableReadLoop","detail":"{readStateIndex:9542; appliedIndex:9541; }","duration":"243.909399ms","start":"2026-04-22T00:46:09.097101Z","end":"2026-04-22T00:46:09.341011Z","steps":["trace[609357472] 'read index received'  (duration: 243.697653ms)","trace[609357472] 'applied index is now lower than readState.Index'  (duration: 210.486µs)"],"step_count":2}
{"level":"info","ts":"2026-04-22T00:46:09.341196Z","caller":"traceutil/trace.go:171","msg":"trace[918216523] transaction","detail":"{read_only:false; response_revision:9219; number_of_response:1; }","duration":"347.836088ms","start":"2026-04-22T00:46:08.993344Z","end":"2026-04-22T00:46:09.341181Z","steps":["trace[918216523] 'process raft request'  (duration: 347.526129ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:46:09.341431Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:46:08.993327Z","time spent":"347.905339ms","remote":"127.0.0.1:43860","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":795,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/events/openstack/rook-ceph-rgw-ceph-a-699b8bdb59-sls54.18a88741a3f79284\" mod_revision:0 > success:<request_put:<key:\"/registry/events/openstack/rook-ceph-rgw-ceph-a-699b8bdb59-sls54.18a88741a3f79284\" value_size:696 lease:3415872232754398740 >> failure:<>"}
{"level":"warn","ts":"2026-04-22T00:46:09.341446Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.32957ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-22T00:46:09.341536Z","caller":"traceutil/trace.go:171","msg":"trace[745427022] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:9219; }","duration":"244.469565ms","start":"2026-04-22T00:46:09.097045Z","end":"2026-04-22T00:46:09.341515Z","steps":["trace[745427022] 'agreement among raft nodes before linearized reading'  (duration: 244.228108ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:46:10.33101Z","caller":"traceutil/trace.go:171","msg":"trace[460834755] transaction","detail":"{read_only:false; response_revision:9226; number_of_response:1; }","duration":"121.254335ms","start":"2026-04-22T00:46:10.209735Z","end":"2026-04-22T00:46:10.33099Z","steps":["trace[460834755] 'process raft request'  (duration: 120.928645ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:46:12.005755Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3415872232754399056,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-04-22T00:46:12.241267Z","caller":"traceutil/trace.go:171","msg":"trace[1034944682] transaction","detail":"{read_only:false; response_revision:9246; number_of_response:1; }","duration":"846.644355ms","start":"2026-04-22T00:46:11.39459Z","end":"2026-04-22T00:46:12.241235Z","steps":["trace[1034944682] 'process raft request'  (duration: 846.47753ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:46:12.241433Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:46:11.394544Z","time spent":"846.810299ms","remote":"127.0.0.1:43860","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":883,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/events/openstack/rook-ceph-crashcollector-instance-754c646bfd-dmb8g.18a88742330df460\" mod_revision:0 > success:<request_put:<key:\"/registry/events/openstack/rook-ceph-crashcollector-instance-754c646bfd-dmb8g.18a88742330df460\" value_size:771 lease:3415872232754398740 >> failure:<>"}
{"level":"info","ts":"2026-04-22T00:46:12.245316Z","caller":"traceutil/trace.go:171","msg":"trace[576946177] transaction","detail":"{read_only:false; response_revision:9247; number_of_response:1; }","duration":"842.449277ms","start":"2026-04-22T00:46:11.402838Z","end":"2026-04-22T00:46:12.245288Z","steps":["trace[576946177] 'process raft request'  (duration: 842.207479ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:46:12.245437Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:46:11.402817Z","time spent":"842.55337ms","remote":"127.0.0.1:43970","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":19674,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/openstack/rook-ceph-rgw-ceph-a-699b8bdb59-sls54\" mod_revision:9231 > success:<request_put:<key:\"/registry/pods/openstack/rook-ceph-rgw-ceph-a-699b8bdb59-sls54\" value_size:19602 >> failure:<request_range:<key:\"/registry/pods/openstack/rook-ceph-rgw-ceph-a-699b8bdb59-sls54\" > >"}
{"level":"info","ts":"2026-04-22T00:46:12.24538Z","caller":"traceutil/trace.go:171","msg":"trace[581080811] transaction","detail":"{read_only:false; response_revision:9248; number_of_response:1; }","duration":"496.575075ms","start":"2026-04-22T00:46:11.748775Z","end":"2026-04-22T00:46:12.24535Z","steps":["trace[581080811] 'process raft request'  (duration: 496.43629ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:46:12.245763Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:46:11.748746Z","time spent":"496.855483ms","remote":"127.0.0.1:44058","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" mod_revision:9138 > success:<request_put:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" value_size:416 >> failure:<request_range:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" > >"}
{"level":"info","ts":"2026-04-22T00:46:12.248033Z","caller":"traceutil/trace.go:171","msg":"trace[1414716794] linearizableReadLoop","detail":"{readStateIndex:9571; appliedIndex:9568; }","duration":"742.436979ms","start":"2026-04-22T00:46:11.505569Z","end":"2026-04-22T00:46:12.248006Z","steps":["trace[1414716794] 'read index received'  (duration: 735.476034ms)","trace[1414716794] 'applied index is now lower than readState.Index'  (duration: 6.959195ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-22T00:46:12.248141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"742.565563ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-22T00:46:12.248181Z","caller":"traceutil/trace.go:171","msg":"trace[950971891] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:9248; }","duration":"742.646285ms","start":"2026-04-22T00:46:11.505524Z","end":"2026-04-22T00:46:12.248171Z","steps":["trace[950971891] 'agreement among raft nodes before linearized reading'  (duration: 742.568983ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:46:12.248206Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:46:11.505504Z","time spent":"742.697317ms","remote":"127.0.0.1:49846","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true "}
{"level":"warn","ts":"2026-04-22T00:46:12.937446Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3415872232754399069,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-04-22T00:46:12.975097Z","caller":"traceutil/trace.go:171","msg":"trace[1058475589] transaction","detail":"{read_only:false; response_revision:9252; number_of_response:1; }","duration":"647.711189ms","start":"2026-04-22T00:46:12.327356Z","end":"2026-04-22T00:46:12.975067Z","steps":["trace[1058475589] 'process raft request'  (duration: 647.551335ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:46:12.975291Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:46:12.327345Z","time spent":"647.862063ms","remote":"127.0.0.1:43970","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9947,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/openstack/rook-ceph-crashcollector-instance-754c646bfd-dmb8g\" mod_revision:9235 > success:<request_put:<key:\"/registry/pods/openstack/rook-ceph-crashcollector-instance-754c646bfd-dmb8g\" value_size:9864 >> failure:<request_range:<key:\"/registry/pods/openstack/rook-ceph-crashcollector-instance-754c646bfd-dmb8g\" > >"}
{"level":"info","ts":"2026-04-22T00:46:12.97996Z","caller":"traceutil/trace.go:171","msg":"trace[8099344] transaction","detail":"{read_only:false; response_revision:9254; number_of_response:1; }","duration":"638.348526ms","start":"2026-04-22T00:46:12.341329Z","end":"2026-04-22T00:46:12.979678Z","steps":["trace[8099344] 'process raft request'  (duration: 638.085008ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:46:12.980026Z","caller":"traceutil/trace.go:171","msg":"trace[988477754] transaction","detail":"{read_only:false; response_revision:9253; number_of_response:1; }","duration":"643.562052ms","start":"2026-04-22T00:46:12.336435Z","end":"2026-04-22T00:46:12.979997Z","steps":["trace[988477754] 'process raft request'  (duration: 642.877723ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:46:12.980172Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:46:12.336404Z","time spent":"643.683746ms","remote":"127.0.0.1:44058","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:9226 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:477 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-04-22T00:46:12.980197Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:46:12.341312Z","time spent":"638.729737ms","remote":"127.0.0.1:44058","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:9227 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:459 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"info","ts":"2026-04-22T00:46:12.980202Z","caller":"traceutil/trace.go:171","msg":"trace[1891523529] linearizableReadLoop","detail":"{readStateIndex:9580; appliedIndex:9575; }","duration":"543.255846ms","start":"2026-04-22T00:46:12.436929Z","end":"2026-04-22T00:46:12.980185Z","steps":["trace[1891523529] 'read index received'  (duration: 538.024419ms)","trace[1891523529] 'applied index is now lower than readState.Index'  (duration: 5.230807ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T00:46:12.98028Z","caller":"traceutil/trace.go:171","msg":"trace[2074273395] transaction","detail":"{read_only:false; response_revision:9256; number_of_response:1; }","duration":"543.661517ms","start":"2026-04-22T00:46:12.4366Z","end":"2026-04-22T00:46:12.980261Z","steps":["trace[2074273395] 'process raft request'  (duration: 543.506622ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:46:12.9804Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"533.754409ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rook-ceph-pdbstatemap\" ","response":"range_response_count:1 size:356"}
{"level":"info","ts":"2026-04-22T00:46:12.980427Z","caller":"traceutil/trace.go:171","msg":"trace[1277333688] range","detail":"{range_begin:/registry/configmaps/openstack/rook-ceph-pdbstatemap; range_end:; response_count:1; response_revision:9256; }","duration":"533.81267ms","start":"2026-04-22T00:46:12.446606Z","end":"2026-04-22T00:46:12.980419Z","steps":["trace[1277333688] 'agreement among raft nodes before linearized reading'  (duration: 533.697737ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:46:12.980427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"543.493032ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephclusters/openstack/ceph\" ","response":"range_response_count:1 size:7036"}
{"level":"info","ts":"2026-04-22T00:46:12.980406Z","caller":"traceutil/trace.go:171","msg":"trace[2113048494] transaction","detail":"{read_only:false; response_revision:9255; number_of_response:1; }","duration":"638.278714ms","start":"2026-04-22T00:46:12.342099Z","end":"2026-04-22T00:46:12.980378Z","steps":["trace[2113048494] 'process raft request'  (duration: 637.550524ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:46:12.980447Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:46:12.436572Z","time spent":"543.791401ms","remote":"127.0.0.1:54116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3700,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/ceph.rook.io/cephobjectstores/openstack/ceph\" mod_revision:8498 > success:<request_put:<key:\"/registry/ceph.rook.io/cephobjectstores/openstack/ceph\" value_size:3638 >> failure:<request_range:<key:\"/registry/ceph.rook.io/cephobjectstores/openstack/ceph\" > >"}
{"level":"warn","ts":"2026-04-22T00:46:12.980465Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:46:12.44656Z","time spent":"533.898933ms","remote":"127.0.0.1:43888","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":379,"request content":"key:\"/registry/configmaps/openstack/rook-ceph-pdbstatemap\" "}
{"level":"info","ts":"2026-04-22T00:46:12.980474Z","caller":"traceutil/trace.go:171","msg":"trace[1857915678] range","detail":"{range_begin:/registry/ceph.rook.io/cephclusters/openstack/ceph; range_end:; response_count:1; response_revision:9256; }","duration":"543.566114ms","start":"2026-04-22T00:46:12.436898Z","end":"2026-04-22T00:46:12.980464Z","steps":["trace[1857915678] 'agreement among raft nodes before linearized reading'  (duration: 543.39129ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:46:12.980507Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:46:12.436886Z","time spent":"543.613775ms","remote":"127.0.0.1:54034","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":7059,"request content":"key:\"/registry/ceph.rook.io/cephclusters/openstack/ceph\" "}
{"level":"warn","ts":"2026-04-22T00:46:12.98056Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:46:12.342087Z","time spent":"638.394007ms","remote":"127.0.0.1:44058","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:9229 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"warn","ts":"2026-04-22T00:46:12.980658Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.484436ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"}
{"level":"info","ts":"2026-04-22T00:46:12.980679Z","caller":"traceutil/trace.go:171","msg":"trace[1954163867] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:9256; }","duration":"291.543437ms","start":"2026-04-22T00:46:12.68913Z","end":"2026-04-22T00:46:12.980673Z","steps":["trace[1954163867] 'agreement among raft nodes before linearized reading'  (duration: 291.482246ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:46:12.980728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.182105ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-04-22T00:46:12.980773Z","caller":"traceutil/trace.go:171","msg":"trace[1408133557] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:9256; }","duration":"297.269118ms","start":"2026-04-22T00:46:12.683491Z","end":"2026-04-22T00:46:12.98076Z","steps":["trace[1408133557] 'agreement among raft nodes before linearized reading'  (duration: 297.127004ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:46:12.980787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"475.02859ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"}
{"level":"info","ts":"2026-04-22T00:46:12.980832Z","caller":"traceutil/trace.go:171","msg":"trace[749954178] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:9256; }","duration":"475.107382ms","start":"2026-04-22T00:46:12.50571Z","end":"2026-04-22T00:46:12.980817Z","steps":["trace[749954178] 'agreement among raft nodes before linearized reading'  (duration: 474.912717ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:46:12.98087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.115851ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-04-22T00:46:12.980907Z","caller":"traceutil/trace.go:171","msg":"trace[1717906107] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:9256; }","duration":"293.219504ms","start":"2026-04-22T00:46:12.687675Z","end":"2026-04-22T00:46:12.980895Z","steps":["trace[1717906107] 'agreement among raft nodes before linearized reading'  (duration: 293.122552ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:46:12.980903Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:46:12.505692Z","time spent":"475.199964ms","remote":"127.0.0.1:44058","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":579,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "}
{"level":"warn","ts":"2026-04-22T00:46:12.981043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.640132ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"}
{"level":"info","ts":"2026-04-22T00:46:12.981079Z","caller":"traceutil/trace.go:171","msg":"trace[928707491] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:9256; }","duration":"284.698224ms","start":"2026-04-22T00:46:12.696369Z","end":"2026-04-22T00:46:12.981067Z","steps":["trace[928707491] 'agreement among raft nodes before linearized reading'  (duration: 284.610312ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:46:12.98108Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.785713ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-c4tqx\" ","response":"range_response_count:1 size:6530"}
{"level":"info","ts":"2026-04-22T00:46:12.981174Z","caller":"traceutil/trace.go:171","msg":"trace[639594275] range","detail":"{range_begin:/registry/pods/openstack/keepalived-c4tqx; range_end:; response_count:1; response_revision:9256; }","duration":"276.840734ms","start":"2026-04-22T00:46:12.704263Z","end":"2026-04-22T00:46:12.981103Z","steps":["trace[639594275] 'agreement among raft nodes before linearized reading'  (duration: 276.67322ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:46:12.981343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.454003ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"}
{"level":"info","ts":"2026-04-22T00:46:12.981553Z","caller":"traceutil/trace.go:171","msg":"trace[1298071401] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:9256; }","duration":"286.514106ms","start":"2026-04-22T00:46:12.694853Z","end":"2026-04-22T00:46:12.981367Z","steps":["trace[1298071401] 'agreement among raft nodes before linearized reading'  (duration: 285.707133ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:46:21.399506Z","caller":"traceutil/trace.go:171","msg":"trace[655234435] linearizableReadLoop","detail":"{readStateIndex:9634; appliedIndex:9633; }","duration":"379.526957ms","start":"2026-04-22T00:46:21.019956Z","end":"2026-04-22T00:46:21.399483Z","steps":["trace[655234435] 'read index received'  (duration: 379.481706ms)","trace[655234435] 'applied index is now lower than readState.Index'  (duration: 44.141µs)"],"step_count":2}
{"level":"info","ts":"2026-04-22T00:46:21.399627Z","caller":"traceutil/trace.go:171","msg":"trace[1141703051] transaction","detail":"{read_only:false; response_revision:9309; number_of_response:1; }","duration":"392.565474ms","start":"2026-04-22T00:46:21.007051Z","end":"2026-04-22T00:46:21.399617Z","steps":["trace[1141703051] 'process raft request'  (duration: 392.299737ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:46:21.399722Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:46:21.00702Z","time spent":"392.630155ms","remote":"127.0.0.1:44058","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":554,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:9295 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:476 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-04-22T00:46:21.399891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"379.909688ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"info","ts":"2026-04-22T00:46:21.39997Z","caller":"traceutil/trace.go:171","msg":"trace[958531520] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:9309; }","duration":"380.036691ms","start":"2026-04-22T00:46:21.019915Z","end":"2026-04-22T00:46:21.399952Z","steps":["trace[958531520] 'agreement among raft nodes before linearized reading'  (duration: 379.769554ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:46:21.40001Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:46:21.019898Z","time spent":"380.104114ms","remote":"127.0.0.1:44058","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-04-22T00:46:21.407472Z","caller":"traceutil/trace.go:171","msg":"trace[1723926459] transaction","detail":"{read_only:false; response_revision:9310; number_of_response:1; }","duration":"153.698436ms","start":"2026-04-22T00:46:21.253744Z","end":"2026-04-22T00:46:21.407443Z","steps":["trace[1723926459] 'process raft request'  (duration: 153.49925ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:46:21.407787Z","caller":"traceutil/trace.go:171","msg":"trace[1763502305] transaction","detail":"{read_only:false; response_revision:9311; number_of_response:1; }","duration":"143.961612ms","start":"2026-04-22T00:46:21.263803Z","end":"2026-04-22T00:46:21.407765Z","steps":["trace[1763502305] 'process raft request'  (duration: 143.587681ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:46:21.407941Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"377.50753ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"warn","ts":"2026-04-22T00:46:21.407986Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.946109ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-22T00:46:21.408029Z","caller":"traceutil/trace.go:171","msg":"trace[1838216861] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:9312; }","duration":"307.044392ms","start":"2026-04-22T00:46:21.100974Z","end":"2026-04-22T00:46:21.408018Z","steps":["trace[1838216861] 'agreement among raft nodes before linearized reading'  (duration: 306.97326ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:46:21.408066Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:46:21.100947Z","time spent":"307.109303ms","remote":"127.0.0.1:43770","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-04-22T00:46:21.408072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"372.668895ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"}
{"level":"info","ts":"2026-04-22T00:46:21.408109Z","caller":"traceutil/trace.go:171","msg":"trace[696866594] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:9312; }","duration":"372.725056ms","start":"2026-04-22T00:46:21.035375Z","end":"2026-04-22T00:46:21.4081Z","steps":["trace[696866594] 'agreement among raft nodes before linearized reading'  (duration: 372.639524ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:46:21.408143Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:46:21.035358Z","time spent":"372.778248ms","remote":"127.0.0.1:44058","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":578,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "}
{"level":"warn","ts":"2026-04-22T00:46:21.408232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"373.582671ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-04-22T00:46:21.408262Z","caller":"traceutil/trace.go:171","msg":"trace[1881321799] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:9312; }","duration":"373.624471ms","start":"2026-04-22T00:46:21.034631Z","end":"2026-04-22T00:46:21.408255Z","steps":["trace[1881321799] 'agreement among raft nodes before linearized reading'  (duration: 373.552919ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:46:21.408296Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:46:21.034623Z","time spent":"373.666852ms","remote":"127.0.0.1:44058","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-04-22T00:46:21.408222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.333142ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-c4tqx\" ","response":"range_response_count:1 size:6530"}
{"level":"warn","ts":"2026-04-22T00:46:21.408296Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.775342ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"}
{"level":"info","ts":"2026-04-22T00:46:21.408424Z","caller":"traceutil/trace.go:171","msg":"trace[628579905] range","detail":"{range_begin:/registry/pods/openstack/keepalived-c4tqx; range_end:; response_count:1; response_revision:9312; }","duration":"113.549298ms","start":"2026-04-22T00:46:21.294855Z","end":"2026-04-22T00:46:21.408404Z","steps":["trace[628579905] 'agreement among raft nodes before linearized reading'  (duration: 113.25847ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:46:21.408468Z","caller":"traceutil/trace.go:171","msg":"trace[623435562] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:9312; }","duration":"119.971488ms","start":"2026-04-22T00:46:21.288485Z","end":"2026-04-22T00:46:21.408457Z","steps":["trace[623435562] 'agreement among raft nodes before linearized reading'  (duration: 119.732101ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:46:21.407993Z","caller":"traceutil/trace.go:171","msg":"trace[1364317576] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:9312; }","duration":"377.609504ms","start":"2026-04-22T00:46:21.030372Z","end":"2026-04-22T00:46:21.407981Z","steps":["trace[1364317576] 'agreement among raft nodes before linearized reading'  (duration: 377.409088ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:46:21.408488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"374.747482ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-04-22T00:46:21.408615Z","caller":"traceutil/trace.go:171","msg":"trace[660139752] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:9312; }","duration":"374.932909ms","start":"2026-04-22T00:46:21.033666Z","end":"2026-04-22T00:46:21.408599Z","steps":["trace[660139752] 'agreement among raft nodes before linearized reading'  (duration: 374.530007ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:46:21.408551Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:46:21.030345Z","time spent":"378.19183ms","remote":"127.0.0.1:44058","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-04-22T00:46:21.408716Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:46:21.033649Z","time spent":"375.053742ms","remote":"127.0.0.1:44058","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-04-22T00:46:27.600283Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3415872232754399281,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-04-22T00:46:28.100843Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3415872232754399281,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-04-22T00:46:28.602009Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3415872232754399281,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-04-22T00:46:29.100223Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000103535s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-04-22T00:46:29.10033Z","caller":"traceutil/trace.go:171","msg":"trace[775470859] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.00028976s","start":"2026-04-22T00:46:27.100018Z","end":"2026-04-22T00:46:29.100307Z","steps":["trace[775470859] 'agreement among raft nodes before linearized reading'  (duration: 2.000134016s)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:46:29.100396Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:46:27.099998Z","time spent":"2.000385443s","remote":"127.0.0.1:43770","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-04-22T00:46:29.102907Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3415872232754399281,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-04-22T00:46:29.603922Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3415872232754399281,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-04-22T00:46:30.104982Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3415872232754399281,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-04-22T00:46:30.605539Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3415872232754399281,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-04-22T00:46:31.101077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000078096s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-04-22T00:46:31.101164Z","caller":"traceutil/trace.go:171","msg":"trace[1907121360] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000219459s","start":"2026-04-22T00:46:29.100925Z","end":"2026-04-22T00:46:31.101144Z","steps":["trace[1907121360] 'agreement among raft nodes before linearized reading'  (duration: 2.000105746s)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:46:31.101217Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:46:29.100905Z","time spent":"2.000299681s","remote":"127.0.0.1:43776","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
2026/04/22 00:46:31 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-04-22T00:46:31.106434Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3415872232754399281,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-04-22T00:46:31.606983Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3415872232754399281,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-04-22T00:46:32.086432Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"5.189633341s","expected-duration":"1s"}
{"level":"warn","ts":"2026-04-22T00:46:32.086966Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:46:26.896695Z","time spent":"5.190265559s","remote":"127.0.0.1:43796","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"info","ts":"2026-04-22T00:46:32.39963Z","caller":"traceutil/trace.go:171","msg":"trace[96767295] transaction","detail":"{read_only:false; response_revision:9342; number_of_response:1; }","duration":"4.979218114s","start":"2026-04-22T00:46:27.420381Z","end":"2026-04-22T00:46:32.399599Z","steps":["trace[96767295] 'process raft request'  (duration: 4.97909172s)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:46:32.399674Z","caller":"traceutil/trace.go:171","msg":"trace[51673581] transaction","detail":"{read_only:false; response_revision:9341; number_of_response:1; }","duration":"5.083816392s","start":"2026-04-22T00:46:27.315818Z","end":"2026-04-22T00:46:32.399635Z","steps":["trace[51673581] 'process raft request'  (duration: 5.083463022s)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:46:32.399872Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:46:27.315793Z","time spent":"5.083985646s","remote":"127.0.0.1:44058","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" mod_revision:9304 > success:<request_put:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" value_size:416 >> failure:<request_range:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" > >"}
{"level":"warn","ts":"2026-04-22T00:46:32.399893Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:46:27.420356Z","time spent":"4.97942733s","remote":"127.0.0.1:44058","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:9331 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:477 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"info","ts":"2026-04-22T00:46:32.400561Z","caller":"traceutil/trace.go:171","msg":"trace[313030277] transaction","detail":"{read_only:false; response_revision:9344; number_of_response:1; }","duration":"4.971243849s","start":"2026-04-22T00:46:27.429304Z","end":"2026-04-22T00:46:32.400548Z","steps":["trace[313030277] 'process raft request'  (duration: 4.971086955s)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:46:32.400642Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:46:27.429284Z","time spent":"4.97131795s","remote":"127.0.0.1:44058","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:9332 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:459 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"info","ts":"2026-04-22T00:46:32.400583Z","caller":"traceutil/trace.go:171","msg":"trace[2115036366] transaction","detail":"{read_only:false; response_revision:9343; number_of_response:1; }","duration":"4.97304652s","start":"2026-04-22T00:46:27.427502Z","end":"2026-04-22T00:46:32.400549Z","steps":["trace[2115036366] 'process raft request'  (duration: 4.972049412s)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:46:32.400905Z","caller":"traceutil/trace.go:171","msg":"trace[550804492] transaction","detail":"{read_only:false; response_revision:9345; number_of_response:1; }","duration":"4.532468628s","start":"2026-04-22T00:46:27.868424Z","end":"2026-04-22T00:46:32.400893Z","steps":["trace[550804492] 'process raft request'  (duration: 4.532057537s)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:46:32.400976Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:46:27.8684Z","time spent":"4.53254001s","remote":"127.0.0.1:44058","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:9294 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:472 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"warn","ts":"2026-04-22T00:46:32.401153Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:46:27.427488Z","time spent":"4.973332397s","remote":"127.0.0.1:44058","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:9333 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"info","ts":"2026-04-22T00:46:32.401226Z","caller":"traceutil/trace.go:171","msg":"trace[97003016] transaction","detail":"{read_only:false; response_revision:9346; number_of_response:1; }","duration":"2.811808958s","start":"2026-04-22T00:46:29.589402Z","end":"2026-04-22T00:46:32.401211Z","steps":["trace[97003016] 'process raft request'  (duration: 2.81114248s)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:46:32.401159Z","caller":"traceutil/trace.go:171","msg":"trace[1060054567] linearizableReadLoop","detail":"{readStateIndex:9673; appliedIndex:9666; }","duration":"5.30104326s","start":"2026-04-22T00:46:27.10009Z","end":"2026-04-22T00:46:32.401133Z","steps":["trace[1060054567] 'read index received'  (duration: 4.986570009s)","trace[1060054567] 'applied index is now lower than readState.Index'  (duration: 314.472091ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-22T00:46:32.401645Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:46:29.58937Z","time spent":"2.811916252s","remote":"127.0.0.1:43958","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":19206,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/minions/instance\" mod_revision:8906 > success:<request_put:<key:\"/registry/minions/instance\" value_size:19170 >> failure:<request_range:<key:\"/registry/minions/instance\" > >"}
{"level":"info","ts":"2026-04-22T00:46:32.405901Z","caller":"traceutil/trace.go:171","msg":"trace[2102294075] transaction","detail":"{read_only:false; response_revision:9347; number_of_response:1; }","duration":"317.585718ms","start":"2026-04-22T00:46:32.088293Z","end":"2026-04-22T00:46:32.405879Z","steps":["trace[2102294075] 'process raft request'  (duration: 317.360281ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:46:32.406028Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:46:32.088269Z","time spent":"317.697421ms","remote":"127.0.0.1:43796","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/masterleases/199.204.45.248\" mod_revision:9284 > success:<request_put:<key:\"/registry/masterleases/199.204.45.248\" value_size:67 lease:3415872232754399282 >> failure:<request_range:<key:\"/registry/masterleases/199.204.45.248\" > >"}
{"level":"warn","ts":"2026-04-22T00:46:32.433403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.999160593s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-04-22T00:46:32.433536Z","caller":"traceutil/trace.go:171","msg":"trace[1406485074] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; }","duration":"4.999346039s","start":"2026-04-22T00:46:27.434151Z","end":"2026-04-22T00:46:32.433497Z","steps":["trace[1406485074] 'agreement among raft nodes before linearized reading'  (duration: 4.999173174s)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:46:32.433594Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:46:27.434135Z","time spent":"4.999447052s","remote":"127.0.0.1:44058","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
2026/04/22 00:46:32 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-04-22T00:46:32.441767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.999816622s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"","error":"context canceled"}
{"level":"info","ts":"2026-04-22T00:46:32.441873Z","caller":"traceutil/trace.go:171","msg":"trace[1517063818] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; }","duration":"4.999974816s","start":"2026-04-22T00:46:27.441876Z","end":"2026-04-22T00:46:32.441851Z","steps":["trace[1517063818] 'agreement among raft nodes before linearized reading'  (duration: 4.999833332s)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:46:32.441931Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:46:27.441865Z","time spent":"5.000050109s","remote":"127.0.0.1:44058","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
2026/04/22 00:46:32 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-04-22T00:46:32.453595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.999524473s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"","error":"context canceled"}
{"level":"info","ts":"2026-04-22T00:46:32.453657Z","caller":"traceutil/trace.go:171","msg":"trace[1758652703] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; }","duration":"4.999614025s","start":"2026-04-22T00:46:27.454029Z","end":"2026-04-22T00:46:32.453643Z","steps":["trace[1758652703] 'agreement among raft nodes before linearized reading'  (duration: 4.999547943s)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:46:32.453696Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:46:27.454015Z","time spent":"4.999672447s","remote":"127.0.0.1:44058","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
2026/04/22 00:46:32 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-04-22T00:46:32.462839Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.788100466s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"}
{"level":"warn","ts":"2026-04-22T00:46:32.462852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"829.74482ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-22T00:46:32.462897Z","caller":"traceutil/trace.go:171","msg":"trace[782580754] 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:9347; }","duration":"4.78820526s","start":"2026-04-22T00:46:27.674674Z","end":"2026-04-22T00:46:32.46288Z","steps":["trace[782580754] 'agreement among raft nodes before linearized reading'  (duration: 4.788010594s)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:46:32.462912Z","caller":"traceutil/trace.go:171","msg":"trace[504300555] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:9347; }","duration":"829.865204ms","start":"2026-04-22T00:46:31.633033Z","end":"2026-04-22T00:46:32.462898Z","steps":["trace[504300555] 'agreement among raft nodes before linearized reading'  (duration: 829.759361ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:46:32.462935Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:46:27.674657Z","time spent":"4.788268742s","remote":"127.0.0.1:43930","response type":"/etcdserverpb.KV/Range","request count":0,"request size":147,"response count":1,"response size":1958,"request content":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" "}
{"level":"warn","ts":"2026-04-22T00:46:32.462949Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:46:31.633017Z","time spent":"829.925067ms","remote":"127.0.0.1:49902","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true "}
{"level":"warn","ts":"2026-04-22T00:46:32.462937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.758603155s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephrbdmirrors/\" range_end:\"/registry/ceph.rook.io/cephrbdmirrors0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-04-22T00:46:32.462968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.802216559s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"warn","ts":"2026-04-22T00:46:32.46299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.631255011s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/\" range_end:\"/registry/cert-manager.io/certificates0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-04-22T00:46:32.463024Z","caller":"traceutil/trace.go:171","msg":"trace[363459971] range","detail":"{range_begin:/registry/ceph.rook.io/cephrbdmirrors/; range_end:/registry/ceph.rook.io/cephrbdmirrors0; response_count:0; response_revision:9347; }","duration":"2.758717999s","start":"2026-04-22T00:46:29.704284Z","end":"2026-04-22T00:46:32.463002Z","steps":["trace[363459971] 'agreement among raft nodes before linearized reading'  (duration: 2.758609486s)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:46:32.463048Z","caller":"traceutil/trace.go:171","msg":"trace[722148287] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:9347; }","duration":"1.802367623s","start":"2026-04-22T00:46:30.660664Z","end":"2026-04-22T00:46:32.463031Z","steps":["trace[722148287] 'agreement among raft nodes before linearized reading'  (duration: 1.802189197s)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:46:32.463055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.764268856s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephclusters/\" range_end:\"/registry/ceph.rook.io/cephclusters0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"warn","ts":"2026-04-22T00:46:32.462833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.669399821s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/permissions/\" range_end:\"/registry/rabbitmq.com/permissions0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-04-22T00:46:32.463088Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"5.00899275s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"}
{"level":"info","ts":"2026-04-22T00:46:32.46311Z","caller":"traceutil/trace.go:171","msg":"trace[1701477409] range","detail":"{range_begin:/registry/rabbitmq.com/permissions/; range_end:/registry/rabbitmq.com/permissions0; response_count:0; response_revision:9347; }","duration":"3.669758122s","start":"2026-04-22T00:46:28.793341Z","end":"2026-04-22T00:46:32.463099Z","steps":["trace[1701477409] 'agreement among raft nodes before linearized reading'  (duration: 3.669305289s)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:46:32.463149Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.35425323s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-04-22T00:46:32.463022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"5.008445304s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"}
{"level":"warn","ts":"2026-04-22T00:46:32.463162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.442366828s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-rgw-ceph-a-699b8bdb59-sls54\" ","response":"range_response_count:1 size:19689"}
{"level":"warn","ts":"2026-04-22T00:46:32.463162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.288730099s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"warn","ts":"2026-04-22T00:46:32.463161Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:46:28.79332Z","time spent":"3.669825303s","remote":"127.0.0.1:48456","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":28,"request content":"key:\"/registry/rabbitmq.com/permissions/\" range_end:\"/registry/rabbitmq.com/permissions0\" count_only:true "}
{"level":"info","ts":"2026-04-22T00:46:32.463182Z","caller":"traceutil/trace.go:171","msg":"trace[2122127787] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:9347; }","duration":"5.00864638s","start":"2026-04-22T00:46:27.454528Z","end":"2026-04-22T00:46:32.463175Z","steps":["trace[2122127787] 'agreement among raft nodes before linearized reading'  (duration: 5.008446685s)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:46:32.463193Z","caller":"traceutil/trace.go:171","msg":"trace[1609560686] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:9347; }","duration":"1.288802931s","start":"2026-04-22T00:46:31.174381Z","end":"2026-04-22T00:46:32.463184Z","steps":["trace[1609560686] 'agreement among raft nodes before linearized reading'  (duration: 1.28873875s)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:46:32.463061Z","caller":"traceutil/trace.go:171","msg":"trace[1002909573] range","detail":"{range_begin:/registry/cert-manager.io/certificates/; range_end:/registry/cert-manager.io/certificates0; response_count:0; response_revision:9347; }","duration":"3.631372835s","start":"2026-04-22T00:46:28.831673Z","end":"2026-04-22T00:46:32.463046Z","steps":["trace[1002909573] 'agreement among raft nodes before linearized reading'  (duration: 3.631231851s)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:46:32.463223Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.439880898s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"warn","ts":"2026-04-22T00:46:32.463223Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:46:31.17436Z","time spent":"1.288856162s","remote":"127.0.0.1:48528","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":30,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "}
{"level":"warn","ts":"2026-04-22T00:46:32.463238Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:46:28.831652Z","time spent":"3.631576841s","remote":"127.0.0.1:34312","response type":"/etcdserverpb.KV/Range","request count":0,"request size":84,"response count":14,"response size":30,"request content":"key:\"/registry/cert-manager.io/certificates/\" range_end:\"/registry/cert-manager.io/certificates0\" count_only:true "}
{"level":"info","ts":"2026-04-22T00:46:32.46325Z","caller":"traceutil/trace.go:171","msg":"trace[1417306415] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:9347; }","duration":"4.439910419s","start":"2026-04-22T00:46:28.023333Z","end":"2026-04-22T00:46:32.463244Z","steps":["trace[1417306415] 'agreement among raft nodes before linearized reading'  (duration: 4.439787286s)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:46:32.463147Z","caller":"traceutil/trace.go:171","msg":"trace[292347581] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:9347; }","duration":"5.009062521s","start":"2026-04-22T00:46:27.454068Z","end":"2026-04-22T00:46:32.46313Z","steps":["trace[292347581] 'agreement among raft nodes before linearized reading'  (duration: 5.008970918s)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:46:32.463272Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:46:28.023302Z","time spent":"4.439964111s","remote":"127.0.0.1:43872","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":107,"response size":30,"request content":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true "}
{"level":"warn","ts":"2026-04-22T00:46:32.463255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.589328473s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusterbackups/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusterbackups0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-04-22T00:46:32.462954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"5.007847008s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"}
{"level":"info","ts":"2026-04-22T00:46:32.463379Z","caller":"traceutil/trace.go:171","msg":"trace[539917907] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:9347; }","duration":"5.008301721s","start":"2026-04-22T00:46:27.455068Z","end":"2026-04-22T00:46:32.46337Z","steps":["trace[539917907] 'agreement among raft nodes before linearized reading'  (duration: 5.007825987s)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:46:32.463374Z","caller":"traceutil/trace.go:171","msg":"trace[915684242] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusterbackups/; range_end:/registry/pxc.percona.com/perconaxtradbclusterbackups0; response_count:0; response_revision:9347; }","duration":"2.589621791s","start":"2026-04-22T00:46:29.873725Z","end":"2026-04-22T00:46:32.463347Z","steps":["trace[915684242] 'agreement among raft nodes before linearized reading'  (duration: 2.589100395s)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:46:32.463399Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.092194634s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/glance-api-68745fddc7-t7w4j.18a8873eb1a404b4\" ","response":"range_response_count:1 size:787"}
{"level":"warn","ts":"2026-04-22T00:46:32.463307Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:46:27.454057Z","time spent":"5.009238426s","remote":"127.0.0.1:44058","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":579,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "}
{"level":"warn","ts":"2026-04-22T00:46:32.463224Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:46:27.454507Z","time spent":"5.008709351s","remote":"127.0.0.1:44058","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-04-22T00:46:32.463085Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:46:29.704263Z","time spent":"2.758809781s","remote":"127.0.0.1:54108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":28,"request content":"key:\"/registry/ceph.rook.io/cephrbdmirrors/\" range_end:\"/registry/ceph.rook.io/cephrbdmirrors0\" count_only:true "}
{"level":"info","ts":"2026-04-22T00:46:32.463179Z","caller":"traceutil/trace.go:171","msg":"trace[1534051275] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:9347; }","duration":"1.354312421s","start":"2026-04-22T00:46:31.108859Z","end":"2026-04-22T00:46:32.463171Z","steps":["trace[1534051275] 'agreement among raft nodes before linearized reading'  (duration: 1.35426458s)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:46:32.463445Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:46:29.873704Z","time spent":"2.589725703s","remote":"127.0.0.1:56082","response type":"/etcdserverpb.KV/Range","request count":0,"request size":114,"response count":0,"response size":28,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusterbackups/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusterbackups0\" count_only:true "}
{"level":"warn","ts":"2026-04-22T00:46:32.462844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.999552844s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-c4tqx\" ","response":"range_response_count:1 size:6530"}
{"level":"info","ts":"2026-04-22T00:46:32.463487Z","caller":"traceutil/trace.go:171","msg":"trace[1047642020] range","detail":"{range_begin:/registry/events/openstack/glance-api-68745fddc7-t7w4j.18a8873eb1a404b4; range_end:; response_count:1; response_revision:9347; }","duration":"4.092276307s","start":"2026-04-22T00:46:28.371144Z","end":"2026-04-22T00:46:32.463421Z","steps":["trace[1047642020] 'agreement among raft nodes before linearized reading'  (duration: 4.091561656s)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:46:32.463487Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:46:31.108841Z","time spent":"1.354636461s","remote":"127.0.0.1:43770","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-04-22T00:46:32.463508Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:46:28.371125Z","time spent":"4.092376879s","remote":"127.0.0.1:43860","response type":"/etcdserverpb.KV/Range","request count":0,"request size":73,"response count":1,"response size":810,"request content":"key:\"/registry/events/openstack/glance-api-68745fddc7-t7w4j.18a8873eb1a404b4\" "}
{"level":"info","ts":"2026-04-22T00:46:32.463509Z","caller":"traceutil/trace.go:171","msg":"trace[324786571] range","detail":"{range_begin:/registry/pods/openstack/keepalived-c4tqx; range_end:; response_count:1; response_revision:9347; }","duration":"5.000255284s","start":"2026-04-22T00:46:27.463236Z","end":"2026-04-22T00:46:32.463491Z","steps":["trace[324786571] 'agreement among raft nodes before linearized reading'  (duration: 4.99944256s)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:46:32.463102Z","caller":"traceutil/trace.go:171","msg":"trace[1484679708] range","detail":"{range_begin:/registry/ceph.rook.io/cephclusters/; range_end:/registry/ceph.rook.io/cephclusters0; response_count:0; response_revision:9347; }","duration":"3.764358979s","start":"2026-04-22T00:46:28.698732Z","end":"2026-04-22T00:46:32.463091Z","steps":["trace[1484679708] 'agreement among raft nodes before linearized reading'  (duration: 3.764269406s)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:46:32.463565Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:46:28.698714Z","time spent":"3.764844692s","remote":"127.0.0.1:54034","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":30,"request content":"key:\"/registry/ceph.rook.io/cephclusters/\" range_end:\"/registry/ceph.rook.io/cephclusters0\" count_only:true "}
{"level":"warn","ts":"2026-04-22T00:46:32.463562Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:46:27.46322Z","time spent":"5.000327266s","remote":"127.0.0.1:43970","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6553,"request content":"key:\"/registry/pods/openstack/keepalived-c4tqx\" "}
{"level":"warn","ts":"2026-04-22T00:46:32.463408Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:46:27.455052Z","time spent":"5.008345261s","remote":"127.0.0.1:44058","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-04-22T00:46:32.463089Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:46:30.660639Z","time spent":"1.802440245s","remote":"127.0.0.1:56028","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":30,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "}
{"level":"warn","ts":"2026-04-22T00:46:32.463089Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.894527145s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"}
{"level":"info","ts":"2026-04-22T00:46:32.463639Z","caller":"traceutil/trace.go:171","msg":"trace[303850819] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:9347; }","duration":"3.895113901s","start":"2026-04-22T00:46:28.568517Z","end":"2026-04-22T00:46:32.463631Z","steps":["trace[303850819] 'agreement among raft nodes before linearized reading'  (duration: 3.894500244s)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:46:32.463189Z","caller":"traceutil/trace.go:171","msg":"trace[1505067355] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-rgw-ceph-a-699b8bdb59-sls54; range_end:; response_count:1; response_revision:9347; }","duration":"4.44243458s","start":"2026-04-22T00:46:28.020745Z","end":"2026-04-22T00:46:32.46318Z","steps":["trace[1505067355] 'agreement among raft nodes before linearized reading'  (duration: 4.442376169s)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:46:32.463672Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:46:28.568496Z","time spent":"3.895167082s","remote":"127.0.0.1:43970","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12236,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "}
{"level":"warn","ts":"2026-04-22T00:46:32.463697Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:46:28.020729Z","time spent":"4.442938814s","remote":"127.0.0.1:43970","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":19712,"request content":"key:\"/registry/pods/openstack/rook-ceph-rgw-ceph-a-699b8bdb59-sls54\" "}
{"level":"warn","ts":"2026-04-22T00:46:32.463827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.496447433s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-04-22T00:46:32.463888Z","caller":"traceutil/trace.go:171","msg":"trace[1723768961] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:9347; }","duration":"2.496546246s","start":"2026-04-22T00:46:29.967332Z","end":"2026-04-22T00:46:32.463878Z","steps":["trace[1723768961] 'agreement among raft nodes before linearized reading'  (duration: 2.496273988s)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:46:32.463913Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.519452109s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-04-22T00:46:32.463987Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:46:29.96731Z","time spent":"2.496641819s","remote":"127.0.0.1:43994","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":128,"response size":31,"request content":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true "}
{"level":"info","ts":"2026-04-22T00:46:32.463985Z","caller":"traceutil/trace.go:171","msg":"trace[1372256961] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:9347; }","duration":"1.519571772s","start":"2026-04-22T00:46:30.944397Z","end":"2026-04-22T00:46:32.463969Z","steps":["trace[1372256961] 'agreement among raft nodes before linearized reading'  (duration: 1.518383248s)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:46:32.464318Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:46:30.944378Z","time spent":"1.519929983s","remote":"127.0.0.1:44002","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":28,"request content":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true "}
{"level":"info","ts":"2026-04-22T00:46:32.611301Z","caller":"traceutil/trace.go:171","msg":"trace[542122453] transaction","detail":"{read_only:false; response_revision:9349; number_of_response:1; }","duration":"141.844002ms","start":"2026-04-22T00:46:32.469427Z","end":"2026-04-22T00:46:32.611271Z","steps":["trace[542122453] 'process raft request'  (duration: 105.76324ms)","trace[542122453] 'compare'  (duration: 35.888517ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T00:46:32.611592Z","caller":"traceutil/trace.go:171","msg":"trace[56497976] transaction","detail":"{read_only:false; response_revision:9350; number_of_response:1; }","duration":"142.000807ms","start":"2026-04-22T00:46:32.46958Z","end":"2026-04-22T00:46:32.611581Z","steps":["trace[56497976] 'process raft request'  (duration: 141.643007ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:46:32.611697Z","caller":"traceutil/trace.go:171","msg":"trace[792278966] linearizableReadLoop","detail":"{readStateIndex:9680; appliedIndex:9676; }","duration":"117.314304ms","start":"2026-04-22T00:46:32.49436Z","end":"2026-04-22T00:46:32.611675Z","steps":["trace[792278966] 'read index received'  (duration: 80.84101ms)","trace[792278966] 'applied index is now lower than readState.Index'  (duration: 36.472294ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T00:46:32.611718Z","caller":"traceutil/trace.go:171","msg":"trace[333833020] transaction","detail":"{read_only:false; response_revision:9351; number_of_response:1; }","duration":"139.848998ms","start":"2026-04-22T00:46:32.471844Z","end":"2026-04-22T00:46:32.611693Z","steps":["trace[333833020] 'process raft request'  (duration: 139.630771ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:46:32.611859Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.853237ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-04-22T00:46:32.611978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.099067ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:481"}
{"level":"info","ts":"2026-04-22T00:46:32.612021Z","caller":"traceutil/trace.go:171","msg":"trace[175372280] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:9352; }","duration":"144.167078ms","start":"2026-04-22T00:46:32.467843Z","end":"2026-04-22T00:46:32.61201Z","steps":["trace[175372280] 'agreement among raft nodes before linearized reading'  (duration: 144.003844ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:46:32.612005Z","caller":"traceutil/trace.go:171","msg":"trace[2085116427] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:9352; }","duration":"139.997781ms","start":"2026-04-22T00:46:32.471958Z","end":"2026-04-22T00:46:32.611956Z","steps":["trace[2085116427] 'agreement among raft nodes before linearized reading'  (duration: 139.837276ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:46:32.612104Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.476206ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/kube-apiserver-instance.18a8873dbd6f8cd6\" ","response":"range_response_count:1 size:774"}
{"level":"info","ts":"2026-04-22T00:46:32.612158Z","caller":"traceutil/trace.go:171","msg":"trace[893471803] range","detail":"{range_begin:/registry/events/kube-system/kube-apiserver-instance.18a8873dbd6f8cd6; range_end:; response_count:1; response_revision:9352; }","duration":"113.552569ms","start":"2026-04-22T00:46:32.498592Z","end":"2026-04-22T00:46:32.612144Z","steps":["trace[893471803] 'agreement among raft nodes before linearized reading'  (duration: 113.400885ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:46:32.612191Z","caller":"traceutil/trace.go:171","msg":"trace[855247579] transaction","detail":"{read_only:false; response_revision:9352; number_of_response:1; }","duration":"135.171315ms","start":"2026-04-22T00:46:32.477006Z","end":"2026-04-22T00:46:32.612177Z","steps":["trace[855247579] 'process raft request'  (duration: 134.594279ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:46:32.612289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.549269ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:31 size:291270"}
{"level":"info","ts":"2026-04-22T00:46:32.612342Z","caller":"traceutil/trace.go:171","msg":"trace[468983482] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:31; response_revision:9352; }","duration":"144.624601ms","start":"2026-04-22T00:46:32.467705Z","end":"2026-04-22T00:46:32.612329Z","steps":["trace[468983482] 'agreement among raft nodes before linearized reading'  (duration: 144.200869ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:46:32.612586Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.815577ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"}
{"level":"info","ts":"2026-04-22T00:46:32.61265Z","caller":"traceutil/trace.go:171","msg":"trace[760895238] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:9352; }","duration":"144.892589ms","start":"2026-04-22T00:46:32.467746Z","end":"2026-04-22T00:46:32.612639Z","steps":["trace[760895238] 'agreement among raft nodes before linearized reading'  (duration: 144.635222ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:46:37.060433Z","caller":"traceutil/trace.go:171","msg":"trace[1133930856] transaction","detail":"{read_only:false; response_revision:9374; number_of_response:1; }","duration":"149.561331ms","start":"2026-04-22T00:46:36.910841Z","end":"2026-04-22T00:46:37.060402Z","steps":["trace[1133930856] 'process raft request'  (duration: 80.365627ms)","trace[1133930856] 'compare'  (duration: 69.04638ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-22T00:46:37.722425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.779183ms","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:5"}
{"level":"info","ts":"2026-04-22T00:46:37.72252Z","caller":"traceutil/trace.go:171","msg":"trace[467849724] range","detail":"{range_begin:/registry/ceph.rook.io/cephblockpoolradosnamespaces/; range_end:/registry/ceph.rook.io/cephblockpoolradosnamespaces0; response_count:0; response_revision:9375; }","duration":"109.940597ms","start":"2026-04-22T00:46:37.612559Z","end":"2026-04-22T00:46:37.722499Z","steps":["trace[467849724] 'count revisions from in-memory index tree'  (duration: 109.67739ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:46:49.923881Z","caller":"traceutil/trace.go:171","msg":"trace[1427158031] transaction","detail":"{read_only:false; response_revision:9472; number_of_response:1; }","duration":"164.307483ms","start":"2026-04-22T00:46:49.759528Z","end":"2026-04-22T00:46:49.923836Z","steps":["trace[1427158031] 'process raft request'  (duration: 140.709831ms)","trace[1427158031] 'compare'  (duration: 23.146519ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T00:46:50.124253Z","caller":"traceutil/trace.go:171","msg":"trace[2101963422] transaction","detail":"{read_only:false; response_revision:9473; number_of_response:1; }","duration":"192.071424ms","start":"2026-04-22T00:46:49.932126Z","end":"2026-04-22T00:46:50.124198Z","steps":["trace[2101963422] 'process raft request'  (duration: 163.226714ms)","trace[2101963422] 'compare'  (duration: 28.715546ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T00:46:50.331606Z","caller":"traceutil/trace.go:171","msg":"trace[1474874616] linearizableReadLoop","detail":"{readStateIndex:9805; appliedIndex:9804; }","duration":"194.246804ms","start":"2026-04-22T00:46:50.137328Z","end":"2026-04-22T00:46:50.331575Z","steps":["trace[1474874616] 'read index received'  (duration: 167.132472ms)","trace[1474874616] 'applied index is now lower than readState.Index'  (duration: 27.113312ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T00:46:50.331775Z","caller":"traceutil/trace.go:171","msg":"trace[744941183] transaction","detail":"{read_only:false; response_revision:9474; number_of_response:1; }","duration":"202.621909ms","start":"2026-04-22T00:46:50.129095Z","end":"2026-04-22T00:46:50.331717Z","steps":["trace[744941183] 'process raft request'  (duration: 175.422415ms)","trace[744941183] 'compare'  (duration: 26.894336ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-22T00:46:50.33211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.110613ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectrealms/\" range_end:\"/registry/ceph.rook.io/cephobjectrealms0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-04-22T00:46:50.332099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.741618ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/glance-ks-service\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-22T00:46:50.332353Z","caller":"traceutil/trace.go:171","msg":"trace[185283197] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectrealms/; range_end:/registry/ceph.rook.io/cephobjectrealms0; response_count:0; response_revision:9474; }","duration":"120.413561ms","start":"2026-04-22T00:46:50.211923Z","end":"2026-04-22T00:46:50.332337Z","steps":["trace[185283197] 'agreement among raft nodes before linearized reading'  (duration: 120.059541ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:46:50.332497Z","caller":"traceutil/trace.go:171","msg":"trace[845309944] range","detail":"{range_begin:/registry/jobs/openstack/glance-ks-service; range_end:; response_count:0; response_revision:9474; }","duration":"195.068377ms","start":"2026-04-22T00:46:50.137285Z","end":"2026-04-22T00:46:50.332354Z","steps":["trace[845309944] 'agreement among raft nodes before linearized reading'  (duration: 194.694786ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:46:50.720135Z","caller":"traceutil/trace.go:171","msg":"trace[1961744497] linearizableReadLoop","detail":"{readStateIndex:9806; appliedIndex:9805; }","duration":"283.182832ms","start":"2026-04-22T00:46:50.436927Z","end":"2026-04-22T00:46:50.72011Z","steps":["trace[1961744497] 'read index received'  (duration: 283.003817ms)","trace[1961744497] 'applied index is now lower than readState.Index'  (duration: 177.685µs)"],"step_count":2}
{"level":"info","ts":"2026-04-22T00:46:50.720196Z","caller":"traceutil/trace.go:171","msg":"trace[1197688934] transaction","detail":"{read_only:false; response_revision:9475; number_of_response:1; }","duration":"348.911649ms","start":"2026-04-22T00:46:50.371256Z","end":"2026-04-22T00:46:50.720168Z","steps":["trace[1197688934] 'process raft request'  (duration: 348.621751ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:46:50.720314Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.372427ms","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:5"}
{"level":"warn","ts":"2026-04-22T00:46:50.720366Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:46:50.371211Z","time spent":"349.050702ms","remote":"127.0.0.1:43872","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":65954,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/secrets/openstack/sh.helm.release.v1.glance.v1\" mod_revision:9404 > success:<request_put:<key:\"/registry/secrets/openstack/sh.helm.release.v1.glance.v1\" value_size:65888 >> failure:<request_range:<key:\"/registry/secrets/openstack/sh.helm.release.v1.glance.v1\" > >"}
{"level":"info","ts":"2026-04-22T00:46:50.720382Z","caller":"traceutil/trace.go:171","msg":"trace[451022149] range","detail":"{range_begin:/registry/secretgen.k14s.io/rsakeys/; range_end:/registry/secretgen.k14s.io/rsakeys0; response_count:0; response_revision:9475; }","duration":"283.511741ms","start":"2026-04-22T00:46:50.436853Z","end":"2026-04-22T00:46:50.720365Z","steps":["trace[451022149] 'agreement among raft nodes before linearized reading'  (duration: 283.362337ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:46:50.74622Z","caller":"traceutil/trace.go:171","msg":"trace[758596883] transaction","detail":"{read_only:false; response_revision:9478; number_of_response:1; }","duration":"230.380229ms","start":"2026-04-22T00:46:50.515804Z","end":"2026-04-22T00:46:50.746184Z","steps":["trace[758596883] 'process raft request'  (duration: 230.281616ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:46:50.746281Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.883536ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"warn","ts":"2026-04-22T00:46:50.746324Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.533235ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"warn","ts":"2026-04-22T00:46:50.746324Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.069304ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"}
{"level":"info","ts":"2026-04-22T00:46:50.746331Z","caller":"traceutil/trace.go:171","msg":"trace[1827370692] transaction","detail":"{read_only:false; response_revision:9476; number_of_response:1; }","duration":"274.433477ms","start":"2026-04-22T00:46:50.471857Z","end":"2026-04-22T00:46:50.746291Z","steps":["trace[1827370692] 'process raft request'  (duration: 274.059997ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:46:50.746355Z","caller":"traceutil/trace.go:171","msg":"trace[242149555] transaction","detail":"{read_only:false; response_revision:9477; number_of_response:1; }","duration":"230.557554ms","start":"2026-04-22T00:46:50.515774Z","end":"2026-04-22T00:46:50.746331Z","steps":["trace[242149555] 'process raft request'  (duration: 230.270616ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:46:50.746383Z","caller":"traceutil/trace.go:171","msg":"trace[977914287] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:9478; }","duration":"182.671899ms","start":"2026-04-22T00:46:50.563696Z","end":"2026-04-22T00:46:50.746368Z","steps":["trace[977914287] 'agreement among raft nodes before linearized reading'  (duration: 182.519115ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:46:50.746406Z","caller":"traceutil/trace.go:171","msg":"trace[1704837591] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:9478; }","duration":"171.188048ms","start":"2026-04-22T00:46:50.575194Z","end":"2026-04-22T00:46:50.746382Z","steps":["trace[1704837591] 'agreement among raft nodes before linearized reading'  (duration: 171.001462ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:46:50.74636Z","caller":"traceutil/trace.go:171","msg":"trace[688070702] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:9478; }","duration":"188.008749ms","start":"2026-04-22T00:46:50.558331Z","end":"2026-04-22T00:46:50.74634Z","steps":["trace[688070702] 'agreement among raft nodes before linearized reading'  (duration: 187.803204ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:46:50.975085Z","caller":"traceutil/trace.go:171","msg":"trace[1217953860] linearizableReadLoop","detail":"{readStateIndex:9810; appliedIndex:9809; }","duration":"226.180071ms","start":"2026-04-22T00:46:50.748874Z","end":"2026-04-22T00:46:50.975054Z","steps":["trace[1217953860] 'read index received'  (duration: 168.018888ms)","trace[1217953860] 'applied index is now lower than readState.Index'  (duration: 58.159413ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T00:46:50.975177Z","caller":"traceutil/trace.go:171","msg":"trace[1644592031] transaction","detail":"{read_only:false; response_revision:9479; number_of_response:1; }","duration":"244.663761ms","start":"2026-04-22T00:46:50.730479Z","end":"2026-04-22T00:46:50.975143Z","steps":["trace[1644592031] 'process raft request'  (duration: 186.387494ms)","trace[1644592031] 'compare'  (duration: 57.714891ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-22T00:46:50.975695Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.806389ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"}
{"level":"info","ts":"2026-04-22T00:46:50.975799Z","caller":"traceutil/trace.go:171","msg":"trace[493238928] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:9479; }","duration":"226.942892ms","start":"2026-04-22T00:46:50.748838Z","end":"2026-04-22T00:46:50.975781Z","steps":["trace[493238928] 'agreement among raft nodes before linearized reading'  (duration: 226.355306ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:46:50.995098Z","caller":"traceutil/trace.go:171","msg":"trace[599625406] transaction","detail":"{read_only:false; response_revision:9480; number_of_response:1; }","duration":"244.000712ms","start":"2026-04-22T00:46:50.751073Z","end":"2026-04-22T00:46:50.995074Z","steps":["trace[599625406] 'process raft request'  (duration: 243.839597ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:46:50.995507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.986837ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"warn","ts":"2026-04-22T00:46:50.995522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.587302ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"}
{"level":"info","ts":"2026-04-22T00:46:50.995537Z","caller":"traceutil/trace.go:171","msg":"trace[1227890582] transaction","detail":"{read_only:false; response_revision:9482; number_of_response:1; }","duration":"244.160816ms","start":"2026-04-22T00:46:50.751359Z","end":"2026-04-22T00:46:50.995519Z","steps":["trace[1227890582] 'process raft request'  (duration: 243.911329ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:46:50.995585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.715517ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"}
{"level":"info","ts":"2026-04-22T00:46:50.995594Z","caller":"traceutil/trace.go:171","msg":"trace[514365172] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:9482; }","duration":"175.704715ms","start":"2026-04-22T00:46:50.819871Z","end":"2026-04-22T00:46:50.995576Z","steps":["trace[514365172] 'agreement among raft nodes before linearized reading'  (duration: 175.5179ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:46:50.995642Z","caller":"traceutil/trace.go:171","msg":"trace[1928389948] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:9482; }","duration":"174.800478ms","start":"2026-04-22T00:46:50.820827Z","end":"2026-04-22T00:46:50.995627Z","steps":["trace[1928389948] 'agreement among raft nodes before linearized reading'  (duration: 174.655534ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:46:50.995581Z","caller":"traceutil/trace.go:171","msg":"trace[299403803] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/; range_end:/registry/mutatingwebhookconfigurations0; response_count:0; response_revision:9482; }","duration":"153.117ms","start":"2026-04-22T00:46:50.842444Z","end":"2026-04-22T00:46:50.995561Z","steps":["trace[299403803] 'agreement among raft nodes before linearized reading'  (duration: 152.948476ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:46:50.995604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.064812ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-c4tqx\" ","response":"range_response_count:1 size:6530"}
{"level":"info","ts":"2026-04-22T00:46:50.995794Z","caller":"traceutil/trace.go:171","msg":"trace[640199800] range","detail":"{range_begin:/registry/pods/openstack/keepalived-c4tqx; range_end:; response_count:1; response_revision:9482; }","duration":"172.282728ms","start":"2026-04-22T00:46:50.823496Z","end":"2026-04-22T00:46:50.995779Z","steps":["trace[640199800] 'agreement among raft nodes before linearized reading'  (duration: 171.954479ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:46:50.995824Z","caller":"traceutil/trace.go:171","msg":"trace[2007547751] transaction","detail":"{read_only:false; response_revision:9481; number_of_response:1; }","duration":"244.28895ms","start":"2026-04-22T00:46:50.751149Z","end":"2026-04-22T00:46:50.995437Z","steps":["trace[2007547751] 'process raft request'  (duration: 243.889829ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:46:51.188298Z","caller":"traceutil/trace.go:171","msg":"trace[1232090999] transaction","detail":"{read_only:false; response_revision:9484; number_of_response:1; }","duration":"205.540703ms","start":"2026-04-22T00:46:50.982727Z","end":"2026-04-22T00:46:51.188268Z","steps":["trace[1232090999] 'process raft request'  (duration: 205.465281ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:46:51.188349Z","caller":"traceutil/trace.go:171","msg":"trace[1114844793] transaction","detail":"{read_only:false; response_revision:9483; number_of_response:1; }","duration":"208.226357ms","start":"2026-04-22T00:46:50.98009Z","end":"2026-04-22T00:46:51.188317Z","steps":["trace[1114844793] 'process raft request'  (duration: 192.32099ms)","trace[1114844793] 'compare'  (duration: 15.64403ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T00:46:51.423893Z","caller":"traceutil/trace.go:171","msg":"trace[687790295] linearizableReadLoop","detail":"{readStateIndex:9817; appliedIndex:9813; }","duration":"423.348417ms","start":"2026-04-22T00:46:51.000521Z","end":"2026-04-22T00:46:51.42387Z","steps":["trace[687790295] 'read index received'  (duration: 172.05244ms)","trace[687790295] 'applied index is now lower than readState.Index'  (duration: 251.294787ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T00:46:51.424004Z","caller":"traceutil/trace.go:171","msg":"trace[1905669000] transaction","detail":"{read_only:false; response_revision:9485; number_of_response:1; }","duration":"424.061457ms","start":"2026-04-22T00:46:50.99993Z","end":"2026-04-22T00:46:51.423991Z","steps":["trace[1905669000] 'process raft request'  (duration: 401.257597ms)","trace[1905669000] 'compare'  (duration: 22.06242ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-22T00:46:51.424101Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:46:50.999911Z","time spent":"424.117908ms","remote":"127.0.0.1:44058","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:9470 > 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-04-22T00:46:51.424143Z","caller":"traceutil/trace.go:171","msg":"trace[1172835682] transaction","detail":"{read_only:false; response_revision:9486; number_of_response:1; }","duration":"423.80353ms","start":"2026-04-22T00:46:51.000313Z","end":"2026-04-22T00:46:51.424116Z","steps":["trace[1172835682] 'process raft request'  (duration: 423.45801ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:46:51.42428Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:46:51.00029Z","time spent":"423.915043ms","remote":"127.0.0.1:44058","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:9469 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-04-22T00:46:51.424598Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"424.056487ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:33 size:304478"}
{"level":"info","ts":"2026-04-22T00:46:51.424666Z","caller":"traceutil/trace.go:171","msg":"trace[333458300] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:33; response_revision:9486; }","duration":"424.154339ms","start":"2026-04-22T00:46:51.000494Z","end":"2026-04-22T00:46:51.424649Z","steps":["trace[333458300] 'agreement among raft nodes before linearized reading'  (duration: 423.651796ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:46:51.424707Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:46:51.000483Z","time spent":"424.214071ms","remote":"127.0.0.1:43970","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":33,"response size":304501,"request content":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" "}
{"level":"info","ts":"2026-04-22T00:46:51.652011Z","caller":"traceutil/trace.go:171","msg":"trace[1980270831] linearizableReadLoop","detail":"{readStateIndex:9820; appliedIndex:9817; }","duration":"228.020093ms","start":"2026-04-22T00:46:51.423958Z","end":"2026-04-22T00:46:51.651978Z","steps":["trace[1980270831] 'read index received'  (duration: 227.572631ms)","trace[1980270831] 'applied index is now lower than readState.Index'  (duration: 445.652µs)"],"step_count":2}
{"level":"info","ts":"2026-04-22T00:46:51.652186Z","caller":"traceutil/trace.go:171","msg":"trace[1916899091] transaction","detail":"{read_only:false; response_revision:9489; number_of_response:1; }","duration":"455.763008ms","start":"2026-04-22T00:46:51.196409Z","end":"2026-04-22T00:46:51.652172Z","steps":["trace[1916899091] 'process raft request'  (duration: 455.49521ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:46:51.652308Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:46:51.1964Z","time spent":"455.810689ms","remote":"127.0.0.1:44026","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6293,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/jobs/openstack/glance-ks-service\" mod_revision:9479 > success:<request_put:<key:\"/registry/jobs/openstack/glance-ks-service\" value_size:6243 >> failure:<request_range:<key:\"/registry/jobs/openstack/glance-ks-service\" > >"}
{"level":"warn","ts":"2026-04-22T00:46:51.652378Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"552.841003ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-22T00:46:51.652375Z","caller":"traceutil/trace.go:171","msg":"trace[1690022169] transaction","detail":"{read_only:false; response_revision:9487; number_of_response:1; }","duration":"459.309596ms","start":"2026-04-22T00:46:51.193023Z","end":"2026-04-22T00:46:51.652333Z","steps":["trace[1690022169] 'process raft request'  (duration: 458.506484ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:46:51.652466Z","caller":"traceutil/trace.go:171","msg":"trace[1565204936] transaction","detail":"{read_only:false; response_revision:9488; number_of_response:1; }","duration":"459.42205ms","start":"2026-04-22T00:46:51.193017Z","end":"2026-04-22T00:46:51.652439Z","steps":["trace[1565204936] 'process raft request'  (duration: 458.789382ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:46:51.652589Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:46:51.192997Z","time spent":"459.505903ms","remote":"127.0.0.1:43860","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":675,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/events/openstack/glance-ks-service.18a8874b77400123\" mod_revision:0 > success:<request_put:<key:\"/registry/events/openstack/glance-ks-service.18a8874b77400123\" value_size:596 lease:3415872232754398740 >> failure:<>"}
{"level":"warn","ts":"2026-04-22T00:46:51.652602Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:46:51.192984Z","time spent":"459.542714ms","remote":"127.0.0.1:43970","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6532,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/openstack/glance-ks-service-r4jf5\" mod_revision:9484 > success:<request_put:<key:\"/registry/pods/openstack/glance-ks-service-r4jf5\" value_size:6476 >> failure:<request_range:<key:\"/registry/pods/openstack/glance-ks-service-r4jf5\" > >"}
{"level":"warn","ts":"2026-04-22T00:46:51.65275Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"582.512688ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.carvel.dev/secretimports/\" range_end:\"/registry/secretgen.carvel.dev/secretimports0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-22T00:46:51.652439Z","caller":"traceutil/trace.go:171","msg":"trace[2062351429] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:9489; }","duration":"552.940307ms","start":"2026-04-22T00:46:51.099485Z","end":"2026-04-22T00:46:51.652425Z","steps":["trace[2062351429] 'agreement among raft nodes before linearized reading'  (duration: 552.812542ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:46:51.652784Z","caller":"traceutil/trace.go:171","msg":"trace[1511006373] range","detail":"{range_begin:/registry/secretgen.carvel.dev/secretimports/; range_end:/registry/secretgen.carvel.dev/secretimports0; response_count:0; response_revision:9489; }","duration":"582.58879ms","start":"2026-04-22T00:46:51.070186Z","end":"2026-04-22T00:46:51.652775Z","steps":["trace[1511006373] 'agreement among raft nodes before linearized reading'  (duration: 582.527818ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:46:51.652793Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:46:51.099464Z","time spent":"553.320618ms","remote":"127.0.0.1:43770","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-04-22T00:46:51.652807Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:46:51.070158Z","time spent":"582.643161ms","remote":"127.0.0.1:32836","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":28,"request content":"key:\"/registry/secretgen.carvel.dev/secretimports/\" range_end:\"/registry/secretgen.carvel.dev/secretimports0\" count_only:true "}
{"level":"warn","ts":"2026-04-22T00:46:51.652909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"500.867895ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/nfd.k8s-sigs.io/nodefeaturerules/\" range_end:\"/registry/nfd.k8s-sigs.io/nodefeaturerules0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-22T00:46:51.652973Z","caller":"traceutil/trace.go:171","msg":"trace[893125336] range","detail":"{range_begin:/registry/nfd.k8s-sigs.io/nodefeaturerules/; range_end:/registry/nfd.k8s-sigs.io/nodefeaturerules0; response_count:0; response_revision:9489; }","duration":"501.004589ms","start":"2026-04-22T00:46:51.151955Z","end":"2026-04-22T00:46:51.65296Z","steps":["trace[893125336] 'agreement among raft nodes before linearized reading'  (duration: 500.904856ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:46:51.652997Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:46:51.151934Z","time spent":"501.058ms","remote":"127.0.0.1:32798","response type":"/etcdserverpb.KV/Range","request count":0,"request size":92,"response count":0,"response size":28,"request content":"key:\"/registry/nfd.k8s-sigs.io/nodefeaturerules/\" range_end:\"/registry/nfd.k8s-sigs.io/nodefeaturerules0\" count_only:true "}
{"level":"warn","ts":"2026-04-22T00:46:51.654764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"480.095561ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/nfd.k8s-sigs.io/nodefeatures/monitoring/instance\" ","response":"range_response_count:1 size:414544"}
{"level":"info","ts":"2026-04-22T00:46:51.655005Z","caller":"traceutil/trace.go:171","msg":"trace[1957666202] range","detail":"{range_begin:/registry/nfd.k8s-sigs.io/nodefeatures/monitoring/instance; range_end:; response_count:1; response_revision:9489; }","duration":"480.378139ms","start":"2026-04-22T00:46:51.174614Z","end":"2026-04-22T00:46:51.654993Z","steps":["trace[1957666202] 'agreement among raft nodes before linearized reading'  (duration: 477.840689ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:46:51.655104Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:46:51.174595Z","time spent":"480.496832ms","remote":"127.0.0.1:32796","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":414567,"request content":"key:\"/registry/nfd.k8s-sigs.io/nodefeatures/monitoring/instance\" "}
{"level":"info","ts":"2026-04-22T00:46:52.162763Z","caller":"traceutil/trace.go:171","msg":"trace[493512553] transaction","detail":"{read_only:false; response_revision:9492; number_of_response:1; }","duration":"153.160301ms","start":"2026-04-22T00:46:52.00958Z","end":"2026-04-22T00:46:52.16274Z","steps":["trace[493512553] 'process raft request'  (duration: 152.822412ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:46:52.475048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.943563ms","expected-duration":"100ms","prefix":"","request":"header:<ID:3415872232754399649 > lease_revoke:<id:2f679db297724883>","response":"size:28"}
{"level":"info","ts":"2026-04-22T00:46:52.475281Z","caller":"traceutil/trace.go:171","msg":"trace[1108975557] linearizableReadLoop","detail":"{readStateIndex:9825; appliedIndex:9823; }","duration":"100.512693ms","start":"2026-04-22T00:46:52.37475Z","end":"2026-04-22T00:46:52.475262Z","steps":["trace[1108975557] 'read index received'  (duration: 57.373711ms)","trace[1108975557] 'applied index is now lower than readState.Index'  (duration: 43.137922ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T00:46:52.475408Z","caller":"traceutil/trace.go:171","msg":"trace[607260348] transaction","detail":"{read_only:false; response_revision:9493; number_of_response:1; }","duration":"164.86587ms","start":"2026-04-22T00:46:52.31051Z","end":"2026-04-22T00:46:52.475375Z","steps":["trace[607260348] 'process raft request'  (duration: 164.641584ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:46:52.475555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.797451ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-04-22T00:46:52.475592Z","caller":"traceutil/trace.go:171","msg":"trace[1453641686] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:9493; }","duration":"100.883334ms","start":"2026-04-22T00:46:52.374698Z","end":"2026-04-22T00:46:52.475581Z","steps":["trace[1453641686] 'agreement among raft nodes before linearized reading'  (duration: 100.75055ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:46:52.663272Z","caller":"traceutil/trace.go:171","msg":"trace[1237677811] linearizableReadLoop","detail":"{readStateIndex:9826; appliedIndex:9825; }","duration":"149.59878ms","start":"2026-04-22T00:46:52.513644Z","end":"2026-04-22T00:46:52.663243Z","steps":["trace[1237677811] 'read index received'  (duration: 102.379454ms)","trace[1237677811] 'applied index is now lower than readState.Index'  (duration: 47.218126ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T00:46:52.663379Z","caller":"traceutil/trace.go:171","msg":"trace[1216271354] transaction","detail":"{read_only:false; response_revision:9494; number_of_response:1; }","duration":"178.215684ms","start":"2026-04-22T00:46:52.485113Z","end":"2026-04-22T00:46:52.663329Z","steps":["trace[1216271354] 'process raft request'  (duration: 130.885554ms)","trace[1216271354] 'compare'  (duration: 47.102643ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-22T00:46:52.663494Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.308054ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-04-22T00:46:52.66356Z","caller":"traceutil/trace.go:171","msg":"trace[1042855070] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; response_count:0; response_revision:9494; }","duration":"122.426958ms","start":"2026-04-22T00:46:52.541116Z","end":"2026-04-22T00:46:52.663543Z","steps":["trace[1042855070] 'agreement among raft nodes before linearized reading'  (duration: 122.284574ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:46:52.663748Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.057555ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:559"}
{"level":"info","ts":"2026-04-22T00:46:52.663842Z","caller":"traceutil/trace.go:171","msg":"trace[1588104238] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:9494; }","duration":"150.193138ms","start":"2026-04-22T00:46:52.513625Z","end":"2026-04-22T00:46:52.663818Z","steps":["trace[1588104238] 'agreement among raft nodes before linearized reading'  (duration: 149.718694ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:46:52.946469Z","caller":"traceutil/trace.go:171","msg":"trace[1927215339] transaction","detail":"{read_only:false; response_revision:9496; number_of_response:1; }","duration":"194.341347ms","start":"2026-04-22T00:46:52.752094Z","end":"2026-04-22T00:46:52.946436Z","steps":["trace[1927215339] 'process raft request'  (duration: 95.532863ms)","trace[1927215339] 'compare'  (duration: 98.677131ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T00:46:52.983514Z","caller":"traceutil/trace.go:171","msg":"trace[1699610540] transaction","detail":"{read_only:false; response_revision:9498; number_of_response:1; }","duration":"230.39087ms","start":"2026-04-22T00:46:52.753089Z","end":"2026-04-22T00:46:52.98348Z","steps":["trace[1699610540] 'process raft request'  (duration: 230.268927ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:46:52.983819Z","caller":"traceutil/trace.go:171","msg":"trace[1224884264] transaction","detail":"{read_only:false; response_revision:9499; number_of_response:1; }","duration":"172.649508ms","start":"2026-04-22T00:46:52.811143Z","end":"2026-04-22T00:46:52.983793Z","steps":["trace[1224884264] 'process raft request'  (duration: 172.253277ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:46:52.983836Z","caller":"traceutil/trace.go:171","msg":"trace[1614405082] transaction","detail":"{read_only:false; response_revision:9497; number_of_response:1; }","duration":"231.10412ms","start":"2026-04-22T00:46:52.752711Z","end":"2026-04-22T00:46:52.983815Z","steps":["trace[1614405082] 'process raft request'  (duration: 230.500743ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:46:53.355656Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.511161ms","expected-duration":"100ms","prefix":"","request":"header:<ID:3415872232754399665 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:9480 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >>","response":"size:16"}
{"level":"info","ts":"2026-04-22T00:46:53.356109Z","caller":"traceutil/trace.go:171","msg":"trace[1314228236] transaction","detail":"{read_only:false; response_revision:9501; number_of_response:1; }","duration":"352.859579ms","start":"2026-04-22T00:46:53.003227Z","end":"2026-04-22T00:46:53.356086Z","steps":["trace[1314228236] 'process raft request'  (duration: 352.693235ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:46:53.356158Z","caller":"traceutil/trace.go:171","msg":"trace[852053119] transaction","detail":"{read_only:false; response_revision:9502; number_of_response:1; }","duration":"352.15694ms","start":"2026-04-22T00:46:53.003964Z","end":"2026-04-22T00:46:53.356121Z","steps":["trace[852053119] 'process raft request'  (duration: 352.070658ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:46:53.356232Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:46:53.003212Z","time spent":"352.960593ms","remote":"127.0.0.1:44058","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:9482 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-04-22T00:46:53.356108Z","caller":"traceutil/trace.go:171","msg":"trace[1600664929] linearizableReadLoop","detail":"{readStateIndex:9834; appliedIndex:9831; }","duration":"258.697735ms","start":"2026-04-22T00:46:53.097391Z","end":"2026-04-22T00:46:53.356089Z","steps":["trace[1600664929] 'read index received'  (duration: 26.71539ms)","trace[1600664929] 'applied index is now lower than readState.Index'  (duration: 231.981305ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-22T00:46:53.356344Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:46:53.003955Z","time spent":"352.289994ms","remote":"127.0.0.1:44058","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:9481 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-04-22T00:46:53.356341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.949963ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-22T00:46:53.356475Z","caller":"traceutil/trace.go:171","msg":"trace[1278130039] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:9502; }","duration":"259.125038ms","start":"2026-04-22T00:46:53.097334Z","end":"2026-04-22T00:46:53.356459Z","steps":["trace[1278130039] 'agreement among raft nodes before linearized reading'  (duration: 258.812079ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:46:53.35605Z","caller":"traceutil/trace.go:171","msg":"trace[389155715] transaction","detail":"{read_only:false; response_revision:9500; number_of_response:1; }","duration":"353.134877ms","start":"2026-04-22T00:46:53.002846Z","end":"2026-04-22T00:46:53.355981Z","steps":["trace[389155715] 'process raft request'  (duration: 121.173983ms)","trace[389155715] 'compare'  (duration: 231.11487ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-22T00:46:53.356673Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.860959ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"}
{"level":"warn","ts":"2026-04-22T00:46:53.356701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.508635ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:19220"}
{"level":"warn","ts":"2026-04-22T00:46:53.356729Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:46:53.002825Z","time spent":"353.851597ms","remote":"127.0.0.1:44058","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:9480 > 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-04-22T00:46:53.356746Z","caller":"traceutil/trace.go:171","msg":"trace[1526146891] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:9502; }","duration":"201.979782ms","start":"2026-04-22T00:46:53.154745Z","end":"2026-04-22T00:46:53.356725Z","steps":["trace[1526146891] 'agreement among raft nodes before linearized reading'  (duration: 201.699714ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:46:53.356752Z","caller":"traceutil/trace.go:171","msg":"trace[1666067661] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:9502; }","duration":"125.600527ms","start":"2026-04-22T00:46:53.231135Z","end":"2026-04-22T00:46:53.356735Z","steps":["trace[1666067661] 'agreement among raft nodes before linearized reading'  (duration: 125.378721ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:46:53.35709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.529951ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"}
{"level":"info","ts":"2026-04-22T00:46:53.357363Z","caller":"traceutil/trace.go:171","msg":"trace[242475833] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:9502; }","duration":"164.832019ms","start":"2026-04-22T00:46:53.192508Z","end":"2026-04-22T00:46:53.35734Z","steps":["trace[242475833] 'agreement among raft nodes before linearized reading'  (duration: 164.250163ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:46:53.583417Z","caller":"traceutil/trace.go:171","msg":"trace[103523680] transaction","detail":"{read_only:false; response_revision:9504; number_of_response:1; }","duration":"150.540907ms","start":"2026-04-22T00:46:53.432857Z","end":"2026-04-22T00:46:53.583398Z","steps":["trace[103523680] 'process raft request'  (duration: 150.414003ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:46:53.605686Z","caller":"traceutil/trace.go:171","msg":"trace[13765357] linearizableReadLoop","detail":"{readStateIndex:9837; appliedIndex:9835; }","duration":"171.343221ms","start":"2026-04-22T00:46:53.434313Z","end":"2026-04-22T00:46:53.605657Z","steps":["trace[13765357] 'read index received'  (duration: 148.939322ms)","trace[13765357] 'applied index is now lower than readState.Index'  (duration: 22.402779ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T00:46:53.605832Z","caller":"traceutil/trace.go:171","msg":"trace[495207450] transaction","detail":"{read_only:false; response_revision:9505; number_of_response:1; }","duration":"172.633078ms","start":"2026-04-22T00:46:53.433169Z","end":"2026-04-22T00:46:53.605802Z","steps":["trace[495207450] 'process raft request'  (duration: 172.31872ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:46:53.605951Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.499364ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5651"}
{"level":"info","ts":"2026-04-22T00:46:53.605999Z","caller":"traceutil/trace.go:171","msg":"trace[1985882832] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:9505; }","duration":"167.589246ms","start":"2026-04-22T00:46:53.438393Z","end":"2026-04-22T00:46:53.605983Z","steps":["trace[1985882832] 'agreement among raft nodes before linearized reading'  (duration: 167.420472ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:46:53.606014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.67031ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-c4tqx\" ","response":"range_response_count:1 size:6530"}
{"level":"info","ts":"2026-04-22T00:46:53.606083Z","caller":"traceutil/trace.go:171","msg":"trace[268192220] range","detail":"{range_begin:/registry/pods/openstack/keepalived-c4tqx; range_end:; response_count:1; response_revision:9505; }","duration":"171.779913ms","start":"2026-04-22T00:46:53.43428Z","end":"2026-04-22T00:46:53.60606Z","steps":["trace[268192220] 'agreement among raft nodes before linearized reading'  (duration: 171.524786ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T00:46:53.789433Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.976091ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-22T00:46:53.789521Z","caller":"traceutil/trace.go:171","msg":"trace[1731589161] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:9505; }","duration":"103.122275ms","start":"2026-04-22T00:46:53.686377Z","end":"2026-04-22T00:46:53.789499Z","steps":["trace[1731589161] 'count revisions from in-memory index tree'  (duration: 102.873979ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T00:47:19.000883Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"39582465ceaa2f67","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-04-22T00:47:19.008535Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001}
{"level":"info","ts":"2026-04-22T00:47:19.00866Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001}
{"level":"info","ts":"2026-04-22T00:49:23.895759Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8260}
{"level":"info","ts":"2026-04-22T00:49:23.971817Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8260,"took":"74.009093ms","hash":2642321135,"current-db-size-bytes":58204160,"current-db-size":"58 MB","current-db-size-in-use-bytes":23687168,"current-db-size-in-use":"24 MB"}
{"level":"info","ts":"2026-04-22T00:49:23.9719Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2642321135,"revision":8260,"compact-revision":6070}
{"level":"info","ts":"2026-04-22T00:54:23.901011Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10441}
{"level":"info","ts":"2026-04-22T00:54:23.979819Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10441,"took":"76.363965ms","hash":3522459240,"current-db-size-bytes":58204160,"current-db-size":"58 MB","current-db-size-in-use-bytes":20635648,"current-db-size-in-use":"21 MB"}
{"level":"info","ts":"2026-04-22T00:54:23.979885Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3522459240,"revision":10441,"compact-revision":8260}