{"level":"warn","ts":"2026-05-05T11:20:34.238051Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-05-05T11:20:34.238138Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.177:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.177:2380","--initial-cluster=instance=https://199.19.213.177:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.177:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.177:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]}
{"level":"warn","ts":"2026-05-05T11:20:34.238204Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-05-05T11:20:34.238218Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.177:2380"]}
{"level":"info","ts":"2026-05-05T11:20:34.238242Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-05-05T11:20:34.238897Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.177:2379"]}
{"level":"info","ts":"2026-05-05T11:20:34.238967Z","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.19.213.177:2380"],"listen-peer-urls":["https://199.19.213.177:2380"],"advertise-client-urls":["https://199.19.213.177:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.177:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.177:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"}
{"level":"info","ts":"2026-05-05T11:20:34.242576Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.411683ms"}
{"level":"info","ts":"2026-05-05T11:20:34.248487Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"f577bc5ae95d61e1","cluster-id":"735860b212d0f0b6"}
{"level":"info","ts":"2026-05-05T11:20:34.248567Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f577bc5ae95d61e1 switched to configuration voters=()"}
{"level":"info","ts":"2026-05-05T11:20:34.248589Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f577bc5ae95d61e1 became follower at term 0"}
{"level":"info","ts":"2026-05-05T11:20:34.248607Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft f577bc5ae95d61e1 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-05-05T11:20:34.24862Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f577bc5ae95d61e1 became follower at term 1"}
{"level":"info","ts":"2026-05-05T11:20:34.248664Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f577bc5ae95d61e1 switched to configuration voters=(17687813160169202145)"}
{"level":"warn","ts":"2026-05-05T11:20:34.254458Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-05-05T11:20:34.256626Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-05-05T11:20:34.257967Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"}
{"level":"info","ts":"2026-05-05T11:20:34.260405Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"f577bc5ae95d61e1","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-05-05T11:20:34.260538Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"f577bc5ae95d61e1","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-05-05T11:20:34.260613Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"}
{"level":"info","ts":"2026-05-05T11:20:34.260769Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"}
{"level":"info","ts":"2026-05-05T11:20:34.260791Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"}
{"level":"info","ts":"2026-05-05T11:20:34.261537Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f577bc5ae95d61e1 switched to configuration voters=(17687813160169202145)"}
{"level":"info","ts":"2026-05-05T11:20:34.261792Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"735860b212d0f0b6","local-member-id":"f577bc5ae95d61e1","added-peer-id":"f577bc5ae95d61e1","added-peer-peer-urls":["https://199.19.213.177:2380"]}
{"level":"info","ts":"2026-05-05T11:20:34.26346Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-05-05T11:20:34.263554Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.177:2380"}
{"level":"info","ts":"2026-05-05T11:20:34.263589Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.177:2380"}
{"level":"info","ts":"2026-05-05T11:20:34.26364Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"f577bc5ae95d61e1","initial-advertise-peer-urls":["https://199.19.213.177:2380"],"listen-peer-urls":["https://199.19.213.177:2380"],"advertise-client-urls":["https://199.19.213.177:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.177:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-05-05T11:20:34.263674Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-05-05T11:20:34.753316Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f577bc5ae95d61e1 is starting a new election at term 1"}
{"level":"info","ts":"2026-05-05T11:20:34.753381Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f577bc5ae95d61e1 became pre-candidate at term 1"}
{"level":"info","ts":"2026-05-05T11:20:34.753416Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f577bc5ae95d61e1 received MsgPreVoteResp from f577bc5ae95d61e1 at term 1"}
{"level":"info","ts":"2026-05-05T11:20:34.753435Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f577bc5ae95d61e1 became candidate at term 2"}
{"level":"info","ts":"2026-05-05T11:20:34.753444Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f577bc5ae95d61e1 received MsgVoteResp from f577bc5ae95d61e1 at term 2"}
{"level":"info","ts":"2026-05-05T11:20:34.753457Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f577bc5ae95d61e1 became leader at term 2"}
{"level":"info","ts":"2026-05-05T11:20:34.753469Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: f577bc5ae95d61e1 elected leader f577bc5ae95d61e1 at term 2"}
{"level":"info","ts":"2026-05-05T11:20:34.754481Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"f577bc5ae95d61e1","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.177:2379]}","request-path":"/0/members/f577bc5ae95d61e1/attributes","cluster-id":"735860b212d0f0b6","publish-timeout":"7s"}
{"level":"info","ts":"2026-05-05T11:20:34.754503Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-05T11:20:34.754648Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-05-05T11:20:34.754722Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-05-05T11:20:34.755404Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"735860b212d0f0b6","local-member-id":"f577bc5ae95d61e1","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-05T11:20:34.755551Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-05T11:20:34.755612Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-05T11:20:34.757036Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.177:2379"}
{"level":"info","ts":"2026-05-05T11:20:34.757072Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-05-05T11:20:34.757105Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-05-05T11:20:34.758621Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"warn","ts":"2026-05-05T11:20:36.682612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"499.682001ms","expected-duration":"100ms","prefix":"","request":"header:<ID:7053092179350964421 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/flowschemas/endpoint-controller\" mod_revision:49 > success:<request_put:<key:\"/registry/flowschemas/endpoint-controller\" value_size:1195 >> failure:<request_range:<key:\"/registry/flowschemas/endpoint-controller\" > >>","response":"size:14"}
{"level":"info","ts":"2026-05-05T11:20:36.682908Z","caller":"traceutil/trace.go:171","msg":"trace[704777498] transaction","detail":"{read_only:false; response_revision:58; number_of_response:1; }","duration":"528.245192ms","start":"2026-05-05T11:20:36.154623Z","end":"2026-05-05T11:20:36.682868Z","steps":["trace[704777498] 'process raft request'  (duration: 27.251374ms)","trace[704777498] 'compare'  (duration: 499.481936ms)"],"step_count":2}
{"level":"info","ts":"2026-05-05T11:20:36.68301Z","caller":"traceutil/trace.go:171","msg":"trace[95469185] linearizableReadLoop","detail":"{readStateIndex:65; appliedIndex:62; }","duration":"441.397953ms","start":"2026-05-05T11:20:36.241571Z","end":"2026-05-05T11:20:36.682969Z","steps":["trace[95469185] 'read index received'  (duration: 274.235782ms)","trace[95469185] 'applied index is now lower than readState.Index'  (duration: 167.161181ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-05T11:20:36.683109Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T11:20:36.15461Z","time spent":"528.405596ms","remote":"127.0.0.1:39572","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1244,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/flowschemas/endpoint-controller\" mod_revision:49 > success:<request_put:<key:\"/registry/flowschemas/endpoint-controller\" value_size:1195 >> failure:<request_range:<key:\"/registry/flowschemas/endpoint-controller\" > >"}
{"level":"info","ts":"2026-05-05T11:20:36.683153Z","caller":"traceutil/trace.go:171","msg":"trace[2412808] transaction","detail":"{read_only:false; response_revision:60; number_of_response:1; }","duration":"516.419409ms","start":"2026-05-05T11:20:36.166701Z","end":"2026-05-05T11:20:36.68312Z","steps":["trace[2412808] 'process raft request'  (duration: 516.196303ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T11:20:36.683174Z","caller":"traceutil/trace.go:171","msg":"trace[1314476397] transaction","detail":"{read_only:false; response_revision:59; number_of_response:1; }","duration":"527.243754ms","start":"2026-05-05T11:20:36.155861Z","end":"2026-05-05T11:20:36.683105Z","steps":["trace[1314476397] 'process raft request'  (duration: 526.918506ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T11:20:36.683235Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"441.651819ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" ","response":"range_response_count:0 size:4"}
{"level":"warn","ts":"2026-05-05T11:20:36.68327Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"358.096559ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-05-05T11:20:36.683284Z","caller":"traceutil/trace.go:171","msg":"trace[799113963] range","detail":"{range_begin:/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te; range_end:; response_count:0; response_revision:60; }","duration":"441.745232ms","start":"2026-05-05T11:20:36.241525Z","end":"2026-05-05T11:20:36.683271Z","steps":["trace[799113963] 'agreement among raft nodes before linearized reading'  (duration: 441.595518ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T11:20:36.683286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.777283ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/kube-system/\" range_end:\"/registry/limitranges/kube-system0\" ","response":"range_response_count:0 size:4"}
{"level":"warn","ts":"2026-05-05T11:20:36.683311Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T11:20:36.155845Z","time spent":"527.393039ms","remote":"127.0.0.1:39228","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":636,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/events/default/instance.18aca76b99a65ef4\" mod_revision:0 > success:<request_put:<key:\"/registry/events/default/instance.18aca76b99a65ef4\" value_size:568 lease:7053092179350964408 >> failure:<>"}
{"level":"warn","ts":"2026-05-05T11:20:36.683319Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T11:20:36.166688Z","time spent":"516.546183ms","remote":"127.0.0.1:39572","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":671,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/flowschemas/service-accounts\" mod_revision:0 > success:<request_put:<key:\"/registry/flowschemas/service-accounts\" value_size:625 >> failure:<>"}
{"level":"info","ts":"2026-05-05T11:20:36.683336Z","caller":"traceutil/trace.go:171","msg":"trace[1773661591] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:60; }","duration":"358.191052ms","start":"2026-05-05T11:20:36.325113Z","end":"2026-05-05T11:20:36.683304Z","steps":["trace[1773661591] 'agreement among raft nodes before linearized reading'  (duration: 358.012567ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T11:20:36.683361Z","caller":"traceutil/trace.go:171","msg":"trace[971953717] range","detail":"{range_begin:/registry/limitranges/kube-system/; range_end:/registry/limitranges/kube-system0; response_count:0; response_revision:60; }","duration":"187.904567ms","start":"2026-05-05T11:20:36.495439Z","end":"2026-05-05T11:20:36.683343Z","steps":["trace[971953717] 'agreement among raft nodes before linearized reading'  (duration: 187.773013ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T11:20:36.683318Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T11:20:36.24151Z","time spent":"441.802143ms","remote":"127.0.0.1:39406","response type":"/etcdserverpb.KV/Range","request count":0,"request size":67,"response count":0,"response size":27,"request content":"key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" "}
{"level":"warn","ts":"2026-05-05T11:20:36.683379Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T11:20:36.325092Z","time spent":"358.279064ms","remote":"127.0.0.1:39546","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":0,"response size":27,"request content":"key:\"/registry/csinodes/instance\" "}
{"level":"warn","ts":"2026-05-05T11:20:43.072398Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.192736ms","expected-duration":"100ms","prefix":"","request":"header:<ID:7053092179350964992 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/serviceaccounts/kube-system/pod-garbage-collector\" mod_revision:0 > success:<request_put:<key:\"/registry/serviceaccounts/kube-system/pod-garbage-collector\" value_size:126 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-05-05T11:20:43.072525Z","caller":"traceutil/trace.go:171","msg":"trace[1029527691] transaction","detail":"{read_only:false; response_revision:336; number_of_response:1; }","duration":"342.896564ms","start":"2026-05-05T11:20:42.72961Z","end":"2026-05-05T11:20:43.072507Z","steps":["trace[1029527691] 'process raft request'  (duration: 188.528053ms)","trace[1029527691] 'compare'  (duration: 154.045082ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-05T11:20:43.072586Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T11:20:42.729586Z","time spent":"342.979766ms","remote":"127.0.0.1:39336","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":192,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/serviceaccounts/kube-system/pod-garbage-collector\" mod_revision:0 > success:<request_put:<key:\"/registry/serviceaccounts/kube-system/pod-garbage-collector\" value_size:126 >> failure:<>"}
{"level":"info","ts":"2026-05-05T11:20:43.232665Z","caller":"traceutil/trace.go:171","msg":"trace[1801093194] transaction","detail":"{read_only:false; response_revision:337; number_of_response:1; }","duration":"150.375782ms","start":"2026-05-05T11:20:43.082253Z","end":"2026-05-05T11:20:43.232629Z","steps":["trace[1801093194] 'process raft request'  (duration: 149.036295ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T11:21:10.057337Z","caller":"traceutil/trace.go:171","msg":"trace[1424002719] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"115.845189ms","start":"2026-05-05T11:21:09.94146Z","end":"2026-05-05T11:21:10.057305Z","steps":["trace[1424002719] 'process raft request'  (duration: 115.201732ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T11:21:10.251154Z","caller":"traceutil/trace.go:171","msg":"trace[1711178198] linearizableReadLoop","detail":"{readStateIndex:639; appliedIndex:638; }","duration":"105.713673ms","start":"2026-05-05T11:21:10.145413Z","end":"2026-05-05T11:21:10.251126Z","steps":["trace[1711178198] 'read index received'  (duration: 105.524388ms)","trace[1711178198] 'applied index is now lower than readState.Index'  (duration: 188.075µs)"],"step_count":2}
{"level":"warn","ts":"2026-05-05T11:21:10.251671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.144935ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-05T11:21:10.251792Z","caller":"traceutil/trace.go:171","msg":"trace[223530031] transaction","detail":"{read_only:false; response_revision:614; number_of_response:1; }","duration":"136.121783ms","start":"2026-05-05T11:21:10.115296Z","end":"2026-05-05T11:21:10.251418Z","steps":["trace[223530031] 'process raft request'  (duration: 135.697101ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T11:21:10.251843Z","caller":"traceutil/trace.go:171","msg":"trace[1487714269] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:614; }","duration":"106.419213ms","start":"2026-05-05T11:21:10.145355Z","end":"2026-05-05T11:21:10.251774Z","steps":["trace[1487714269] 'agreement among raft nodes before linearized reading'  (duration: 106.118564ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T11:21:10.445616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.9217ms","expected-duration":"100ms","prefix":"","request":"header:<ID:7053092179350965516 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:600 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-05T11:21:10.445915Z","caller":"traceutil/trace.go:171","msg":"trace[1471098515] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"172.030553ms","start":"2026-05-05T11:21:10.273835Z","end":"2026-05-05T11:21:10.445866Z","steps":["trace[1471098515] 'process raft request'  (duration: 171.936971ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T11:21:10.446102Z","caller":"traceutil/trace.go:171","msg":"trace[1818271203] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"189.156301ms","start":"2026-05-05T11:21:10.256929Z","end":"2026-05-05T11:21:10.446085Z","steps":["trace[1818271203] 'process raft request'  (duration: 71.606844ms)","trace[1818271203] 'compare'  (duration: 116.657793ms)"],"step_count":2}
{"level":"info","ts":"2026-05-05T11:21:10.446334Z","caller":"traceutil/trace.go:171","msg":"trace[847160614] linearizableReadLoop","detail":"{readStateIndex:640; appliedIndex:639; }","duration":"183.352512ms","start":"2026-05-05T11:21:10.26297Z","end":"2026-05-05T11:21:10.446322Z","steps":["trace[847160614] 'read index received'  (duration: 65.577719ms)","trace[847160614] 'applied index is now lower than readState.Index'  (duration: 117.773473ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-05T11:21:10.44656Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.555517ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-05T11:21:10.446654Z","caller":"traceutil/trace.go:171","msg":"trace[1158273648] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system; range_end:; response_count:0; response_revision:616; }","duration":"183.688382ms","start":"2026-05-05T11:21:10.262941Z","end":"2026-05-05T11:21:10.44663Z","steps":["trace[1158273648] 'agreement among raft nodes before linearized reading'  (duration: 183.528508ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T11:21:11.279191Z","caller":"traceutil/trace.go:171","msg":"trace[974856390] linearizableReadLoop","detail":"{readStateIndex:644; appliedIndex:643; }","duration":"358.557162ms","start":"2026-05-05T11:21:10.920615Z","end":"2026-05-05T11:21:11.279172Z","steps":["trace[974856390] 'read index received'  (duration: 357.328519ms)","trace[974856390] 'applied index is now lower than readState.Index'  (duration: 1.227923ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-05T11:21:11.279342Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"358.718426ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-05-05T11:21:11.279368Z","caller":"traceutil/trace.go:171","msg":"trace[1414322614] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:619; }","duration":"358.803698ms","start":"2026-05-05T11:21:10.920556Z","end":"2026-05-05T11:21:11.27936Z","steps":["trace[1414322614] 'agreement among raft nodes before linearized reading'  (duration: 358.683004ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T11:21:11.279395Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T11:21:10.920536Z","time spent":"358.85357ms","remote":"127.0.0.1:39406","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":"info","ts":"2026-05-05T11:21:11.279501Z","caller":"traceutil/trace.go:171","msg":"trace[966671086] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"443.040456ms","start":"2026-05-05T11:21:10.836168Z","end":"2026-05-05T11:21:11.279209Z","steps":["trace[966671086] 'process raft request'  (duration: 442.013868ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T11:21:11.279702Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T11:21:10.836132Z","time spent":"443.491238ms","remote":"127.0.0.1:39248","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036293,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" mod_revision:613 > success:<request_put:<key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" value_size:1036209 >> failure:<request_range:<key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" > >"}
{"level":"info","ts":"2026-05-05T11:21:11.421544Z","caller":"traceutil/trace.go:171","msg":"trace[273158043] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"137.539192ms","start":"2026-05-05T11:21:11.283969Z","end":"2026-05-05T11:21:11.421509Z","steps":["trace[273158043] 'process raft request'  (duration: 82.319405ms)","trace[273158043] 'compare'  (duration: 55.028212ms)"],"step_count":2}
{"level":"info","ts":"2026-05-05T11:22:06.146623Z","caller":"traceutil/trace.go:171","msg":"trace[1243047211] transaction","detail":"{read_only:false; response_revision:1287; number_of_response:1; }","duration":"120.05384ms","start":"2026-05-05T11:22:06.026538Z","end":"2026-05-05T11:22:06.146592Z","steps":["trace[1243047211] 'process raft request'  (duration: 70.154487ms)","trace[1243047211] 'compare'  (duration: 49.642797ms)"],"step_count":2}
{"level":"info","ts":"2026-05-05T11:22:06.146753Z","caller":"traceutil/trace.go:171","msg":"trace[927448349] linearizableReadLoop","detail":"{readStateIndex:1331; appliedIndex:1328; }","duration":"108.695026ms","start":"2026-05-05T11:22:06.037999Z","end":"2026-05-05T11:22:06.146694Z","steps":["trace[927448349] 'read index received'  (duration: 13.833438ms)","trace[927448349] 'applied index is now lower than readState.Index'  (duration: 94.856368ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-05T11:22:06.147011Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.961212ms","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-05-05T11:22:06.147144Z","caller":"traceutil/trace.go:171","msg":"trace[1879169970] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:1289; }","duration":"109.149847ms","start":"2026-05-05T11:22:06.037962Z","end":"2026-05-05T11:22:06.147112Z","steps":["trace[1879169970] 'agreement among raft nodes before linearized reading'  (duration: 108.86101ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T11:22:06.147961Z","caller":"traceutil/trace.go:171","msg":"trace[51516631] transaction","detail":"{read_only:false; response_revision:1288; number_of_response:1; }","duration":"119.222288ms","start":"2026-05-05T11:22:06.028337Z","end":"2026-05-05T11:22:06.147559Z","steps":["trace[51516631] 'process raft request'  (duration: 118.178571ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T11:22:12.719729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.542014ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-05T11:22:12.71992Z","caller":"traceutil/trace.go:171","msg":"trace[1878245601] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1319; }","duration":"102.755391ms","start":"2026-05-05T11:22:12.61713Z","end":"2026-05-05T11:22:12.719885Z","steps":["trace[1878245601] 'range keys from in-memory index tree'  (duration: 102.503592ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T11:22:42.3475Z","caller":"traceutil/trace.go:171","msg":"trace[955068449] transaction","detail":"{read_only:false; response_revision:1843; number_of_response:1; }","duration":"174.006337ms","start":"2026-05-05T11:22:42.173425Z","end":"2026-05-05T11:22:42.347431Z","steps":["trace[955068449] 'process raft request'  (duration: 173.7754ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T11:22:42.34744Z","caller":"traceutil/trace.go:171","msg":"trace[460656132] linearizableReadLoop","detail":"{readStateIndex:1916; appliedIndex:1915; }","duration":"121.632881ms","start":"2026-05-05T11:22:42.225763Z","end":"2026-05-05T11:22:42.347396Z","steps":["trace[460656132] 'read index received'  (duration: 121.377813ms)","trace[460656132] 'applied index is now lower than readState.Index'  (duration: 253.208µs)"],"step_count":2}
{"level":"warn","ts":"2026-05-05T11:22:42.347815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.005222ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-29c21416-63d3-409b-91a8-bb766dd4aeac\" ","response":"range_response_count:1 size:3627"}
{"level":"info","ts":"2026-05-05T11:22:42.347952Z","caller":"traceutil/trace.go:171","msg":"trace[1798922854] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-29c21416-63d3-409b-91a8-bb766dd4aeac; range_end:; response_count:1; response_revision:1843; }","duration":"122.220237ms","start":"2026-05-05T11:22:42.225699Z","end":"2026-05-05T11:22:42.347919Z","steps":["trace[1798922854] 'agreement among raft nodes before linearized reading'  (duration: 121.834367ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T11:22:54.52408Z","caller":"traceutil/trace.go:171","msg":"trace[218213711] transaction","detail":"{read_only:false; response_revision:1945; number_of_response:1; }","duration":"113.603103ms","start":"2026-05-05T11:22:54.410445Z","end":"2026-05-05T11:22:54.524048Z","steps":["trace[218213711] 'process raft request'  (duration: 113.447428ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T11:23:27.55728Z","caller":"traceutil/trace.go:171","msg":"trace[927107154] transaction","detail":"{read_only:false; response_revision:2138; number_of_response:1; }","duration":"148.020269ms","start":"2026-05-05T11:23:27.409233Z","end":"2026-05-05T11:23:27.557253Z","steps":["trace[927107154] 'process raft request'  (duration: 135.130888ms)","trace[927107154] 'compare'  (duration: 12.594443ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-05T11:23:27.827815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.967452ms","expected-duration":"100ms","prefix":"","request":"header:<ID:7053092179350968694 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:2130 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:458 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-05T11:23:27.82793Z","caller":"traceutil/trace.go:171","msg":"trace[1816555355] linearizableReadLoop","detail":"{readStateIndex:2221; appliedIndex:2220; }","duration":"136.541837ms","start":"2026-05-05T11:23:27.691368Z","end":"2026-05-05T11:23:27.82791Z","steps":["trace[1816555355] 'read index received'  (duration: 4.323437ms)","trace[1816555355] 'applied index is now lower than readState.Index'  (duration: 132.21657ms)"],"step_count":2}
{"level":"info","ts":"2026-05-05T11:23:27.828061Z","caller":"traceutil/trace.go:171","msg":"trace[1544511424] transaction","detail":"{read_only:false; response_revision:2139; number_of_response:1; }","duration":"154.272259ms","start":"2026-05-05T11:23:27.673748Z","end":"2026-05-05T11:23:27.82802Z","steps":["trace[1544511424] 'process raft request'  (duration: 22.001168ms)","trace[1544511424] 'compare'  (duration: 131.811427ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-05T11:23:27.828299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.869595ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:570"}
{"level":"info","ts":"2026-05-05T11:23:27.82839Z","caller":"traceutil/trace.go:171","msg":"trace[271364246] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:2139; }","duration":"137.04401ms","start":"2026-05-05T11:23:27.691329Z","end":"2026-05-05T11:23:27.828373Z","steps":["trace[271364246] 'agreement among raft nodes before linearized reading'  (duration: 136.686941ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T11:23:27.967852Z","caller":"traceutil/trace.go:171","msg":"trace[1273859741] transaction","detail":"{read_only:false; response_revision:2140; number_of_response:1; }","duration":"134.001097ms","start":"2026-05-05T11:23:27.833826Z","end":"2026-05-05T11:23:27.967827Z","steps":["trace[1273859741] 'process raft request'  (duration: 133.830702ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T11:24:17.063661Z","caller":"traceutil/trace.go:171","msg":"trace[438553900] transaction","detail":"{read_only:false; response_revision:2452; number_of_response:1; }","duration":"103.807546ms","start":"2026-05-05T11:24:16.95983Z","end":"2026-05-05T11:24:17.063637Z","steps":["trace[438553900] 'process raft request'  (duration: 103.174429ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T11:27:26.974405Z","caller":"traceutil/trace.go:171","msg":"trace[57357133] transaction","detail":"{read_only:false; response_revision:3650; number_of_response:1; }","duration":"112.959759ms","start":"2026-05-05T11:27:26.861412Z","end":"2026-05-05T11:27:26.974372Z","steps":["trace[57357133] 'process raft request'  (duration: 112.763714ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T11:28:52.332036Z","caller":"traceutil/trace.go:171","msg":"trace[1736699434] linearizableReadLoop","detail":"{readStateIndex:4874; appliedIndex:4873; }","duration":"103.874035ms","start":"2026-05-05T11:28:52.228125Z","end":"2026-05-05T11:28:52.331999Z","steps":["trace[1736699434] 'read index received'  (duration: 92.825304ms)","trace[1736699434] 'applied index is now lower than readState.Index'  (duration: 11.046401ms)"],"step_count":2}
{"level":"info","ts":"2026-05-05T11:28:52.332397Z","caller":"traceutil/trace.go:171","msg":"trace[767604819] transaction","detail":"{read_only:false; response_revision:4691; number_of_response:1; }","duration":"109.653831ms","start":"2026-05-05T11:28:52.222614Z","end":"2026-05-05T11:28:52.332268Z","steps":["trace[767604819] 'process raft request'  (duration: 98.319322ms)","trace[767604819] 'compare'  (duration: 10.429714ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-05T11:28:52.332506Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.346709ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated\" ","response":"range_response_count:1 size:1131"}
{"level":"info","ts":"2026-05-05T11:28:52.332616Z","caller":"traceutil/trace.go:171","msg":"trace[702923260] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated; range_end:; response_count:1; response_revision:4691; }","duration":"104.515962ms","start":"2026-05-05T11:28:52.228078Z","end":"2026-05-05T11:28:52.332594Z","steps":["trace[702923260] 'agreement among raft nodes before linearized reading'  (duration: 104.224904ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T11:28:56.329611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.931604ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-05T11:28:56.329689Z","caller":"traceutil/trace.go:171","msg":"trace[390486081] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4823; }","duration":"193.072468ms","start":"2026-05-05T11:28:56.136596Z","end":"2026-05-05T11:28:56.329669Z","steps":["trace[390486081] 'range keys from in-memory index tree'  (duration: 192.798151ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T11:28:56.33001Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.963529ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-05-05T11:28:56.330053Z","caller":"traceutil/trace.go:171","msg":"trace[329837870] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4823; }","duration":"199.033751ms","start":"2026-05-05T11:28:56.13101Z","end":"2026-05-05T11:28:56.330044Z","steps":["trace[329837870] 'range keys from in-memory index tree'  (duration: 198.795654ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T11:28:56.330057Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.439313ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-bf47b037-ac92-4a6c-9a48-abde340040a7\" ","response":"range_response_count:1 size:3601"}
{"level":"info","ts":"2026-05-05T11:28:56.330163Z","caller":"traceutil/trace.go:171","msg":"trace[1174728777] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-bf47b037-ac92-4a6c-9a48-abde340040a7; range_end:; response_count:1; response_revision:4823; }","duration":"265.599467ms","start":"2026-05-05T11:28:56.064535Z","end":"2026-05-05T11:28:56.330135Z","steps":["trace[1174728777] 'range keys from in-memory index tree'  (duration: 265.218247ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T11:29:08.741388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.665257ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-05-05T11:29:08.741613Z","caller":"traceutil/trace.go:171","msg":"trace[647413638] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5070; }","duration":"118.940795ms","start":"2026-05-05T11:29:08.622644Z","end":"2026-05-05T11:29:08.741585Z","steps":["trace[647413638] 'range keys from in-memory index tree'  (duration: 118.450092ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T11:29:14.973786Z","caller":"traceutil/trace.go:171","msg":"trace[1938933418] transaction","detail":"{read_only:false; response_revision:5214; number_of_response:1; }","duration":"146.277941ms","start":"2026-05-05T11:29:14.827474Z","end":"2026-05-05T11:29:14.973752Z","steps":["trace[1938933418] 'process raft request'  (duration: 145.070548ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T11:29:15.161345Z","caller":"traceutil/trace.go:171","msg":"trace[276796770] transaction","detail":"{read_only:false; response_revision:5216; number_of_response:1; }","duration":"118.302427ms","start":"2026-05-05T11:29:15.043014Z","end":"2026-05-05T11:29:15.161317Z","steps":["trace[276796770] 'process raft request'  (duration: 118.250926ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T11:29:15.161483Z","caller":"traceutil/trace.go:171","msg":"trace[1982609964] transaction","detail":"{read_only:false; response_revision:5215; number_of_response:1; }","duration":"121.242738ms","start":"2026-05-05T11:29:15.040205Z","end":"2026-05-05T11:29:15.161448Z","steps":["trace[1982609964] 'process raft request'  (duration: 33.663929ms)","trace[1982609964] 'compare'  (duration: 87.26459ms)"],"step_count":2}
{"level":"info","ts":"2026-05-05T11:29:15.189588Z","caller":"traceutil/trace.go:171","msg":"trace[2367400] transaction","detail":"{read_only:false; response_revision:5217; number_of_response:1; }","duration":"115.337016ms","start":"2026-05-05T11:29:15.074229Z","end":"2026-05-05T11:29:15.189566Z","steps":["trace[2367400] 'process raft request'  (duration: 115.219203ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T11:29:15.189787Z","caller":"traceutil/trace.go:171","msg":"trace[1710062688] linearizableReadLoop","detail":"{readStateIndex:5415; appliedIndex:5412; }","duration":"110.312689ms","start":"2026-05-05T11:29:15.079438Z","end":"2026-05-05T11:29:15.18974Z","steps":["trace[1710062688] 'read index received'  (duration: 73.875185ms)","trace[1710062688] 'applied index is now lower than readState.Index'  (duration: 36.424314ms)"],"step_count":2}
{"level":"info","ts":"2026-05-05T11:29:15.189831Z","caller":"traceutil/trace.go:171","msg":"trace[1994089259] transaction","detail":"{read_only:false; response_revision:5218; number_of_response:1; }","duration":"109.412625ms","start":"2026-05-05T11:29:15.080398Z","end":"2026-05-05T11:29:15.18981Z","steps":["trace[1994089259] 'process raft request'  (duration: 109.134337ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T11:29:15.189971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.527336ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/loki-gateway-748b556d75-zz468\" ","response":"range_response_count:1 size:4765"}
{"level":"info","ts":"2026-05-05T11:29:15.190067Z","caller":"traceutil/trace.go:171","msg":"trace[1147394688] range","detail":"{range_begin:/registry/pods/monitoring/loki-gateway-748b556d75-zz468; range_end:; response_count:1; response_revision:5218; }","duration":"110.665469ms","start":"2026-05-05T11:29:15.079384Z","end":"2026-05-05T11:29:15.190049Z","steps":["trace[1147394688] 'agreement among raft nodes before linearized reading'  (duration: 110.467394ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T11:29:15.457856Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.092328ms","expected-duration":"100ms","prefix":"","request":"header:<ID:7053092179350976464 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/pods/monitoring/loki-gateway-748b556d75-zz468\" mod_revision:4942 > success:<request_put:<key:\"/registry/pods/monitoring/loki-gateway-748b556d75-zz468\" value_size:4513 >> failure:<request_range:<key:\"/registry/pods/monitoring/loki-gateway-748b556d75-zz468\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-05T11:29:15.457956Z","caller":"traceutil/trace.go:171","msg":"trace[651285097] transaction","detail":"{read_only:false; response_revision:5220; number_of_response:1; }","duration":"260.523499ms","start":"2026-05-05T11:29:15.197418Z","end":"2026-05-05T11:29:15.457941Z","steps":["trace[651285097] 'process raft request'  (duration: 133.273026ms)","trace[651285097] 'compare'  (duration: 126.982025ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-05T11:30:18.353534Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"366.352366ms","expected-duration":"100ms","prefix":"","request":"header:<ID:7053092179350978028 username:\"kube-apiserver-etcd-client\" auth_revision:1 > lease_grant:<ttl:15-second id:61e19df7de4cfdeb>","response":"size:40"}
{"level":"warn","ts":"2026-05-05T11:30:18.353778Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T11:30:17.808015Z","time spent":"545.758067ms","remote":"127.0.0.1:39186","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"warn","ts":"2026-05-05T11:30:18.50283Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7053092179350978026,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-05-05T11:30:18.869545Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.103547ms","expected-duration":"100ms","prefix":"","request":"header:<ID:7053092179350978029 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/jobs/openstack/keystone-db-init\" mod_revision:5742 > success:<request_put:<key:\"/registry/jobs/openstack/keystone-db-init\" value_size:5494 >> failure:<request_range:<key:\"/registry/jobs/openstack/keystone-db-init\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-05T11:30:18.869803Z","caller":"traceutil/trace.go:171","msg":"trace[165446868] transaction","detail":"{read_only:false; response_revision:5823; number_of_response:1; }","duration":"1.037306919s","start":"2026-05-05T11:30:17.832467Z","end":"2026-05-05T11:30:18.869774Z","steps":["trace[165446868] 'process raft request'  (duration: 910.81961ms)","trace[165446868] 'compare'  (duration: 125.203033ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-05T11:30:18.870078Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T11:30:17.832441Z","time spent":"1.037563265s","remote":"127.0.0.1:39364","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5543,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/jobs/openstack/keystone-db-init\" mod_revision:5742 > success:<request_put:<key:\"/registry/jobs/openstack/keystone-db-init\" value_size:5494 >> failure:<request_range:<key:\"/registry/jobs/openstack/keystone-db-init\" > >"}
{"level":"warn","ts":"2026-05-05T11:30:19.730343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"636.920754ms","expected-duration":"100ms","prefix":"","request":"header:<ID:7053092179350978030 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/masterleases/199.19.213.177\" mod_revision:5757 > success:<request_put:<key:\"/registry/masterleases/199.19.213.177\" value_size:67 lease:7053092179350978027 >> failure:<request_range:<key:\"/registry/masterleases/199.19.213.177\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-05T11:30:19.730815Z","caller":"traceutil/trace.go:171","msg":"trace[1172031603] transaction","detail":"{read_only:false; response_revision:5825; number_of_response:1; }","duration":"824.573958ms","start":"2026-05-05T11:30:18.906213Z","end":"2026-05-05T11:30:19.730787Z","steps":["trace[1172031603] 'process raft request'  (duration: 824.476715ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T11:30:19.730843Z","caller":"traceutil/trace.go:171","msg":"trace[1000491060] transaction","detail":"{read_only:false; response_revision:5824; number_of_response:1; }","duration":"1.375681632s","start":"2026-05-05T11:30:18.355108Z","end":"2026-05-05T11:30:19.73079Z","steps":["trace[1000491060] 'process raft request'  (duration: 737.956937ms)","trace[1000491060] 'compare'  (duration: 636.315556ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-05T11:30:19.731104Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.729310762s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"}
{"level":"info","ts":"2026-05-05T11:30:19.731168Z","caller":"traceutil/trace.go:171","msg":"trace[382894829] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5825; }","duration":"1.729420175s","start":"2026-05-05T11:30:18.001733Z","end":"2026-05-05T11:30:19.731154Z","steps":["trace[382894829] 'agreement among raft nodes before linearized reading'  (duration: 1.7292169s)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T11:30:19.731113Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T11:30:18.355088Z","time spent":"1.375920078s","remote":"127.0.0.1:39186","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.19.213.177\" mod_revision:5757 > success:<request_put:<key:\"/registry/masterleases/199.19.213.177\" value_size:67 lease:7053092179350978027 >> failure:<request_range:<key:\"/registry/masterleases/199.19.213.177\" > >"}
{"level":"warn","ts":"2026-05-05T11:30:19.731217Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T11:30:18.00171Z","time spent":"1.729495956s","remote":"127.0.0.1:39406","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-05-05T11:30:19.730923Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T11:30:18.906183Z","time spent":"824.698502ms","remote":"127.0.0.1:39406","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:5815 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"info","ts":"2026-05-05T11:30:19.730889Z","caller":"traceutil/trace.go:171","msg":"trace[2058106274] linearizableReadLoop","detail":"{readStateIndex:6038; appliedIndex:6036; }","duration":"1.729076785s","start":"2026-05-05T11:30:18.001781Z","end":"2026-05-05T11:30:19.730858Z","steps":["trace[2058106274] 'read index received'  (duration: 741.526613ms)","trace[2058106274] 'applied index is now lower than readState.Index'  (duration: 987.546692ms)"],"step_count":2}
{"level":"info","ts":"2026-05-05T11:30:19.747063Z","caller":"traceutil/trace.go:171","msg":"trace[1888842865] transaction","detail":"{read_only:false; response_revision:5826; number_of_response:1; }","duration":"573.569867ms","start":"2026-05-05T11:30:19.173472Z","end":"2026-05-05T11:30:19.747042Z","steps":["trace[1888842865] 'process raft request'  (duration: 573.460104ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T11:30:19.747207Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T11:30:19.173443Z","time spent":"573.69088ms","remote":"127.0.0.1:39406","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:5762 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:599 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"warn","ts":"2026-05-05T11:30:20.138395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000400893s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"}
{"level":"info","ts":"2026-05-05T11:30:20.138485Z","caller":"traceutil/trace.go:171","msg":"trace[1746363397] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000548477s","start":"2026-05-05T11:30:18.137916Z","end":"2026-05-05T11:30:20.138465Z","steps":["trace[1746363397] 'agreement among raft nodes before linearized reading'  (duration: 2.000433693s)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T11:30:20.138534Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T11:30:18.137894Z","time spent":"2.00062919s","remote":"127.0.0.1:39144","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
2026/05/05 11:30:20 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"info","ts":"2026-05-05T11:30:20.377718Z","caller":"traceutil/trace.go:171","msg":"trace[1897122401] transaction","detail":"{read_only:false; response_revision:5827; number_of_response:1; }","duration":"846.391164ms","start":"2026-05-05T11:30:19.531303Z","end":"2026-05-05T11:30:20.377694Z","steps":["trace[1897122401] 'process raft request'  (duration: 846.228389ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T11:30:20.378002Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T11:30:19.531286Z","time spent":"846.505206ms","remote":"127.0.0.1:39406","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:5818 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:458 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"info","ts":"2026-05-05T11:30:20.377983Z","caller":"traceutil/trace.go:171","msg":"trace[349033261] linearizableReadLoop","detail":"{readStateIndex:6041; appliedIndex:6040; }","duration":"646.574886ms","start":"2026-05-05T11:30:19.731358Z","end":"2026-05-05T11:30:20.377933Z","steps":["trace[349033261] 'read index received'  (duration: 15.671587ms)","trace[349033261] 'applied index is now lower than readState.Index'  (duration: 630.898409ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-05T11:30:20.378199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.411482228s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"}
{"level":"warn","ts":"2026-05-05T11:30:20.378226Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.65512334s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/superstreams/\" range_end:\"/registry/rabbitmq.com/superstreams0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-05T11:30:20.378286Z","caller":"traceutil/trace.go:171","msg":"trace[489553728] range","detail":"{range_begin:/registry/rabbitmq.com/superstreams/; range_end:/registry/rabbitmq.com/superstreams0; response_count:0; response_revision:5828; }","duration":"1.655247063s","start":"2026-05-05T11:30:18.72302Z","end":"2026-05-05T11:30:20.378267Z","steps":["trace[489553728] 'agreement among raft nodes before linearized reading'  (duration: 1.655118499s)"],"step_count":1}
{"level":"info","ts":"2026-05-05T11:30:20.378271Z","caller":"traceutil/trace.go:171","msg":"trace[1661292306] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5828; }","duration":"1.411606622s","start":"2026-05-05T11:30:18.966648Z","end":"2026-05-05T11:30:20.378255Z","steps":["trace[1661292306] 'agreement among raft nodes before linearized reading'  (duration: 1.411374075s)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T11:30:20.37829Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"882.803665ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12212"}
{"level":"warn","ts":"2026-05-05T11:30:20.37831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.177968452s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"warn","ts":"2026-05-05T11:30:20.378347Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T11:30:18.722996Z","time spent":"1.655334566s","remote":"127.0.0.1:56788","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":28,"request content":"key:\"/registry/rabbitmq.com/superstreams/\" range_end:\"/registry/rabbitmq.com/superstreams0\" count_only:true "}
{"level":"info","ts":"2026-05-05T11:30:20.378383Z","caller":"traceutil/trace.go:171","msg":"trace[1054073968] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5828; }","duration":"1.178083865s","start":"2026-05-05T11:30:19.200282Z","end":"2026-05-05T11:30:20.378366Z","steps":["trace[1054073968] 'agreement among raft nodes before linearized reading'  (duration: 1.177859609s)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T11:30:20.378393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"769.573209ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"}
{"level":"warn","ts":"2026-05-05T11:30:20.378421Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T11:30:19.200262Z","time spent":"1.178153187s","remote":"127.0.0.1:39406","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-05-05T11:30:20.378444Z","caller":"traceutil/trace.go:171","msg":"trace[2061405483] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5828; }","duration":"769.639721ms","start":"2026-05-05T11:30:19.608786Z","end":"2026-05-05T11:30:20.378426Z","steps":["trace[2061405483] 'agreement among raft nodes before linearized reading'  (duration: 769.549219ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T11:30:20.378452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.682754413s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/keystone-db-sync\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-05-05T11:30:20.378438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"836.215525ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-05T11:30:20.37849Z","caller":"traceutil/trace.go:171","msg":"trace[1399454963] range","detail":"{range_begin:/registry/jobs/openstack/keystone-db-sync; range_end:; response_count:0; response_revision:5828; }","duration":"1.682816346s","start":"2026-05-05T11:30:18.695667Z","end":"2026-05-05T11:30:20.378484Z","steps":["trace[1399454963] 'agreement among raft nodes before linearized reading'  (duration: 1.682741244s)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T11:30:20.378506Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T11:30:19.608772Z","time spent":"769.726143ms","remote":"127.0.0.1:39406","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-05-05T11:30:20.378521Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.373020921s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-05-05T11:30:20.378522Z","caller":"traceutil/trace.go:171","msg":"trace[515635847] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:5828; }","duration":"836.324808ms","start":"2026-05-05T11:30:19.542174Z","end":"2026-05-05T11:30:20.378499Z","steps":["trace[515635847] 'agreement among raft nodes before linearized reading'  (duration: 836.199645ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T11:30:20.378436Z","caller":"traceutil/trace.go:171","msg":"trace[1547366567] transaction","detail":"{read_only:false; response_revision:5828; number_of_response:1; }","duration":"641.923279ms","start":"2026-05-05T11:30:19.736476Z","end":"2026-05-05T11:30:20.378399Z","steps":["trace[1547366567] 'process raft request'  (duration: 641.1885ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T11:30:20.378573Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T11:30:19.542164Z","time spent":"836.38993ms","remote":"127.0.0.1:60170","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true "}
{"level":"warn","ts":"2026-05-05T11:30:20.378542Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.384501813s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-05-05T11:30:20.378586Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.682890467s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/keystone-fernet-setup\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-05-05T11:30:20.378637Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.002403637s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:571"}
{"level":"info","ts":"2026-05-05T11:30:20.378639Z","caller":"traceutil/trace.go:171","msg":"trace[1247706744] range","detail":"{range_begin:/registry/jobs/openstack/keystone-fernet-setup; range_end:; response_count:0; response_revision:5828; }","duration":"1.68299995s","start":"2026-05-05T11:30:18.695633Z","end":"2026-05-05T11:30:20.378633Z","steps":["trace[1247706744] 'agreement among raft nodes before linearized reading'  (duration: 1.682936168s)"],"step_count":1}
{"level":"info","ts":"2026-05-05T11:30:20.378662Z","caller":"traceutil/trace.go:171","msg":"trace[149324053] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:5828; }","duration":"2.002480369s","start":"2026-05-05T11:30:18.376175Z","end":"2026-05-05T11:30:20.378655Z","steps":["trace[149324053] 'agreement among raft nodes before linearized reading'  (duration: 2.002392187s)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T11:30:20.378669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.96215462s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-d4phr\" ","response":"range_response_count:1 size:6524"}
{"level":"warn","ts":"2026-05-05T11:30:20.378665Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T11:30:18.695604Z","time spent":"1.683056042s","remote":"127.0.0.1:39364","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/openstack/keystone-fernet-setup\" "}
{"level":"warn","ts":"2026-05-05T11:30:20.378685Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"644.798268ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:422"}
{"level":"warn","ts":"2026-05-05T11:30:20.378718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.105358143s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-05-05T11:30:20.378299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"759.980187ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:557"}
{"level":"info","ts":"2026-05-05T11:30:20.378663Z","caller":"traceutil/trace.go:171","msg":"trace[1243506506] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:5828; }","duration":"1.384643316s","start":"2026-05-05T11:30:18.993968Z","end":"2026-05-05T11:30:20.378611Z","steps":["trace[1243506506] 'agreement among raft nodes before linearized reading'  (duration: 1.384477822s)"],"step_count":1}
{"level":"info","ts":"2026-05-05T11:30:20.378751Z","caller":"traceutil/trace.go:171","msg":"trace[987003857] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:5828; }","duration":"2.105432905s","start":"2026-05-05T11:30:18.273308Z","end":"2026-05-05T11:30:20.378741Z","steps":["trace[987003857] 'agreement among raft nodes before linearized reading'  (duration: 2.105392004s)"],"step_count":1}
{"level":"info","ts":"2026-05-05T11:30:20.378746Z","caller":"traceutil/trace.go:171","msg":"trace[459420444] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:5828; }","duration":"644.90197ms","start":"2026-05-05T11:30:19.733829Z","end":"2026-05-05T11:30:20.378731Z","steps":["trace[459420444] 'agreement among raft nodes before linearized reading'  (duration: 644.784827ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T11:30:20.378761Z","caller":"traceutil/trace.go:171","msg":"trace[77602460] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5828; }","duration":"760.516732ms","start":"2026-05-05T11:30:19.618234Z","end":"2026-05-05T11:30:20.378751Z","steps":["trace[77602460] 'agreement among raft nodes before linearized reading'  (duration: 759.908446ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T11:30:20.378796Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T11:30:19.618222Z","time spent":"760.568123ms","remote":"127.0.0.1:39406","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":580,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "}
{"level":"warn","ts":"2026-05-05T11:30:20.378797Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.981861ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-05-05T11:30:20.378803Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T11:30:19.73381Z","time spent":"644.980862ms","remote":"127.0.0.1:39306","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":445,"request content":"key:\"/registry/services/endpoints/default/kubernetes\" "}
{"level":"warn","ts":"2026-05-05T11:30:20.378792Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T11:30:18.993955Z","time spent":"1.384824171s","remote":"127.0.0.1:60394","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true "}
{"level":"warn","ts":"2026-05-05T11:30:20.378365Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T11:30:18.96662Z","time spent":"1.411711165s","remote":"127.0.0.1:39406","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-05-05T11:30:20.378824Z","caller":"traceutil/trace.go:171","msg":"trace[1052466405] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5828; }","duration":"240.041113ms","start":"2026-05-05T11:30:20.138776Z","end":"2026-05-05T11:30:20.378817Z","steps":["trace[1052466405] 'agreement among raft nodes before linearized reading'  (duration: 240.008612ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T11:30:20.378553Z","caller":"traceutil/trace.go:171","msg":"trace[2048806795] range","detail":"{range_begin:/registry/certificatesigningrequests/; range_end:/registry/certificatesigningrequests0; response_count:0; response_revision:5828; }","duration":"2.373069791s","start":"2026-05-05T11:30:18.005473Z","end":"2026-05-05T11:30:20.378543Z","steps":["trace[2048806795] 'agreement among raft nodes before linearized reading'  (duration: 2.3730173s)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T11:30:20.378688Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T11:30:18.376151Z","time spent":"2.00253169s","remote":"127.0.0.1:39406","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":594,"request content":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" "}
{"level":"info","ts":"2026-05-05T11:30:20.378706Z","caller":"traceutil/trace.go:171","msg":"trace[107215101] range","detail":"{range_begin:/registry/pods/openstack/keepalived-d4phr; range_end:; response_count:1; response_revision:5828; }","duration":"1.962235352s","start":"2026-05-05T11:30:18.416464Z","end":"2026-05-05T11:30:20.3787Z","steps":["trace[107215101] 'agreement among raft nodes before linearized reading'  (duration: 1.962151559s)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T11:30:20.379009Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T11:30:18.41644Z","time spent":"1.962563361s","remote":"127.0.0.1:39318","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6547,"request content":"key:\"/registry/pods/openstack/keepalived-d4phr\" "}
{"level":"warn","ts":"2026-05-05T11:30:20.378769Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T11:30:18.273286Z","time spent":"2.105478446s","remote":"127.0.0.1:60284","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "}
{"level":"warn","ts":"2026-05-05T11:30:20.378975Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T11:30:19.736458Z","time spent":"642.129995ms","remote":"127.0.0.1:39406","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:5808 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-05-05T11:30:20.378384Z","caller":"traceutil/trace.go:171","msg":"trace[1603046574] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5828; }","duration":"882.932639ms","start":"2026-05-05T11:30:19.495405Z","end":"2026-05-05T11:30:20.378338Z","steps":["trace[1603046574] 'agreement among raft nodes before linearized reading'  (duration: 882.731043ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T11:30:20.379164Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T11:30:19.495384Z","time spent":"883.761682ms","remote":"127.0.0.1:39318","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12235,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "}
{"level":"warn","ts":"2026-05-05T11:30:20.378978Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T11:30:18.005464Z","time spent":"2.373478473s","remote":"127.0.0.1:39390","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":1,"response size":30,"request content":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true "}
{"level":"warn","ts":"2026-05-05T11:30:20.378541Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T11:30:18.69558Z","time spent":"1.682952139s","remote":"127.0.0.1:39364","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/openstack/keystone-db-sync\" "}
{"level":"warn","ts":"2026-05-05T11:30:20.378399Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.965261954s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-05-05T11:30:20.379485Z","caller":"traceutil/trace.go:171","msg":"trace[1302734062] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:5828; }","duration":"1.966338604s","start":"2026-05-05T11:30:18.413127Z","end":"2026-05-05T11:30:20.379466Z","steps":["trace[1302734062] 'agreement among raft nodes before linearized reading'  (duration: 1.965239614s)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T11:30:20.379521Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T11:30:18.413083Z","time spent":"1.966426776s","remote":"127.0.0.1:39378","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":2,"response size":30,"request content":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true "}
{"level":"warn","ts":"2026-05-05T11:30:20.378284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"834.491499ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-05-05T11:30:20.379588Z","caller":"traceutil/trace.go:171","msg":"trace[527983487] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5828; }","duration":"835.848326ms","start":"2026-05-05T11:30:19.543729Z","end":"2026-05-05T11:30:20.379578Z","steps":["trace[527983487] 'agreement among raft nodes before linearized reading'  (duration: 834.371495ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T11:30:20.379624Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T11:30:19.543714Z","time spent":"835.900438ms","remote":"127.0.0.1:39406","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-05-05T11:30:20.379804Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.889336855s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/thanosrulers/\" range_end:\"/registry/monitoring.coreos.com/thanosrulers0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-05T11:30:20.379883Z","caller":"traceutil/trace.go:171","msg":"trace[478850855] range","detail":"{range_begin:/registry/monitoring.coreos.com/thanosrulers/; range_end:/registry/monitoring.coreos.com/thanosrulers0; response_count:0; response_revision:5828; }","duration":"1.889371656s","start":"2026-05-05T11:30:18.490456Z","end":"2026-05-05T11:30:20.379828Z","steps":["trace[478850855] 'agreement among raft nodes before linearized reading'  (duration: 1.889316074s)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T11:30:20.379911Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T11:30:18.490375Z","time spent":"1.8895294s","remote":"127.0.0.1:52860","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":28,"request content":"key:\"/registry/monitoring.coreos.com/thanosrulers/\" range_end:\"/registry/monitoring.coreos.com/thanosrulers0\" count_only:true "}
{"level":"warn","ts":"2026-05-05T11:30:20.910134Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.776214ms","expected-duration":"100ms","prefix":"","request":"header:<ID:7053092179350978040 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:5816 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-05T11:30:20.910291Z","caller":"traceutil/trace.go:171","msg":"trace[1125301140] transaction","detail":"{read_only:false; response_revision:5829; number_of_response:1; }","duration":"527.291784ms","start":"2026-05-05T11:30:20.382974Z","end":"2026-05-05T11:30:20.910266Z","steps":["trace[1125301140] 'process raft request'  (duration: 257.275693ms)","trace[1125301140] 'compare'  (duration: 269.507857ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-05T11:30:20.910364Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T11:30:20.382955Z","time spent":"527.376967ms","remote":"127.0.0.1:39406","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:5816 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-05-05T11:30:20.996833Z","caller":"traceutil/trace.go:171","msg":"trace[1469292229] transaction","detail":"{read_only:false; response_revision:5830; number_of_response:1; }","duration":"613.489674ms","start":"2026-05-05T11:30:20.383307Z","end":"2026-05-05T11:30:20.996797Z","steps":["trace[1469292229] 'process raft request'  (duration: 613.208456ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T11:30:20.996915Z","caller":"traceutil/trace.go:171","msg":"trace[1948492877] linearizableReadLoop","detail":"{readStateIndex:6044; appliedIndex:6042; }","duration":"612.871347ms","start":"2026-05-05T11:30:20.384021Z","end":"2026-05-05T11:30:20.996892Z","steps":["trace[1948492877] 'read index received'  (duration: 256.263396ms)","trace[1948492877] 'applied index is now lower than readState.Index'  (duration: 356.606621ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-05T11:30:20.99703Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T11:30:20.383295Z","time spent":"613.613998ms","remote":"127.0.0.1:39228","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":759,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/kube-apiserver-instance.18aca7f43f59a024\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/kube-apiserver-instance.18aca7f43f59a024\" value_size:672 lease:7053092179350977676 >> failure:<>"}
{"level":"info","ts":"2026-05-05T11:30:20.997099Z","caller":"traceutil/trace.go:171","msg":"trace[1322708813] transaction","detail":"{read_only:false; response_revision:5834; number_of_response:1; }","duration":"612.797176ms","start":"2026-05-05T11:30:20.38429Z","end":"2026-05-05T11:30:20.997087Z","steps":["trace[1322708813] 'process raft request'  (duration: 612.526668ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T11:30:20.997147Z","caller":"traceutil/trace.go:171","msg":"trace[1985022501] transaction","detail":"{read_only:false; response_revision:5832; number_of_response:1; }","duration":"612.920179ms","start":"2026-05-05T11:30:20.384172Z","end":"2026-05-05T11:30:20.997092Z","steps":["trace[1985022501] 'process raft request'  (duration: 612.568609ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T11:30:20.997229Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T11:30:20.384272Z","time spent":"612.868227ms","remote":"127.0.0.1:39406","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:5810 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:477 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"info","ts":"2026-05-05T11:30:20.997226Z","caller":"traceutil/trace.go:171","msg":"trace[806985847] transaction","detail":"{read_only:false; response_revision:5835; number_of_response:1; }","duration":"612.757715ms","start":"2026-05-05T11:30:20.384409Z","end":"2026-05-05T11:30:20.997167Z","steps":["trace[806985847] 'process raft request'  (duration: 612.442046ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T11:30:20.997387Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"611.112049ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-05-05T11:30:20.997404Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T11:30:20.384163Z","time spent":"613.098633ms","remote":"127.0.0.1:39406","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:5821 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:465 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"info","ts":"2026-05-05T11:30:20.997434Z","caller":"traceutil/trace.go:171","msg":"trace[185820608] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5835; }","duration":"611.205582ms","start":"2026-05-05T11:30:20.386216Z","end":"2026-05-05T11:30:20.997422Z","steps":["trace[185820608] 'agreement among raft nodes before linearized reading'  (duration: 611.113279ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T11:30:20.997461Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T11:30:20.384349Z","time spent":"612.99424ms","remote":"127.0.0.1:39406","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:5820 > 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-05-05T11:30:20.997474Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T11:30:20.386195Z","time spent":"611.272364ms","remote":"127.0.0.1:39144","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-05-05T11:30:20.996944Z","caller":"traceutil/trace.go:171","msg":"trace[1193695865] transaction","detail":"{read_only:false; response_revision:5833; number_of_response:1; }","duration":"612.635481ms","start":"2026-05-05T11:30:20.384282Z","end":"2026-05-05T11:30:20.996917Z","steps":["trace[1193695865] 'process raft request'  (duration: 612.496447ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T11:30:20.997606Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"613.555026ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12212"}
{"level":"warn","ts":"2026-05-05T11:30:20.997664Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"613.407102ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:11 size:92252"}
{"level":"info","ts":"2026-05-05T11:30:20.997689Z","caller":"traceutil/trace.go:171","msg":"trace[758122456] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5835; }","duration":"613.651038ms","start":"2026-05-05T11:30:20.384016Z","end":"2026-05-05T11:30:20.997667Z","steps":["trace[758122456] 'agreement among raft nodes before linearized reading'  (duration: 613.35084ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T11:30:20.997734Z","caller":"traceutil/trace.go:171","msg":"trace[64819974] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:11; response_revision:5835; }","duration":"613.493695ms","start":"2026-05-05T11:30:20.384225Z","end":"2026-05-05T11:30:20.997719Z","steps":["trace[64819974] 'agreement among raft nodes before linearized reading'  (duration: 613.039522ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T11:30:20.997739Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T11:30:20.383981Z","time spent":"613.748921ms","remote":"127.0.0.1:39318","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12235,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "}
{"level":"warn","ts":"2026-05-05T11:30:20.99773Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T11:30:20.384271Z","time spent":"613.379141ms","remote":"127.0.0.1:39406","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:5819 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-05-05T11:30:20.997781Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T11:30:20.384199Z","time spent":"613.573016ms","remote":"127.0.0.1:39318","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":11,"response size":92275,"request content":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" "}
{"level":"info","ts":"2026-05-05T11:30:20.99712Z","caller":"traceutil/trace.go:171","msg":"trace[1636899577] transaction","detail":"{read_only:false; response_revision:5831; number_of_response:1; }","duration":"612.765235ms","start":"2026-05-05T11:30:20.384108Z","end":"2026-05-05T11:30:20.996873Z","steps":["trace[1636899577] 'process raft request'  (duration: 612.57292ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T11:30:20.998004Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T11:30:20.384097Z","time spent":"613.833513ms","remote":"127.0.0.1:39406","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:5817 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:429 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"warn","ts":"2026-05-05T11:30:21.203041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.043975ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-05T11:30:21.203153Z","caller":"traceutil/trace.go:171","msg":"trace[835136231] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:5835; }","duration":"101.240951ms","start":"2026-05-05T11:30:21.101886Z","end":"2026-05-05T11:30:21.203127Z","steps":["trace[835136231] 'range keys from in-memory index tree'  (duration: 100.847429ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T11:30:22.559644Z","caller":"traceutil/trace.go:171","msg":"trace[2085874938] linearizableReadLoop","detail":"{readStateIndex:6050; appliedIndex:6049; }","duration":"420.937355ms","start":"2026-05-05T11:30:22.138671Z","end":"2026-05-05T11:30:22.559609Z","steps":["trace[2085874938] 'read index received'  (duration: 420.75256ms)","trace[2085874938] 'applied index is now lower than readState.Index'  (duration: 182.944µs)"],"step_count":2}
{"level":"info","ts":"2026-05-05T11:30:22.559742Z","caller":"traceutil/trace.go:171","msg":"trace[1725350689] transaction","detail":"{read_only:false; response_revision:5836; number_of_response:1; }","duration":"822.525773ms","start":"2026-05-05T11:30:21.737176Z","end":"2026-05-05T11:30:22.559702Z","steps":["trace[1725350689] 'process raft request'  (duration: 822.230295ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T11:30:22.559869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"421.178221ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-05T11:30:22.559973Z","caller":"traceutil/trace.go:171","msg":"trace[1771418540] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5836; }","duration":"421.346997ms","start":"2026-05-05T11:30:22.138601Z","end":"2026-05-05T11:30:22.559948Z","steps":["trace[1771418540] 'agreement among raft nodes before linearized reading'  (duration: 421.139891ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T11:30:22.560033Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T11:30:22.138568Z","time spent":"421.45527ms","remote":"127.0.0.1:39144","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-05-05T11:30:22.560162Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T11:30:21.73714Z","time spent":"822.79288ms","remote":"127.0.0.1:39406","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:5825 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"info","ts":"2026-05-05T11:30:22.671824Z","caller":"traceutil/trace.go:171","msg":"trace[1563504331] linearizableReadLoop","detail":"{readStateIndex:6052; appliedIndex:6050; }","duration":"112.047744ms","start":"2026-05-05T11:30:22.559732Z","end":"2026-05-05T11:30:22.67178Z","steps":["trace[1563504331] 'read index received'  (duration: 82.135929ms)","trace[1563504331] 'applied index is now lower than readState.Index'  (duration: 29.908415ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-05T11:30:22.671873Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.684378ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/keystone-db-sync\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-05T11:30:22.671887Z","caller":"traceutil/trace.go:171","msg":"trace[634887142] transaction","detail":"{read_only:false; response_revision:5838; number_of_response:1; }","duration":"287.409415ms","start":"2026-05-05T11:30:22.384441Z","end":"2026-05-05T11:30:22.671851Z","steps":["trace[634887142] 'process raft request'  (duration: 287.134098ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T11:30:22.671945Z","caller":"traceutil/trace.go:171","msg":"trace[704614825] range","detail":"{range_begin:/registry/jobs/openstack/keystone-db-sync; range_end:; response_count:0; response_revision:5838; }","duration":"285.794841ms","start":"2026-05-05T11:30:22.38613Z","end":"2026-05-05T11:30:22.671925Z","steps":["trace[704614825] 'agreement among raft nodes before linearized reading'  (duration: 285.662748ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T11:30:22.671945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.847173ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/keystone-fernet-setup\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-05T11:30:22.672026Z","caller":"traceutil/trace.go:171","msg":"trace[691699628] range","detail":"{range_begin:/registry/jobs/openstack/keystone-fernet-setup; range_end:; response_count:0; response_revision:5838; }","duration":"285.960275ms","start":"2026-05-05T11:30:22.386043Z","end":"2026-05-05T11:30:22.672003Z","steps":["trace[691699628] 'agreement among raft nodes before linearized reading'  (duration: 285.801031ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T11:30:22.672202Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.970081ms","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":"warn","ts":"2026-05-05T11:30:22.672215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.768009ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-05T11:30:22.67225Z","caller":"traceutil/trace.go:171","msg":"trace[1004941581] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5838; }","duration":"288.105765ms","start":"2026-05-05T11:30:22.384132Z","end":"2026-05-05T11:30:22.672238Z","steps":["trace[1004941581] 'agreement among raft nodes before linearized reading'  (duration: 287.843877ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T11:30:22.672214Z","caller":"traceutil/trace.go:171","msg":"trace[1341571011] transaction","detail":"{read_only:false; response_revision:5837; number_of_response:1; }","duration":"442.733179ms","start":"2026-05-05T11:30:22.2289Z","end":"2026-05-05T11:30:22.671633Z","steps":["trace[1341571011] 'process raft request'  (duration: 412.995538ms)","trace[1341571011] 'compare'  (duration: 29.490085ms)"],"step_count":2}
{"level":"info","ts":"2026-05-05T11:30:22.672278Z","caller":"traceutil/trace.go:171","msg":"trace[1341712241] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5838; }","duration":"110.900293ms","start":"2026-05-05T11:30:22.561362Z","end":"2026-05-05T11:30:22.672262Z","steps":["trace[1341712241] 'agreement among raft nodes before linearized reading'  (duration: 110.79863ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T11:30:22.67232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"517.495778ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-controller\" ","response":"range_response_count:1 size:1990"}
{"level":"info","ts":"2026-05-05T11:30:22.672358Z","caller":"traceutil/trace.go:171","msg":"trace[1810438811] range","detail":"{range_begin:/registry/services/specs/ingress-nginx/ingress-nginx-controller; range_end:; response_count:1; response_revision:5838; }","duration":"517.526448ms","start":"2026-05-05T11:30:22.154815Z","end":"2026-05-05T11:30:22.672341Z","steps":["trace[1810438811] 'agreement among raft nodes before linearized reading'  (duration: 517.377834ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T11:30:22.672396Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T11:30:22.154746Z","time spent":"517.641012ms","remote":"127.0.0.1:39330","response type":"/etcdserverpb.KV/Range","request count":0,"request size":65,"response count":1,"response size":2013,"request content":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-controller\" "}
{"level":"warn","ts":"2026-05-05T11:30:22.672397Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T11:30:22.228858Z","time spent":"443.432458ms","remote":"127.0.0.1:39406","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:5789 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:471 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"info","ts":"2026-05-05T11:30:23.025751Z","caller":"traceutil/trace.go:171","msg":"trace[767787185] transaction","detail":"{read_only:false; response_revision:5839; number_of_response:1; }","duration":"347.919415ms","start":"2026-05-05T11:30:22.677805Z","end":"2026-05-05T11:30:23.025724Z","steps":["trace[767787185] 'process raft request'  (duration: 316.975851ms)","trace[767787185] 'compare'  (duration: 30.826101ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-05T11:30:23.025917Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T11:30:22.677782Z","time spent":"348.056208ms","remote":"127.0.0.1:39406","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:5828 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-05-05T11:30:23.079897Z","caller":"traceutil/trace.go:171","msg":"trace[411558431] transaction","detail":"{read_only:false; response_revision:5840; number_of_response:1; }","duration":"311.463901ms","start":"2026-05-05T11:30:22.768386Z","end":"2026-05-05T11:30:23.07985Z","steps":["trace[411558431] 'process raft request'  (duration: 311.144562ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T11:30:23.080121Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T11:30:22.768351Z","time spent":"311.648897ms","remote":"127.0.0.1:39406","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" mod_revision:5803 > success:<request_put:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" value_size:415 >> failure:<request_range:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" > >"}
{"level":"warn","ts":"2026-05-05T11:30:23.242051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.026237ms","expected-duration":"100ms","prefix":"","request":"header:<ID:7053092179350978064 > lease_revoke:<id:61e19df7de4cfd35>","response":"size:28"}
{"level":"info","ts":"2026-05-05T11:30:23.24216Z","caller":"traceutil/trace.go:171","msg":"trace[1410392267] linearizableReadLoop","detail":"{readStateIndex:6054; appliedIndex:6052; }","duration":"326.946302ms","start":"2026-05-05T11:30:22.915193Z","end":"2026-05-05T11:30:23.24214Z","steps":["trace[1410392267] 'read index received'  (duration: 79.60928ms)","trace[1410392267] 'applied index is now lower than readState.Index'  (duration: 247.335262ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-05T11:30:23.242433Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.580209ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-05-05T11:30:23.242468Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.30373ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-05-05T11:30:23.242538Z","caller":"traceutil/trace.go:171","msg":"trace[1399332160] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5840; }","duration":"240.384823ms","start":"2026-05-05T11:30:23.002129Z","end":"2026-05-05T11:30:23.242514Z","steps":["trace[1399332160] 'agreement among raft nodes before linearized reading'  (duration: 240.157776ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T11:30:23.242532Z","caller":"traceutil/trace.go:171","msg":"trace[1789490766] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:5840; }","duration":"105.691942ms","start":"2026-05-05T11:30:23.136813Z","end":"2026-05-05T11:30:23.242505Z","steps":["trace[1789490766] 'agreement among raft nodes before linearized reading'  (duration: 105.536307ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T11:30:23.242652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.590195ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-d4phr\" ","response":"range_response_count:1 size:6524"}
{"level":"warn","ts":"2026-05-05T11:30:23.242703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.9113ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:571"}
{"level":"info","ts":"2026-05-05T11:30:23.242822Z","caller":"traceutil/trace.go:171","msg":"trace[204430964] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:5840; }","duration":"240.113995ms","start":"2026-05-05T11:30:23.002676Z","end":"2026-05-05T11:30:23.24279Z","steps":["trace[204430964] 'agreement among raft nodes before linearized reading'  (duration: 239.738035ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T11:30:23.242703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.140927ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"info","ts":"2026-05-05T11:30:23.242899Z","caller":"traceutil/trace.go:171","msg":"trace[2049934688] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5840; }","duration":"240.385623ms","start":"2026-05-05T11:30:23.002499Z","end":"2026-05-05T11:30:23.242885Z","steps":["trace[2049934688] 'agreement among raft nodes before linearized reading'  (duration: 239.957611ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T11:30:23.242733Z","caller":"traceutil/trace.go:171","msg":"trace[1332893442] range","detail":"{range_begin:/registry/pods/openstack/keepalived-d4phr; range_end:; response_count:1; response_revision:5840; }","duration":"238.738748ms","start":"2026-05-05T11:30:23.003976Z","end":"2026-05-05T11:30:23.242714Z","steps":["trace[1332893442] 'agreement among raft nodes before linearized reading'  (duration: 238.42175ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T11:30:23.243249Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.438934ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"}
{"level":"warn","ts":"2026-05-05T11:30:23.243532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.335981ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"}
{"level":"warn","ts":"2026-05-05T11:30:23.242706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.740316ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:557"}
{"level":"info","ts":"2026-05-05T11:30:23.243663Z","caller":"traceutil/trace.go:171","msg":"trace[2087545762] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5840; }","duration":"240.822624ms","start":"2026-05-05T11:30:23.002818Z","end":"2026-05-05T11:30:23.243641Z","steps":["trace[2087545762] 'agreement among raft nodes before linearized reading'  (duration: 239.528588ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T11:30:23.243629Z","caller":"traceutil/trace.go:171","msg":"trace[982980532] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5840; }","duration":"328.491975ms","start":"2026-05-05T11:30:22.915123Z","end":"2026-05-05T11:30:23.243615Z","steps":["trace[982980532] 'agreement among raft nodes before linearized reading'  (duration: 327.122437ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T11:30:23.243606Z","caller":"traceutil/trace.go:171","msg":"trace[2006502689] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5840; }","duration":"240.814155ms","start":"2026-05-05T11:30:23.002772Z","end":"2026-05-05T11:30:23.243586Z","steps":["trace[2006502689] 'agreement among raft nodes before linearized reading'  (duration: 239.675104ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T11:30:23.243763Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T11:30:22.915099Z","time spent":"328.621809ms","remote":"127.0.0.1:39406","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-05-05T11:30:23.504354Z","caller":"traceutil/trace.go:171","msg":"trace[1184077747] transaction","detail":"{read_only:false; response_revision:5842; number_of_response:1; }","duration":"255.934346ms","start":"2026-05-05T11:30:23.248376Z","end":"2026-05-05T11:30:23.50431Z","steps":["trace[1184077747] 'process raft request'  (duration: 255.595007ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T11:30:23.504397Z","caller":"traceutil/trace.go:171","msg":"trace[1820829459] transaction","detail":"{read_only:false; response_revision:5843; number_of_response:1; }","duration":"255.979618ms","start":"2026-05-05T11:30:23.248376Z","end":"2026-05-05T11:30:23.504356Z","steps":["trace[1820829459] 'process raft request'  (duration: 255.837624ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T11:30:23.504825Z","caller":"traceutil/trace.go:171","msg":"trace[410381144] linearizableReadLoop","detail":"{readStateIndex:6060; appliedIndex:6055; }","duration":"256.186694ms","start":"2026-05-05T11:30:23.248613Z","end":"2026-05-05T11:30:23.5048Z","steps":["trace[410381144] 'read index received'  (duration: 78.643814ms)","trace[410381144] 'applied index is now lower than readState.Index'  (duration: 177.54132ms)"],"step_count":2}
{"level":"info","ts":"2026-05-05T11:30:23.504858Z","caller":"traceutil/trace.go:171","msg":"trace[540212239] transaction","detail":"{read_only:false; response_revision:5845; number_of_response:1; }","duration":"256.217214ms","start":"2026-05-05T11:30:23.248605Z","end":"2026-05-05T11:30:23.504822Z","steps":["trace[540212239] 'process raft request'  (duration: 256.001278ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T11:30:23.504791Z","caller":"traceutil/trace.go:171","msg":"trace[1466301762] transaction","detail":"{read_only:false; response_revision:5844; number_of_response:1; }","duration":"256.180543ms","start":"2026-05-05T11:30:23.248575Z","end":"2026-05-05T11:30:23.504756Z","steps":["trace[1466301762] 'process raft request'  (duration: 255.703921ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T11:30:23.505025Z","caller":"traceutil/trace.go:171","msg":"trace[1836656129] transaction","detail":"{read_only:false; response_revision:5846; number_of_response:1; }","duration":"256.032669ms","start":"2026-05-05T11:30:23.248974Z","end":"2026-05-05T11:30:23.505007Z","steps":["trace[1836656129] 'process raft request'  (duration: 255.764082ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T11:30:23.505176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.534973ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:11 size:92252"}
{"level":"info","ts":"2026-05-05T11:30:23.505222Z","caller":"traceutil/trace.go:171","msg":"trace[1449701520] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:11; response_revision:5846; }","duration":"256.626235ms","start":"2026-05-05T11:30:23.248585Z","end":"2026-05-05T11:30:23.505212Z","steps":["trace[1449701520] 'agreement among raft nodes before linearized reading'  (duration: 256.315876ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T11:30:34.79263Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2871}
{"level":"info","ts":"2026-05-05T11:30:34.86397Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2871,"took":"69.875605ms","hash":1549041236,"current-db-size-bytes":57856000,"current-db-size":"58 MB","current-db-size-in-use-bytes":32878592,"current-db-size-in-use":"33 MB"}
{"level":"info","ts":"2026-05-05T11:30:34.864038Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1549041236,"revision":2871,"compact-revision":-1}
{"level":"info","ts":"2026-05-05T11:35:07.83176Z","caller":"traceutil/trace.go:171","msg":"trace[1932149193] transaction","detail":"{read_only:false; response_revision:7978; number_of_response:1; }","duration":"100.733907ms","start":"2026-05-05T11:35:07.731Z","end":"2026-05-05T11:35:07.831734Z","steps":["trace[1932149193] 'process raft request'  (duration: 100.555542ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T11:35:07.851117Z","caller":"traceutil/trace.go:171","msg":"trace[1676877265] transaction","detail":"{read_only:false; response_revision:7979; number_of_response:1; }","duration":"119.92963ms","start":"2026-05-05T11:35:07.731127Z","end":"2026-05-05T11:35:07.851057Z","steps":["trace[1676877265] 'process raft request'  (duration: 119.661653ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T11:35:19.520775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.391334ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-d4phr\" ","response":"range_response_count:1 size:6524"}
{"level":"info","ts":"2026-05-05T11:35:19.520877Z","caller":"traceutil/trace.go:171","msg":"trace[393557853] range","detail":"{range_begin:/registry/pods/openstack/keepalived-d4phr; range_end:; response_count:1; response_revision:8042; }","duration":"165.56125ms","start":"2026-05-05T11:35:19.355289Z","end":"2026-05-05T11:35:19.520851Z","steps":["trace[393557853] 'range keys from in-memory index tree'  (duration: 165.104667ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T11:35:19.52104Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.373744ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/barbican-api-7c49c454c9-d94cl.18aca8352b3f5c3f\" ","response":"range_response_count:1 size:1135"}
{"level":"info","ts":"2026-05-05T11:35:19.521203Z","caller":"traceutil/trace.go:171","msg":"trace[1812750972] range","detail":"{range_begin:/registry/events/openstack/barbican-api-7c49c454c9-d94cl.18aca8352b3f5c3f; range_end:; response_count:1; response_revision:8042; }","duration":"300.58573ms","start":"2026-05-05T11:35:19.220584Z","end":"2026-05-05T11:35:19.521169Z","steps":["trace[1812750972] 'range keys from in-memory index tree'  (duration: 300.130197ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T11:35:19.521279Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T11:35:19.220558Z","time spent":"300.698703ms","remote":"127.0.0.1:39228","response type":"/etcdserverpb.KV/Range","request count":0,"request size":75,"response count":1,"response size":1158,"request content":"key:\"/registry/events/openstack/barbican-api-7c49c454c9-d94cl.18aca8352b3f5c3f\" "}
{"level":"info","ts":"2026-05-05T11:35:34.800627Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5932}
{"level":"info","ts":"2026-05-05T11:35:34.893779Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5932,"took":"90.979131ms","hash":3466935758,"current-db-size-bytes":57856000,"current-db-size":"58 MB","current-db-size-in-use-bytes":26275840,"current-db-size-in-use":"26 MB"}
{"level":"info","ts":"2026-05-05T11:35:34.893847Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3466935758,"revision":5932,"compact-revision":2871}
{"level":"info","ts":"2026-05-05T11:36:01.795727Z","caller":"traceutil/trace.go:171","msg":"trace[909331744] transaction","detail":"{read_only:false; response_revision:8360; number_of_response:1; }","duration":"322.340138ms","start":"2026-05-05T11:36:01.473357Z","end":"2026-05-05T11:36:01.795698Z","steps":["trace[909331744] 'process raft request'  (duration: 322.137683ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T11:36:01.795943Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T11:36:01.473325Z","time spent":"322.500353ms","remote":"127.0.0.1:39406","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:8337 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:477 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"info","ts":"2026-05-05T11:36:01.796239Z","caller":"traceutil/trace.go:171","msg":"trace[1255527407] transaction","detail":"{read_only:false; response_revision:8361; number_of_response:1; }","duration":"321.458614ms","start":"2026-05-05T11:36:01.474744Z","end":"2026-05-05T11:36:01.796203Z","steps":["trace[1255527407] 'process raft request'  (duration: 320.905869ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T11:36:01.796433Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T11:36:01.474734Z","time spent":"321.602957ms","remote":"127.0.0.1:39406","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:8335 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-05-05T11:36:01.796613Z","caller":"traceutil/trace.go:171","msg":"trace[669768996] linearizableReadLoop","detail":"{readStateIndex:8658; appliedIndex:8656; }","duration":"322.654436ms","start":"2026-05-05T11:36:01.47394Z","end":"2026-05-05T11:36:01.796594Z","steps":["trace[669768996] 'read index received'  (duration: 72.201494ms)","trace[669768996] 'applied index is now lower than readState.Index'  (duration: 250.451312ms)"],"step_count":2}
{"level":"info","ts":"2026-05-05T11:36:01.796831Z","caller":"traceutil/trace.go:171","msg":"trace[6747607] transaction","detail":"{read_only:false; response_revision:8362; number_of_response:1; }","duration":"319.84368ms","start":"2026-05-05T11:36:01.476973Z","end":"2026-05-05T11:36:01.796817Z","steps":["trace[6747607] 'process raft request'  (duration: 319.10924ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T11:36:01.796832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"322.879763ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"}
{"level":"info","ts":"2026-05-05T11:36:01.796874Z","caller":"traceutil/trace.go:171","msg":"trace[378259250] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8362; }","duration":"322.935414ms","start":"2026-05-05T11:36:01.473929Z","end":"2026-05-05T11:36:01.796864Z","steps":["trace[378259250] 'agreement among raft nodes before linearized reading'  (duration: 322.742919ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T11:36:01.796898Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T11:36:01.476944Z","time spent":"319.919062ms","remote":"127.0.0.1:39406","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:8339 > 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-05-05T11:36:01.796904Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T11:36:01.473924Z","time spent":"322.974085ms","remote":"127.0.0.1:39406","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-05-05T11:36:01.803457Z","caller":"traceutil/trace.go:171","msg":"trace[94603619] transaction","detail":"{read_only:false; response_revision:8363; number_of_response:1; }","duration":"112.316636ms","start":"2026-05-05T11:36:01.691101Z","end":"2026-05-05T11:36:01.803417Z","steps":["trace[94603619] 'process raft request'  (duration: 112.09715ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T11:36:02.744723Z","caller":"traceutil/trace.go:171","msg":"trace[1195918368] linearizableReadLoop","detail":"{readStateIndex:8666; appliedIndex:8665; }","duration":"104.047419ms","start":"2026-05-05T11:36:02.640648Z","end":"2026-05-05T11:36:02.744696Z","steps":["trace[1195918368] 'read index received'  (duration: 103.845674ms)","trace[1195918368] 'applied index is now lower than readState.Index'  (duration: 200.225µs)"],"step_count":2}
{"level":"info","ts":"2026-05-05T11:36:02.744799Z","caller":"traceutil/trace.go:171","msg":"trace[1877689720] transaction","detail":"{read_only:false; response_revision:8368; number_of_response:1; }","duration":"205.811635ms","start":"2026-05-05T11:36:02.538943Z","end":"2026-05-05T11:36:02.744754Z","steps":["trace[1877689720] 'process raft request'  (duration: 205.551978ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T11:36:02.744947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.288776ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-05T11:36:02.744984Z","caller":"traceutil/trace.go:171","msg":"trace[1607281074] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8368; }","duration":"104.375818ms","start":"2026-05-05T11:36:02.640598Z","end":"2026-05-05T11:36:02.744973Z","steps":["trace[1607281074] 'agreement among raft nodes before linearized reading'  (duration: 104.276505ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T11:36:03.217803Z","caller":"traceutil/trace.go:171","msg":"trace[1483042377] transaction","detail":"{read_only:false; response_revision:8371; number_of_response:1; }","duration":"100.652176ms","start":"2026-05-05T11:36:03.117107Z","end":"2026-05-05T11:36:03.217759Z","steps":["trace[1483042377] 'process raft request'  (duration: 100.294506ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T11:37:04.479475Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-000000000000244c.wal"}
{"level":"warn","ts":"2026-05-05T11:37:12.241578Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.603639ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-05T11:37:12.241822Z","caller":"traceutil/trace.go:171","msg":"trace[1888314333] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:9015; }","duration":"102.858066ms","start":"2026-05-05T11:37:12.138932Z","end":"2026-05-05T11:37:12.24179Z","steps":["trace[1888314333] 'range keys from in-memory index tree'  (duration: 102.397624ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T11:37:12.424439Z","caller":"traceutil/trace.go:171","msg":"trace[306355711] transaction","detail":"{read_only:false; response_revision:9017; number_of_response:1; }","duration":"177.665883ms","start":"2026-05-05T11:37:12.246727Z","end":"2026-05-05T11:37:12.424393Z","steps":["trace[306355711] 'process raft request'  (duration: 114.824195ms)","trace[306355711] 'compare'  (duration: 62.450127ms)"],"step_count":2}
{"level":"info","ts":"2026-05-05T11:37:12.424695Z","caller":"traceutil/trace.go:171","msg":"trace[227636409] transaction","detail":"{read_only:false; response_revision:9019; number_of_response:1; }","duration":"177.683234ms","start":"2026-05-05T11:37:12.246968Z","end":"2026-05-05T11:37:12.424651Z","steps":["trace[227636409] 'process raft request'  (duration: 177.386456ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T11:37:12.424545Z","caller":"traceutil/trace.go:171","msg":"trace[1732194375] transaction","detail":"{read_only:false; response_revision:9018; number_of_response:1; }","duration":"177.666482ms","start":"2026-05-05T11:37:12.246832Z","end":"2026-05-05T11:37:12.424498Z","steps":["trace[1732194375] 'process raft request'  (duration: 177.410166ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T11:38:31.160616Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"f577bc5ae95d61e1","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-05-05T11:38:31.167192Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001}
{"level":"info","ts":"2026-05-05T11:38:31.167335Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001}
{"level":"info","ts":"2026-05-05T11:40:34.808292Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8125}
{"level":"info","ts":"2026-05-05T11:40:34.878239Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8125,"took":"66.727072ms","hash":1315149759,"current-db-size-bytes":57856000,"current-db-size":"58 MB","current-db-size-in-use-bytes":30576640,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-05-05T11:40:34.878333Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1315149759,"revision":8125,"compact-revision":5932}
{"level":"info","ts":"2026-05-05T11:45:34.816185Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10846}
{"level":"info","ts":"2026-05-05T11:45:34.906806Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10846,"took":"87.21301ms","hash":855046968,"current-db-size-bytes":57856000,"current-db-size":"58 MB","current-db-size-in-use-bytes":27312128,"current-db-size-in-use":"27 MB"}
{"level":"info","ts":"2026-05-05T11:45:34.906889Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":855046968,"revision":10846,"compact-revision":8125}
{"level":"info","ts":"2026-05-05T11:50:34.82325Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12883}
{"level":"info","ts":"2026-05-05T11:50:34.908588Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12883,"took":"82.192832ms","hash":932470441,"current-db-size-bytes":57856000,"current-db-size":"58 MB","current-db-size-in-use-bytes":23285760,"current-db-size-in-use":"23 MB"}
{"level":"info","ts":"2026-05-05T11:50:34.908723Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":932470441,"revision":12883,"compact-revision":10846}
{"level":"info","ts":"2026-05-05T11:55:34.831457Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14520}
{"level":"info","ts":"2026-05-05T11:55:34.906076Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14520,"took":"71.787526ms","hash":4192869994,"current-db-size-bytes":57856000,"current-db-size":"58 MB","current-db-size-in-use-bytes":20049920,"current-db-size-in-use":"20 MB"}
{"level":"info","ts":"2026-05-05T11:55:34.906168Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4192869994,"revision":14520,"compact-revision":12883}