{"level":"warn","ts":"2026-04-14T02:00:24.606455Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-14T02:00:24.606572Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.235:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.235:2380","--initial-cluster=instance=https://199.204.45.235:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.235:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.235:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-04-14T02:00:24.606646Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-14T02:00:24.606658Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.235:2380"]} {"level":"info","ts":"2026-04-14T02:00:24.606675Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-14T02:00:24.607307Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.235:2379"]} {"level":"info","ts":"2026-04-14T02:00:24.607389Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.235:2380"],"listen-peer-urls":["https://199.204.45.235:2380"],"advertise-client-urls":["https://199.204.45.235:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.235:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.235:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-04-14T02:00:24.614288Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.527464ms"} {"level":"info","ts":"2026-04-14T02:00:24.62187Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"aab6040abcf11","cluster-id":"2bae7d3d8857c059"} {"level":"info","ts":"2026-04-14T02:00:24.621929Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 switched to configuration voters=()"} {"level":"info","ts":"2026-04-14T02:00:24.621946Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 became follower at term 0"} {"level":"info","ts":"2026-04-14T02:00:24.62196Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft aab6040abcf11 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-14T02:00:24.62197Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 became follower at term 1"} {"level":"info","ts":"2026-04-14T02:00:24.621998Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 switched to configuration voters=(3003179657318161)"} {"level":"warn","ts":"2026-04-14T02:00:24.627599Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-14T02:00:24.629111Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-14T02:00:24.630264Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-04-14T02:00:24.632982Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"aab6040abcf11","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-14T02:00:24.633112Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"aab6040abcf11","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-14T02:00:24.633468Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-14T02:00:24.633599Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-14T02:00:24.633645Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-14T02:00:24.63381Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 switched to configuration voters=(3003179657318161)"} {"level":"info","ts":"2026-04-14T02:00:24.633977Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"2bae7d3d8857c059","local-member-id":"aab6040abcf11","added-peer-id":"aab6040abcf11","added-peer-peer-urls":["https://199.204.45.235:2380"]} {"level":"info","ts":"2026-04-14T02:00:24.637765Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-14T02:00:24.638097Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"aab6040abcf11","initial-advertise-peer-urls":["https://199.204.45.235:2380"],"listen-peer-urls":["https://199.204.45.235:2380"],"advertise-client-urls":["https://199.204.45.235:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.235:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-14T02:00:24.638131Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-14T02:00:24.638276Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.235:2380"} {"level":"info","ts":"2026-04-14T02:00:24.638883Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.235:2380"} {"level":"info","ts":"2026-04-14T02:00:25.22242Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 is starting a new election at term 1"} {"level":"info","ts":"2026-04-14T02:00:25.22248Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-14T02:00:25.222515Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 received MsgPreVoteResp from aab6040abcf11 at term 1"} {"level":"info","ts":"2026-04-14T02:00:25.222545Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 became candidate at term 2"} {"level":"info","ts":"2026-04-14T02:00:25.222556Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 received MsgVoteResp from aab6040abcf11 at term 2"} {"level":"info","ts":"2026-04-14T02:00:25.222573Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 became leader at term 2"} {"level":"info","ts":"2026-04-14T02:00:25.22274Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: aab6040abcf11 elected leader aab6040abcf11 at term 2"} {"level":"info","ts":"2026-04-14T02:00:25.223956Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"aab6040abcf11","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.235:2379]}","request-path":"/0/members/aab6040abcf11/attributes","cluster-id":"2bae7d3d8857c059","publish-timeout":"7s"} {"level":"info","ts":"2026-04-14T02:00:25.224093Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-14T02:00:25.2242Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-14T02:00:25.224176Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-14T02:00:25.225029Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"2bae7d3d8857c059","local-member-id":"aab6040abcf11","cluster-version":"3.5"} {"level":"info","ts":"2026-04-14T02:00:25.225097Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-14T02:00:25.225115Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-14T02:00:25.226061Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.235:2379"} {"level":"info","ts":"2026-04-14T02:00:25.226186Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-14T02:00:25.226265Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-14T02:00:25.227556Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-14T02:00:29.410931Z","caller":"traceutil/trace.go:171","msg":"trace[1136620995] transaction","detail":"{read_only:false; response_revision:215; number_of_response:1; }","duration":"255.802879ms","start":"2026-04-14T02:00:29.155098Z","end":"2026-04-14T02:00:29.410901Z","steps":["trace[1136620995] 'process raft request' (duration: 255.500502ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:00:30.040225Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.23226ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-14T02:00:30.040422Z","caller":"traceutil/trace.go:171","msg":"trace[384357284] transaction","detail":"{read_only:false; response_revision:218; number_of_response:1; }","duration":"567.723023ms","start":"2026-04-14T02:00:29.472682Z","end":"2026-04-14T02:00:30.040405Z","steps":["trace[384357284] 'process raft request' (duration: 567.668982ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:00:30.040484Z","caller":"traceutil/trace.go:171","msg":"trace[1692627066] transaction","detail":"{read_only:false; response_revision:217; number_of_response:1; }","duration":"568.133873ms","start":"2026-04-14T02:00:29.472304Z","end":"2026-04-14T02:00:30.040438Z","steps":["trace[1692627066] 'process raft request' (duration: 282.183056ms)","trace[1692627066] 'compare' (duration: 285.097217ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T02:00:30.040557Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:00:29.472653Z","time spent":"567.870217ms","remote":"127.0.0.1:34956","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":290,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-14T02:00:30.04075Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:00:29.472278Z","time spent":"568.387849ms","remote":"127.0.0.1:34892","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-14T02:00:40.960713Z","caller":"traceutil/trace.go:171","msg":"trace[1229059743] transaction","detail":"{read_only:false; response_revision:428; number_of_response:1; }","duration":"120.392606ms","start":"2026-04-14T02:00:40.840279Z","end":"2026-04-14T02:00:40.960671Z","steps":["trace[1229059743] 'process raft request' (duration: 75.479087ms)","trace[1229059743] 'compare' (duration: 44.751655ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T02:00:48.453479Z","caller":"traceutil/trace.go:171","msg":"trace[792169461] transaction","detail":"{read_only:false; number_of_response:1; response_revision:499; }","duration":"460.654961ms","start":"2026-04-14T02:00:47.992789Z","end":"2026-04-14T02:00:48.453444Z","steps":["trace[792169461] 'process raft request' (duration: 412.778785ms)","trace[792169461] 'compare' (duration: 47.732613ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T02:00:48.454801Z","caller":"traceutil/trace.go:171","msg":"trace[571231332] transaction","detail":"{read_only:false; response_revision:500; number_of_response:1; }","duration":"452.44085ms","start":"2026-04-14T02:00:48.002227Z","end":"2026-04-14T02:00:48.454667Z","steps":["trace[571231332] 'process raft request' (duration: 451.200434ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:00:48.45498Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:00:48.002209Z","time spent":"452.682944ms","remote":"127.0.0.1:34618","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-14T02:00:48.455213Z","caller":"traceutil/trace.go:171","msg":"trace[962989558] transaction","detail":"{read_only:false; response_revision:501; number_of_response:1; }","duration":"447.792783ms","start":"2026-04-14T02:00:48.007377Z","end":"2026-04-14T02:00:48.45517Z","steps":["trace[962989558] 'process raft request' (duration: 446.156409ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:00:48.455352Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:00:47.99277Z","time spent":"460.810335ms","remote":"127.0.0.1:34618","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":101,"response count":0,"response size":10110,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-14T02:00:48.45548Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:00:48.007357Z","time spent":"447.944136ms","remote":"127.0.0.1:34618","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30374,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-14T02:00:48.460598Z","caller":"traceutil/trace.go:171","msg":"trace[752133150] transaction","detail":"{read_only:false; response_revision:502; number_of_response:1; }","duration":"451.208524ms","start":"2026-04-14T02:00:48.009289Z","end":"2026-04-14T02:00:48.460497Z","steps":["trace[752133150] 'process raft request' (duration: 446.957405ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:00:48.461147Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:00:48.009279Z","time spent":"451.710684ms","remote":"127.0.0.1:34618","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":64462,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-14T02:00:48.464378Z","caller":"traceutil/trace.go:171","msg":"trace[926657724] linearizableReadLoop","detail":"{readStateIndex:523; appliedIndex:518; }","duration":"454.024592ms","start":"2026-04-14T02:00:48.010315Z","end":"2026-04-14T02:00:48.46434Z","steps":["trace[926657724] 'read index received' (duration: 395.279889ms)","trace[926657724] 'applied index is now lower than readState.Index' (duration: 58.743953ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T02:00:48.464514Z","caller":"traceutil/trace.go:171","msg":"trace[1419985950] transaction","detail":"{read_only:false; response_revision:504; number_of_response:1; }","duration":"336.72288ms","start":"2026-04-14T02:00:48.127768Z","end":"2026-04-14T02:00:48.464491Z","steps":["trace[1419985950] 'process raft request' (duration: 336.466195ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:00:48.46459Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:00:48.127743Z","time spent":"336.810962ms","remote":"127.0.0.1:34618","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-14T02:00:48.464597Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"454.226916ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.235\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-14T02:00:48.464667Z","caller":"traceutil/trace.go:171","msg":"trace[429699201] range","detail":"{range_begin:/registry/masterleases/199.204.45.235; range_end:; response_count:1; response_revision:504; }","duration":"454.539064ms","start":"2026-04-14T02:00:48.010116Z","end":"2026-04-14T02:00:48.464655Z","steps":["trace[429699201] 'agreement among raft nodes before linearized reading' (duration: 454.37628ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:00:48.464708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.628497ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-14T02:00:48.464736Z","caller":"traceutil/trace.go:171","msg":"trace[677185085] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:504; }","duration":"249.654767ms","start":"2026-04-14T02:00:48.215072Z","end":"2026-04-14T02:00:48.464727Z","steps":["trace[677185085] 'agreement among raft nodes before linearized reading' (duration: 249.591686ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:00:48.464721Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:00:48.010107Z","time spent":"454.603665ms","remote":"127.0.0.1:34586","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/199.204.45.235\" "} {"level":"info","ts":"2026-04-14T02:00:48.46501Z","caller":"traceutil/trace.go:171","msg":"trace[1921359960] transaction","detail":"{read_only:false; response_revision:503; number_of_response:1; }","duration":"451.418019ms","start":"2026-04-14T02:00:48.00944Z","end":"2026-04-14T02:00:48.460858Z","steps":["trace[1921359960] 'process raft request' (duration: 451.040701ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:00:48.465057Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:00:48.009396Z","time spent":"455.640406ms","remote":"127.0.0.1:34618","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-14T02:00:54.777199Z","caller":"traceutil/trace.go:171","msg":"trace[2008571727] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"402.065673ms","start":"2026-04-14T02:00:54.375091Z","end":"2026-04-14T02:00:54.777156Z","steps":["trace[2008571727] 'process raft request' (duration: 401.842808ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:00:54.77742Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:00:54.375054Z","time spent":"402.261646ms","remote":"127.0.0.1:35118","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-14T02:00:54.777523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.519624ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-14T02:00:54.777582Z","caller":"traceutil/trace.go:171","msg":"trace[1618901289] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:589; }","duration":"276.630426ms","start":"2026-04-14T02:00:54.500939Z","end":"2026-04-14T02:00:54.77757Z","steps":["trace[1618901289] 'agreement among raft nodes before linearized reading' (duration: 276.423602ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:00:54.777323Z","caller":"traceutil/trace.go:171","msg":"trace[609652416] linearizableReadLoop","detail":"{readStateIndex:611; appliedIndex:610; }","duration":"276.079795ms","start":"2026-04-14T02:00:54.500992Z","end":"2026-04-14T02:00:54.777071Z","steps":["trace[609652416] 'read index received' (duration: 275.82726ms)","trace[609652416] 'applied index is now lower than readState.Index' (duration: 251.415µs)"],"step_count":2} {"level":"warn","ts":"2026-04-14T02:00:54.778078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.627299ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-6sn4k\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-04-14T02:00:54.778126Z","caller":"traceutil/trace.go:171","msg":"trace[2020270293] range","detail":"{range_begin:/registry/pods/kube-system/cilium-6sn4k; range_end:; response_count:1; response_revision:589; }","duration":"231.710481ms","start":"2026-04-14T02:00:54.546397Z","end":"2026-04-14T02:00:54.778107Z","steps":["trace[2020270293] 'agreement among raft nodes before linearized reading' (duration: 231.575788ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:00:55.336282Z","caller":"traceutil/trace.go:171","msg":"trace[1669460246] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"543.047514ms","start":"2026-04-14T02:00:54.793203Z","end":"2026-04-14T02:00:55.336251Z","steps":["trace[1669460246] 'process raft request' (duration: 542.886181ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:00:55.336679Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:00:54.79319Z","time spent":"543.186847ms","remote":"127.0.0.1:34806","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-14T02:00:55.336928Z","caller":"traceutil/trace.go:171","msg":"trace[958996083] linearizableReadLoop","detail":"{readStateIndex:613; appliedIndex:613; }","duration":"452.487398ms","start":"2026-04-14T02:00:54.88441Z","end":"2026-04-14T02:00:55.336898Z","steps":["trace[958996083] 'read index received' (duration: 452.479618ms)","trace[958996083] 'applied index is now lower than readState.Index' (duration: 5.89µs)"],"step_count":2} {"level":"warn","ts":"2026-04-14T02:00:55.337151Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"452.721853ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-14T02:00:55.337203Z","caller":"traceutil/trace.go:171","msg":"trace[1801055550] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:591; }","duration":"452.816015ms","start":"2026-04-14T02:00:54.884371Z","end":"2026-04-14T02:00:55.337187Z","steps":["trace[1801055550] 'agreement among raft nodes before linearized reading' (duration: 452.654902ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:00:55.337253Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:00:54.884352Z","time spent":"452.887626ms","remote":"127.0.0.1:34892","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-14T02:00:55.494572Z","caller":"traceutil/trace.go:171","msg":"trace[1457662852] linearizableReadLoop","detail":"{readStateIndex:614; appliedIndex:613; }","duration":"157.499079ms","start":"2026-04-14T02:00:55.337Z","end":"2026-04-14T02:00:55.494499Z","steps":["trace[1457662852] 'read index received' (duration: 153.14008ms)","trace[1457662852] 'applied index is now lower than readState.Index' (duration: 4.357449ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T02:00:55.494641Z","caller":"traceutil/trace.go:171","msg":"trace[1970585888] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"234.696446ms","start":"2026-04-14T02:00:55.259864Z","end":"2026-04-14T02:00:55.49456Z","steps":["trace[1970585888] 'process raft request' (duration: 230.495881ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:00:55.494854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"560.671592ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-14T02:00:55.494927Z","caller":"traceutil/trace.go:171","msg":"trace[795304089] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:592; }","duration":"560.799864ms","start":"2026-04-14T02:00:54.934104Z","end":"2026-04-14T02:00:55.494904Z","steps":["trace[795304089] 'agreement among raft nodes before linearized reading' (duration: 560.512138ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:00:55.494974Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:00:54.934088Z","time spent":"560.876506ms","remote":"127.0.0.1:34892","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-14T02:00:55.494983Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"457.100753ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-04-14T02:00:55.495149Z","caller":"traceutil/trace.go:171","msg":"trace[1495373226] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:592; }","duration":"457.265516ms","start":"2026-04-14T02:00:55.037848Z","end":"2026-04-14T02:00:55.495113Z","steps":["trace[1495373226] 'agreement among raft nodes before linearized reading' (duration: 456.733805ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:00:55.495256Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:00:55.037756Z","time spent":"457.485601ms","remote":"127.0.0.1:34892","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":453,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-14T02:00:55.501614Z","caller":"traceutil/trace.go:171","msg":"trace[1752065769] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"159.53656ms","start":"2026-04-14T02:00:55.342063Z","end":"2026-04-14T02:00:55.5016Z","steps":["trace[1752065769] 'process raft request' (duration: 159.469009ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:00:56.339488Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14920880255276757717,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-14T02:00:56.576407Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.017187882s","expected-duration":"1s"} {"level":"info","ts":"2026-04-14T02:00:56.576797Z","caller":"traceutil/trace.go:171","msg":"trace[764576535] linearizableReadLoop","detail":"{readStateIndex:618; appliedIndex:617; }","duration":"737.93632ms","start":"2026-04-14T02:00:55.838836Z","end":"2026-04-14T02:00:56.576773Z","steps":["trace[764576535] 'read index received' (duration: 737.749666ms)","trace[764576535] 'applied index is now lower than readState.Index' (duration: 185.734µs)"],"step_count":2} {"level":"warn","ts":"2026-04-14T02:00:56.576944Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"738.086013ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T02:00:56.576989Z","caller":"traceutil/trace.go:171","msg":"trace[1998007732] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:596; }","duration":"738.169775ms","start":"2026-04-14T02:00:55.838803Z","end":"2026-04-14T02:00:56.576973Z","steps":["trace[1998007732] 'agreement among raft nodes before linearized reading' (duration: 738.038283ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:00:56.57705Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:00:55.838786Z","time spent":"738.230326ms","remote":"127.0.0.1:34554","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":26,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-14T02:00:56.576992Z","caller":"traceutil/trace.go:171","msg":"trace[640529013] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"1.017859455s","start":"2026-04-14T02:00:55.559086Z","end":"2026-04-14T02:00:56.576946Z","steps":["trace[640529013] 'process raft request' (duration: 1.017552688s)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:00:56.577178Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:00:55.559059Z","time spent":"1.018046609s","remote":"127.0.0.1:34864","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-14T02:00:58.828732Z","caller":"traceutil/trace.go:171","msg":"trace[206549329] transaction","detail":"{read_only:false; response_revision:637; number_of_response:1; }","duration":"127.231551ms","start":"2026-04-14T02:00:58.701475Z","end":"2026-04-14T02:00:58.828707Z","steps":["trace[206549329] 'process raft request' (duration: 126.984296ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:00:58.863969Z","caller":"traceutil/trace.go:171","msg":"trace[1825238650] transaction","detail":"{read_only:false; response_revision:638; number_of_response:1; }","duration":"100.693226ms","start":"2026-04-14T02:00:58.763249Z","end":"2026-04-14T02:00:58.863942Z","steps":["trace[1825238650] 'process raft request' (duration: 100.534133ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:01:02.048717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.720036ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-14T02:01:02.048797Z","caller":"traceutil/trace.go:171","msg":"trace[1443843547] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:679; }","duration":"130.817208ms","start":"2026-04-14T02:01:01.917961Z","end":"2026-04-14T02:01:02.048778Z","steps":["trace[1443843547] 'range keys from in-memory index tree' (duration: 130.500162ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:01:02.07548Z","caller":"traceutil/trace.go:171","msg":"trace[127874558] transaction","detail":"{read_only:false; response_revision:680; number_of_response:1; }","duration":"148.593871ms","start":"2026-04-14T02:01:01.926864Z","end":"2026-04-14T02:01:02.075458Z","steps":["trace[127874558] 'process raft request' (duration: 148.421578ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:01:13.737612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.010956ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-14T02:01:13.738044Z","caller":"traceutil/trace.go:171","msg":"trace[481161320] transaction","detail":"{read_only:false; response_revision:757; number_of_response:1; }","duration":"132.954152ms","start":"2026-04-14T02:01:13.60507Z","end":"2026-04-14T02:01:13.738025Z","steps":["trace[481161320] 'process raft request' (duration: 22.431096ms)","trace[481161320] 'compare' (duration: 109.850843ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T02:01:13.792108Z","caller":"traceutil/trace.go:171","msg":"trace[975502386] transaction","detail":"{read_only:false; response_revision:758; number_of_response:1; }","duration":"186.392409ms","start":"2026-04-14T02:01:13.60569Z","end":"2026-04-14T02:01:13.792082Z","steps":["trace[975502386] 'process raft request' (duration: 186.206736ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:01:13.792438Z","caller":"traceutil/trace.go:171","msg":"trace[1982531441] transaction","detail":"{read_only:false; response_revision:759; number_of_response:1; }","duration":"186.548182ms","start":"2026-04-14T02:01:13.60582Z","end":"2026-04-14T02:01:13.792369Z","steps":["trace[1982531441] 'process raft request' (duration: 186.219565ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:01:13.792953Z","caller":"traceutil/trace.go:171","msg":"trace[1432771513] linearizableReadLoop","detail":"{readStateIndex:786; appliedIndex:784; }","duration":"142.964926ms","start":"2026-04-14T02:01:13.649967Z","end":"2026-04-14T02:01:13.792932Z","steps":["trace[1432771513] 'read index received' (duration: 141.938486ms)","trace[1432771513] 'applied index is now lower than readState.Index' (duration: 1.02409ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T02:01:13.793141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.154639ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-lp6zr\" ","response":"range_response_count:1 size:3965"} {"level":"info","ts":"2026-04-14T02:01:13.793181Z","caller":"traceutil/trace.go:171","msg":"trace[1353301439] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-lp6zr; range_end:; response_count:1; response_revision:759; }","duration":"143.252361ms","start":"2026-04-14T02:01:13.649913Z","end":"2026-04-14T02:01:13.793165Z","steps":["trace[1353301439] 'agreement among raft nodes before linearized reading' (duration: 143.091348ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:01:14.953802Z","caller":"traceutil/trace.go:171","msg":"trace[1073132345] transaction","detail":"{read_only:false; response_revision:767; number_of_response:1; }","duration":"142.584212ms","start":"2026-04-14T02:01:14.811188Z","end":"2026-04-14T02:01:14.953773Z","steps":["trace[1073132345] 'process raft request' (duration: 142.403668ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:01:19.289306Z","caller":"traceutil/trace.go:171","msg":"trace[1900345393] transaction","detail":"{read_only:false; response_revision:800; number_of_response:1; }","duration":"125.854779ms","start":"2026-04-14T02:01:19.163411Z","end":"2026-04-14T02:01:19.289266Z","steps":["trace[1900345393] 'process raft request' (duration: 125.191874ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:01:19.289328Z","caller":"traceutil/trace.go:171","msg":"trace[2145025276] transaction","detail":"{read_only:false; response_revision:801; number_of_response:1; }","duration":"124.295178ms","start":"2026-04-14T02:01:19.164991Z","end":"2026-04-14T02:01:19.289286Z","steps":["trace[2145025276] 'process raft request' (duration: 124.234168ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:01:29.360211Z","caller":"traceutil/trace.go:171","msg":"trace[621062149] transaction","detail":"{read_only:false; response_revision:925; number_of_response:1; }","duration":"129.035737ms","start":"2026-04-14T02:01:29.231148Z","end":"2026-04-14T02:01:29.360184Z","steps":["trace[621062149] 'process raft request' (duration: 128.856966ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:01:29.795688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.440729ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-14T02:01:29.795759Z","caller":"traceutil/trace.go:171","msg":"trace[1255968116] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/; range_end:/registry/mutatingwebhookconfigurations0; response_count:0; response_revision:925; }","duration":"204.558969ms","start":"2026-04-14T02:01:29.591183Z","end":"2026-04-14T02:01:29.795742Z","steps":["trace[1255968116] 'count revisions from in-memory index tree' (duration: 204.366438ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:01:30.305095Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14920880255276758407,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-14T02:01:30.747011Z","caller":"traceutil/trace.go:171","msg":"trace[249730750] linearizableReadLoop","detail":"{readStateIndex:956; appliedIndex:955; }","duration":"942.143829ms","start":"2026-04-14T02:01:29.80485Z","end":"2026-04-14T02:01:30.746994Z","steps":["trace[249730750] 'read index received' (duration: 942.020078ms)","trace[249730750] 'applied index is now lower than readState.Index' (duration: 123.301µs)"],"step_count":2} {"level":"info","ts":"2026-04-14T02:01:30.747224Z","caller":"traceutil/trace.go:171","msg":"trace[1737040349] transaction","detail":"{read_only:false; response_revision:926; number_of_response:1; }","duration":"942.716014ms","start":"2026-04-14T02:01:29.804502Z","end":"2026-04-14T02:01:30.747218Z","steps":["trace[1737040349] 'process raft request' (duration: 942.410772ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:01:30.747295Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:01:29.804483Z","time spent":"942.763524ms","remote":"127.0.0.1:34806","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5472,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-14T02:01:30.747446Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"942.595833ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-14T02:01:30.747471Z","caller":"traceutil/trace.go:171","msg":"trace[812331935] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:926; }","duration":"942.641403ms","start":"2026-04-14T02:01:29.804824Z","end":"2026-04-14T02:01:30.747465Z","steps":["trace[812331935] 'agreement among raft nodes before linearized reading' (duration: 942.562733ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:01:30.747489Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:01:29.804813Z","time spent":"942.671924ms","remote":"127.0.0.1:34892","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-14T02:01:30.86933Z","caller":"traceutil/trace.go:171","msg":"trace[1955955594] transaction","detail":"{read_only:false; response_revision:927; number_of_response:1; }","duration":"391.025127ms","start":"2026-04-14T02:01:30.478279Z","end":"2026-04-14T02:01:30.869304Z","steps":["trace[1955955594] 'process raft request' (duration: 328.095683ms)","trace[1955955594] 'compare' (duration: 62.820633ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T02:01:30.869409Z","caller":"traceutil/trace.go:171","msg":"trace[1346171245] transaction","detail":"{read_only:false; response_revision:928; number_of_response:1; }","duration":"118.477223ms","start":"2026-04-14T02:01:30.750902Z","end":"2026-04-14T02:01:30.869379Z","steps":["trace[1346171245] 'process raft request' (duration: 118.398663ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:01:30.869426Z","caller":"traceutil/trace.go:171","msg":"trace[301061390] transaction","detail":"{read_only:false; response_revision:929; number_of_response:1; }","duration":"116.487866ms","start":"2026-04-14T02:01:30.752928Z","end":"2026-04-14T02:01:30.869415Z","steps":["trace[301061390] 'process raft request' (duration: 116.401075ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:01:30.869464Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:01:30.478256Z","time spent":"391.130988ms","remote":"127.0.0.1:34892","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-14T02:01:30.869582Z","caller":"traceutil/trace.go:171","msg":"trace[676184368] transaction","detail":"{read_only:false; response_revision:931; number_of_response:1; }","duration":"115.319886ms","start":"2026-04-14T02:01:30.754256Z","end":"2026-04-14T02:01:30.869576Z","steps":["trace[676184368] 'process raft request' (duration: 115.285496ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:01:30.86963Z","caller":"traceutil/trace.go:171","msg":"trace[1983156164] linearizableReadLoop","detail":"{readStateIndex:957; appliedIndex:956; }","duration":"122.559638ms","start":"2026-04-14T02:01:30.747061Z","end":"2026-04-14T02:01:30.869621Z","steps":["trace[1983156164] 'read index received' (duration: 59.337763ms)","trace[1983156164] 'applied index is now lower than readState.Index' (duration: 63.220785ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T02:01:30.869702Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.032456664s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T02:01:30.86971Z","caller":"traceutil/trace.go:171","msg":"trace[1134620696] transaction","detail":"{read_only:false; response_revision:930; number_of_response:1; }","duration":"116.328864ms","start":"2026-04-14T02:01:30.753376Z","end":"2026-04-14T02:01:30.869704Z","steps":["trace[1134620696] 'process raft request' (duration: 115.983221ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:01:30.869727Z","caller":"traceutil/trace.go:171","msg":"trace[1281905576] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:931; }","duration":"1.032528694s","start":"2026-04-14T02:01:29.837192Z","end":"2026-04-14T02:01:30.869721Z","steps":["trace[1281905576] 'agreement among raft nodes before linearized reading' (duration: 1.032461244s)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:01:30.869746Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:01:29.837175Z","time spent":"1.032567105s","remote":"127.0.0.1:34554","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":26,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-14T02:01:30.869774Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"975.213927ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-14T02:01:30.869823Z","caller":"traceutil/trace.go:171","msg":"trace[779984950] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:931; }","duration":"975.310867ms","start":"2026-04-14T02:01:29.8945Z","end":"2026-04-14T02:01:30.869811Z","steps":["trace[779984950] 'agreement among raft nodes before linearized reading' (duration: 975.180466ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:01:30.869859Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:01:29.894479Z","time spent":"975.372518ms","remote":"127.0.0.1:34892","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-14T02:01:30.869747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"545.461982ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-14T02:01:30.869929Z","caller":"traceutil/trace.go:171","msg":"trace[1320097998] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:931; }","duration":"545.677643ms","start":"2026-04-14T02:01:30.324243Z","end":"2026-04-14T02:01:30.869921Z","steps":["trace[1320097998] 'agreement among raft nodes before linearized reading' (duration: 545.420001ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:01:30.869959Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:01:30.324226Z","time spent":"545.726643ms","remote":"127.0.0.1:34892","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-14T02:01:30.869902Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"978.785707ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-14T02:01:30.870029Z","caller":"traceutil/trace.go:171","msg":"trace[1068780358] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:931; }","duration":"978.936939ms","start":"2026-04-14T02:01:29.891084Z","end":"2026-04-14T02:01:30.870021Z","steps":["trace[1068780358] 'agreement among raft nodes before linearized reading' (duration: 978.754757ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:01:30.870057Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:01:29.89107Z","time spent":"978.979149ms","remote":"127.0.0.1:34892","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-14T02:02:01.199855Z","caller":"traceutil/trace.go:171","msg":"trace[1748949666] linearizableReadLoop","detail":"{readStateIndex:1085; appliedIndex:1084; }","duration":"103.578658ms","start":"2026-04-14T02:02:01.096239Z","end":"2026-04-14T02:02:01.199817Z","steps":["trace[1748949666] 'read index received' (duration: 103.133732ms)","trace[1748949666] 'applied index is now lower than readState.Index' (duration: 443.716µs)"],"step_count":2} {"level":"warn","ts":"2026-04-14T02:02:01.20045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.177015ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-14T02:02:01.200521Z","caller":"traceutil/trace.go:171","msg":"trace[1761740360] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1046; }","duration":"104.296466ms","start":"2026-04-14T02:02:01.096206Z","end":"2026-04-14T02:02:01.200503Z","steps":["trace[1761740360] 'agreement among raft nodes before linearized reading' (duration: 104.050983ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:02:01.200456Z","caller":"traceutil/trace.go:171","msg":"trace[1048068689] transaction","detail":"{read_only:false; response_revision:1046; number_of_response:1; }","duration":"111.035086ms","start":"2026-04-14T02:02:01.089383Z","end":"2026-04-14T02:02:01.200418Z","steps":["trace[1048068689] 'process raft request' (duration: 110.132125ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:02:01.200736Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.301515ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-04-14T02:02:01.201489Z","caller":"traceutil/trace.go:171","msg":"trace[1990771976] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1046; }","duration":"104.095064ms","start":"2026-04-14T02:02:01.097377Z","end":"2026-04-14T02:02:01.201472Z","steps":["trace[1990771976] 'agreement among raft nodes before linearized reading' (duration: 102.972921ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:03:03.679591Z","caller":"traceutil/trace.go:171","msg":"trace[511896402] transaction","detail":"{read_only:false; response_revision:1443; number_of_response:1; }","duration":"165.217464ms","start":"2026-04-14T02:03:03.514346Z","end":"2026-04-14T02:03:03.679564Z","steps":["trace[511896402] 'process raft request' (duration: 163.348926ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:03:03.685097Z","caller":"traceutil/trace.go:171","msg":"trace[357802333] linearizableReadLoop","detail":"{readStateIndex:1497; appliedIndex:1495; }","duration":"129.913173ms","start":"2026-04-14T02:03:03.555156Z","end":"2026-04-14T02:03:03.685069Z","steps":["trace[357802333] 'read index received' (duration: 122.551512ms)","trace[357802333] 'applied index is now lower than readState.Index' (duration: 7.360571ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T02:03:03.685174Z","caller":"traceutil/trace.go:171","msg":"trace[1600015954] transaction","detail":"{read_only:false; response_revision:1444; number_of_response:1; }","duration":"144.34436ms","start":"2026-04-14T02:03:03.540812Z","end":"2026-04-14T02:03:03.685156Z","steps":["trace[1600015954] 'process raft request' (duration: 144.139127ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:03:03.685572Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.40491ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-14T02:03:03.685633Z","caller":"traceutil/trace.go:171","msg":"trace[959829742] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1444; }","duration":"130.518552ms","start":"2026-04-14T02:03:03.5551Z","end":"2026-04-14T02:03:03.685618Z","steps":["trace[959829742] 'agreement among raft nodes before linearized reading' (duration: 130.084916ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:03:09.025154Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.203946ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T02:03:09.025334Z","caller":"traceutil/trace.go:171","msg":"trace[961043522] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1504; }","duration":"186.43476ms","start":"2026-04-14T02:03:08.83888Z","end":"2026-04-14T02:03:09.025315Z","steps":["trace[961043522] 'range keys from in-memory index tree' (duration: 186.124925ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:03:09.409413Z","caller":"traceutil/trace.go:171","msg":"trace[1045150055] transaction","detail":"{read_only:false; response_revision:1505; number_of_response:1; }","duration":"362.970638ms","start":"2026-04-14T02:03:09.046368Z","end":"2026-04-14T02:03:09.409338Z","steps":["trace[1045150055] 'process raft request' (duration: 362.811765ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:03:09.409625Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:03:09.046356Z","time spent":"363.156032ms","remote":"127.0.0.1:34806","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4335,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-14T02:03:17.382327Z","caller":"traceutil/trace.go:171","msg":"trace[1437267462] transaction","detail":"{read_only:false; response_revision:1645; number_of_response:1; }","duration":"279.900515ms","start":"2026-04-14T02:03:17.102403Z","end":"2026-04-14T02:03:17.382303Z","steps":["trace[1437267462] 'process raft request' (duration: 279.755762ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:03:28.71817Z","caller":"traceutil/trace.go:171","msg":"trace[23515626] transaction","detail":"{read_only:false; response_revision:1905; number_of_response:1; }","duration":"185.15246ms","start":"2026-04-14T02:03:28.532987Z","end":"2026-04-14T02:03:28.71814Z","steps":["trace[23515626] 'process raft request' (duration: 116.83014ms)","trace[23515626] 'compare' (duration: 67.925073ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T02:03:28.718538Z","caller":"traceutil/trace.go:171","msg":"trace[1845826984] transaction","detail":"{read_only:false; response_revision:1906; number_of_response:1; }","duration":"185.475834ms","start":"2026-04-14T02:03:28.533026Z","end":"2026-04-14T02:03:28.718502Z","steps":["trace[1845826984] 'process raft request' (duration: 185.042108ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:03:28.718657Z","caller":"traceutil/trace.go:171","msg":"trace[713416963] transaction","detail":"{read_only:false; response_revision:1907; number_of_response:1; }","duration":"182.494548ms","start":"2026-04-14T02:03:28.536025Z","end":"2026-04-14T02:03:28.71852Z","steps":["trace[713416963] 'process raft request' (duration: 182.296594ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:03:28.724133Z","caller":"traceutil/trace.go:171","msg":"trace[891564442] transaction","detail":"{read_only:false; response_revision:1909; number_of_response:1; }","duration":"153.847769ms","start":"2026-04-14T02:03:28.570259Z","end":"2026-04-14T02:03:28.724107Z","steps":["trace[891564442] 'process raft request' (duration: 153.624715ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:03:28.724145Z","caller":"traceutil/trace.go:171","msg":"trace[1403789443] transaction","detail":"{read_only:false; number_of_response:1; response_revision:1910; }","duration":"147.387818ms","start":"2026-04-14T02:03:28.57674Z","end":"2026-04-14T02:03:28.724127Z","steps":["trace[1403789443] 'process raft request' (duration: 147.221716ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:03:28.72416Z","caller":"traceutil/trace.go:171","msg":"trace[1145558153] transaction","detail":"{read_only:false; response_revision:1910; number_of_response:1; }","duration":"150.08666ms","start":"2026-04-14T02:03:28.57401Z","end":"2026-04-14T02:03:28.724096Z","steps":["trace[1145558153] 'process raft request' (duration: 149.918017ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:03:28.724564Z","caller":"traceutil/trace.go:171","msg":"trace[261497114] transaction","detail":"{read_only:false; response_revision:1908; number_of_response:1; }","duration":"154.56545ms","start":"2026-04-14T02:03:28.569986Z","end":"2026-04-14T02:03:28.724551Z","steps":["trace[261497114] 'process raft request' (duration: 153.808788ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:03:28.724735Z","caller":"traceutil/trace.go:171","msg":"trace[1603490266] transaction","detail":"{read_only:false; response_revision:1911; number_of_response:1; }","duration":"144.407711ms","start":"2026-04-14T02:03:28.580321Z","end":"2026-04-14T02:03:28.724728Z","steps":["trace[1603490266] 'process raft request' (duration: 143.663599ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:03:28.939298Z","caller":"traceutil/trace.go:171","msg":"trace[597750199] transaction","detail":"{read_only:false; response_revision:1929; number_of_response:1; }","duration":"124.399998ms","start":"2026-04-14T02:03:28.814879Z","end":"2026-04-14T02:03:28.939279Z","steps":["trace[597750199] 'process raft request' (duration: 123.974721ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:03:28.93949Z","caller":"traceutil/trace.go:171","msg":"trace[1926643289] transaction","detail":"{read_only:false; response_revision:1930; number_of_response:1; }","duration":"124.372997ms","start":"2026-04-14T02:03:28.81511Z","end":"2026-04-14T02:03:28.939483Z","steps":["trace[1926643289] 'process raft request' (duration: 123.841739ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:03:28.939623Z","caller":"traceutil/trace.go:171","msg":"trace[872668762] transaction","detail":"{read_only:false; response_revision:1931; number_of_response:1; }","duration":"123.195299ms","start":"2026-04-14T02:03:28.816422Z","end":"2026-04-14T02:03:28.939617Z","steps":["trace[872668762] 'process raft request' (duration: 122.5712ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:03:28.939748Z","caller":"traceutil/trace.go:171","msg":"trace[1618559108] transaction","detail":"{read_only:false; response_revision:1932; number_of_response:1; }","duration":"102.444474ms","start":"2026-04-14T02:03:28.837298Z","end":"2026-04-14T02:03:28.939743Z","steps":["trace[1618559108] 'process raft request' (duration: 101.725593ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:03:28.963062Z","caller":"traceutil/trace.go:171","msg":"trace[682530680] transaction","detail":"{read_only:false; response_revision:1933; number_of_response:1; }","duration":"113.0172ms","start":"2026-04-14T02:03:28.850023Z","end":"2026-04-14T02:03:28.96304Z","steps":["trace[682530680] 'process raft request' (duration: 112.602734ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:03:28.963349Z","caller":"traceutil/trace.go:171","msg":"trace[1550841305] transaction","detail":"{read_only:false; response_revision:1934; number_of_response:1; }","duration":"104.325054ms","start":"2026-04-14T02:03:28.859011Z","end":"2026-04-14T02:03:28.963336Z","steps":["trace[1550841305] 'process raft request' (duration: 103.943168ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:03:39.525762Z","caller":"traceutil/trace.go:171","msg":"trace[185184927] transaction","detail":"{read_only:false; response_revision:2196; number_of_response:1; }","duration":"312.136082ms","start":"2026-04-14T02:03:39.213602Z","end":"2026-04-14T02:03:39.525738Z","steps":["trace[185184927] 'process raft request' (duration: 311.941459ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:03:39.526056Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:03:39.213579Z","time spent":"312.330656ms","remote":"127.0.0.1:34806","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6132,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-14T02:03:40.415796Z","caller":"traceutil/trace.go:171","msg":"trace[1657523937] transaction","detail":"{read_only:false; response_revision:2197; number_of_response:1; }","duration":"1.160785373s","start":"2026-04-14T02:03:39.254987Z","end":"2026-04-14T02:03:40.415773Z","steps":["trace[1657523937] 'process raft request' (duration: 1.140604553s)","trace[1657523937] 'compare' (duration: 20.055958ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T02:03:40.415785Z","caller":"traceutil/trace.go:171","msg":"trace[130329965] linearizableReadLoop","detail":"{readStateIndex:2291; appliedIndex:2289; }","duration":"1.127973392s","start":"2026-04-14T02:03:39.287785Z","end":"2026-04-14T02:03:40.415758Z","steps":["trace[130329965] 'read index received' (duration: 237.800472ms)","trace[130329965] 'applied index is now lower than readState.Index' (duration: 890.17157ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T02:03:40.415918Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:03:39.254964Z","time spent":"1.160886944s","remote":"127.0.0.1:34892","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":508,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-14T02:03:40.416183Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.128338457s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-0c9d09e8-ab3d-4667-b0f0-fabc24ef3a61\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-04-14T02:03:40.416262Z","caller":"traceutil/trace.go:171","msg":"trace[1638001225] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-0c9d09e8-ab3d-4667-b0f0-fabc24ef3a61; range_end:; response_count:1; response_revision:2197; }","duration":"1.12849777s","start":"2026-04-14T02:03:39.28774Z","end":"2026-04-14T02:03:40.416238Z","steps":["trace[1638001225] 'agreement among raft nodes before linearized reading' (duration: 1.128142445s)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:03:40.416312Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:03:39.28772Z","time spent":"1.128580881s","remote":"127.0.0.1:34806","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3648,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-0c9d09e8-ab3d-4667-b0f0-fabc24ef3a61\" "} {"level":"info","ts":"2026-04-14T02:03:40.564799Z","caller":"traceutil/trace.go:171","msg":"trace[1648656741] transaction","detail":"{read_only:false; response_revision:2198; number_of_response:1; }","duration":"1.031736657s","start":"2026-04-14T02:03:39.533041Z","end":"2026-04-14T02:03:40.564778Z","steps":["trace[1648656741] 'process raft request' (duration: 1.024459552s)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:03:40.565115Z","caller":"traceutil/trace.go:171","msg":"trace[1249735728] transaction","detail":"{read_only:false; response_revision:2199; number_of_response:1; }","duration":"1.031802459s","start":"2026-04-14T02:03:39.533269Z","end":"2026-04-14T02:03:40.565071Z","steps":["trace[1249735728] 'process raft request' (duration: 1.031438093s)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:03:40.565316Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:03:39.533258Z","time spent":"1.031957171s","remote":"127.0.0.1:34900","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1847,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-14T02:03:40.565174Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:03:39.533018Z","time spent":"1.031854s","remote":"127.0.0.1:34778","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1231,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-14T02:03:40.565591Z","caller":"traceutil/trace.go:171","msg":"trace[45587751] transaction","detail":"{read_only:false; response_revision:2200; number_of_response:1; }","duration":"649.433623ms","start":"2026-04-14T02:03:39.91614Z","end":"2026-04-14T02:03:40.565573Z","steps":["trace[45587751] 'process raft request' (duration: 648.835953ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:03:40.565727Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:03:39.916117Z","time spent":"649.561254ms","remote":"127.0.0.1:34892","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-14T02:03:40.565757Z","caller":"traceutil/trace.go:171","msg":"trace[79214986] transaction","detail":"{read_only:false; response_revision:2201; number_of_response:1; }","duration":"557.143858ms","start":"2026-04-14T02:03:40.0086Z","end":"2026-04-14T02:03:40.565744Z","steps":["trace[79214986] 'process raft request' (duration: 556.736012ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:03:40.565894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"552.593256ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-04-14T02:03:40.565938Z","caller":"traceutil/trace.go:171","msg":"trace[1744781363] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2201; }","duration":"552.670097ms","start":"2026-04-14T02:03:40.01326Z","end":"2026-04-14T02:03:40.56593Z","steps":["trace[1744781363] 'agreement among raft nodes before linearized reading' (duration: 552.533805ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:03:40.565933Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:03:40.008577Z","time spent":"557.28971ms","remote":"127.0.0.1:34892","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-14T02:03:40.565978Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:03:40.013242Z","time spent":"552.726158ms","remote":"127.0.0.1:34892","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":512,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-04-14T02:03:40.565885Z","caller":"traceutil/trace.go:171","msg":"trace[869735453] linearizableReadLoop","detail":"{readStateIndex:2295; appliedIndex:2291; }","duration":"149.908701ms","start":"2026-04-14T02:03:40.415854Z","end":"2026-04-14T02:03:40.565763Z","steps":["trace[869735453] 'read index received' (duration: 141.587039ms)","trace[869735453] 'applied index is now lower than readState.Index' (duration: 8.320142ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T02:03:40.566055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.03631096s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-af388537-4629-4567-80fe-60a6f3f658f3\" ","response":"range_response_count:1 size:3617"} {"level":"warn","ts":"2026-04-14T02:03:40.566194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"526.054284ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-04-14T02:03:40.566203Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.95826ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-14T02:03:40.566264Z","caller":"traceutil/trace.go:171","msg":"trace[776383851] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2201; }","duration":"279.055352ms","start":"2026-04-14T02:03:40.287199Z","end":"2026-04-14T02:03:40.566255Z","steps":["trace[776383851] 'agreement among raft nodes before linearized reading' (duration: 278.913159ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:03:40.566263Z","caller":"traceutil/trace.go:171","msg":"trace[1366531524] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2201; }","duration":"526.138285ms","start":"2026-04-14T02:03:40.040106Z","end":"2026-04-14T02:03:40.566244Z","steps":["trace[1366531524] 'agreement among raft nodes before linearized reading' (duration: 525.950352ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:03:40.566123Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"827.043581ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"warn","ts":"2026-04-14T02:03:40.56631Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:03:40.040097Z","time spent":"526.202476ms","remote":"127.0.0.1:34892","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-14T02:03:40.566338Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.126969399s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-af388537-4629-4567-80fe-60a6f3f658f3\" ","response":"range_response_count:1 size:3617"} {"level":"info","ts":"2026-04-14T02:03:40.566506Z","caller":"traceutil/trace.go:171","msg":"trace[2038637077] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-af388537-4629-4567-80fe-60a6f3f658f3; range_end:; response_count:1; response_revision:2201; }","duration":"1.127173181s","start":"2026-04-14T02:03:39.439315Z","end":"2026-04-14T02:03:40.566488Z","steps":["trace[2038637077] 'agreement among raft nodes before linearized reading' (duration: 1.126913507s)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:03:40.566565Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:03:39.439286Z","time spent":"1.127262503s","remote":"127.0.0.1:34806","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3638,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-af388537-4629-4567-80fe-60a6f3f658f3\" "} {"level":"warn","ts":"2026-04-14T02:03:40.56604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"617.281502ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-14T02:03:40.566889Z","caller":"traceutil/trace.go:171","msg":"trace[343939014] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2201; }","duration":"618.153626ms","start":"2026-04-14T02:03:39.948719Z","end":"2026-04-14T02:03:40.566873Z","steps":["trace[343939014] 'agreement among raft nodes before linearized reading' (duration: 617.200291ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:03:40.566953Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:03:39.948703Z","time spent":"618.230597ms","remote":"127.0.0.1:34892","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-14T02:03:40.566211Z","caller":"traceutil/trace.go:171","msg":"trace[1371344946] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-af388537-4629-4567-80fe-60a6f3f658f3; range_end:; response_count:1; response_revision:2201; }","duration":"1.036504423s","start":"2026-04-14T02:03:39.529693Z","end":"2026-04-14T02:03:40.566197Z","steps":["trace[1371344946] 'agreement among raft nodes before linearized reading' (duration: 1.036232588s)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:03:40.56703Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:03:39.529671Z","time spent":"1.037346387s","remote":"127.0.0.1:34806","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3638,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-af388537-4629-4567-80fe-60a6f3f658f3\" "} {"level":"warn","ts":"2026-04-14T02:03:40.565867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"727.028393ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-14T02:03:40.567088Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"537.961154ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-04-14T02:03:40.567169Z","caller":"traceutil/trace.go:171","msg":"trace[1782283317] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2201; }","duration":"728.377455ms","start":"2026-04-14T02:03:39.838779Z","end":"2026-04-14T02:03:40.567157Z","steps":["trace[1782283317] 'agreement among raft nodes before linearized reading' (duration: 727.054574ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:03:40.567198Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:03:39.838759Z","time spent":"728.431376ms","remote":"127.0.0.1:34554","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":26,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-14T02:03:40.567198Z","caller":"traceutil/trace.go:171","msg":"trace[2176603] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2201; }","duration":"538.073885ms","start":"2026-04-14T02:03:40.029109Z","end":"2026-04-14T02:03:40.567183Z","steps":["trace[2176603] 'agreement among raft nodes before linearized reading' (duration: 536.961628ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:03:40.567279Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:03:40.029098Z","time spent":"538.169167ms","remote":"127.0.0.1:34892","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":453,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-14T02:03:40.566362Z","caller":"traceutil/trace.go:171","msg":"trace[1453746137] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2201; }","duration":"827.297935ms","start":"2026-04-14T02:03:39.739025Z","end":"2026-04-14T02:03:40.566323Z","steps":["trace[1453746137] 'agreement among raft nodes before linearized reading' (duration: 826.833637ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:03:40.567369Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:03:39.738968Z","time spent":"828.389062ms","remote":"127.0.0.1:50966","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5433,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"info","ts":"2026-04-14T02:03:46.39271Z","caller":"traceutil/trace.go:171","msg":"trace[1297547624] transaction","detail":"{read_only:false; response_revision:2282; number_of_response:1; }","duration":"109.026842ms","start":"2026-04-14T02:03:46.283642Z","end":"2026-04-14T02:03:46.392669Z","steps":["trace[1297547624] 'process raft request' (duration: 108.171709ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:03:46.501176Z","caller":"traceutil/trace.go:171","msg":"trace[589787754] transaction","detail":"{read_only:false; response_revision:2283; number_of_response:1; }","duration":"101.485431ms","start":"2026-04-14T02:03:46.399658Z","end":"2026-04-14T02:03:46.501144Z","steps":["trace[589787754] 'process raft request' (duration: 27.774093ms)","trace[589787754] 'compare' (duration: 73.550456ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T02:03:46.552133Z","caller":"traceutil/trace.go:171","msg":"trace[79043016] transaction","detail":"{read_only:false; response_revision:2284; number_of_response:1; }","duration":"152.325343ms","start":"2026-04-14T02:03:46.399785Z","end":"2026-04-14T02:03:46.552111Z","steps":["trace[79043016] 'process raft request' (duration: 152.1329ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:03:46.552403Z","caller":"traceutil/trace.go:171","msg":"trace[717383619] transaction","detail":"{read_only:false; response_revision:2286; number_of_response:1; }","duration":"151.617983ms","start":"2026-04-14T02:03:46.400778Z","end":"2026-04-14T02:03:46.552396Z","steps":["trace[717383619] 'process raft request' (duration: 151.531011ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:03:46.552651Z","caller":"traceutil/trace.go:171","msg":"trace[2141067679] transaction","detail":"{read_only:false; response_revision:2285; number_of_response:1; }","duration":"152.327844ms","start":"2026-04-14T02:03:46.400306Z","end":"2026-04-14T02:03:46.552633Z","steps":["trace[2141067679] 'process raft request' (duration: 151.751714ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:03:46.62369Z","caller":"traceutil/trace.go:171","msg":"trace[2125174566] transaction","detail":"{read_only:false; response_revision:2287; number_of_response:1; }","duration":"184.485878ms","start":"2026-04-14T02:03:46.439167Z","end":"2026-04-14T02:03:46.623653Z","steps":["trace[2125174566] 'process raft request' (duration: 183.501112ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:03:50.76471Z","caller":"traceutil/trace.go:171","msg":"trace[1293093471] transaction","detail":"{read_only:false; response_revision:2315; number_of_response:1; }","duration":"130.434292ms","start":"2026-04-14T02:03:50.634247Z","end":"2026-04-14T02:03:50.764681Z","steps":["trace[1293093471] 'process raft request' (duration: 130.227879ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:03:50.781074Z","caller":"traceutil/trace.go:171","msg":"trace[626867273] linearizableReadLoop","detail":"{readStateIndex:2412; appliedIndex:2410; }","duration":"135.417802ms","start":"2026-04-14T02:03:50.645637Z","end":"2026-04-14T02:03:50.781055Z","steps":["trace[626867273] 'read index received' (duration: 118.841876ms)","trace[626867273] 'applied index is now lower than readState.Index' (duration: 16.575006ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T02:03:50.78108Z","caller":"traceutil/trace.go:171","msg":"trace[1242621048] transaction","detail":"{read_only:false; response_revision:2316; number_of_response:1; }","duration":"140.113317ms","start":"2026-04-14T02:03:50.640913Z","end":"2026-04-14T02:03:50.781026Z","steps":["trace[1242621048] 'process raft request' (duration: 133.163066ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:03:50.781177Z","caller":"traceutil/trace.go:171","msg":"trace[1650236911] transaction","detail":"{read_only:false; response_revision:2317; number_of_response:1; }","duration":"134.353845ms","start":"2026-04-14T02:03:50.646813Z","end":"2026-04-14T02:03:50.781167Z","steps":["trace[1650236911] 'process raft request' (duration: 134.124561ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:03:50.781457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.510094ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-04-14T02:03:50.781484Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.824308ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-14T02:03:50.781524Z","caller":"traceutil/trace.go:171","msg":"trace[1441144990] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2319; }","duration":"135.623075ms","start":"2026-04-14T02:03:50.645883Z","end":"2026-04-14T02:03:50.781506Z","steps":["trace[1441144990] 'agreement among raft nodes before linearized reading' (duration: 135.403112ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:03:50.781568Z","caller":"traceutil/trace.go:171","msg":"trace[978343218] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2319; }","duration":"135.949981ms","start":"2026-04-14T02:03:50.6456Z","end":"2026-04-14T02:03:50.78155Z","steps":["trace[978343218] 'agreement among raft nodes before linearized reading' (duration: 135.678567ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:03:50.781604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.792138ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"warn","ts":"2026-04-14T02:03:50.781614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.929364ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-04-14T02:03:50.781606Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.28762ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-14T02:03:50.781639Z","caller":"traceutil/trace.go:171","msg":"trace[80130947] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2319; }","duration":"130.847269ms","start":"2026-04-14T02:03:50.65078Z","end":"2026-04-14T02:03:50.781627Z","steps":["trace[80130947] 'agreement among raft nodes before linearized reading' (duration: 130.680306ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:03:50.78166Z","caller":"traceutil/trace.go:171","msg":"trace[2120834212] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2319; }","duration":"130.000545ms","start":"2026-04-14T02:03:50.651647Z","end":"2026-04-14T02:03:50.781648Z","steps":["trace[2120834212] 'agreement among raft nodes before linearized reading' (duration: 129.840903ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:03:50.781673Z","caller":"traceutil/trace.go:171","msg":"trace[1620859437] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2319; }","duration":"135.418823ms","start":"2026-04-14T02:03:50.646239Z","end":"2026-04-14T02:03:50.781658Z","steps":["trace[1620859437] 'agreement among raft nodes before linearized reading' (duration: 135.26405ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:03:50.781759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.512004ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-14T02:03:50.781799Z","caller":"traceutil/trace.go:171","msg":"trace[1737329269] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/; range_end:/registry/apiregistration.k8s.io/apiservices0; response_count:0; response_revision:2319; }","duration":"112.599636ms","start":"2026-04-14T02:03:50.669185Z","end":"2026-04-14T02:03:50.781785Z","steps":["trace[1737329269] 'agreement among raft nodes before linearized reading' (duration: 112.516344ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:03:50.781963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.982163ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-14T02:03:50.781984Z","caller":"traceutil/trace.go:171","msg":"trace[199674385] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2319; }","duration":"128.070545ms","start":"2026-04-14T02:03:50.653908Z","end":"2026-04-14T02:03:50.781979Z","steps":["trace[199674385] 'agreement among raft nodes before linearized reading' (duration: 127.523646ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:04:00.337142Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14920880255276761346,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-14T02:04:00.703485Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.034432514s","expected-duration":"1s"} {"level":"info","ts":"2026-04-14T02:04:00.703857Z","caller":"traceutil/trace.go:171","msg":"trace[465931808] transaction","detail":"{read_only:false; response_revision:2378; number_of_response:1; }","duration":"1.034903112s","start":"2026-04-14T02:03:59.668936Z","end":"2026-04-14T02:04:00.703839Z","steps":["trace[465931808] 'process raft request' (duration: 1.034721829s)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:04:00.703974Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:03:59.668917Z","time spent":"1.034984814s","remote":"127.0.0.1:34806","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5918,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-14T02:04:00.704109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"867.433136ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T02:04:00.704188Z","caller":"traceutil/trace.go:171","msg":"trace[2094244644] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2378; }","duration":"867.567898ms","start":"2026-04-14T02:03:59.836602Z","end":"2026-04-14T02:04:00.70417Z","steps":["trace[2094244644] 'agreement among raft nodes before linearized reading' (duration: 867.387245ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:04:00.704233Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:03:59.83658Z","time spent":"867.645299ms","remote":"127.0.0.1:34554","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":26,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-14T02:04:00.704248Z","caller":"traceutil/trace.go:171","msg":"trace[1020616154] linearizableReadLoop","detail":"{readStateIndex:2476; appliedIndex:2475; }","duration":"867.128271ms","start":"2026-04-14T02:03:59.83666Z","end":"2026-04-14T02:04:00.703788Z","steps":["trace[1020616154] 'read index received' (duration: 866.925788ms)","trace[1020616154] 'applied index is now lower than readState.Index' (duration: 201.603µs)"],"step_count":2} {"level":"warn","ts":"2026-04-14T02:04:00.704388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"856.411268ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-04-14T02:04:00.704422Z","caller":"traceutil/trace.go:171","msg":"trace[1351661767] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2378; }","duration":"856.458968ms","start":"2026-04-14T02:03:59.847955Z","end":"2026-04-14T02:04:00.704413Z","steps":["trace[1351661767] 'agreement among raft nodes before linearized reading' (duration: 856.346976ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:04:00.704442Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:03:59.847947Z","time spent":"856.49034ms","remote":"127.0.0.1:50966","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5433,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-04-14T02:04:00.704562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"498.969609ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-14T02:04:00.704606Z","caller":"traceutil/trace.go:171","msg":"trace[533171683] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; response_count:0; response_revision:2378; }","duration":"499.055691ms","start":"2026-04-14T02:04:00.205541Z","end":"2026-04-14T02:04:00.704596Z","steps":["trace[533171683] 'agreement among raft nodes before linearized reading' (duration: 498.98773ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:04:00.704651Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:04:00.205519Z","time spent":"499.108032ms","remote":"127.0.0.1:34968","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":2,"response size":28,"request content":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true "} {"level":"info","ts":"2026-04-14T02:04:06.959558Z","caller":"traceutil/trace.go:171","msg":"trace[1472957397] transaction","detail":"{read_only:false; response_revision:2419; number_of_response:1; }","duration":"103.130615ms","start":"2026-04-14T02:04:06.856406Z","end":"2026-04-14T02:04:06.959536Z","steps":["trace[1472957397] 'process raft request' (duration: 103.037883ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:04:06.95975Z","caller":"traceutil/trace.go:171","msg":"trace[1005666398] transaction","detail":"{read_only:false; response_revision:2418; number_of_response:1; }","duration":"107.999594ms","start":"2026-04-14T02:04:06.85174Z","end":"2026-04-14T02:04:06.95974Z","steps":["trace[1005666398] 'process raft request' (duration: 36.889709ms)","trace[1005666398] 'compare' (duration: 70.588247ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T02:04:07.087067Z","caller":"traceutil/trace.go:171","msg":"trace[827602573] transaction","detail":"{read_only:false; response_revision:2421; number_of_response:1; }","duration":"123.07337ms","start":"2026-04-14T02:04:06.963967Z","end":"2026-04-14T02:04:07.087041Z","steps":["trace[827602573] 'process raft request' (duration: 122.993738ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:04:07.087288Z","caller":"traceutil/trace.go:171","msg":"trace[1860765570] transaction","detail":"{read_only:false; response_revision:2422; number_of_response:1; }","duration":"123.020549ms","start":"2026-04-14T02:04:06.964249Z","end":"2026-04-14T02:04:07.087269Z","steps":["trace[1860765570] 'process raft request' (duration: 122.759155ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:04:07.087084Z","caller":"traceutil/trace.go:171","msg":"trace[2009883892] transaction","detail":"{read_only:false; response_revision:2420; number_of_response:1; }","duration":"123.515607ms","start":"2026-04-14T02:04:06.96354Z","end":"2026-04-14T02:04:07.087056Z","steps":["trace[2009883892] 'process raft request' (duration: 97.983952ms)","trace[2009883892] 'compare' (duration: 25.316172ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T02:04:07.087486Z","caller":"traceutil/trace.go:171","msg":"trace[132481693] transaction","detail":"{read_only:false; response_revision:2423; number_of_response:1; }","duration":"123.156882ms","start":"2026-04-14T02:04:06.964318Z","end":"2026-04-14T02:04:07.087475Z","steps":["trace[132481693] 'process raft request' (duration: 122.857567ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:04:07.087671Z","caller":"traceutil/trace.go:171","msg":"trace[1960957499] transaction","detail":"{read_only:false; response_revision:2424; number_of_response:1; }","duration":"122.330918ms","start":"2026-04-14T02:04:06.965329Z","end":"2026-04-14T02:04:07.08766Z","steps":["trace[1960957499] 'process raft request' (duration: 122.108474ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:04:08.423906Z","caller":"traceutil/trace.go:171","msg":"trace[698123204] transaction","detail":"{read_only:false; response_revision:2426; number_of_response:1; }","duration":"124.930871ms","start":"2026-04-14T02:04:08.29895Z","end":"2026-04-14T02:04:08.42388Z","steps":["trace[698123204] 'process raft request' (duration: 83.952225ms)","trace[698123204] 'compare' (duration: 40.844114ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T02:04:09.363786Z","caller":"traceutil/trace.go:171","msg":"trace[974821317] transaction","detail":"{read_only:false; response_revision:2427; number_of_response:1; }","duration":"522.504922ms","start":"2026-04-14T02:04:08.841263Z","end":"2026-04-14T02:04:09.363768Z","steps":["trace[974821317] 'process raft request' (duration: 522.37027ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:04:09.36389Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:04:08.841237Z","time spent":"522.598433ms","remote":"127.0.0.1:34892","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-14T02:04:09.364817Z","caller":"traceutil/trace.go:171","msg":"trace[1786547787] linearizableReadLoop","detail":"{readStateIndex:2530; appliedIndex:2527; }","duration":"271.951426ms","start":"2026-04-14T02:04:09.092842Z","end":"2026-04-14T02:04:09.364793Z","steps":["trace[1786547787] 'read index received' (duration: 270.96945ms)","trace[1786547787] 'applied index is now lower than readState.Index' (duration: 980.836µs)"],"step_count":2} {"level":"info","ts":"2026-04-14T02:04:09.365372Z","caller":"traceutil/trace.go:171","msg":"trace[565945895] transaction","detail":"{read_only:false; response_revision:2428; number_of_response:1; }","duration":"500.783789ms","start":"2026-04-14T02:04:08.864556Z","end":"2026-04-14T02:04:09.36534Z","steps":["trace[565945895] 'process raft request' (duration: 500.037087ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:04:09.365478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.617237ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-14T02:04:09.36552Z","caller":"traceutil/trace.go:171","msg":"trace[2040074988] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2430; }","duration":"272.700719ms","start":"2026-04-14T02:04:09.092808Z","end":"2026-04-14T02:04:09.365509Z","steps":["trace[2040074988] 'agreement among raft nodes before linearized reading' (duration: 272.523636ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:04:09.365564Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:04:08.864514Z","time spent":"500.957692ms","remote":"127.0.0.1:34892","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-14T02:04:09.365697Z","caller":"traceutil/trace.go:171","msg":"trace[1632135097] transaction","detail":"{read_only:false; response_revision:2429; number_of_response:1; }","duration":"401.419643ms","start":"2026-04-14T02:04:08.964267Z","end":"2026-04-14T02:04:09.365687Z","steps":["trace[1632135097] 'process raft request' (duration: 400.442077ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:04:09.365776Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:04:08.96425Z","time spent":"401.471814ms","remote":"127.0.0.1:34892","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-14T02:04:09.36579Z","caller":"traceutil/trace.go:171","msg":"trace[480188226] transaction","detail":"{read_only:false; response_revision:2430; number_of_response:1; }","duration":"400.933645ms","start":"2026-04-14T02:04:08.964831Z","end":"2026-04-14T02:04:09.365765Z","steps":["trace[480188226] 'process raft request' (duration: 399.928368ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:04:09.365833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.712839ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-04-14T02:04:09.365829Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.702869ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-14T02:04:09.365863Z","caller":"traceutil/trace.go:171","msg":"trace[698112487] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2430; }","duration":"272.81236ms","start":"2026-04-14T02:04:09.093041Z","end":"2026-04-14T02:04:09.365853Z","steps":["trace[698112487] 'agreement among raft nodes before linearized reading' (duration: 272.755839ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:04:09.365882Z","caller":"traceutil/trace.go:171","msg":"trace[1867534359] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2430; }","duration":"272.78127ms","start":"2026-04-14T02:04:09.093086Z","end":"2026-04-14T02:04:09.365868Z","steps":["trace[1867534359] 'agreement among raft nodes before linearized reading' (duration: 272.645197ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:04:09.3659Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:04:08.964822Z","time spent":"401.019456ms","remote":"127.0.0.1:34892","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-14T02:04:09.365921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.037953ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-14T02:04:09.365942Z","caller":"traceutil/trace.go:171","msg":"trace[1126773343] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2430; }","duration":"273.067025ms","start":"2026-04-14T02:04:09.09287Z","end":"2026-04-14T02:04:09.365937Z","steps":["trace[1126773343] 'agreement among raft nodes before linearized reading' (duration: 272.855881ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:04:09.365991Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.875891ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-14T02:04:09.366057Z","caller":"traceutil/trace.go:171","msg":"trace[788754612] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2430; }","duration":"272.977702ms","start":"2026-04-14T02:04:09.093065Z","end":"2026-04-14T02:04:09.366042Z","steps":["trace[788754612] 'agreement among raft nodes before linearized reading' (duration: 272.718298ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:04:10.045135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.071615ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T02:04:10.045216Z","caller":"traceutil/trace.go:171","msg":"trace[1203397687] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:2435; }","duration":"195.205047ms","start":"2026-04-14T02:04:09.849996Z","end":"2026-04-14T02:04:10.045201Z","steps":["trace[1203397687] 'count revisions from in-memory index tree' (duration: 194.977543ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:04:10.045242Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.669284ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T02:04:10.045318Z","caller":"traceutil/trace.go:171","msg":"trace[1919256208] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2435; }","duration":"206.790115ms","start":"2026-04-14T02:04:09.838509Z","end":"2026-04-14T02:04:10.0453Z","steps":["trace[1919256208] 'range keys from in-memory index tree' (duration: 206.583892ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:04:10.045427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.091167ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-04-14T02:04:10.045488Z","caller":"traceutil/trace.go:171","msg":"trace[1490689982] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2435; }","duration":"275.215289ms","start":"2026-04-14T02:04:09.770257Z","end":"2026-04-14T02:04:10.045472Z","steps":["trace[1490689982] 'range keys from in-memory index tree' (duration: 274.901264ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:04:11.74915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.909854ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-14T02:04:11.749297Z","caller":"traceutil/trace.go:171","msg":"trace[1424957923] transaction","detail":"{read_only:false; response_revision:2437; number_of_response:1; }","duration":"379.905831ms","start":"2026-04-14T02:04:11.36937Z","end":"2026-04-14T02:04:11.749276Z","steps":["trace[1424957923] 'process raft request' (duration: 232.764833ms)","trace[1424957923] 'compare' (duration: 146.722521ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T02:04:11.749362Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:04:11.369338Z","time spent":"379.992503ms","remote":"127.0.0.1:34892","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-14T02:04:12.162009Z","caller":"traceutil/trace.go:171","msg":"trace[202843975] transaction","detail":"{read_only:false; response_revision:2438; number_of_response:1; }","duration":"790.543625ms","start":"2026-04-14T02:04:11.371395Z","end":"2026-04-14T02:04:12.161938Z","steps":["trace[202843975] 'process raft request' (duration: 790.23374ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:04:12.162284Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:04:11.37138Z","time spent":"790.748318ms","remote":"127.0.0.1:34892","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-14T02:04:12.162939Z","caller":"traceutil/trace.go:171","msg":"trace[731181334] linearizableReadLoop","detail":"{readStateIndex:2540; appliedIndex:2536; }","duration":"786.801174ms","start":"2026-04-14T02:04:11.376119Z","end":"2026-04-14T02:04:12.16292Z","steps":["trace[731181334] 'read index received' (duration: 226.028643ms)","trace[731181334] 'applied index is now lower than readState.Index' (duration: 560.771841ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T02:04:12.162983Z","caller":"traceutil/trace.go:171","msg":"trace[1796942956] transaction","detail":"{read_only:false; response_revision:2440; number_of_response:1; }","duration":"790.420613ms","start":"2026-04-14T02:04:11.372539Z","end":"2026-04-14T02:04:12.16296Z","steps":["trace[1796942956] 'process raft request' (duration: 790.26563ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:04:12.162996Z","caller":"traceutil/trace.go:171","msg":"trace[1627246403] transaction","detail":"{read_only:false; response_revision:2439; number_of_response:1; }","duration":"791.44814ms","start":"2026-04-14T02:04:11.371517Z","end":"2026-04-14T02:04:12.162965Z","steps":["trace[1627246403] 'process raft request' (duration: 790.352502ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:04:12.163115Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:04:11.371509Z","time spent":"791.547391ms","remote":"127.0.0.1:34892","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-14T02:04:12.163139Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:04:11.372508Z","time spent":"790.535725ms","remote":"127.0.0.1:34892","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-14T02:04:12.163239Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"787.100139ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-04-14T02:04:12.163306Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.510104ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T02:04:12.163334Z","caller":"traceutil/trace.go:171","msg":"trace[1455945046] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2440; }","duration":"787.236011ms","start":"2026-04-14T02:04:11.376085Z","end":"2026-04-14T02:04:12.163321Z","steps":["trace[1455945046] 'agreement among raft nodes before linearized reading' (duration: 786.999878ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:04:12.163431Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"768.13457ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"warn","ts":"2026-04-14T02:04:12.163478Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:04:11.376073Z","time spent":"787.392024ms","remote":"127.0.0.1:34892","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":453,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-14T02:04:12.163557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"768.76731ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-14T02:04:12.16359Z","caller":"traceutil/trace.go:171","msg":"trace[230591823] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2440; }","duration":"768.828722ms","start":"2026-04-14T02:04:11.394754Z","end":"2026-04-14T02:04:12.163583Z","steps":["trace[230591823] 'agreement among raft nodes before linearized reading' (duration: 768.75036ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:04:12.163621Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:04:11.394738Z","time spent":"768.876082ms","remote":"127.0.0.1:34892","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":499,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-14T02:04:12.163342Z","caller":"traceutil/trace.go:171","msg":"trace[1671473082] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2440; }","duration":"323.603906ms","start":"2026-04-14T02:04:11.839723Z","end":"2026-04-14T02:04:12.163327Z","steps":["trace[1671473082] 'agreement among raft nodes before linearized reading' (duration: 323.548085ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:04:12.163694Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:04:11.839708Z","time spent":"323.975631ms","remote":"127.0.0.1:34554","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":26,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-14T02:04:12.163832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.012873ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-04-14T02:04:12.163904Z","caller":"traceutil/trace.go:171","msg":"trace[68679264] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2440; }","duration":"105.104634ms","start":"2026-04-14T02:04:12.058764Z","end":"2026-04-14T02:04:12.163869Z","steps":["trace[68679264] 'agreement among raft nodes before linearized reading' (duration: 104.948222ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:04:12.163335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"772.757335ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-14T02:04:12.164096Z","caller":"traceutil/trace.go:171","msg":"trace[2064195731] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2440; }","duration":"773.533668ms","start":"2026-04-14T02:04:11.390548Z","end":"2026-04-14T02:04:12.164081Z","steps":["trace[2064195731] 'agreement among raft nodes before linearized reading' (duration: 772.649843ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:04:12.163484Z","caller":"traceutil/trace.go:171","msg":"trace[282612078] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2440; }","duration":"768.231712ms","start":"2026-04-14T02:04:11.395238Z","end":"2026-04-14T02:04:12.163469Z","steps":["trace[282612078] 'agreement among raft nodes before linearized reading' (duration: 768.13152ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:04:12.164144Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:04:11.390537Z","time spent":"773.592369ms","remote":"127.0.0.1:34892","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":526,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-14T02:04:12.164163Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:04:11.395226Z","time spent":"768.925863ms","remote":"127.0.0.1:34892","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":512,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-14T02:04:12.163843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"773.184263ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-04-14T02:04:12.164257Z","caller":"traceutil/trace.go:171","msg":"trace[714285962] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2440; }","duration":"773.60937ms","start":"2026-04-14T02:04:11.390634Z","end":"2026-04-14T02:04:12.164244Z","steps":["trace[714285962] 'agreement among raft nodes before linearized reading' (duration: 773.131562ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:04:12.164596Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:04:11.390617Z","time spent":"773.960445ms","remote":"127.0.0.1:34892","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-14T02:04:12.398184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.09568ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-14T02:04:12.398494Z","caller":"traceutil/trace.go:171","msg":"trace[1969445919] transaction","detail":"{read_only:false; response_revision:2443; number_of_response:1; }","duration":"227.856426ms","start":"2026-04-14T02:04:12.170613Z","end":"2026-04-14T02:04:12.39847Z","steps":["trace[1969445919] 'process raft request' (duration: 227.711153ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:04:12.398477Z","caller":"traceutil/trace.go:171","msg":"trace[121207836] transaction","detail":"{read_only:false; response_revision:2442; number_of_response:1; }","duration":"227.926576ms","start":"2026-04-14T02:04:12.170505Z","end":"2026-04-14T02:04:12.398432Z","steps":["trace[121207836] 'process raft request' (duration: 121.4615ms)","trace[121207836] 'compare' (duration: 105.775695ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T02:04:12.398769Z","caller":"traceutil/trace.go:171","msg":"trace[1406218941] linearizableReadLoop","detail":"{readStateIndex:2545; appliedIndex:2540; }","duration":"227.335997ms","start":"2026-04-14T02:04:12.171415Z","end":"2026-04-14T02:04:12.398751Z","steps":["trace[1406218941] 'read index received' (duration: 33.739001ms)","trace[1406218941] 'applied index is now lower than readState.Index' (duration: 193.596036ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T02:04:12.399007Z","caller":"traceutil/trace.go:171","msg":"trace[2045560957] transaction","detail":"{read_only:false; response_revision:2445; number_of_response:1; }","duration":"227.637092ms","start":"2026-04-14T02:04:12.171341Z","end":"2026-04-14T02:04:12.398978Z","steps":["trace[2045560957] 'process raft request' (duration: 227.332117ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:04:12.399047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.624402ms","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-04-14T02:04:12.399276Z","caller":"traceutil/trace.go:171","msg":"trace[211638765] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:2445; }","duration":"228.084549ms","start":"2026-04-14T02:04:12.171176Z","end":"2026-04-14T02:04:12.399261Z","steps":["trace[211638765] 'agreement among raft nodes before linearized reading' (duration: 227.823944ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:04:12.399465Z","caller":"traceutil/trace.go:171","msg":"trace[1881701492] transaction","detail":"{read_only:false; response_revision:2444; number_of_response:1; }","duration":"228.073609ms","start":"2026-04-14T02:04:12.170892Z","end":"2026-04-14T02:04:12.398966Z","steps":["trace[1881701492] 'process raft request' (duration: 227.53288ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:04:13.954257Z","caller":"traceutil/trace.go:171","msg":"trace[1926510365] linearizableReadLoop","detail":"{readStateIndex:2547; appliedIndex:2546; }","duration":"114.664471ms","start":"2026-04-14T02:04:13.839568Z","end":"2026-04-14T02:04:13.954233Z","steps":["trace[1926510365] 'read index received' (duration: 114.539869ms)","trace[1926510365] 'applied index is now lower than readState.Index' (duration: 123.682µs)"],"step_count":2} {"level":"warn","ts":"2026-04-14T02:04:13.954469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.891404ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T02:04:13.954537Z","caller":"traceutil/trace.go:171","msg":"trace[741412776] transaction","detail":"{read_only:false; response_revision:2446; number_of_response:1; }","duration":"199.26271ms","start":"2026-04-14T02:04:13.755075Z","end":"2026-04-14T02:04:13.954338Z","steps":["trace[741412776] 'process raft request' (duration: 199.015746ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:04:13.954568Z","caller":"traceutil/trace.go:171","msg":"trace[1119496281] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2446; }","duration":"115.044277ms","start":"2026-04-14T02:04:13.839509Z","end":"2026-04-14T02:04:13.954553Z","steps":["trace[1119496281] 'agreement among raft nodes before linearized reading' (duration: 114.912035ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:04:14.314103Z","caller":"traceutil/trace.go:171","msg":"trace[1101867358] linearizableReadLoop","detail":"{readStateIndex:2551; appliedIndex:2548; }","duration":"136.153363ms","start":"2026-04-14T02:04:14.177925Z","end":"2026-04-14T02:04:14.314078Z","steps":["trace[1101867358] 'read index received' (duration: 22.576179ms)","trace[1101867358] 'applied index is now lower than readState.Index' (duration: 113.576154ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T02:04:14.314141Z","caller":"traceutil/trace.go:171","msg":"trace[459698452] transaction","detail":"{read_only:false; response_revision:2449; number_of_response:1; }","duration":"142.168561ms","start":"2026-04-14T02:04:14.171939Z","end":"2026-04-14T02:04:14.314107Z","steps":["trace[459698452] 'process raft request' (duration: 141.955727ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:04:14.314196Z","caller":"traceutil/trace.go:171","msg":"trace[368591755] transaction","detail":"{read_only:false; response_revision:2450; number_of_response:1; }","duration":"142.025959ms","start":"2026-04-14T02:04:14.172139Z","end":"2026-04-14T02:04:14.314165Z","steps":["trace[368591755] 'process raft request' (duration: 141.896116ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:04:14.314451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.697366ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-04-14T02:04:14.314501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.55716ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-04-14T02:04:14.314658Z","caller":"traceutil/trace.go:171","msg":"trace[1027616711] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2450; }","duration":"136.709522ms","start":"2026-04-14T02:04:14.177897Z","end":"2026-04-14T02:04:14.314607Z","steps":["trace[1027616711] 'agreement among raft nodes before linearized reading' (duration: 136.315905ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:04:14.314514Z","caller":"traceutil/trace.go:171","msg":"trace[1002458784] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2450; }","duration":"105.819388ms","start":"2026-04-14T02:04:14.208682Z","end":"2026-04-14T02:04:14.314502Z","steps":["trace[1002458784] 'agreement among raft nodes before linearized reading' (duration: 105.594234ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:04:15.351908Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"782.309136ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-14T02:04:15.352031Z","caller":"traceutil/trace.go:171","msg":"trace[544970123] linearizableReadLoop","detail":"{readStateIndex:2552; appliedIndex:2551; }","duration":"947.788728ms","start":"2026-04-14T02:04:14.404221Z","end":"2026-04-14T02:04:15.35201Z","steps":["trace[544970123] 'read index received' (duration: 165.259418ms)","trace[544970123] 'applied index is now lower than readState.Index' (duration: 782.52714ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T02:04:15.35229Z","caller":"traceutil/trace.go:171","msg":"trace[1991180513] transaction","detail":"{read_only:false; response_revision:2451; number_of_response:1; }","duration":"1.032921818s","start":"2026-04-14T02:04:14.319348Z","end":"2026-04-14T02:04:15.35227Z","steps":["trace[1991180513] 'process raft request' (duration: 250.134754ms)","trace[1991180513] 'compare' (duration: 781.821999ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T02:04:15.352391Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:04:14.319324Z","time spent":"1.033019749s","remote":"127.0.0.1:34892","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-14T02:04:15.352633Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"948.405498ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-14T02:04:15.352696Z","caller":"traceutil/trace.go:171","msg":"trace[1493725859] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2451; }","duration":"948.50235ms","start":"2026-04-14T02:04:14.404173Z","end":"2026-04-14T02:04:15.352676Z","steps":["trace[1493725859] 'agreement among raft nodes before linearized reading' (duration: 948.347157ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:04:15.35275Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:04:14.40415Z","time spent":"948.585911ms","remote":"127.0.0.1:34892","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-14T02:04:15.356064Z","caller":"traceutil/trace.go:171","msg":"trace[367972274] transaction","detail":"{read_only:false; response_revision:2452; number_of_response:1; }","duration":"167.702229ms","start":"2026-04-14T02:04:15.188346Z","end":"2026-04-14T02:04:15.356048Z","steps":["trace[367972274] 'process raft request' (duration: 167.542946ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:04:15.356216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.647509ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-14T02:04:15.356285Z","caller":"traceutil/trace.go:171","msg":"trace[1632947638] range","detail":"{range_begin:/registry/deployments/; range_end:/registry/deployments0; response_count:0; response_revision:2452; }","duration":"309.822442ms","start":"2026-04-14T02:04:15.046446Z","end":"2026-04-14T02:04:15.356268Z","steps":["trace[1632947638] 'agreement among raft nodes before linearized reading' (duration: 309.576588ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:04:15.356336Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:04:15.046386Z","time spent":"309.936343ms","remote":"127.0.0.1:35048","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":12,"response size":28,"request content":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true "} {"level":"warn","ts":"2026-04-14T02:04:15.356456Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"951.639802ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-14T02:04:15.356493Z","caller":"traceutil/trace.go:171","msg":"trace[1730083756] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2452; }","duration":"951.710782ms","start":"2026-04-14T02:04:14.404776Z","end":"2026-04-14T02:04:15.356487Z","steps":["trace[1730083756] 'agreement among raft nodes before linearized reading' (duration: 951.642511ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:04:15.356508Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:04:14.404758Z","time spent":"951.745292ms","remote":"127.0.0.1:34892","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-14T02:04:15.356645Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"673.49068ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T02:04:15.356864Z","caller":"traceutil/trace.go:171","msg":"trace[1794804886] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:2452; }","duration":"673.780704ms","start":"2026-04-14T02:04:14.683064Z","end":"2026-04-14T02:04:15.356845Z","steps":["trace[1794804886] 'agreement among raft nodes before linearized reading' (duration: 673.50538ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:04:15.357056Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:04:14.683042Z","time spent":"673.967208ms","remote":"127.0.0.1:35886","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":26,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-14T02:04:15.35678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"952.321622ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-14T02:04:15.357366Z","caller":"traceutil/trace.go:171","msg":"trace[1120817427] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2452; }","duration":"952.940232ms","start":"2026-04-14T02:04:14.404418Z","end":"2026-04-14T02:04:15.357358Z","steps":["trace[1120817427] 'agreement among raft nodes before linearized reading' (duration: 952.307982ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:04:15.357409Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:04:14.404399Z","time spent":"952.985023ms","remote":"127.0.0.1:34892","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-14T02:04:15.356963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"952.494605ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-14T02:04:15.357516Z","caller":"traceutil/trace.go:171","msg":"trace[1740424969] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2452; }","duration":"953.217427ms","start":"2026-04-14T02:04:14.404275Z","end":"2026-04-14T02:04:15.357492Z","steps":["trace[1740424969] 'agreement among raft nodes before linearized reading' (duration: 951.737732ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:04:15.357538Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:04:14.404262Z","time spent":"953.270448ms","remote":"127.0.0.1:34892","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-04-14T02:04:51.669178Z","caller":"traceutil/trace.go:171","msg":"trace[1039639486] transaction","detail":"{read_only:false; response_revision:2676; number_of_response:1; }","duration":"112.857064ms","start":"2026-04-14T02:04:51.556298Z","end":"2026-04-14T02:04:51.669155Z","steps":["trace[1039639486] 'process raft request' (duration: 112.778482ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:04:51.669448Z","caller":"traceutil/trace.go:171","msg":"trace[536798292] transaction","detail":"{read_only:false; response_revision:2675; number_of_response:1; }","duration":"115.03966ms","start":"2026-04-14T02:04:51.554347Z","end":"2026-04-14T02:04:51.669387Z","steps":["trace[536798292] 'process raft request' (duration: 108.37793ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:04:51.669618Z","caller":"traceutil/trace.go:171","msg":"trace[1966862961] linearizableReadLoop","detail":"{readStateIndex:2784; appliedIndex:2782; }","duration":"114.124155ms","start":"2026-04-14T02:04:51.555478Z","end":"2026-04-14T02:04:51.669602Z","steps":["trace[1966862961] 'read index received' (duration: 37.036265ms)","trace[1966862961] 'applied index is now lower than readState.Index' (duration: 77.0865ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T02:04:51.669528Z","caller":"traceutil/trace.go:171","msg":"trace[2085773442] transaction","detail":"{read_only:false; response_revision:2677; number_of_response:1; }","duration":"112.549909ms","start":"2026-04-14T02:04:51.556945Z","end":"2026-04-14T02:04:51.669495Z","steps":["trace[2085773442] 'process raft request' (duration: 112.177463ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:04:51.669647Z","caller":"traceutil/trace.go:171","msg":"trace[1250022519] transaction","detail":"{read_only:false; response_revision:2678; number_of_response:1; }","duration":"112.454458ms","start":"2026-04-14T02:04:51.557183Z","end":"2026-04-14T02:04:51.669638Z","steps":["trace[1250022519] 'process raft request' (duration: 112.136072ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:04:51.669895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.365819ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-14T02:04:51.669966Z","caller":"traceutil/trace.go:171","msg":"trace[1727097141] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2678; }","duration":"114.518122ms","start":"2026-04-14T02:04:51.555432Z","end":"2026-04-14T02:04:51.669951Z","steps":["trace[1727097141] 'agreement among raft nodes before linearized reading' (duration: 114.281378ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:04:52.239973Z","caller":"traceutil/trace.go:171","msg":"trace[951280798] transaction","detail":"{read_only:false; response_revision:2681; number_of_response:1; }","duration":"115.01108ms","start":"2026-04-14T02:04:52.124933Z","end":"2026-04-14T02:04:52.239944Z","steps":["trace[951280798] 'process raft request' (duration: 114.657934ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:05:31.894023Z","caller":"traceutil/trace.go:171","msg":"trace[1114225320] transaction","detail":"{read_only:false; response_revision:2913; number_of_response:1; }","duration":"115.714535ms","start":"2026-04-14T02:05:31.778279Z","end":"2026-04-14T02:05:31.893994Z","steps":["trace[1114225320] 'process raft request' (duration: 115.285107ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:05:38.536904Z","caller":"traceutil/trace.go:171","msg":"trace[1059684489] transaction","detail":"{read_only:false; response_revision:2988; number_of_response:1; }","duration":"131.523779ms","start":"2026-04-14T02:05:38.405362Z","end":"2026-04-14T02:05:38.536885Z","steps":["trace[1059684489] 'process raft request' (duration: 131.407685ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:05:54.442424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.159143ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T02:05:54.442631Z","caller":"traceutil/trace.go:171","msg":"trace[1346500875] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:3078; }","duration":"195.430412ms","start":"2026-04-14T02:05:54.247179Z","end":"2026-04-14T02:05:54.442609Z","steps":["trace[1346500875] 'count revisions from in-memory index tree' (duration: 195.019679ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:06:14.547498Z","caller":"traceutil/trace.go:171","msg":"trace[35213705] linearizableReadLoop","detail":"{readStateIndex:3311; appliedIndex:3310; }","duration":"152.95717ms","start":"2026-04-14T02:06:14.394516Z","end":"2026-04-14T02:06:14.547473Z","steps":["trace[35213705] 'read index received' (duration: 74.247998ms)","trace[35213705] 'applied index is now lower than readState.Index' (duration: 78.707882ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T02:06:14.547614Z","caller":"traceutil/trace.go:171","msg":"trace[2015473850] transaction","detail":"{read_only:false; response_revision:3184; number_of_response:1; }","duration":"286.621905ms","start":"2026-04-14T02:06:14.260965Z","end":"2026-04-14T02:06:14.547587Z","steps":["trace[2015473850] 'process raft request' (duration: 207.669047ms)","trace[2015473850] 'compare' (duration: 78.64913ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T02:06:14.547664Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.131624ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-14T02:06:14.54769Z","caller":"traceutil/trace.go:171","msg":"trace[1324799686] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; response_count:0; response_revision:3184; }","duration":"153.207717ms","start":"2026-04-14T02:06:14.394475Z","end":"2026-04-14T02:06:14.547683Z","steps":["trace[1324799686] 'agreement among raft nodes before linearized reading' (duration: 153.077363ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:06:15.061811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.566546ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-14T02:06:15.061932Z","caller":"traceutil/trace.go:171","msg":"trace[817647508] transaction","detail":"{read_only:false; response_revision:3185; number_of_response:1; }","duration":"403.048378ms","start":"2026-04-14T02:06:14.658863Z","end":"2026-04-14T02:06:15.061911Z","steps":["trace[817647508] 'process raft request' (duration: 299.273516ms)","trace[817647508] 'compare' (duration: 103.366231ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T02:06:15.061992Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:06:14.65884Z","time spent":"403.12157ms","remote":"127.0.0.1:34892","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-14T02:06:15.499442Z","caller":"traceutil/trace.go:171","msg":"trace[1134367375] linearizableReadLoop","detail":"{readStateIndex:3313; appliedIndex:3311; }","duration":"761.196684ms","start":"2026-04-14T02:06:14.738229Z","end":"2026-04-14T02:06:15.499426Z","steps":["trace[1134367375] 'read index received' (duration: 219.919246ms)","trace[1134367375] 'applied index is now lower than readState.Index' (duration: 541.276788ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T02:06:15.499534Z","caller":"traceutil/trace.go:171","msg":"trace[1292729168] transaction","detail":"{read_only:false; response_revision:3187; number_of_response:1; }","duration":"679.235432ms","start":"2026-04-14T02:06:14.82029Z","end":"2026-04-14T02:06:15.499526Z","steps":["trace[1292729168] 'process raft request' (duration: 679.075288ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:06:15.49954Z","caller":"traceutil/trace.go:171","msg":"trace[131051465] transaction","detail":"{read_only:false; response_revision:3186; number_of_response:1; }","duration":"840.529994ms","start":"2026-04-14T02:06:14.658977Z","end":"2026-04-14T02:06:15.499507Z","steps":["trace[131051465] 'process raft request' (duration: 760.722637ms)","trace[131051465] 'compare' (duration: 79.56608ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T02:06:15.499601Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:06:14.820267Z","time spent":"679.283854ms","remote":"127.0.0.1:34892","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-14T02:06:15.49974Z","caller":"traceutil/trace.go:171","msg":"trace[131485145] transaction","detail":"{read_only:false; response_revision:3188; number_of_response:1; }","duration":"675.248522ms","start":"2026-04-14T02:06:14.824485Z","end":"2026-04-14T02:06:15.499734Z","steps":["trace[131485145] 'process raft request' (duration: 674.910312ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:06:15.499779Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:06:14.824453Z","time spent":"675.308734ms","remote":"127.0.0.1:34892","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-14T02:06:15.499815Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:06:14.658949Z","time spent":"840.78548ms","remote":"127.0.0.1:34892","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-14T02:06:15.499963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"761.731409ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-14T02:06:15.499963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"390.153967ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T02:06:15.499987Z","caller":"traceutil/trace.go:171","msg":"trace[495492560] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:3188; }","duration":"761.794721ms","start":"2026-04-14T02:06:14.738186Z","end":"2026-04-14T02:06:15.499981Z","steps":["trace[495492560] 'agreement among raft nodes before linearized reading' (duration: 761.730869ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:06:15.499943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"662.609231ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-14T02:06:15.500009Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:06:14.738166Z","time spent":"761.838391ms","remote":"127.0.0.1:35022","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":13,"response size":28,"request content":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true "} {"level":"info","ts":"2026-04-14T02:06:15.500044Z","caller":"traceutil/trace.go:171","msg":"trace[917206027] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:3188; }","duration":"662.768676ms","start":"2026-04-14T02:06:14.837252Z","end":"2026-04-14T02:06:15.500021Z","steps":["trace[917206027] 'agreement among raft nodes before linearized reading' (duration: 662.56057ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:06:15.500089Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:06:14.837235Z","time spent":"662.848357ms","remote":"127.0.0.1:34554","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":26,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-14T02:06:15.499993Z","caller":"traceutil/trace.go:171","msg":"trace[1287013619] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:3188; }","duration":"390.221409ms","start":"2026-04-14T02:06:15.109764Z","end":"2026-04-14T02:06:15.499985Z","steps":["trace[1287013619] 'agreement among raft nodes before linearized reading' (duration: 390.158877ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:06:15.500218Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:06:15.109737Z","time spent":"390.472766ms","remote":"127.0.0.1:34982","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":0,"response size":26,"request content":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true "} {"level":"info","ts":"2026-04-14T02:07:55.737272Z","caller":"traceutil/trace.go:171","msg":"trace[1423008328] transaction","detail":"{read_only:false; response_revision:3729; number_of_response:1; }","duration":"156.062742ms","start":"2026-04-14T02:07:55.581184Z","end":"2026-04-14T02:07:55.737246Z","steps":["trace[1423008328] 'process raft request' (duration: 155.913058ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:07:55.833001Z","caller":"traceutil/trace.go:171","msg":"trace[1024753712] transaction","detail":"{read_only:false; response_revision:3730; number_of_response:1; }","duration":"204.298257ms","start":"2026-04-14T02:07:55.62861Z","end":"2026-04-14T02:07:55.832908Z","steps":["trace[1024753712] 'process raft request' (duration: 139.836434ms)","trace[1024753712] 'compare' (duration: 63.835349ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T02:08:09.004506Z","caller":"traceutil/trace.go:171","msg":"trace[1388682155] transaction","detail":"{read_only:false; response_revision:3886; number_of_response:1; }","duration":"118.253197ms","start":"2026-04-14T02:08:08.88623Z","end":"2026-04-14T02:08:09.004483Z","steps":["trace[1388682155] 'process raft request' (duration: 117.93294ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:08:09.216484Z","caller":"traceutil/trace.go:171","msg":"trace[312310346] transaction","detail":"{read_only:false; response_revision:3888; number_of_response:1; }","duration":"204.793151ms","start":"2026-04-14T02:08:09.01167Z","end":"2026-04-14T02:08:09.216463Z","steps":["trace[312310346] 'process raft request' (duration: 204.642618ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:08:09.216613Z","caller":"traceutil/trace.go:171","msg":"trace[1539127254] linearizableReadLoop","detail":"{readStateIndex:4044; appliedIndex:4041; }","duration":"195.175277ms","start":"2026-04-14T02:08:09.021418Z","end":"2026-04-14T02:08:09.216594Z","steps":["trace[1539127254] 'read index received' (duration: 32.861502ms)","trace[1539127254] 'applied index is now lower than readState.Index' (duration: 162.312325ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T02:08:09.2167Z","caller":"traceutil/trace.go:171","msg":"trace[1473512115] transaction","detail":"{read_only:false; response_revision:3889; number_of_response:1; }","duration":"204.330201ms","start":"2026-04-14T02:08:09.012359Z","end":"2026-04-14T02:08:09.216689Z","steps":["trace[1473512115] 'process raft request' (duration: 204.070445ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:08:09.216867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.432702ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-14T02:08:09.216953Z","caller":"traceutil/trace.go:171","msg":"trace[1624435938] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:3889; }","duration":"195.562465ms","start":"2026-04-14T02:08:09.02138Z","end":"2026-04-14T02:08:09.216942Z","steps":["trace[1624435938] 'agreement among raft nodes before linearized reading' (duration: 195.284108ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:08:18.971157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.454094ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T02:08:18.971322Z","caller":"traceutil/trace.go:171","msg":"trace[1166210882] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:3996; }","duration":"131.72243ms","start":"2026-04-14T02:08:18.839568Z","end":"2026-04-14T02:08:18.97129Z","steps":["trace[1166210882] 'range keys from in-memory index tree' (duration: 131.309501ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:08:23.096341Z","caller":"traceutil/trace.go:171","msg":"trace[1003959841] transaction","detail":"{read_only:false; response_revision:4040; number_of_response:1; }","duration":"120.705422ms","start":"2026-04-14T02:08:22.975619Z","end":"2026-04-14T02:08:23.096325Z","steps":["trace[1003959841] 'process raft request' (duration: 120.539049ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:08:26.009877Z","caller":"traceutil/trace.go:171","msg":"trace[1428846224] transaction","detail":"{read_only:false; response_revision:4060; number_of_response:1; }","duration":"146.085038ms","start":"2026-04-14T02:08:25.863744Z","end":"2026-04-14T02:08:26.009829Z","steps":["trace[1428846224] 'process raft request' (duration: 145.891484ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:08:30.941199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.624526ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"warn","ts":"2026-04-14T02:08:30.941261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.765519ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T02:08:30.94131Z","caller":"traceutil/trace.go:171","msg":"trace[386229564] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4096; }","duration":"101.853391ms","start":"2026-04-14T02:08:30.839443Z","end":"2026-04-14T02:08:30.941297Z","steps":["trace[386229564] 'range keys from in-memory index tree' (duration: 101.683127ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:08:30.941302Z","caller":"traceutil/trace.go:171","msg":"trace[390418927] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4096; }","duration":"201.757199ms","start":"2026-04-14T02:08:30.739517Z","end":"2026-04-14T02:08:30.941274Z","steps":["trace[390418927] 'range keys from in-memory index tree' (duration: 201.450393ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:08:31.338421Z","caller":"traceutil/trace.go:171","msg":"trace[895229383] linearizableReadLoop","detail":"{readStateIndex:4257; appliedIndex:4256; }","duration":"120.112884ms","start":"2026-04-14T02:08:31.218277Z","end":"2026-04-14T02:08:31.338389Z","steps":["trace[895229383] 'read index received' (duration: 120.078064ms)","trace[895229383] 'applied index is now lower than readState.Index' (duration: 33.02µs)"],"step_count":2} {"level":"info","ts":"2026-04-14T02:08:31.338466Z","caller":"traceutil/trace.go:171","msg":"trace[453540400] transaction","detail":"{read_only:false; response_revision:4097; number_of_response:1; }","duration":"120.659645ms","start":"2026-04-14T02:08:31.217773Z","end":"2026-04-14T02:08:31.338433Z","steps":["trace[453540400] 'process raft request' (duration: 120.455091ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:08:31.338691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.38865ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-14T02:08:31.338767Z","caller":"traceutil/trace.go:171","msg":"trace[729366409] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4097; }","duration":"120.584674ms","start":"2026-04-14T02:08:31.21817Z","end":"2026-04-14T02:08:31.338755Z","steps":["trace[729366409] 'agreement among raft nodes before linearized reading' (duration: 120.334069ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:08:31.577182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.387328ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-14T02:08:31.577287Z","caller":"traceutil/trace.go:171","msg":"trace[252130023] linearizableReadLoop","detail":"{readStateIndex:4258; appliedIndex:4257; }","duration":"232.149472ms","start":"2026-04-14T02:08:31.345122Z","end":"2026-04-14T02:08:31.577272Z","steps":["trace[252130023] 'read index received' (duration: 82.357036ms)","trace[252130023] 'applied index is now lower than readState.Index' (duration: 149.791116ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T02:08:31.577627Z","caller":"traceutil/trace.go:171","msg":"trace[1837155064] transaction","detail":"{read_only:false; response_revision:4098; number_of_response:1; }","duration":"234.81239ms","start":"2026-04-14T02:08:31.342804Z","end":"2026-04-14T02:08:31.577616Z","steps":["trace[1837155064] 'process raft request' (duration: 84.87615ms)","trace[1837155064] 'compare' (duration: 149.196174ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T02:08:31.577762Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.903237ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-04-14T02:08:31.577834Z","caller":"traceutil/trace.go:171","msg":"trace[1967562428] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4098; }","duration":"226.002869ms","start":"2026-04-14T02:08:31.351815Z","end":"2026-04-14T02:08:31.577817Z","steps":["trace[1967562428] 'agreement among raft nodes before linearized reading' (duration: 225.832906ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:08:31.577845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.223237ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-04-14T02:08:31.577872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.735745ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-14T02:08:31.577914Z","caller":"traceutil/trace.go:171","msg":"trace[1486864450] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4098; }","duration":"192.331139ms","start":"2026-04-14T02:08:31.385567Z","end":"2026-04-14T02:08:31.577898Z","steps":["trace[1486864450] 'agreement among raft nodes before linearized reading' (duration: 192.157925ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:08:31.577949Z","caller":"traceutil/trace.go:171","msg":"trace[614341366] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4098; }","duration":"232.852838ms","start":"2026-04-14T02:08:31.345079Z","end":"2026-04-14T02:08:31.577932Z","steps":["trace[614341366] 'agreement among raft nodes before linearized reading' (duration: 232.633653ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:08:31.890125Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.15494ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-14T02:08:31.890216Z","caller":"traceutil/trace.go:171","msg":"trace[444841347] transaction","detail":"{read_only:false; response_revision:4099; number_of_response:1; }","duration":"308.17371ms","start":"2026-04-14T02:08:31.582025Z","end":"2026-04-14T02:08:31.890199Z","steps":["trace[444841347] 'process raft request' (duration: 166.865087ms)","trace[444841347] 'compare' (duration: 140.998027ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T02:08:31.890258Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:08:31.582008Z","time spent":"308.229842ms","remote":"127.0.0.1:34892","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-14T02:08:32.26334Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.355711ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-14T02:08:32.263533Z","caller":"traceutil/trace.go:171","msg":"trace[130572932] linearizableReadLoop","detail":"{readStateIndex:4261; appliedIndex:4258; }","duration":"577.848412ms","start":"2026-04-14T02:08:31.685668Z","end":"2026-04-14T02:08:32.263516Z","steps":["trace[130572932] 'read index received' (duration: 63.228221ms)","trace[130572932] 'applied index is now lower than readState.Index' (duration: 514.619121ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T02:08:32.263602Z","caller":"traceutil/trace.go:171","msg":"trace[16186598] transaction","detail":"{read_only:false; response_revision:4101; number_of_response:1; }","duration":"679.207009ms","start":"2026-04-14T02:08:31.58438Z","end":"2026-04-14T02:08:32.263587Z","steps":["trace[16186598] 'process raft request' (duration: 679.074596ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:08:32.263667Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:08:31.584361Z","time spent":"679.27301ms","remote":"127.0.0.1:34892","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-14T02:08:32.263681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"578.017175ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-04-14T02:08:32.263709Z","caller":"traceutil/trace.go:171","msg":"trace[717148238] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4101; }","duration":"578.081667ms","start":"2026-04-14T02:08:31.685617Z","end":"2026-04-14T02:08:32.263699Z","steps":["trace[717148238] 'agreement among raft nodes before linearized reading' (duration: 577.969654ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:08:32.263673Z","caller":"traceutil/trace.go:171","msg":"trace[1772167752] transaction","detail":"{read_only:false; response_revision:4100; number_of_response:1; }","duration":"681.58731ms","start":"2026-04-14T02:08:31.582043Z","end":"2026-04-14T02:08:32.26363Z","steps":["trace[1772167752] 'process raft request' (duration: 521.864171ms)","trace[1772167752] 'compare' (duration: 159.126616ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T02:08:32.263737Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:08:31.685598Z","time spent":"578.133157ms","remote":"127.0.0.1:34764","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":1,"response size":1886,"request content":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" "} {"level":"warn","ts":"2026-04-14T02:08:32.263846Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:08:31.582023Z","time spent":"681.732774ms","remote":"127.0.0.1:34892","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-14T02:08:32.341285Z","caller":"traceutil/trace.go:171","msg":"trace[659751053] transaction","detail":"{read_only:false; response_revision:4102; number_of_response:1; }","duration":"299.459655ms","start":"2026-04-14T02:08:32.041804Z","end":"2026-04-14T02:08:32.341263Z","steps":["trace[659751053] 'process raft request' (duration: 299.295671ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:08:32.342663Z","caller":"traceutil/trace.go:171","msg":"trace[1825511247] transaction","detail":"{read_only:false; response_revision:4103; number_of_response:1; }","duration":"270.103769ms","start":"2026-04-14T02:08:32.072425Z","end":"2026-04-14T02:08:32.342529Z","steps":["trace[1825511247] 'process raft request' (duration: 268.795551ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:08:32.343056Z","caller":"traceutil/trace.go:171","msg":"trace[1027374087] transaction","detail":"{read_only:false; response_revision:4105; number_of_response:1; }","duration":"270.419476ms","start":"2026-04-14T02:08:32.072588Z","end":"2026-04-14T02:08:32.343007Z","steps":["trace[1027374087] 'process raft request' (duration: 269.786873ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:08:32.34324Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"408.828686ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T02:08:32.343119Z","caller":"traceutil/trace.go:171","msg":"trace[1792467668] transaction","detail":"{read_only:false; response_revision:4104; number_of_response:1; }","duration":"270.61373ms","start":"2026-04-14T02:08:32.072482Z","end":"2026-04-14T02:08:32.343096Z","steps":["trace[1792467668] 'process raft request' (duration: 269.764632ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:08:32.34331Z","caller":"traceutil/trace.go:171","msg":"trace[2131859517] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:4105; }","duration":"408.957679ms","start":"2026-04-14T02:08:31.934336Z","end":"2026-04-14T02:08:32.343293Z","steps":["trace[2131859517] 'agreement among raft nodes before linearized reading' (duration: 408.832706ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:08:32.343365Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:08:31.934319Z","time spent":"409.031ms","remote":"127.0.0.1:36008","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":26,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-14T02:08:50.238288Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.099934ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/openstack/rabbitmq-keystone-server\" ","response":"range_response_count:1 size:9582"} {"level":"info","ts":"2026-04-14T02:08:50.238483Z","caller":"traceutil/trace.go:171","msg":"trace[971783139] range","detail":"{range_begin:/registry/statefulsets/openstack/rabbitmq-keystone-server; range_end:; response_count:1; response_revision:4214; }","duration":"106.356669ms","start":"2026-04-14T02:08:50.132098Z","end":"2026-04-14T02:08:50.238455Z","steps":["trace[971783139] 'range keys from in-memory index tree' (duration: 103.930319ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:08:54.244352Z","caller":"traceutil/trace.go:171","msg":"trace[386811128] transaction","detail":"{read_only:false; response_revision:4239; number_of_response:1; }","duration":"109.885916ms","start":"2026-04-14T02:08:54.134434Z","end":"2026-04-14T02:08:54.24432Z","steps":["trace[386811128] 'process raft request' (duration: 109.697562ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:09:07.884391Z","caller":"traceutil/trace.go:171","msg":"trace[623218070] transaction","detail":"{read_only:false; response_revision:4411; number_of_response:1; }","duration":"179.468052ms","start":"2026-04-14T02:09:07.704862Z","end":"2026-04-14T02:09:07.88433Z","steps":["trace[623218070] 'process raft request' (duration: 179.246398ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:09:12.544341Z","caller":"traceutil/trace.go:171","msg":"trace[1287930906] linearizableReadLoop","detail":"{readStateIndex:4646; appliedIndex:4645; }","duration":"153.970745ms","start":"2026-04-14T02:09:12.390344Z","end":"2026-04-14T02:09:12.544315Z","steps":["trace[1287930906] 'read index received' (duration: 130.323533ms)","trace[1287930906] 'applied index is now lower than readState.Index' (duration: 23.646252ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T02:09:12.544443Z","caller":"traceutil/trace.go:171","msg":"trace[2080967704] transaction","detail":"{read_only:false; response_revision:4475; number_of_response:1; }","duration":"197.306938ms","start":"2026-04-14T02:09:12.347102Z","end":"2026-04-14T02:09:12.544409Z","steps":["trace[2080967704] 'process raft request' (duration: 173.464702ms)","trace[2080967704] 'compare' (duration: 23.580061ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T02:09:12.544551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.181529ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/prometheusagents.monitoring.coreos.com\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T02:09:12.544595Z","caller":"traceutil/trace.go:171","msg":"trace[1114584117] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/prometheusagents.monitoring.coreos.com; range_end:; response_count:0; response_revision:4475; }","duration":"154.271952ms","start":"2026-04-14T02:09:12.390312Z","end":"2026-04-14T02:09:12.544584Z","steps":["trace[1114584117] 'agreement among raft nodes before linearized reading' (duration: 154.163329ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:09:12.544849Z","caller":"traceutil/trace.go:171","msg":"trace[376283193] transaction","detail":"{read_only:false; response_revision:4476; number_of_response:1; }","duration":"150.128105ms","start":"2026-04-14T02:09:12.394709Z","end":"2026-04-14T02:09:12.544837Z","steps":["trace[376283193] 'process raft request' (duration: 149.929441ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:09:12.544921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.256983ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-14T02:09:12.545007Z","caller":"traceutil/trace.go:171","msg":"trace[1866067228] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:4476; }","duration":"119.393035ms","start":"2026-04-14T02:09:12.425597Z","end":"2026-04-14T02:09:12.54499Z","steps":["trace[1866067228] 'agreement among raft nodes before linearized reading' (duration: 119.198041ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:09:12.919158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.861036ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-14T02:09:12.919417Z","caller":"traceutil/trace.go:171","msg":"trace[1920351566] transaction","detail":"{read_only:false; response_revision:4483; number_of_response:1; }","duration":"216.250572ms","start":"2026-04-14T02:09:12.703147Z","end":"2026-04-14T02:09:12.919397Z","steps":["trace[1920351566] 'process raft request' (duration: 107.066209ms)","trace[1920351566] 'compare' (duration: 108.661232ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T02:09:12.920125Z","caller":"traceutil/trace.go:171","msg":"trace[643531143] transaction","detail":"{read_only:false; response_revision:4484; number_of_response:1; }","duration":"216.803223ms","start":"2026-04-14T02:09:12.703274Z","end":"2026-04-14T02:09:12.920077Z","steps":["trace[643531143] 'process raft request' (duration: 216.065048ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:09:12.920233Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.668657ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/prometheuses.monitoring.coreos.com\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T02:09:12.920283Z","caller":"traceutil/trace.go:171","msg":"trace[969523609] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/prometheuses.monitoring.coreos.com; range_end:; response_count:0; response_revision:4485; }","duration":"199.733538ms","start":"2026-04-14T02:09:12.720538Z","end":"2026-04-14T02:09:12.920271Z","steps":["trace[969523609] 'agreement among raft nodes before linearized reading' (duration: 199.646506ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:09:12.920131Z","caller":"traceutil/trace.go:171","msg":"trace[1456236255] linearizableReadLoop","detail":"{readStateIndex:4656; appliedIndex:4653; }","duration":"199.547165ms","start":"2026-04-14T02:09:12.720556Z","end":"2026-04-14T02:09:12.920103Z","steps":["trace[1456236255] 'read index received' (duration: 89.679537ms)","trace[1456236255] 'applied index is now lower than readState.Index' (duration: 109.866588ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T02:09:12.921479Z","caller":"traceutil/trace.go:171","msg":"trace[255726069] transaction","detail":"{read_only:false; response_revision:4485; number_of_response:1; }","duration":"217.006777ms","start":"2026-04-14T02:09:12.70327Z","end":"2026-04-14T02:09:12.920277Z","steps":["trace[255726069] 'process raft request' (duration: 216.284092ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:09:12.935293Z","caller":"traceutil/trace.go:171","msg":"trace[1057366903] transaction","detail":"{read_only:false; response_revision:4486; number_of_response:1; }","duration":"202.004706ms","start":"2026-04-14T02:09:12.733266Z","end":"2026-04-14T02:09:12.935271Z","steps":["trace[1057366903] 'process raft request' (duration: 200.930123ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:09:12.935526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.040467ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-14T02:09:12.935626Z","caller":"traceutil/trace.go:171","msg":"trace[1455347062] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:4486; }","duration":"105.332423ms","start":"2026-04-14T02:09:12.83027Z","end":"2026-04-14T02:09:12.935602Z","steps":["trace[1455347062] 'agreement among raft nodes before linearized reading' (duration: 105.023057ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:09:12.935897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.660803ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-04-14T02:09:12.935963Z","caller":"traceutil/trace.go:171","msg":"trace[1944136413] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4486; }","duration":"195.762596ms","start":"2026-04-14T02:09:12.740183Z","end":"2026-04-14T02:09:12.935946Z","steps":["trace[1944136413] 'agreement among raft nodes before linearized reading' (duration: 194.938328ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:09:13.148534Z","caller":"traceutil/trace.go:171","msg":"trace[2071493306] transaction","detail":"{read_only:false; response_revision:4488; number_of_response:1; }","duration":"109.219292ms","start":"2026-04-14T02:09:13.039293Z","end":"2026-04-14T02:09:13.148513Z","steps":["trace[2071493306] 'process raft request' (duration: 108.346973ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:09:16.769836Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.546337ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-14T02:09:16.769916Z","caller":"traceutil/trace.go:171","msg":"trace[726491033] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4523; }","duration":"102.67908ms","start":"2026-04-14T02:09:16.667224Z","end":"2026-04-14T02:09:16.769903Z","steps":["trace[726491033] 'range keys from in-memory index tree' (duration: 102.374724ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:09:18.308118Z","caller":"traceutil/trace.go:171","msg":"trace[1460386852] transaction","detail":"{read_only:false; response_revision:4535; number_of_response:1; }","duration":"122.14793ms","start":"2026-04-14T02:09:18.185942Z","end":"2026-04-14T02:09:18.30809Z","steps":["trace[1460386852] 'process raft request' (duration: 121.823573ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:09:31.722106Z","caller":"traceutil/trace.go:171","msg":"trace[1383299975] transaction","detail":"{read_only:false; response_revision:4647; number_of_response:1; }","duration":"197.631613ms","start":"2026-04-14T02:09:31.52446Z","end":"2026-04-14T02:09:31.722092Z","steps":["trace[1383299975] 'process raft request' (duration: 197.431819ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:09:35.999733Z","caller":"traceutil/trace.go:171","msg":"trace[40704100] transaction","detail":"{read_only:false; number_of_response:0; response_revision:4687; }","duration":"101.519674ms","start":"2026-04-14T02:09:35.898193Z","end":"2026-04-14T02:09:35.999712Z","steps":["trace[40704100] 'process raft request' (duration: 101.421452ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:09:53.34458Z","caller":"traceutil/trace.go:171","msg":"trace[1706148224] linearizableReadLoop","detail":"{readStateIndex:5033; appliedIndex:5032; }","duration":"216.232737ms","start":"2026-04-14T02:09:53.128313Z","end":"2026-04-14T02:09:53.344546Z","steps":["trace[1706148224] 'read index received' (duration: 195.311324ms)","trace[1706148224] 'applied index is now lower than readState.Index' (duration: 20.919603ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T02:09:53.344858Z","caller":"traceutil/trace.go:171","msg":"trace[811081777] transaction","detail":"{read_only:false; response_revision:4842; number_of_response:1; }","duration":"240.689631ms","start":"2026-04-14T02:09:53.10401Z","end":"2026-04-14T02:09:53.3447Z","steps":["trace[811081777] 'process raft request' (duration: 219.592625ms)","trace[811081777] 'compare' (duration: 20.759619ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T02:09:53.345041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.671095ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-14T02:09:53.345148Z","caller":"traceutil/trace.go:171","msg":"trace[1768871988] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4842; }","duration":"216.876989ms","start":"2026-04-14T02:09:53.12825Z","end":"2026-04-14T02:09:53.345127Z","steps":["trace[1768871988] 'agreement among raft nodes before linearized reading' (duration: 216.505962ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:09:53.353654Z","caller":"traceutil/trace.go:171","msg":"trace[599894734] transaction","detail":"{read_only:false; response_revision:4843; number_of_response:1; }","duration":"105.093493ms","start":"2026-04-14T02:09:53.248502Z","end":"2026-04-14T02:09:53.353595Z","steps":["trace[599894734] 'process raft request' (duration: 104.95247ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:09:53.530884Z","caller":"traceutil/trace.go:171","msg":"trace[662552856] transaction","detail":"{read_only:false; response_revision:4845; number_of_response:1; }","duration":"156.466019ms","start":"2026-04-14T02:09:53.374396Z","end":"2026-04-14T02:09:53.530862Z","steps":["trace[662552856] 'process raft request' (duration: 156.341817ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:09:53.530974Z","caller":"traceutil/trace.go:171","msg":"trace[1309259254] transaction","detail":"{read_only:false; response_revision:4844; number_of_response:1; }","duration":"180.432583ms","start":"2026-04-14T02:09:53.35047Z","end":"2026-04-14T02:09:53.530902Z","steps":["trace[1309259254] 'process raft request' (duration: 180.065236ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:09:53.531066Z","caller":"traceutil/trace.go:171","msg":"trace[1975508572] transaction","detail":"{read_only:false; response_revision:4846; number_of_response:1; }","duration":"128.443084ms","start":"2026-04-14T02:09:53.402589Z","end":"2026-04-14T02:09:53.531032Z","steps":["trace[1975508572] 'process raft request' (duration: 128.23692ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:09:58.840491Z","caller":"traceutil/trace.go:171","msg":"trace[1435975711] transaction","detail":"{read_only:false; response_revision:5139; number_of_response:1; }","duration":"137.817334ms","start":"2026-04-14T02:09:58.702647Z","end":"2026-04-14T02:09:58.840464Z","steps":["trace[1435975711] 'process raft request' (duration: 113.337582ms)","trace[1435975711] 'compare' (duration: 24.041313ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T02:09:58.840568Z","caller":"traceutil/trace.go:171","msg":"trace[1371599984] transaction","detail":"{read_only:false; response_revision:5140; number_of_response:1; }","duration":"135.154381ms","start":"2026-04-14T02:09:58.705372Z","end":"2026-04-14T02:09:58.840526Z","steps":["trace[1371599984] 'process raft request' (duration: 134.960247ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:09:58.840867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.225562ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-tls\" ","response":"range_response_count:1 size:4326"} {"level":"info","ts":"2026-04-14T02:09:58.840677Z","caller":"traceutil/trace.go:171","msg":"trace[70473244] linearizableReadLoop","detail":"{readStateIndex:5338; appliedIndex:5335; }","duration":"135.028738ms","start":"2026-04-14T02:09:58.705625Z","end":"2026-04-14T02:09:58.840654Z","steps":["trace[70473244] 'read index received' (duration: 40.940474ms)","trace[70473244] 'applied index is now lower than readState.Index' (duration: 94.087024ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T02:09:58.840926Z","caller":"traceutil/trace.go:171","msg":"trace[947940524] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-tls; range_end:; response_count:1; response_revision:5141; }","duration":"135.324064ms","start":"2026-04-14T02:09:58.705592Z","end":"2026-04-14T02:09:58.840916Z","steps":["trace[947940524] 'agreement among raft nodes before linearized reading' (duration: 135.138551ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:09:58.841003Z","caller":"traceutil/trace.go:171","msg":"trace[1484382041] transaction","detail":"{read_only:false; response_revision:5141; number_of_response:1; }","duration":"119.969825ms","start":"2026-04-14T02:09:58.721008Z","end":"2026-04-14T02:09:58.840977Z","steps":["trace[1484382041] 'process raft request' (duration: 119.439944ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:10:00.194672Z","caller":"traceutil/trace.go:171","msg":"trace[377766432] linearizableReadLoop","detail":"{readStateIndex:5396; appliedIndex:5395; }","duration":"357.930119ms","start":"2026-04-14T02:09:59.83672Z","end":"2026-04-14T02:10:00.19465Z","steps":["trace[377766432] 'read index received' (duration: 343.949448ms)","trace[377766432] 'applied index is now lower than readState.Index' (duration: 13.979011ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T02:10:00.194789Z","caller":"traceutil/trace.go:171","msg":"trace[2091802092] transaction","detail":"{read_only:false; response_revision:5198; number_of_response:1; }","duration":"365.970021ms","start":"2026-04-14T02:09:59.828623Z","end":"2026-04-14T02:10:00.194593Z","steps":["trace[2091802092] 'process raft request' (duration: 352.587022ms)","trace[2091802092] 'compare' (duration: 12.689655ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T02:10:00.194933Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:09:59.828598Z","time spent":"366.258127ms","remote":"127.0.0.1:34670","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":451233,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-14T02:10:00.195216Z","caller":"traceutil/trace.go:171","msg":"trace[1904915530] transaction","detail":"{read_only:false; response_revision:5199; number_of_response:1; }","duration":"304.151247ms","start":"2026-04-14T02:09:59.891052Z","end":"2026-04-14T02:10:00.195203Z","steps":["trace[1904915530] 'process raft request' (duration: 303.551365ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:10:00.195335Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:09:59.891035Z","time spent":"304.240379ms","remote":"127.0.0.1:34656","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":766,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-14T02:10:00.195392Z","caller":"traceutil/trace.go:171","msg":"trace[1259948407] transaction","detail":"{read_only:false; response_revision:5200; number_of_response:1; }","duration":"244.344174ms","start":"2026-04-14T02:09:59.951031Z","end":"2026-04-14T02:10:00.195375Z","steps":["trace[1259948407] 'process raft request' (duration: 243.926995ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:10:00.195708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"358.98375ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T02:10:00.195753Z","caller":"traceutil/trace.go:171","msg":"trace[1171921280] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5200; }","duration":"359.073442ms","start":"2026-04-14T02:09:59.836669Z","end":"2026-04-14T02:10:00.195743Z","steps":["trace[1171921280] 'agreement among raft nodes before linearized reading' (duration: 358.103012ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:10:00.195781Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:09:59.836655Z","time spent":"359.119023ms","remote":"127.0.0.1:34554","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":26,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-14T02:10:00.196163Z","caller":"traceutil/trace.go:171","msg":"trace[302196625] transaction","detail":"{read_only:false; response_revision:5201; number_of_response:1; }","duration":"205.452821ms","start":"2026-04-14T02:09:59.990699Z","end":"2026-04-14T02:10:00.196151Z","steps":["trace[302196625] 'process raft request' (duration: 204.589624ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:10:00.196297Z","caller":"traceutil/trace.go:171","msg":"trace[991534208] transaction","detail":"{read_only:false; response_revision:5202; number_of_response:1; }","duration":"155.433856ms","start":"2026-04-14T02:10:00.040855Z","end":"2026-04-14T02:10:00.196289Z","steps":["trace[991534208] 'process raft request' (duration: 155.069509ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:10:00.196419Z","caller":"traceutil/trace.go:171","msg":"trace[161632925] transaction","detail":"{read_only:false; response_revision:5203; number_of_response:1; }","duration":"104.516161ms","start":"2026-04-14T02:10:00.091892Z","end":"2026-04-14T02:10:00.196408Z","steps":["trace[161632925] 'process raft request' (duration: 104.075622ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:10:00.206495Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.932416ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"} {"level":"info","ts":"2026-04-14T02:10:00.206608Z","caller":"traceutil/trace.go:171","msg":"trace[1110785783] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5206; }","duration":"168.10737ms","start":"2026-04-14T02:10:00.038488Z","end":"2026-04-14T02:10:00.206595Z","steps":["trace[1110785783] 'agreement among raft nodes before linearized reading' (duration: 167.782094ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:10:00.206748Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"344.418437ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/keystone-db-sync\" ","response":"range_response_count:1 size:8242"} {"level":"info","ts":"2026-04-14T02:10:00.206762Z","caller":"traceutil/trace.go:171","msg":"trace[1933498126] range","detail":"{range_begin:/registry/jobs/openstack/keystone-db-sync; range_end:; response_count:1; response_revision:5206; }","duration":"344.451557ms","start":"2026-04-14T02:09:59.862306Z","end":"2026-04-14T02:10:00.206757Z","steps":["trace[1933498126] 'agreement among raft nodes before linearized reading' (duration: 344.398826ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:10:00.206777Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:09:59.862296Z","time spent":"344.477168ms","remote":"127.0.0.1:34864","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":8263,"request content":"key:\"/registry/jobs/openstack/keystone-db-sync\" "} {"level":"warn","ts":"2026-04-14T02:10:00.206877Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"366.046652ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/alertmanager-tls.18a61730341dc2c6\" ","response":"range_response_count:1 size:801"} {"level":"info","ts":"2026-04-14T02:10:00.206893Z","caller":"traceutil/trace.go:171","msg":"trace[1871300148] range","detail":"{range_begin:/registry/events/monitoring/alertmanager-tls.18a61730341dc2c6; range_end:; response_count:1; response_revision:5206; }","duration":"366.071433ms","start":"2026-04-14T02:09:59.840814Z","end":"2026-04-14T02:10:00.206886Z","steps":["trace[1871300148] 'agreement among raft nodes before linearized reading' (duration: 366.032002ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:10:00.206905Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:09:59.84081Z","time spent":"366.092133ms","remote":"127.0.0.1:34656","response type":"/etcdserverpb.KV/Range","request count":0,"request size":63,"response count":1,"response size":822,"request content":"key:\"/registry/events/monitoring/alertmanager-tls.18a61730341dc2c6\" "} {"level":"warn","ts":"2026-04-14T02:10:01.405206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.463864ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-14T02:10:01.405326Z","caller":"traceutil/trace.go:171","msg":"trace[149466325] transaction","detail":"{read_only:false; response_revision:5250; number_of_response:1; }","duration":"184.414145ms","start":"2026-04-14T02:10:01.220885Z","end":"2026-04-14T02:10:01.4053Z","steps":["trace[149466325] 'process raft request' (duration: 29.790518ms)","trace[149466325] 'compare' (duration: 154.026715ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T02:10:01.405664Z","caller":"traceutil/trace.go:171","msg":"trace[918466402] transaction","detail":"{read_only:false; response_revision:5251; number_of_response:1; }","duration":"143.81497ms","start":"2026-04-14T02:10:01.261831Z","end":"2026-04-14T02:10:01.405646Z","steps":["trace[918466402] 'process raft request' (duration: 143.482134ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:10:01.406012Z","caller":"traceutil/trace.go:171","msg":"trace[538910857] linearizableReadLoop","detail":"{readStateIndex:5448; appliedIndex:5447; }","duration":"184.66307ms","start":"2026-04-14T02:10:01.221335Z","end":"2026-04-14T02:10:01.405998Z","steps":["trace[538910857] 'read index received' (duration: 29.255637ms)","trace[538910857] 'applied index is now lower than readState.Index' (duration: 155.211489ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T02:10:01.406129Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.774423ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T02:10:01.406168Z","caller":"traceutil/trace.go:171","msg":"trace[932981972] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:5251; }","duration":"184.869505ms","start":"2026-04-14T02:10:01.22129Z","end":"2026-04-14T02:10:01.406159Z","steps":["trace[932981972] 'agreement among raft nodes before linearized reading' (duration: 184.779753ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:10:01.406793Z","caller":"traceutil/trace.go:171","msg":"trace[1114515909] transaction","detail":"{read_only:false; response_revision:5253; number_of_response:1; }","duration":"100.735524ms","start":"2026-04-14T02:10:01.306048Z","end":"2026-04-14T02:10:01.406784Z","steps":["trace[1114515909] 'process raft request' (duration: 100.53878ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:10:01.40745Z","caller":"traceutil/trace.go:171","msg":"trace[1218131885] transaction","detail":"{read_only:false; response_revision:5252; number_of_response:1; }","duration":"125.055053ms","start":"2026-04-14T02:10:01.282386Z","end":"2026-04-14T02:10:01.407442Z","steps":["trace[1218131885] 'process raft request' (duration: 124.120255ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:10:01.418009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.164197ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T02:10:01.418089Z","caller":"traceutil/trace.go:171","msg":"trace[1835899019] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:5254; }","duration":"139.3138ms","start":"2026-04-14T02:10:01.278755Z","end":"2026-04-14T02:10:01.418069Z","steps":["trace[1835899019] 'agreement among raft nodes before linearized reading' (duration: 139.168667ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:10:02.372186Z","caller":"traceutil/trace.go:171","msg":"trace[731643929] linearizableReadLoop","detail":"{readStateIndex:5500; appliedIndex:5497; }","duration":"163.86985ms","start":"2026-04-14T02:10:02.208292Z","end":"2026-04-14T02:10:02.372162Z","steps":["trace[731643929] 'read index received' (duration: 98.401026ms)","trace[731643929] 'applied index is now lower than readState.Index' (duration: 65.467714ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T02:10:02.372352Z","caller":"traceutil/trace.go:171","msg":"trace[465777429] transaction","detail":"{read_only:false; response_revision:5300; number_of_response:1; }","duration":"165.838761ms","start":"2026-04-14T02:10:02.206482Z","end":"2026-04-14T02:10:02.372321Z","steps":["trace[465777429] 'process raft request' (duration: 165.570645ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:10:02.372567Z","caller":"traceutil/trace.go:171","msg":"trace[1257576609] transaction","detail":"{read_only:false; response_revision:5298; number_of_response:1; }","duration":"170.230838ms","start":"2026-04-14T02:10:02.202328Z","end":"2026-04-14T02:10:02.372559Z","steps":["trace[1257576609] 'process raft request' (duration: 104.393306ms)","trace[1257576609] 'compare' (duration: 64.989955ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T02:10:02.372583Z","caller":"traceutil/trace.go:171","msg":"trace[199032242] transaction","detail":"{read_only:false; response_revision:5301; number_of_response:1; }","duration":"160.983502ms","start":"2026-04-14T02:10:02.211574Z","end":"2026-04-14T02:10:02.372557Z","steps":["trace[199032242] 'process raft request' (duration: 160.537643ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:10:02.372768Z","caller":"traceutil/trace.go:171","msg":"trace[1380653720] transaction","detail":"{read_only:false; response_revision:5299; number_of_response:1; }","duration":"166.499073ms","start":"2026-04-14T02:10:02.206261Z","end":"2026-04-14T02:10:02.372761Z","steps":["trace[1380653720] 'process raft request' (duration: 165.712818ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:10:02.37291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.596346ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config\" ","response":"range_response_count:1 size:708"} {"level":"info","ts":"2026-04-14T02:10:02.372962Z","caller":"traceutil/trace.go:171","msg":"trace[1894890344] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config; range_end:; response_count:1; response_revision:5301; }","duration":"164.672337ms","start":"2026-04-14T02:10:02.208273Z","end":"2026-04-14T02:10:02.372945Z","steps":["trace[1894890344] 'agreement among raft nodes before linearized reading' (duration: 164.503324ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:10:02.373182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.3337ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/keystone-db-sync\" ","response":"range_response_count:1 size:8242"} {"level":"info","ts":"2026-04-14T02:10:02.373211Z","caller":"traceutil/trace.go:171","msg":"trace[1156086879] range","detail":"{range_begin:/registry/jobs/openstack/keystone-db-sync; range_end:; response_count:1; response_revision:5301; }","duration":"154.410241ms","start":"2026-04-14T02:10:02.218792Z","end":"2026-04-14T02:10:02.373202Z","steps":["trace[1156086879] 'agreement among raft nodes before linearized reading' (duration: 154.320729ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:10:02.374321Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.337259ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T02:10:02.374353Z","caller":"traceutil/trace.go:171","msg":"trace[415931530] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:0; response_revision:5301; }","duration":"139.44252ms","start":"2026-04-14T02:10:02.234901Z","end":"2026-04-14T02:10:02.374343Z","steps":["trace[415931530] 'agreement among raft nodes before linearized reading' (duration: 139.401859ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:10:04.366379Z","caller":"traceutil/trace.go:171","msg":"trace[446258992] linearizableReadLoop","detail":"{readStateIndex:5556; appliedIndex:5555; }","duration":"115.371184ms","start":"2026-04-14T02:10:04.250981Z","end":"2026-04-14T02:10:04.366352Z","steps":["trace[446258992] 'read index received' (duration: 73.923113ms)","trace[446258992] 'applied index is now lower than readState.Index' (duration: 41.446991ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T02:10:04.366535Z","caller":"traceutil/trace.go:171","msg":"trace[505954505] transaction","detail":"{read_only:false; response_revision:5355; number_of_response:1; }","duration":"133.745853ms","start":"2026-04-14T02:10:04.23274Z","end":"2026-04-14T02:10:04.366486Z","steps":["trace[505954505] 'process raft request' (duration: 92.173049ms)","trace[505954505] 'compare' (duration: 41.301118ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T02:10:04.366573Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.978206ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-14T02:10:04.366714Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.701171ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-8164e26d-fcb4-4874-94e0-b9313a435fd5\" ","response":"range_response_count:1 size:3760"} {"level":"info","ts":"2026-04-14T02:10:04.366771Z","caller":"traceutil/trace.go:171","msg":"trace[1980248689] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:5355; }","duration":"105.146559ms","start":"2026-04-14T02:10:04.261531Z","end":"2026-04-14T02:10:04.366677Z","steps":["trace[1980248689] 'agreement among raft nodes before linearized reading' (duration: 104.980505ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:10:04.36682Z","caller":"traceutil/trace.go:171","msg":"trace[803849559] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-8164e26d-fcb4-4874-94e0-b9313a435fd5; range_end:; response_count:1; response_revision:5355; }","duration":"115.841584ms","start":"2026-04-14T02:10:04.250945Z","end":"2026-04-14T02:10:04.366787Z","steps":["trace[803849559] 'agreement among raft nodes before linearized reading' (duration: 115.555048ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:10:07.140344Z","caller":"traceutil/trace.go:171","msg":"trace[1927685652] transaction","detail":"{read_only:false; response_revision:5430; number_of_response:1; }","duration":"173.31467ms","start":"2026-04-14T02:10:06.966946Z","end":"2026-04-14T02:10:07.14026Z","steps":["trace[1927685652] 'process raft request' (duration: 172.929472ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:10:08.885173Z","caller":"traceutil/trace.go:171","msg":"trace[843075571] transaction","detail":"{read_only:false; response_revision:5502; number_of_response:1; }","duration":"110.320338ms","start":"2026-04-14T02:10:08.774829Z","end":"2026-04-14T02:10:08.885149Z","steps":["trace[843075571] 'process raft request' (duration: 109.954571ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:10:09.951054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.139943ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-14T02:10:09.951119Z","caller":"traceutil/trace.go:171","msg":"trace[596205141] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5515; }","duration":"229.251995ms","start":"2026-04-14T02:10:09.721852Z","end":"2026-04-14T02:10:09.951104Z","steps":["trace[596205141] 'range keys from in-memory index tree' (duration: 228.99146ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:10:09.951296Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.402348ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-04-14T02:10:09.951321Z","caller":"traceutil/trace.go:171","msg":"trace[914009843] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5515; }","duration":"229.451889ms","start":"2026-04-14T02:10:09.721862Z","end":"2026-04-14T02:10:09.951314Z","steps":["trace[914009843] 'range keys from in-memory index tree' (duration: 229.302506ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:10:09.951413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.123142ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T02:10:09.951436Z","caller":"traceutil/trace.go:171","msg":"trace[787650853] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5515; }","duration":"109.172724ms","start":"2026-04-14T02:10:09.842258Z","end":"2026-04-14T02:10:09.951431Z","steps":["trace[787650853] 'range keys from in-memory index tree' (duration: 109.073031ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:10:10.687158Z","caller":"traceutil/trace.go:171","msg":"trace[254923263] linearizableReadLoop","detail":"{readStateIndex:5730; appliedIndex:5728; }","duration":"152.980328ms","start":"2026-04-14T02:10:10.534154Z","end":"2026-04-14T02:10:10.687134Z","steps":["trace[254923263] 'read index received' (duration: 77.661083ms)","trace[254923263] 'applied index is now lower than readState.Index' (duration: 75.318185ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T02:10:10.687328Z","caller":"traceutil/trace.go:171","msg":"trace[1326563938] transaction","detail":"{read_only:false; response_revision:5523; number_of_response:1; }","duration":"173.429917ms","start":"2026-04-14T02:10:10.51386Z","end":"2026-04-14T02:10:10.68729Z","steps":["trace[1326563938] 'process raft request' (duration: 97.979749ms)","trace[1326563938] 'compare' (duration: 75.088241ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T02:10:10.687398Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.220923ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:11071"} {"level":"info","ts":"2026-04-14T02:10:10.687441Z","caller":"traceutil/trace.go:171","msg":"trace[878072274] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:5524; }","duration":"153.308964ms","start":"2026-04-14T02:10:10.534122Z","end":"2026-04-14T02:10:10.687431Z","steps":["trace[878072274] 'agreement among raft nodes before linearized reading' (duration: 153.11156ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:10:10.687751Z","caller":"traceutil/trace.go:171","msg":"trace[1629670495] transaction","detail":"{read_only:false; response_revision:5524; number_of_response:1; }","duration":"169.09767ms","start":"2026-04-14T02:10:10.518633Z","end":"2026-04-14T02:10:10.68773Z","steps":["trace[1629670495] 'process raft request' (duration: 168.438387ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:10:14.917576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.481967ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-04-14T02:10:14.917665Z","caller":"traceutil/trace.go:171","msg":"trace[445103126] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5569; }","duration":"217.654721ms","start":"2026-04-14T02:10:14.699992Z","end":"2026-04-14T02:10:14.917647Z","steps":["trace[445103126] 'range keys from in-memory index tree' (duration: 217.253603ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:10:15.219684Z","caller":"traceutil/trace.go:171","msg":"trace[1343757687] transaction","detail":"{read_only:false; response_revision:5573; number_of_response:1; }","duration":"103.724298ms","start":"2026-04-14T02:10:15.115924Z","end":"2026-04-14T02:10:15.219648Z","steps":["trace[1343757687] 'process raft request' (duration: 103.587405ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:10:15.489742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.442493ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-14T02:10:15.48986Z","caller":"traceutil/trace.go:171","msg":"trace[799881198] linearizableReadLoop","detail":"{readStateIndex:5781; appliedIndex:5780; }","duration":"241.421452ms","start":"2026-04-14T02:10:15.248421Z","end":"2026-04-14T02:10:15.489842Z","steps":["trace[799881198] 'read index received' (duration: 11.775025ms)","trace[799881198] 'applied index is now lower than readState.Index' (duration: 229.645177ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T02:10:15.489875Z","caller":"traceutil/trace.go:171","msg":"trace[634796347] transaction","detail":"{read_only:false; response_revision:5574; number_of_response:1; }","duration":"259.775337ms","start":"2026-04-14T02:10:15.230071Z","end":"2026-04-14T02:10:15.489846Z","steps":["trace[634796347] 'process raft request' (duration: 30.14118ms)","trace[634796347] 'compare' (duration: 228.702788ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T02:10:15.490093Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.678276ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-04-14T02:10:15.490096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.074142ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:12975"} {"level":"info","ts":"2026-04-14T02:10:15.490129Z","caller":"traceutil/trace.go:171","msg":"trace[611007930] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5574; }","duration":"241.751518ms","start":"2026-04-14T02:10:15.248367Z","end":"2026-04-14T02:10:15.490118Z","steps":["trace[611007930] 'agreement among raft nodes before linearized reading' (duration: 241.598875ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:10:15.49015Z","caller":"traceutil/trace.go:171","msg":"trace[749367517] range","detail":"{range_begin:/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:5574; }","duration":"135.161765ms","start":"2026-04-14T02:10:15.354972Z","end":"2026-04-14T02:10:15.490134Z","steps":["trace[749367517] 'agreement among raft nodes before linearized reading' (duration: 135.017522ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:10:15.490191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.456612ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"} {"level":"info","ts":"2026-04-14T02:10:15.490272Z","caller":"traceutil/trace.go:171","msg":"trace[1645571934] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:5574; }","duration":"112.543954ms","start":"2026-04-14T02:10:15.377704Z","end":"2026-04-14T02:10:15.490247Z","steps":["trace[1645571934] 'agreement among raft nodes before linearized reading' (duration: 112.321239ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:10:15.490373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.45219ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-grafana-6fbcd76cd7-hrp75.18a61733cfee3460\" ","response":"range_response_count:1 size:896"} {"level":"info","ts":"2026-04-14T02:10:15.490415Z","caller":"traceutil/trace.go:171","msg":"trace[1062230922] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-grafana-6fbcd76cd7-hrp75.18a61733cfee3460; range_end:; response_count:1; response_revision:5574; }","duration":"134.518341ms","start":"2026-04-14T02:10:15.355884Z","end":"2026-04-14T02:10:15.490402Z","steps":["trace[1062230922] 'agreement among raft nodes before linearized reading' (duration: 134.352128ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:10:15.747109Z","caller":"traceutil/trace.go:171","msg":"trace[563189534] transaction","detail":"{read_only:false; response_revision:5584; number_of_response:1; }","duration":"110.196976ms","start":"2026-04-14T02:10:15.636879Z","end":"2026-04-14T02:10:15.747076Z","steps":["trace[563189534] 'process raft request' (duration: 108.823759ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:10:15.750436Z","caller":"traceutil/trace.go:171","msg":"trace[1670531473] transaction","detail":"{read_only:false; response_revision:5585; number_of_response:1; }","duration":"113.518503ms","start":"2026-04-14T02:10:15.636888Z","end":"2026-04-14T02:10:15.750406Z","steps":["trace[1670531473] 'process raft request' (duration: 113.207887ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:10:15.750794Z","caller":"traceutil/trace.go:171","msg":"trace[1344402319] linearizableReadLoop","detail":"{readStateIndex:5796; appliedIndex:5790; }","duration":"103.755578ms","start":"2026-04-14T02:10:15.647022Z","end":"2026-04-14T02:10:15.750777Z","steps":["trace[1344402319] 'read index received' (duration: 98.942092ms)","trace[1344402319] 'applied index is now lower than readState.Index' (duration: 4.810716ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T02:10:15.750869Z","caller":"traceutil/trace.go:171","msg":"trace[303427705] transaction","detail":"{read_only:false; response_revision:5586; number_of_response:1; }","duration":"113.570094ms","start":"2026-04-14T02:10:15.636975Z","end":"2026-04-14T02:10:15.750545Z","steps":["trace[303427705] 'process raft request' (duration: 113.319839ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:10:15.750911Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.867181ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/vhosts/\" range_end:\"/registry/rabbitmq.com/vhosts0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T02:10:15.751173Z","caller":"traceutil/trace.go:171","msg":"trace[746258605] range","detail":"{range_begin:/registry/rabbitmq.com/vhosts/; range_end:/registry/rabbitmq.com/vhosts0; response_count:0; response_revision:5589; }","duration":"104.143647ms","start":"2026-04-14T02:10:15.64699Z","end":"2026-04-14T02:10:15.751134Z","steps":["trace[746258605] 'agreement among raft nodes before linearized reading' (duration: 103.871251ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:10:15.750949Z","caller":"traceutil/trace.go:171","msg":"trace[1064910693] transaction","detail":"{read_only:false; response_revision:5588; number_of_response:1; }","duration":"112.645906ms","start":"2026-04-14T02:10:15.638293Z","end":"2026-04-14T02:10:15.750939Z","steps":["trace[1064910693] 'process raft request' (duration: 112.317199ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:10:15.7511Z","caller":"traceutil/trace.go:171","msg":"trace[573238548] transaction","detail":"{read_only:false; response_revision:5589; number_of_response:1; }","duration":"108.652156ms","start":"2026-04-14T02:10:15.642331Z","end":"2026-04-14T02:10:15.750983Z","steps":["trace[573238548] 'process raft request' (duration: 108.39185ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:10:15.751066Z","caller":"traceutil/trace.go:171","msg":"trace[355797782] transaction","detail":"{read_only:false; response_revision:5587; number_of_response:1; }","duration":"113.521253ms","start":"2026-04-14T02:10:15.637427Z","end":"2026-04-14T02:10:15.750948Z","steps":["trace[355797782] 'process raft request' (duration: 113.000282ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:10:18.12293Z","caller":"traceutil/trace.go:171","msg":"trace[1148071462] transaction","detail":"{read_only:false; response_revision:5604; number_of_response:1; }","duration":"365.232801ms","start":"2026-04-14T02:10:17.757668Z","end":"2026-04-14T02:10:18.122901Z","steps":["trace[1148071462] 'process raft request' (duration: 355.280413ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:10:18.123245Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:10:17.757639Z","time spent":"365.525877ms","remote":"127.0.0.1:34892","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-14T02:10:18.124474Z","caller":"traceutil/trace.go:171","msg":"trace[1828870616] linearizableReadLoop","detail":"{readStateIndex:5812; appliedIndex:5810; }","duration":"328.824266ms","start":"2026-04-14T02:10:17.795624Z","end":"2026-04-14T02:10:18.124448Z","steps":["trace[1828870616] 'read index received' (duration: 317.337377ms)","trace[1828870616] 'applied index is now lower than readState.Index' (duration: 11.485489ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T02:10:18.124568Z","caller":"traceutil/trace.go:171","msg":"trace[1706795821] transaction","detail":"{read_only:false; response_revision:5605; number_of_response:1; }","duration":"366.639078ms","start":"2026-04-14T02:10:17.757898Z","end":"2026-04-14T02:10:18.124537Z","steps":["trace[1706795821] 'process raft request' (duration: 366.387063ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:10:18.124701Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:10:17.757875Z","time spent":"366.754931ms","remote":"127.0.0.1:34892","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-14T02:10:18.12474Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.105891ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/keystone-api\" ","response":"range_response_count:1 size:675"} {"level":"warn","ts":"2026-04-14T02:10:18.124741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.410971ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T02:10:18.124777Z","caller":"traceutil/trace.go:171","msg":"trace[1755121232] range","detail":"{range_begin:/registry/services/endpoints/openstack/keystone-api; range_end:; response_count:1; response_revision:5605; }","duration":"329.185303ms","start":"2026-04-14T02:10:17.795581Z","end":"2026-04-14T02:10:18.124766Z","steps":["trace[1755121232] 'agreement among raft nodes before linearized reading' (duration: 329.009ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:10:18.124791Z","caller":"traceutil/trace.go:171","msg":"trace[1923118042] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5605; }","duration":"286.464342ms","start":"2026-04-14T02:10:17.838313Z","end":"2026-04-14T02:10:18.124777Z","steps":["trace[1923118042] 'agreement among raft nodes before linearized reading' (duration: 286.386581ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:10:18.124813Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:10:17.795569Z","time spent":"329.235854ms","remote":"127.0.0.1:34778","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":1,"response size":696,"request content":"key:\"/registry/services/endpoints/openstack/keystone-api\" "} {"level":"warn","ts":"2026-04-14T02:10:18.125073Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.971217ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-14T02:10:18.12511Z","caller":"traceutil/trace.go:171","msg":"trace[1189848463] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5605; }","duration":"123.041028ms","start":"2026-04-14T02:10:18.002058Z","end":"2026-04-14T02:10:18.125099Z","steps":["trace[1189848463] 'agreement among raft nodes before linearized reading' (duration: 122.910775ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:10:18.125295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.421687ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-14T02:10:18.125329Z","caller":"traceutil/trace.go:171","msg":"trace[488243144] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5605; }","duration":"105.456858ms","start":"2026-04-14T02:10:18.019863Z","end":"2026-04-14T02:10:18.12532Z","steps":["trace[488243144] 'agreement among raft nodes before linearized reading' (duration: 105.369406ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:10:21.119648Z","caller":"traceutil/trace.go:171","msg":"trace[781291685] transaction","detail":"{read_only:false; response_revision:5636; number_of_response:1; }","duration":"150.900079ms","start":"2026-04-14T02:10:20.968722Z","end":"2026-04-14T02:10:21.119623Z","steps":["trace[781291685] 'process raft request' (duration: 150.679914ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:10:23.53832Z","caller":"traceutil/trace.go:171","msg":"trace[1647243930] transaction","detail":"{read_only:false; response_revision:5654; number_of_response:1; }","duration":"411.5775ms","start":"2026-04-14T02:10:23.126716Z","end":"2026-04-14T02:10:23.538293Z","steps":["trace[1647243930] 'process raft request' (duration: 411.367485ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:10:23.538486Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:10:23.126696Z","time spent":"411.704572ms","remote":"127.0.0.1:34892","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-14T02:10:23.876559Z","caller":"traceutil/trace.go:171","msg":"trace[2012673226] transaction","detail":"{read_only:false; response_revision:5655; number_of_response:1; }","duration":"360.839333ms","start":"2026-04-14T02:10:23.515689Z","end":"2026-04-14T02:10:23.876528Z","steps":["trace[2012673226] 'process raft request' (duration: 282.242133ms)","trace[2012673226] 'compare' (duration: 78.271433ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T02:10:23.877019Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:10:23.515656Z","time spent":"360.972206ms","remote":"127.0.0.1:34892","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-14T02:10:23.908748Z","caller":"traceutil/trace.go:171","msg":"trace[825373691] linearizableReadLoop","detail":"{readStateIndex:5865; appliedIndex:5863; }","duration":"317.005203ms","start":"2026-04-14T02:10:23.591724Z","end":"2026-04-14T02:10:23.908729Z","steps":["trace[825373691] 'read index received' (duration: 206.222554ms)","trace[825373691] 'applied index is now lower than readState.Index' (duration: 110.778259ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T02:10:23.90881Z","caller":"traceutil/trace.go:171","msg":"trace[662032874] transaction","detail":"{read_only:false; response_revision:5656; number_of_response:1; }","duration":"321.89429ms","start":"2026-04-14T02:10:23.58688Z","end":"2026-04-14T02:10:23.908775Z","steps":["trace[662032874] 'process raft request' (duration: 321.755037ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:10:23.909001Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:10:23.586848Z","time spent":"322.034313ms","remote":"127.0.0.1:34892","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-14T02:10:23.909489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.153195ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-14T02:10:23.909534Z","caller":"traceutil/trace.go:171","msg":"trace[617624716] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5656; }","duration":"317.853549ms","start":"2026-04-14T02:10:23.59167Z","end":"2026-04-14T02:10:23.909523Z","steps":["trace[617624716] 'agreement among raft nodes before linearized reading' (duration: 317.125865ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:10:23.909569Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:10:23.59165Z","time spent":"317.91038ms","remote":"127.0.0.1:34892","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-14T02:10:25.247806Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2878} {"level":"info","ts":"2026-04-14T02:10:25.361297Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2878,"took":"111.795937ms","hash":2656411712,"current-db-size-bytes":54222848,"current-db-size":"54 MB","current-db-size-in-use-bytes":30822400,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-04-14T02:10:25.361346Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2656411712,"revision":2878,"compact-revision":-1} {"level":"info","ts":"2026-04-14T02:10:26.789858Z","caller":"traceutil/trace.go:171","msg":"trace[1976826083] transaction","detail":"{read_only:false; response_revision:5717; number_of_response:1; }","duration":"136.096858ms","start":"2026-04-14T02:10:26.653723Z","end":"2026-04-14T02:10:26.78982Z","steps":["trace[1976826083] 'process raft request' (duration: 117.53014ms)","trace[1976826083] 'compare' (duration: 18.294202ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T02:11:59.512406Z","caller":"traceutil/trace.go:171","msg":"trace[990513531] linearizableReadLoop","detail":"{readStateIndex:6527; appliedIndex:6526; }","duration":"132.655871ms","start":"2026-04-14T02:11:59.379721Z","end":"2026-04-14T02:11:59.512376Z","steps":["trace[990513531] 'read index received' (duration: 132.440177ms)","trace[990513531] 'applied index is now lower than readState.Index' (duration: 213.774µs)"],"step_count":2} {"level":"info","ts":"2026-04-14T02:11:59.512457Z","caller":"traceutil/trace.go:171","msg":"trace[164290857] transaction","detail":"{read_only:false; response_revision:6291; number_of_response:1; }","duration":"240.744003ms","start":"2026-04-14T02:11:59.271691Z","end":"2026-04-14T02:11:59.512435Z","steps":["trace[164290857] 'process raft request' (duration: 240.539329ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:11:59.512551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.811314ms","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":"info","ts":"2026-04-14T02:11:59.512612Z","caller":"traceutil/trace.go:171","msg":"trace[1527614805] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:6291; }","duration":"132.923127ms","start":"2026-04-14T02:11:59.37967Z","end":"2026-04-14T02:11:59.512594Z","steps":["trace[1527614805] 'agreement among raft nodes before linearized reading' (duration: 132.820695ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:12:13.753721Z","caller":"traceutil/trace.go:171","msg":"trace[563443715] transaction","detail":"{read_only:false; response_revision:6484; number_of_response:1; }","duration":"185.312199ms","start":"2026-04-14T02:12:13.568385Z","end":"2026-04-14T02:12:13.753697Z","steps":["trace[563443715] 'process raft request' (duration: 185.147326ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:12:25.065597Z","caller":"traceutil/trace.go:171","msg":"trace[1555662595] linearizableReadLoop","detail":"{readStateIndex:6793; appliedIndex:6792; }","duration":"134.122465ms","start":"2026-04-14T02:12:24.931449Z","end":"2026-04-14T02:12:25.065571Z","steps":["trace[1555662595] 'read index received' (duration: 134.004903ms)","trace[1555662595] 'applied index is now lower than readState.Index' (duration: 114.542µs)"],"step_count":2} {"level":"info","ts":"2026-04-14T02:12:25.065658Z","caller":"traceutil/trace.go:171","msg":"trace[2123602232] transaction","detail":"{read_only:false; response_revision:6551; number_of_response:1; }","duration":"215.71375ms","start":"2026-04-14T02:12:24.849905Z","end":"2026-04-14T02:12:25.065619Z","steps":["trace[2123602232] 'process raft request' (duration: 215.522276ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:12:25.06585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.38974ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-04-14T02:12:25.065895Z","caller":"traceutil/trace.go:171","msg":"trace[1719400062] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:6551; }","duration":"134.485942ms","start":"2026-04-14T02:12:24.931396Z","end":"2026-04-14T02:12:25.065882Z","steps":["trace[1719400062] 'agreement among raft nodes before linearized reading' (duration: 134.307888ms)"],"step_count":1}