{"level":"warn","ts":"2026-05-19T19:13:26.739664Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-19T19:13:26.739745Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.223: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.223:2380","--initial-cluster=instance=https://199.204.45.223:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.223:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.223:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-05-19T19:13:26.739814Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-19T19:13:26.739823Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.223:2380"]} {"level":"info","ts":"2026-05-19T19:13:26.73984Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-19T19:13:26.740458Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.223:2379"]} {"level":"info","ts":"2026-05-19T19:13:26.74053Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.223:2380"],"listen-peer-urls":["https://199.204.45.223:2380"],"advertise-client-urls":["https://199.204.45.223:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.223:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.223:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-05-19T19:13:26.744707Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.961304ms"} {"level":"info","ts":"2026-05-19T19:13:26.758463Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"11f26225a5bb9fe3","cluster-id":"75c25101f01fd4c6"} {"level":"info","ts":"2026-05-19T19:13:26.758562Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 switched to configuration voters=()"} {"level":"info","ts":"2026-05-19T19:13:26.758588Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 became follower at term 0"} {"level":"info","ts":"2026-05-19T19:13:26.758606Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 11f26225a5bb9fe3 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-19T19:13:26.758616Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 became follower at term 1"} {"level":"info","ts":"2026-05-19T19:13:26.758707Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 switched to configuration voters=(1293203956842602467)"} {"level":"warn","ts":"2026-05-19T19:13:26.769442Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-19T19:13:26.771Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-19T19:13:26.772171Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-05-19T19:13:26.775387Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"11f26225a5bb9fe3","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-19T19:13:26.775529Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-19T19:13:26.775644Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-19T19:13:26.775657Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-19T19:13:26.775616Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"11f26225a5bb9fe3","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-19T19:13:26.777742Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 switched to configuration voters=(1293203956842602467)"} {"level":"info","ts":"2026-05-19T19:13:26.778441Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"75c25101f01fd4c6","local-member-id":"11f26225a5bb9fe3","added-peer-id":"11f26225a5bb9fe3","added-peer-peer-urls":["https://199.204.45.223:2380"]} {"level":"info","ts":"2026-05-19T19:13:26.782712Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-19T19:13:26.78278Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.223:2380"} {"level":"info","ts":"2026-05-19T19:13:26.782841Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.223:2380"} {"level":"info","ts":"2026-05-19T19:13:26.782989Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"11f26225a5bb9fe3","initial-advertise-peer-urls":["https://199.204.45.223:2380"],"listen-peer-urls":["https://199.204.45.223:2380"],"advertise-client-urls":["https://199.204.45.223:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.223:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-19T19:13:26.783039Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-19T19:13:26.859528Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 is starting a new election at term 1"} {"level":"info","ts":"2026-05-19T19:13:26.859606Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-19T19:13:26.85963Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 received MsgPreVoteResp from 11f26225a5bb9fe3 at term 1"} {"level":"info","ts":"2026-05-19T19:13:26.85965Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 became candidate at term 2"} {"level":"info","ts":"2026-05-19T19:13:26.859662Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 received MsgVoteResp from 11f26225a5bb9fe3 at term 2"} {"level":"info","ts":"2026-05-19T19:13:26.859678Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 became leader at term 2"} {"level":"info","ts":"2026-05-19T19:13:26.859692Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 11f26225a5bb9fe3 elected leader 11f26225a5bb9fe3 at term 2"} {"level":"info","ts":"2026-05-19T19:13:26.860691Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-19T19:13:26.861649Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"11f26225a5bb9fe3","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.223:2379]}","request-path":"/0/members/11f26225a5bb9fe3/attributes","cluster-id":"75c25101f01fd4c6","publish-timeout":"7s"} {"level":"info","ts":"2026-05-19T19:13:26.861831Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-19T19:13:26.861882Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-19T19:13:26.862092Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"75c25101f01fd4c6","local-member-id":"11f26225a5bb9fe3","cluster-version":"3.5"} {"level":"info","ts":"2026-05-19T19:13:26.862226Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-19T19:13:26.862282Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-19T19:13:26.862609Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-19T19:13:26.862656Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-19T19:13:26.865797Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-19T19:13:26.865784Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.223:2379"} {"level":"info","ts":"2026-05-19T19:13:30.115048Z","caller":"traceutil/trace.go:171","msg":"trace[220711426] transaction","detail":"{read_only:false; response_revision:85; number_of_response:1; }","duration":"102.670272ms","start":"2026-05-19T19:13:30.012351Z","end":"2026-05-19T19:13:30.115021Z","steps":["trace[220711426] 'process raft request' (duration: 102.554729ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:13:30.412565Z","caller":"traceutil/trace.go:171","msg":"trace[140170020] transaction","detail":"{read_only:false; response_revision:86; number_of_response:1; }","duration":"294.553146ms","start":"2026-05-19T19:13:30.117979Z","end":"2026-05-19T19:13:30.412533Z","steps":["trace[140170020] 'process raft request' (duration: 198.672435ms)","trace[140170020] 'compare' (duration: 95.745377ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T19:13:30.599287Z","caller":"traceutil/trace.go:171","msg":"trace[686639575] transaction","detail":"{read_only:false; response_revision:90; number_of_response:1; }","duration":"108.738887ms","start":"2026-05-19T19:13:30.490517Z","end":"2026-05-19T19:13:30.599256Z","steps":["trace[686639575] 'process raft request' (duration: 74.345489ms)","trace[686639575] 'compare' (duration: 34.255764ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T19:13:41.758716Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11521226276576881297,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-19T19:13:41.854272Z","caller":"traceutil/trace.go:171","msg":"trace[1611314900] transaction","detail":"{read_only:false; response_revision:406; number_of_response:1; }","duration":"908.110039ms","start":"2026-05-19T19:13:40.946138Z","end":"2026-05-19T19:13:41.854248Z","steps":["trace[1611314900] 'process raft request' (duration: 907.950596ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:13:41.854866Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:13:40.946118Z","time spent":"908.225832ms","remote":"127.0.0.1:49458","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T19:13:41.856144Z","caller":"traceutil/trace.go:171","msg":"trace[1856380372] linearizableReadLoop","detail":"{readStateIndex:423; appliedIndex:421; }","duration":"597.449771ms","start":"2026-05-19T19:13:41.258666Z","end":"2026-05-19T19:13:41.856116Z","steps":["trace[1856380372] 'read index received' (duration: 595.352701ms)","trace[1856380372] 'applied index is now lower than readState.Index' (duration: 2.09612ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T19:13:41.856207Z","caller":"traceutil/trace.go:171","msg":"trace[1602618843] transaction","detail":"{read_only:false; response_revision:407; number_of_response:1; }","duration":"909.964883ms","start":"2026-05-19T19:13:40.946216Z","end":"2026-05-19T19:13:41.856181Z","steps":["trace[1602618843] 'process raft request' (duration: 909.786499ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:13:41.856302Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"597.615964ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.223\" ","response":"range_response_count:1 size:135"} {"level":"warn","ts":"2026-05-19T19:13:41.856363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"433.06693ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-19T19:13:41.85639Z","caller":"traceutil/trace.go:171","msg":"trace[300447650] range","detail":"{range_begin:/registry/masterleases/199.204.45.223; range_end:; response_count:1; response_revision:407; }","duration":"597.722697ms","start":"2026-05-19T19:13:41.258651Z","end":"2026-05-19T19:13:41.856374Z","steps":["trace[300447650] 'agreement among raft nodes before linearized reading' (duration: 597.586894ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:13:41.856429Z","caller":"traceutil/trace.go:171","msg":"trace[1026485139] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:407; }","duration":"433.154353ms","start":"2026-05-19T19:13:41.423256Z","end":"2026-05-19T19:13:41.85641Z","steps":["trace[1026485139] 'agreement among raft nodes before linearized reading' (duration: 433.04032ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:13:41.856441Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:13:41.258595Z","time spent":"597.832669ms","remote":"127.0.0.1:43628","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.204.45.223\" "} {"level":"warn","ts":"2026-05-19T19:13:41.856456Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:13:40.946184Z","time spent":"910.084886ms","remote":"127.0.0.1:49458","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T19:13:41.856473Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:13:41.42324Z","time spent":"433.221564ms","remote":"127.0.0.1:49458","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-05-19T19:13:52.670081Z","caller":"traceutil/trace.go:171","msg":"trace[1075021184] transaction","detail":"{read_only:false; response_revision:469; number_of_response:1; }","duration":"305.352139ms","start":"2026-05-19T19:13:52.364667Z","end":"2026-05-19T19:13:52.670019Z","steps":["trace[1075021184] 'process raft request' (duration: 305.200525ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:13:52.670255Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:13:52.364651Z","time spent":"305.527333ms","remote":"127.0.0.1:49458","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T19:13:53.008059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.46576ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T19:13:53.008152Z","caller":"traceutil/trace.go:171","msg":"trace[1165888480] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:469; }","duration":"219.631084ms","start":"2026-05-19T19:13:52.788501Z","end":"2026-05-19T19:13:53.008132Z","steps":["trace[1165888480] 'range keys from in-memory index tree' (duration: 219.347998ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:13:58.306498Z","caller":"traceutil/trace.go:171","msg":"trace[1461020064] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"371.372091ms","start":"2026-05-19T19:13:57.935099Z","end":"2026-05-19T19:13:58.306471Z","steps":["trace[1461020064] 'process raft request' (duration: 371.187236ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:13:58.306647Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:13:57.935082Z","time spent":"371.493864ms","remote":"127.0.0.1:49458","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T19:13:58.973759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.531595ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-19T19:13:58.973911Z","caller":"traceutil/trace.go:171","msg":"trace[1195620238] linearizableReadLoop","detail":"{readStateIndex:536; appliedIndex:533; }","duration":"910.463421ms","start":"2026-05-19T19:13:58.063433Z","end":"2026-05-19T19:13:58.973896Z","steps":["trace[1195620238] 'read index received' (duration: 242.871701ms)","trace[1195620238] 'applied index is now lower than readState.Index' (duration: 667.59073ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T19:13:58.973951Z","caller":"traceutil/trace.go:171","msg":"trace[1436798029] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"1.03725682s","start":"2026-05-19T19:13:57.936679Z","end":"2026-05-19T19:13:58.973936Z","steps":["trace[1436798029] 'process raft request' (duration: 1.037167128s)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:13:58.973947Z","caller":"traceutil/trace.go:171","msg":"trace[740033077] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"1.037509377s","start":"2026-05-19T19:13:57.9364Z","end":"2026-05-19T19:13:58.973909Z","steps":["trace[740033077] 'process raft request' (duration: 849.602033ms)","trace[740033077] 'compare' (duration: 187.423112ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T19:13:58.974022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.409549ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-05-19T19:13:58.974031Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:13:57.936635Z","time spent":"1.037351843s","remote":"127.0.0.1:49458","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T19:13:58.974099Z","caller":"traceutil/trace.go:171","msg":"trace[315860535] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:515; }","duration":"277.522662ms","start":"2026-05-19T19:13:58.696566Z","end":"2026-05-19T19:13:58.974089Z","steps":["trace[315860535] 'agreement among raft nodes before linearized reading' (duration: 277.42102ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:13:58.974074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"910.583084ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-19T19:13:58.974105Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:13:57.93636Z","time spent":"1.03764857s","remote":"127.0.0.1:49458","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T19:13:58.974163Z","caller":"traceutil/trace.go:171","msg":"trace[2056904992] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:0; response_revision:515; }","duration":"910.735038ms","start":"2026-05-19T19:13:58.063404Z","end":"2026-05-19T19:13:58.974139Z","steps":["trace[2056904992] 'agreement among raft nodes before linearized reading' (duration: 910.533713ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:13:58.974219Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:13:58.063386Z","time spent":"910.82411ms","remote":"127.0.0.1:43694","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":27,"request content":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" "} {"level":"warn","ts":"2026-05-19T19:13:58.974218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.294981ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T19:13:58.974296Z","caller":"traceutil/trace.go:171","msg":"trace[1498804228] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:515; }","duration":"185.422145ms","start":"2026-05-19T19:13:58.78885Z","end":"2026-05-19T19:13:58.974273Z","steps":["trace[1498804228] 'agreement among raft nodes before linearized reading' (duration: 185.269901ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:14:05.80422Z","caller":"traceutil/trace.go:171","msg":"trace[207965072] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"527.211656ms","start":"2026-05-19T19:14:05.276977Z","end":"2026-05-19T19:14:05.804188Z","steps":["trace[207965072] 'process raft request' (duration: 525.807782ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:14:05.804445Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:14:05.276948Z","time spent":"527.35879ms","remote":"127.0.0.1:43694","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036281,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T19:14:06.243054Z","caller":"traceutil/trace.go:171","msg":"trace[991735119] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"388.82477ms","start":"2026-05-19T19:14:05.854196Z","end":"2026-05-19T19:14:06.243021Z","steps":["trace[991735119] 'process raft request' (duration: 333.542685ms)","trace[991735119] 'compare' (duration: 55.038779ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T19:14:06.24322Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:14:05.854161Z","time spent":"388.984033ms","remote":"127.0.0.1:49706","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-19T19:14:06.844955Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11521226276576881704,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-19T19:14:07.757763Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"619.400046ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-05-19T19:14:07.758913Z","caller":"traceutil/trace.go:171","msg":"trace[682914466] linearizableReadLoop","detail":"{readStateIndex:654; appliedIndex:652; }","duration":"1.414204185s","start":"2026-05-19T19:14:06.344687Z","end":"2026-05-19T19:14:07.758892Z","steps":["trace[682914466] 'read index received' (duration: 793.760005ms)","trace[682914466] 'applied index is now lower than readState.Index' (duration: 620.44305ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T19:14:07.758981Z","caller":"traceutil/trace.go:171","msg":"trace[952695350] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"1.108452598s","start":"2026-05-19T19:14:06.650498Z","end":"2026-05-19T19:14:07.75895Z","steps":["trace[952695350] 'process raft request' (duration: 1.107753081s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:14:07.759144Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"484.309778ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-19T19:14:07.759171Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:14:06.65046Z","time spent":"1.108614661s","remote":"127.0.0.1:43694","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036305,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T19:14:07.759205Z","caller":"traceutil/trace.go:171","msg":"trace[1603963085] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:627; }","duration":"484.399049ms","start":"2026-05-19T19:14:07.27479Z","end":"2026-05-19T19:14:07.75919Z","steps":["trace[1603963085] 'agreement among raft nodes before linearized reading' (duration: 484.297467ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:14:07.759166Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.003999003s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-19T19:14:07.759301Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.345556ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T19:14:07.759321Z","caller":"traceutil/trace.go:171","msg":"trace[940170160] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:627; }","duration":"1.004139247s","start":"2026-05-19T19:14:06.755114Z","end":"2026-05-19T19:14:07.759253Z","steps":["trace[940170160] 'agreement among raft nodes before linearized reading' (duration: 1.003953092s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:14:07.759332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.912667ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-19T19:14:07.75942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"485.558828ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-19T19:14:07.759391Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:14:06.755096Z","time spent":"1.00428059s","remote":"127.0.0.1:35000","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true "} {"level":"warn","ts":"2026-05-19T19:14:07.759459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"719.083645ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:503"} {"level":"info","ts":"2026-05-19T19:14:07.759457Z","caller":"traceutil/trace.go:171","msg":"trace[1814287425] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:627; }","duration":"141.084851ms","start":"2026-05-19T19:14:07.618357Z","end":"2026-05-19T19:14:07.759442Z","steps":["trace[1814287425] 'agreement among raft nodes before linearized reading' (duration: 140.838085ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:14:07.759573Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.888016ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-19T19:14:07.759579Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"592.937292ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-19T19:14:07.759597Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"619.57495ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T19:14:07.759611Z","caller":"traceutil/trace.go:171","msg":"trace[1144669977] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:627; }","duration":"228.941957ms","start":"2026-05-19T19:14:07.530659Z","end":"2026-05-19T19:14:07.759601Z","steps":["trace[1144669977] 'agreement among raft nodes before linearized reading' (duration: 228.896246ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:14:07.759624Z","caller":"traceutil/trace.go:171","msg":"trace[967263296] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:627; }","duration":"592.988093ms","start":"2026-05-19T19:14:07.166626Z","end":"2026-05-19T19:14:07.759614Z","steps":["trace[967263296] 'agreement among raft nodes before linearized reading' (duration: 592.941771ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:14:07.759627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"534.218744ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-19T19:14:07.759653Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"755.439866ms","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-05-19T19:14:07.759653Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"841.417587ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-19T19:14:07.759681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"592.382378ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T19:14:07.759683Z","caller":"traceutil/trace.go:171","msg":"trace[439139367] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:627; }","duration":"534.310896ms","start":"2026-05-19T19:14:07.225357Z","end":"2026-05-19T19:14:07.759668Z","steps":["trace[439139367] 'agreement among raft nodes before linearized reading' (duration: 534.225854ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:14:07.759695Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"620.168444ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-19T19:14:07.759731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"592.995863ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-19T19:14:07.759731Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:14:07.225344Z","time spent":"534.372488ms","remote":"127.0.0.1:35088","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 "} {"level":"info","ts":"2026-05-19T19:14:07.759748Z","caller":"traceutil/trace.go:171","msg":"trace[258751280] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:627; }","duration":"593.016374ms","start":"2026-05-19T19:14:07.166727Z","end":"2026-05-19T19:14:07.759743Z","steps":["trace[258751280] 'agreement among raft nodes before linearized reading' (duration: 592.991543ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:14:07.759757Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.004516445s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T19:14:07.759794Z","caller":"traceutil/trace.go:171","msg":"trace[1662793587] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:627; }","duration":"1.004566547s","start":"2026-05-19T19:14:06.755218Z","end":"2026-05-19T19:14:07.759784Z","steps":["trace[1662793587] 'agreement among raft nodes before linearized reading' (duration: 1.004502405s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:14:07.759787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"620.262336ms","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-05-19T19:14:07.759818Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:14:06.755155Z","time spent":"1.004657339s","remote":"127.0.0.1:35000","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:10000 "} {"level":"info","ts":"2026-05-19T19:14:07.759827Z","caller":"traceutil/trace.go:171","msg":"trace[1862285670] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:627; }","duration":"620.323247ms","start":"2026-05-19T19:14:07.139493Z","end":"2026-05-19T19:14:07.759817Z","steps":["trace[1862285670] 'agreement among raft nodes before linearized reading' (duration: 620.264826ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:14:07.759869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"403.637305ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T19:14:07.759886Z","caller":"traceutil/trace.go:171","msg":"trace[416044273] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:627; }","duration":"403.653295ms","start":"2026-05-19T19:14:07.356228Z","end":"2026-05-19T19:14:07.759881Z","steps":["trace[416044273] 'agreement among raft nodes before linearized reading' (duration: 403.630224ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:14:07.759886Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:14:07.139483Z","time spent":"620.389619ms","remote":"127.0.0.1:35064","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true "} {"level":"warn","ts":"2026-05-19T19:14:07.759935Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"535.272329ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-19T19:14:07.759938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"535.247999ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T19:14:07.759958Z","caller":"traceutil/trace.go:171","msg":"trace[1594727767] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:627; }","duration":"535.316141ms","start":"2026-05-19T19:14:07.224636Z","end":"2026-05-19T19:14:07.759953Z","steps":["trace[1594727767] 'agreement among raft nodes before linearized reading' (duration: 535.28604ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:14:07.759955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"438.628483ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-19T19:14:07.759981Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:14:07.224622Z","time spent":"535.353271ms","remote":"127.0.0.1:35088","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true "} {"level":"info","ts":"2026-05-19T19:14:07.759985Z","caller":"traceutil/trace.go:171","msg":"trace[1355807268] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:627; }","duration":"535.31239ms","start":"2026-05-19T19:14:07.224657Z","end":"2026-05-19T19:14:07.75997Z","steps":["trace[1355807268] 'agreement among raft nodes before linearized reading' (duration: 535.254749ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:14:07.759994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.004552016s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T19:14:07.760019Z","caller":"traceutil/trace.go:171","msg":"trace[1422592103] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:627; }","duration":"1.004609228s","start":"2026-05-19T19:14:06.755403Z","end":"2026-05-19T19:14:07.760012Z","steps":["trace[1422592103] 'agreement among raft nodes before linearized reading' (duration: 1.004570237s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:14:07.760025Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:14:07.224646Z","time spent":"535.367981ms","remote":"127.0.0.1:35088","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 "} {"level":"warn","ts":"2026-05-19T19:14:07.760038Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:14:06.755383Z","time spent":"1.004650349s","remote":"127.0.0.1:35000","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:500 "} {"level":"warn","ts":"2026-05-19T19:14:07.760034Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"404.547356ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-19T19:14:07.759941Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"558.215589ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T19:14:07.759996Z","caller":"traceutil/trace.go:171","msg":"trace[1623680516] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:627; }","duration":"438.684704ms","start":"2026-05-19T19:14:07.321296Z","end":"2026-05-19T19:14:07.759981Z","steps":["trace[1623680516] 'agreement among raft nodes before linearized reading' (duration: 438.629613ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:14:07.760112Z","caller":"traceutil/trace.go:171","msg":"trace[678284074] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:627; }","duration":"558.434744ms","start":"2026-05-19T19:14:07.201668Z","end":"2026-05-19T19:14:07.760103Z","steps":["trace[678284074] 'agreement among raft nodes before linearized reading' (duration: 558.235479ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:14:07.760077Z","caller":"traceutil/trace.go:171","msg":"trace[988872796] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:627; }","duration":"404.606827ms","start":"2026-05-19T19:14:07.35545Z","end":"2026-05-19T19:14:07.760057Z","steps":["trace[988872796] 'agreement among raft nodes before linearized reading' (duration: 404.561266ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:14:07.760148Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:14:07.201638Z","time spent":"558.501876ms","remote":"127.0.0.1:35082","response type":"/etcdserverpb.KV/Range","request count":0,"request size":89,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:10000 "} {"level":"warn","ts":"2026-05-19T19:14:07.760176Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:14:07.355432Z","time spent":"404.731971ms","remote":"127.0.0.1:35114","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 "} {"level":"warn","ts":"2026-05-19T19:14:07.75989Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"557.539913ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-19T19:14:07.759847Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.519764ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T19:14:07.760282Z","caller":"traceutil/trace.go:171","msg":"trace[1979720904] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:627; }","duration":"265.965744ms","start":"2026-05-19T19:14:07.494305Z","end":"2026-05-19T19:14:07.760271Z","steps":["trace[1979720904] 'agreement among raft nodes before linearized reading' (duration: 265.526784ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:14:07.76028Z","caller":"traceutil/trace.go:171","msg":"trace[465009505] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:627; }","duration":"557.941942ms","start":"2026-05-19T19:14:07.20232Z","end":"2026-05-19T19:14:07.760262Z","steps":["trace[465009505] 'agreement among raft nodes before linearized reading' (duration: 557.545443ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:14:07.760336Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:14:07.202312Z","time spent":"558.006414ms","remote":"127.0.0.1:35082","response type":"/etcdserverpb.KV/Range","request count":0,"request size":89,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:500 "} {"level":"warn","ts":"2026-05-19T19:14:07.760374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.97095ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T19:14:07.760395Z","caller":"traceutil/trace.go:171","msg":"trace[1229271303] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:627; }","duration":"115.99017ms","start":"2026-05-19T19:14:07.644398Z","end":"2026-05-19T19:14:07.760388Z","steps":["trace[1229271303] 'agreement among raft nodes before linearized reading' (duration: 115.964669ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:14:07.759821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.474132ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T19:14:07.760434Z","caller":"traceutil/trace.go:171","msg":"trace[68745663] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:627; }","duration":"266.080587ms","start":"2026-05-19T19:14:07.494342Z","end":"2026-05-19T19:14:07.760423Z","steps":["trace[68745663] 'agreement among raft nodes before linearized reading' (duration: 265.466282ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:14:07.760122Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:14:07.32128Z","time spent":"438.835139ms","remote":"127.0.0.1:35108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 "} {"level":"warn","ts":"2026-05-19T19:14:07.759594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"755.348044ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-19T19:14:07.760578Z","caller":"traceutil/trace.go:171","msg":"trace[865635403] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:627; }","duration":"756.374588ms","start":"2026-05-19T19:14:07.004195Z","end":"2026-05-19T19:14:07.76057Z","steps":["trace[865635403] 'agreement among raft nodes before linearized reading' (duration: 755.340274ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:14:07.76061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.931611ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-19T19:14:07.760615Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:14:07.004169Z","time spent":"756.43569ms","remote":"127.0.0.1:49458","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-19T19:14:07.759797Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"404.235379ms","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-05-19T19:14:07.760638Z","caller":"traceutil/trace.go:171","msg":"trace[77567414] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:627; }","duration":"141.983593ms","start":"2026-05-19T19:14:07.618645Z","end":"2026-05-19T19:14:07.760629Z","steps":["trace[77567414] 'agreement among raft nodes before linearized reading' (duration: 141.944862ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:14:07.760658Z","caller":"traceutil/trace.go:171","msg":"trace[7832293] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:627; }","duration":"405.095229ms","start":"2026-05-19T19:14:07.355547Z","end":"2026-05-19T19:14:07.760642Z","steps":["trace[7832293] 'agreement among raft nodes before linearized reading' (duration: 404.236709ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:14:07.759463Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"676.991466ms","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-05-19T19:14:07.759705Z","caller":"traceutil/trace.go:171","msg":"trace[1573252864] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:627; }","duration":"592.423269ms","start":"2026-05-19T19:14:07.167276Z","end":"2026-05-19T19:14:07.7597Z","steps":["trace[1573252864] 'agreement among raft nodes before linearized reading' (duration: 592.391498ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:14:07.759347Z","caller":"traceutil/trace.go:171","msg":"trace[1068781694] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:627; }","duration":"264.398547ms","start":"2026-05-19T19:14:07.494933Z","end":"2026-05-19T19:14:07.759331Z","steps":["trace[1068781694] 'agreement among raft nodes before linearized reading' (duration: 264.323905ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:14:07.760349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.429227ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T19:14:07.760775Z","caller":"traceutil/trace.go:171","msg":"trace[967122411] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:627; }","duration":"115.874437ms","start":"2026-05-19T19:14:07.644892Z","end":"2026-05-19T19:14:07.760767Z","steps":["trace[967122411] 'agreement among raft nodes before linearized reading' (duration: 115.440087ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:14:07.759651Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:14:07.166619Z","time spent":"593.025083ms","remote":"127.0.0.1:35072","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:10000 "} {"level":"info","ts":"2026-05-19T19:14:07.760818Z","caller":"traceutil/trace.go:171","msg":"trace[1749292197] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:627; }","duration":"678.377169ms","start":"2026-05-19T19:14:07.082424Z","end":"2026-05-19T19:14:07.760801Z","steps":["trace[1749292197] 'agreement among raft nodes before linearized reading' (duration: 677.027697ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:14:07.759638Z","caller":"traceutil/trace.go:171","msg":"trace[1258671649] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:627; }","duration":"619.647982ms","start":"2026-05-19T19:14:07.139977Z","end":"2026-05-19T19:14:07.759625Z","steps":["trace[1258671649] 'agreement among raft nodes before linearized reading' (duration: 619.59158ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:14:07.759439Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"646.515175ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-19T19:14:07.759472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.284461ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-19T19:14:07.759347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"645.923731ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-19T19:14:07.760777Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:14:07.35554Z","time spent":"405.225142ms","remote":"127.0.0.1:35114","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"warn","ts":"2026-05-19T19:14:07.760906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"439.590796ms","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-05-19T19:14:07.759681Z","caller":"traceutil/trace.go:171","msg":"trace[201145460] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:627; }","duration":"755.517478ms","start":"2026-05-19T19:14:07.004155Z","end":"2026-05-19T19:14:07.759673Z","steps":["trace[201145460] 'agreement among raft nodes before linearized reading' (duration: 755.455326ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:14:07.759358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"718.495891ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-19T19:14:07.759356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"841.003617ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-19T19:14:07.7594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.077701ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-19T19:14:07.759412Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"646.25767ms","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":"warn","ts":"2026-05-19T19:14:07.759438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.360728ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-19T19:14:07.760967Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:14:07.139959Z","time spent":"620.997544ms","remote":"127.0.0.1:35064","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:500 "} {"level":"info","ts":"2026-05-19T19:14:07.759732Z","caller":"traceutil/trace.go:171","msg":"trace[159315741] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:627; }","duration":"620.242386ms","start":"2026-05-19T19:14:07.139479Z","end":"2026-05-19T19:14:07.759721Z","steps":["trace[159315741] 'agreement among raft nodes before linearized reading' (duration: 620.183445ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:14:07.76102Z","caller":"traceutil/trace.go:171","msg":"trace[683748804] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:627; }","duration":"196.844928ms","start":"2026-05-19T19:14:07.56416Z","end":"2026-05-19T19:14:07.761005Z","steps":["trace[683748804] 'agreement among raft nodes before linearized reading' (duration: 195.295401ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:14:07.761023Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:14:07.082392Z","time spent":"678.582734ms","remote":"127.0.0.1:35032","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"warn","ts":"2026-05-19T19:14:07.761099Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:14:07.274779Z","time spent":"486.295726ms","remote":"127.0.0.1:35092","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:500 "} {"level":"info","ts":"2026-05-19T19:14:07.759482Z","caller":"traceutil/trace.go:171","msg":"trace[1506682826] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:627; }","duration":"485.63703ms","start":"2026-05-19T19:14:07.273824Z","end":"2026-05-19T19:14:07.759461Z","steps":["trace[1506682826] 'agreement among raft nodes before linearized reading' (duration: 485.563938ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:14:07.761117Z","caller":"traceutil/trace.go:171","msg":"trace[8874945] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:627; }","duration":"647.709494ms","start":"2026-05-19T19:14:07.113377Z","end":"2026-05-19T19:14:07.761087Z","steps":["trace[8874945] 'agreement among raft nodes before linearized reading' (duration: 645.87686ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:14:07.761167Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:14:07.273807Z","time spent":"487.34583ms","remote":"127.0.0.1:35092","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:10000 "} {"level":"warn","ts":"2026-05-19T19:14:07.76118Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:14:07.113369Z","time spent":"647.790797ms","remote":"127.0.0.1:35032","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:500 "} {"level":"warn","ts":"2026-05-19T19:14:07.761251Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:14:07.004127Z","time spent":"757.115427ms","remote":"127.0.0.1:49458","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-05-19T19:14:07.761384Z","caller":"traceutil/trace.go:171","msg":"trace[834188906] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:627; }","duration":"720.54492ms","start":"2026-05-19T19:14:07.040828Z","end":"2026-05-19T19:14:07.761373Z","steps":["trace[834188906] 'agreement among raft nodes before linearized reading' (duration: 718.450769ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:14:07.761417Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:14:07.040772Z","time spent":"720.633622ms","remote":"127.0.0.1:35024","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"warn","ts":"2026-05-19T19:14:07.759503Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"677.14186ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T19:14:07.761462Z","caller":"traceutil/trace.go:171","msg":"trace[1555182160] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:627; }","duration":"679.108536ms","start":"2026-05-19T19:14:07.082341Z","end":"2026-05-19T19:14:07.761449Z","steps":["trace[1555182160] 'agreement among raft nodes before linearized reading' (duration: 677.134579ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:14:07.761459Z","caller":"traceutil/trace.go:171","msg":"trace[1758306072] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:627; }","duration":"648.324949ms","start":"2026-05-19T19:14:07.113114Z","end":"2026-05-19T19:14:07.761439Z","steps":["trace[1758306072] 'agreement among raft nodes before linearized reading' (duration: 646.28141ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:14:07.761559Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:14:07.082329Z","time spent":"679.215249ms","remote":"127.0.0.1:35032","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 "} {"level":"warn","ts":"2026-05-19T19:14:07.761591Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:14:07.113093Z","time spent":"648.476872ms","remote":"127.0.0.1:35048","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"info","ts":"2026-05-19T19:14:07.761739Z","caller":"traceutil/trace.go:171","msg":"trace[242672309] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:627; }","duration":"196.616783ms","start":"2026-05-19T19:14:07.565052Z","end":"2026-05-19T19:14:07.761669Z","steps":["trace[242672309] 'agreement among raft nodes before linearized reading' (duration: 194.369949ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:14:07.761795Z","caller":"traceutil/trace.go:171","msg":"trace[704610345] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:627; }","duration":"843.499566ms","start":"2026-05-19T19:14:06.918279Z","end":"2026-05-19T19:14:07.761778Z","steps":["trace[704610345] 'agreement among raft nodes before linearized reading' (duration: 841.025397ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:14:07.759505Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.372713ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-19T19:14:07.76185Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:14:06.918241Z","time spent":"843.591799ms","remote":"127.0.0.1:35010","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 "} {"level":"info","ts":"2026-05-19T19:14:07.761883Z","caller":"traceutil/trace.go:171","msg":"trace[1009171815] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:627; }","duration":"197.7609ms","start":"2026-05-19T19:14:07.564111Z","end":"2026-05-19T19:14:07.761872Z","steps":["trace[1009171815] 'agreement among raft nodes before linearized reading' (duration: 195.377743ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:14:07.759512Z","caller":"traceutil/trace.go:171","msg":"trace[1945583559] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:627; }","duration":"719.163916ms","start":"2026-05-19T19:14:07.040318Z","end":"2026-05-19T19:14:07.759482Z","steps":["trace[1945583559] 'agreement among raft nodes before linearized reading' (duration: 719.079644ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:14:07.762014Z","caller":"traceutil/trace.go:171","msg":"trace[183592789] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:627; }","duration":"143.686134ms","start":"2026-05-19T19:14:07.618285Z","end":"2026-05-19T19:14:07.761971Z","steps":["trace[183592789] 'agreement among raft nodes before linearized reading' (duration: 141.093642ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:14:07.762078Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:14:07.040294Z","time spent":"721.772099ms","remote":"127.0.0.1:49458","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":525,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-19T19:14:07.759526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"718.05098ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T19:14:07.762204Z","caller":"traceutil/trace.go:171","msg":"trace[84474312] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:627; }","duration":"720.742394ms","start":"2026-05-19T19:14:07.041446Z","end":"2026-05-19T19:14:07.762189Z","steps":["trace[84474312] 'agreement among raft nodes before linearized reading' (duration: 718.06859ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:14:07.762241Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:14:07.041429Z","time spent":"720.797666ms","remote":"127.0.0.1:35010","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:500 "} {"level":"warn","ts":"2026-05-19T19:14:07.759539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.6327ms","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-05-19T19:14:07.762362Z","caller":"traceutil/trace.go:171","msg":"trace[505756812] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:627; }","duration":"231.487358ms","start":"2026-05-19T19:14:07.530865Z","end":"2026-05-19T19:14:07.762352Z","steps":["trace[505756812] 'agreement among raft nodes before linearized reading' (duration: 228.6589ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:14:07.759548Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"718.537152ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T19:14:07.762449Z","caller":"traceutil/trace.go:171","msg":"trace[1552427626] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:627; }","duration":"721.435001ms","start":"2026-05-19T19:14:07.041006Z","end":"2026-05-19T19:14:07.762441Z","steps":["trace[1552427626] 'agreement among raft nodes before linearized reading' (duration: 718.530652ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:14:07.76248Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:14:07.040957Z","time spent":"721.511523ms","remote":"127.0.0.1:35024","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 "} {"level":"warn","ts":"2026-05-19T19:14:07.759545Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"485.735702ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T19:14:07.762615Z","caller":"traceutil/trace.go:171","msg":"trace[205397116] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:627; }","duration":"488.825226ms","start":"2026-05-19T19:14:07.27378Z","end":"2026-05-19T19:14:07.762606Z","steps":["trace[205397116] 'agreement among raft nodes before linearized reading' (duration: 485.731692ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:14:07.76265Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:14:07.273771Z","time spent":"488.865757ms","remote":"127.0.0.1:35092","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true "} {"level":"warn","ts":"2026-05-19T19:14:07.759555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"557.957063ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T19:14:07.762768Z","caller":"traceutil/trace.go:171","msg":"trace[399855562] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:627; }","duration":"561.193091ms","start":"2026-05-19T19:14:07.201563Z","end":"2026-05-19T19:14:07.762756Z","steps":["trace[399855562] 'agreement among raft nodes before linearized reading' (duration: 557.951063ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:14:07.762808Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:14:07.201549Z","time spent":"561.246852ms","remote":"127.0.0.1:35082","response type":"/etcdserverpb.KV/Range","request count":0,"request size":88,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true "} {"level":"info","ts":"2026-05-19T19:14:07.759722Z","caller":"traceutil/trace.go:171","msg":"trace[1287382410] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:627; }","duration":"841.498829ms","start":"2026-05-19T19:14:06.918184Z","end":"2026-05-19T19:14:07.759683Z","steps":["trace[1287382410] 'agreement among raft nodes before linearized reading' (duration: 841.439508ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:14:07.762928Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:14:06.918165Z","time spent":"844.751267ms","remote":"127.0.0.1:35010","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"warn","ts":"2026-05-19T19:14:07.759769Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:14:07.166687Z","time spent":"593.077485ms","remote":"127.0.0.1:35072","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true "} {"level":"warn","ts":"2026-05-19T19:14:07.759903Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:14:07.356212Z","time spent":"403.687295ms","remote":"127.0.0.1:35108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:500 "} {"level":"warn","ts":"2026-05-19T19:14:07.760243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.932558ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T19:14:07.76315Z","caller":"traceutil/trace.go:171","msg":"trace[1171057451] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:627; }","duration":"118.849879ms","start":"2026-05-19T19:14:07.64429Z","end":"2026-05-19T19:14:07.76314Z","steps":["trace[1171057451] 'agreement among raft nodes before linearized reading' (duration: 115.935819ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:14:07.760735Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:14:07.167269Z","time spent":"593.447754ms","remote":"127.0.0.1:35072","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:500 "} {"level":"info","ts":"2026-05-19T19:14:07.760936Z","caller":"traceutil/trace.go:171","msg":"trace[855040092] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:627; }","duration":"648.033362ms","start":"2026-05-19T19:14:07.112893Z","end":"2026-05-19T19:14:07.760926Z","steps":["trace[855040092] 'agreement among raft nodes before linearized reading' (duration: 646.532646ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:14:07.763363Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:14:07.112879Z","time spent":"650.46888ms","remote":"127.0.0.1:35048","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 "} {"level":"warn","ts":"2026-05-19T19:14:07.764228Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.414365969s","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-05-19T19:14:07.764266Z","caller":"traceutil/trace.go:171","msg":"trace[1994921276] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:627; }","duration":"1.419629225s","start":"2026-05-19T19:14:06.344626Z","end":"2026-05-19T19:14:07.764256Z","steps":["trace[1994921276] 'agreement among raft nodes before linearized reading' (duration: 1.414374349s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:14:07.764334Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:14:06.344592Z","time spent":"1.419732347s","remote":"127.0.0.1:49458","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-05-19T19:14:07.760958Z","caller":"traceutil/trace.go:171","msg":"trace[546255887] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:627; }","duration":"439.660047ms","start":"2026-05-19T19:14:07.321285Z","end":"2026-05-19T19:14:07.760945Z","steps":["trace[546255887] 'agreement among raft nodes before linearized reading' (duration: 439.519974ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:14:07.764589Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:14:07.321273Z","time spent":"443.209583ms","remote":"127.0.0.1:35108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"warn","ts":"2026-05-19T19:14:07.765288Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:14:07.13946Z","time spent":"625.804349ms","remote":"127.0.0.1:35064","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:10000 "} {"level":"info","ts":"2026-05-19T19:14:09.574832Z","caller":"traceutil/trace.go:171","msg":"trace[1182180634] transaction","detail":"{read_only:false; response_revision:666; number_of_response:1; }","duration":"224.996853ms","start":"2026-05-19T19:14:09.349808Z","end":"2026-05-19T19:14:09.574805Z","steps":["trace[1182180634] 'process raft request' (duration: 224.88388ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:14:13.928361Z","caller":"traceutil/trace.go:171","msg":"trace[752255273] transaction","detail":"{read_only:false; response_revision:721; number_of_response:1; }","duration":"123.461089ms","start":"2026-05-19T19:14:13.804858Z","end":"2026-05-19T19:14:13.928319Z","steps":["trace[752255273] 'process raft request' (duration: 123.404728ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:14:13.928684Z","caller":"traceutil/trace.go:171","msg":"trace[39676866] transaction","detail":"{read_only:false; response_revision:719; number_of_response:1; }","duration":"124.32289ms","start":"2026-05-19T19:14:13.804335Z","end":"2026-05-19T19:14:13.928658Z","steps":["trace[39676866] 'process raft request' (duration: 123.672895ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:14:13.928926Z","caller":"traceutil/trace.go:171","msg":"trace[1149328365] transaction","detail":"{read_only:false; response_revision:720; number_of_response:1; }","duration":"124.155465ms","start":"2026-05-19T19:14:13.804722Z","end":"2026-05-19T19:14:13.928878Z","steps":["trace[1149328365] 'process raft request' (duration: 123.49681ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:14:21.230962Z","caller":"traceutil/trace.go:171","msg":"trace[599325612] transaction","detail":"{read_only:false; response_revision:776; number_of_response:1; }","duration":"229.047649ms","start":"2026-05-19T19:14:21.001885Z","end":"2026-05-19T19:14:21.230933Z","steps":["trace[599325612] 'process raft request' (duration: 228.900446ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:14:51.0751Z","caller":"traceutil/trace.go:171","msg":"trace[2114916525] linearizableReadLoop","detail":"{readStateIndex:1220; appliedIndex:1219; }","duration":"286.240041ms","start":"2026-05-19T19:14:50.788833Z","end":"2026-05-19T19:14:51.075073Z","steps":["trace[2114916525] 'read index received' (duration: 286.057766ms)","trace[2114916525] 'applied index is now lower than readState.Index' (duration: 181.135µs)"],"step_count":2} {"level":"info","ts":"2026-05-19T19:14:51.075162Z","caller":"traceutil/trace.go:171","msg":"trace[1712230196] transaction","detail":"{read_only:false; response_revision:1183; number_of_response:1; }","duration":"532.623126ms","start":"2026-05-19T19:14:50.542501Z","end":"2026-05-19T19:14:51.075124Z","steps":["trace[1712230196] 'process raft request' (duration: 532.413341ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:14:51.075235Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.383374ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T19:14:51.075271Z","caller":"traceutil/trace.go:171","msg":"trace[803233970] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1183; }","duration":"286.467726ms","start":"2026-05-19T19:14:50.788792Z","end":"2026-05-19T19:14:51.07526Z","steps":["trace[803233970] 'agreement among raft nodes before linearized reading' (duration: 286.388164ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:14:51.075333Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:14:50.542471Z","time spent":"532.77053ms","remote":"127.0.0.1:49458","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T19:15:02.986933Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.840413ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-19T19:15:02.987076Z","caller":"traceutil/trace.go:171","msg":"trace[1875081542] transaction","detail":"{read_only:false; response_revision:1284; number_of_response:1; }","duration":"177.60328ms","start":"2026-05-19T19:15:02.809446Z","end":"2026-05-19T19:15:02.987049Z","steps":["trace[1875081542] 'process raft request' (duration: 76.550632ms)","trace[1875081542] 'compare' (duration: 100.461904ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T19:15:36.218218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"428.849174ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T19:15:36.218307Z","caller":"traceutil/trace.go:171","msg":"trace[314569384] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1847; }","duration":"428.993867ms","start":"2026-05-19T19:15:35.789294Z","end":"2026-05-19T19:15:36.218288Z","steps":["trace[314569384] 'range keys from in-memory index tree' (duration: 428.761101ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:15:36.218348Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:15:35.789272Z","time spent":"429.066838ms","remote":"127.0.0.1:43602","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-19T19:15:36.881039Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"412.969913ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-05-19T19:15:36.881304Z","caller":"traceutil/trace.go:171","msg":"trace[1110333364] transaction","detail":"{read_only:false; response_revision:1850; number_of_response:1; }","duration":"436.568008ms","start":"2026-05-19T19:15:36.444718Z","end":"2026-05-19T19:15:36.881286Z","steps":["trace[1110333364] 'process raft request' (duration: 436.429555ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:15:36.881441Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:15:36.444698Z","time spent":"436.64969ms","remote":"127.0.0.1:49458","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T19:15:36.881446Z","caller":"traceutil/trace.go:171","msg":"trace[1399829148] linearizableReadLoop","detail":"{readStateIndex:1924; appliedIndex:1923; }","duration":"441.965718ms","start":"2026-05-19T19:15:36.439383Z","end":"2026-05-19T19:15:36.881349Z","steps":["trace[1399829148] 'read index received' (duration: 28.80168ms)","trace[1399829148] 'applied index is now lower than readState.Index' (duration: 413.161547ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T19:15:36.881541Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"458.758619ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-19T19:15:36.881606Z","caller":"traceutil/trace.go:171","msg":"trace[1129650648] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1850; }","duration":"458.847201ms","start":"2026-05-19T19:15:36.422744Z","end":"2026-05-19T19:15:36.881591Z","steps":["trace[1129650648] 'agreement among raft nodes before linearized reading' (duration: 458.637326ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:15:36.881649Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:15:36.422733Z","time spent":"458.907342ms","remote":"127.0.0.1:49458","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-19T19:15:36.881872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"461.646178ms","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-05-19T19:15:36.881949Z","caller":"traceutil/trace.go:171","msg":"trace[1877650789] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1850; }","duration":"461.761671ms","start":"2026-05-19T19:15:36.42015Z","end":"2026-05-19T19:15:36.881911Z","steps":["trace[1877650789] 'agreement among raft nodes before linearized reading' (duration: 461.407362ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:15:36.882075Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:15:36.420137Z","time spent":"461.925865ms","remote":"127.0.0.1:49458","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-05-19T19:15:36.885018Z","caller":"traceutil/trace.go:171","msg":"trace[696632174] transaction","detail":"{read_only:false; response_revision:1851; number_of_response:1; }","duration":"320.616503ms","start":"2026-05-19T19:15:36.564375Z","end":"2026-05-19T19:15:36.884991Z","steps":["trace[696632174] 'process raft request' (duration: 318.478381ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:15:36.886032Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:15:36.564352Z","time spent":"321.571706ms","remote":"127.0.0.1:49458","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T19:15:36.886128Z","caller":"traceutil/trace.go:171","msg":"trace[793741554] transaction","detail":"{read_only:false; response_revision:1852; number_of_response:1; }","duration":"117.189494ms","start":"2026-05-19T19:15:36.768914Z","end":"2026-05-19T19:15:36.886103Z","steps":["trace[793741554] 'process raft request' (duration: 116.001996ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:15:36.886668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.570467ms","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-05-19T19:15:36.88669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.580211ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-4465c959-5ae3-4029-a48c-12216836203a\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-05-19T19:15:36.886733Z","caller":"traceutil/trace.go:171","msg":"trace[2013897014] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1852; }","duration":"263.66026ms","start":"2026-05-19T19:15:36.623053Z","end":"2026-05-19T19:15:36.886714Z","steps":["trace[2013897014] 'agreement among raft nodes before linearized reading' (duration: 263.082906ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:15:36.886721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.303174ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/datadir-percona-xtradb-pxc-0.18b10d77629cc24a\" ","response":"range_response_count:1 size:982"} {"level":"info","ts":"2026-05-19T19:15:36.886857Z","caller":"traceutil/trace.go:171","msg":"trace[2087299168] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-4465c959-5ae3-4029-a48c-12216836203a; range_end:; response_count:1; response_revision:1852; }","duration":"241.711925ms","start":"2026-05-19T19:15:36.645045Z","end":"2026-05-19T19:15:36.886757Z","steps":["trace[2087299168] 'agreement among raft nodes before linearized reading' (duration: 241.172032ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:15:36.887024Z","caller":"traceutil/trace.go:171","msg":"trace[516875640] range","detail":"{range_begin:/registry/events/openstack/datadir-percona-xtradb-pxc-0.18b10d77629cc24a; range_end:; response_count:1; response_revision:1852; }","duration":"350.645212ms","start":"2026-05-19T19:15:36.536353Z","end":"2026-05-19T19:15:36.886998Z","steps":["trace[516875640] 'agreement among raft nodes before linearized reading' (duration: 349.576936ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:15:36.887104Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:15:36.53633Z","time spent":"350.757544ms","remote":"127.0.0.1:43676","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":1004,"request content":"key:\"/registry/events/openstack/datadir-percona-xtradb-pxc-0.18b10d77629cc24a\" "} {"level":"warn","ts":"2026-05-19T19:15:36.887125Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"348.621074ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-05-19T19:15:36.887246Z","caller":"traceutil/trace.go:171","msg":"trace[1429222192] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1852; }","duration":"348.742286ms","start":"2026-05-19T19:15:36.538464Z","end":"2026-05-19T19:15:36.887206Z","steps":["trace[1429222192] 'agreement among raft nodes before linearized reading' (duration: 348.293925ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:15:36.887327Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:15:36.538451Z","time spent":"348.861019ms","remote":"127.0.0.1:57384","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5434,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"info","ts":"2026-05-19T19:15:51.312114Z","caller":"traceutil/trace.go:171","msg":"trace[1151167737] transaction","detail":"{read_only:false; response_revision:1968; number_of_response:1; }","duration":"321.534885ms","start":"2026-05-19T19:15:50.990553Z","end":"2026-05-19T19:15:51.312088Z","steps":["trace[1151167737] 'process raft request' (duration: 321.348131ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:15:51.312279Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:15:50.990535Z","time spent":"321.652648ms","remote":"127.0.0.1:49458","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T19:15:51.320086Z","caller":"traceutil/trace.go:171","msg":"trace[367392044] linearizableReadLoop","detail":"{readStateIndex:2048; appliedIndex:2045; }","duration":"314.20685ms","start":"2026-05-19T19:15:51.005849Z","end":"2026-05-19T19:15:51.320056Z","steps":["trace[367392044] 'read index received' (duration: 306.170148ms)","trace[367392044] 'applied index is now lower than readState.Index' (duration: 8.035642ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T19:15:51.320151Z","caller":"traceutil/trace.go:171","msg":"trace[905281207] transaction","detail":"{read_only:false; response_revision:1969; number_of_response:1; }","duration":"323.865921ms","start":"2026-05-19T19:15:50.99623Z","end":"2026-05-19T19:15:51.320096Z","steps":["trace[905281207] 'process raft request' (duration: 323.614145ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:15:51.320174Z","caller":"traceutil/trace.go:171","msg":"trace[1126516412] transaction","detail":"{read_only:false; response_revision:1970; number_of_response:1; }","duration":"322.676643ms","start":"2026-05-19T19:15:50.997455Z","end":"2026-05-19T19:15:51.320131Z","steps":["trace[1126516412] 'process raft request' (duration: 322.54961ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:15:51.320368Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:15:50.996207Z","time spent":"324.038275ms","remote":"127.0.0.1:49458","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T19:15:51.320376Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.508437ms","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-05-19T19:15:51.320523Z","caller":"traceutil/trace.go:171","msg":"trace[1715219000] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1970; }","duration":"314.694012ms","start":"2026-05-19T19:15:51.005814Z","end":"2026-05-19T19:15:51.320508Z","steps":["trace[1715219000] 'agreement among raft nodes before linearized reading' (duration: 314.416105ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:15:51.320387Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:15:50.997425Z","time spent":"322.852606ms","remote":"127.0.0.1:49458","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T19:15:51.320571Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:15:51.005804Z","time spent":"314.755443ms","remote":"127.0.0.1:49458","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-19T19:15:51.320579Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.23238ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-05-19T19:15:51.320466Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.425683ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-19T19:15:51.320555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.8397ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-05-19T19:15:51.320639Z","caller":"traceutil/trace.go:171","msg":"trace[769370856] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:1970; }","duration":"184.643289ms","start":"2026-05-19T19:15:51.135981Z","end":"2026-05-19T19:15:51.320624Z","steps":["trace[769370856] 'agreement among raft nodes before linearized reading' (duration: 184.440224ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:15:51.320616Z","caller":"traceutil/trace.go:171","msg":"trace[855979677] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1970; }","duration":"291.280191ms","start":"2026-05-19T19:15:51.029326Z","end":"2026-05-19T19:15:51.320606Z","steps":["trace[855979677] 'agreement among raft nodes before linearized reading' (duration: 291.107277ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:15:51.320687Z","caller":"traceutil/trace.go:171","msg":"trace[1851648495] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1970; }","duration":"300.965543ms","start":"2026-05-19T19:15:51.019679Z","end":"2026-05-19T19:15:51.320645Z","steps":["trace[1851648495] 'agreement among raft nodes before linearized reading' (duration: 300.673746ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:15:51.320773Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:15:51.019655Z","time spent":"301.102096ms","remote":"127.0.0.1:57384","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5434,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"info","ts":"2026-05-19T19:15:51.434257Z","caller":"traceutil/trace.go:171","msg":"trace[845624246] transaction","detail":"{read_only:false; response_revision:1971; number_of_response:1; }","duration":"108.974928ms","start":"2026-05-19T19:15:51.325237Z","end":"2026-05-19T19:15:51.434212Z","steps":["trace[845624246] 'process raft request' (duration: 106.130949ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:15:51.435333Z","caller":"traceutil/trace.go:171","msg":"trace[1896151931] transaction","detail":"{read_only:false; response_revision:1972; number_of_response:1; }","duration":"109.614753ms","start":"2026-05-19T19:15:51.325695Z","end":"2026-05-19T19:15:51.43531Z","steps":["trace[1896151931] 'process raft request' (duration: 108.472515ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:16:20.875961Z","caller":"traceutil/trace.go:171","msg":"trace[1335337464] transaction","detail":"{read_only:false; response_revision:2147; number_of_response:1; }","duration":"171.068888ms","start":"2026-05-19T19:16:20.704859Z","end":"2026-05-19T19:16:20.875928Z","steps":["trace[1335337464] 'process raft request' (duration: 170.926794ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:16:21.616417Z","caller":"traceutil/trace.go:171","msg":"trace[489226734] transaction","detail":"{read_only:false; response_revision:2150; number_of_response:1; }","duration":"189.304175ms","start":"2026-05-19T19:16:21.427072Z","end":"2026-05-19T19:16:21.616376Z","steps":["trace[489226734] 'process raft request' (duration: 113.346682ms)","trace[489226734] 'compare' (duration: 75.725288ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T19:16:21.616444Z","caller":"traceutil/trace.go:171","msg":"trace[393764265] linearizableReadLoop","detail":"{readStateIndex:2235; appliedIndex:2233; }","duration":"162.753217ms","start":"2026-05-19T19:16:21.453662Z","end":"2026-05-19T19:16:21.616415Z","steps":["trace[393764265] 'read index received' (duration: 17.175152ms)","trace[393764265] 'applied index is now lower than readState.Index' (duration: 145.575115ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T19:16:21.616826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.151707ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-05-19T19:16:21.61691Z","caller":"traceutil/trace.go:171","msg":"trace[1100738000] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2151; }","duration":"163.284021ms","start":"2026-05-19T19:16:21.453602Z","end":"2026-05-19T19:16:21.616886Z","steps":["trace[1100738000] 'agreement among raft nodes before linearized reading' (duration: 163.054835ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:16:28.158322Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11521226276576884826,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-19T19:16:28.16787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"593.462769ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T19:16:28.167962Z","caller":"traceutil/trace.go:171","msg":"trace[952663511] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:2179; }","duration":"593.598952ms","start":"2026-05-19T19:16:27.574336Z","end":"2026-05-19T19:16:28.167935Z","steps":["trace[952663511] 'count revisions from in-memory index tree' (duration: 593.388757ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:16:28.168688Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:16:27.574316Z","time spent":"594.3052ms","remote":"127.0.0.1:55704","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":27,"request content":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true "} {"level":"info","ts":"2026-05-19T19:16:28.212Z","caller":"traceutil/trace.go:171","msg":"trace[1949601230] transaction","detail":"{read_only:false; response_revision:2180; number_of_response:1; }","duration":"577.024785ms","start":"2026-05-19T19:16:27.634953Z","end":"2026-05-19T19:16:28.211978Z","steps":["trace[1949601230] 'process raft request' (duration: 576.81583ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:16:28.212172Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:16:27.634926Z","time spent":"577.156867ms","remote":"127.0.0.1:49458","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T19:16:28.238947Z","caller":"traceutil/trace.go:171","msg":"trace[796798467] transaction","detail":"{read_only:false; response_revision:2182; number_of_response:1; }","duration":"555.851376ms","start":"2026-05-19T19:16:27.683068Z","end":"2026-05-19T19:16:28.23892Z","steps":["trace[796798467] 'process raft request' (duration: 555.766564ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:16:28.238958Z","caller":"traceutil/trace.go:171","msg":"trace[1645817995] transaction","detail":"{read_only:false; response_revision:2181; number_of_response:1; }","duration":"602.743452ms","start":"2026-05-19T19:16:27.63618Z","end":"2026-05-19T19:16:28.238924Z","steps":["trace[1645817995] 'process raft request' (duration: 602.516306ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:16:28.239096Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:16:27.683039Z","time spent":"555.975059ms","remote":"127.0.0.1:49458","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T19:16:28.239135Z","caller":"traceutil/trace.go:171","msg":"trace[547530561] linearizableReadLoop","detail":"{readStateIndex:2269; appliedIndex:2265; }","duration":"581.638455ms","start":"2026-05-19T19:16:27.657444Z","end":"2026-05-19T19:16:28.239082Z","steps":["trace[547530561] 'read index received' (duration: 554.391921ms)","trace[547530561] 'applied index is now lower than readState.Index' (duration: 27.244504ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T19:16:28.239204Z","caller":"traceutil/trace.go:171","msg":"trace[607642228] transaction","detail":"{read_only:false; response_revision:2183; number_of_response:1; }","duration":"407.125406ms","start":"2026-05-19T19:16:27.832046Z","end":"2026-05-19T19:16:28.239171Z","steps":["trace[607642228] 'process raft request' (duration: 406.836589ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:16:28.239392Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"576.193985ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-19T19:16:28.239468Z","caller":"traceutil/trace.go:171","msg":"trace[831272681] range","detail":"{range_begin:/registry/roles/; range_end:/registry/roles0; response_count:0; response_revision:2183; }","duration":"576.289156ms","start":"2026-05-19T19:16:27.663167Z","end":"2026-05-19T19:16:28.239456Z","steps":["trace[831272681] 'agreement among raft nodes before linearized reading' (duration: 576.171124ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:16:28.239404Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"581.948112ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-05-19T19:16:28.239563Z","caller":"traceutil/trace.go:171","msg":"trace[247128401] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2183; }","duration":"582.181948ms","start":"2026-05-19T19:16:27.657362Z","end":"2026-05-19T19:16:28.239544Z","steps":["trace[247128401] 'agreement among raft nodes before linearized reading' (duration: 581.898092ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:16:28.239203Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:16:27.636152Z","time spent":"602.948067ms","remote":"127.0.0.1:49458","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T19:16:28.239556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"349.419749ms","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":"warn","ts":"2026-05-19T19:16:28.239591Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"555.444596ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-05-19T19:16:28.239592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"572.308331ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-05-19T19:16:28.239618Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:16:27.657349Z","time spent":"582.25594ms","remote":"127.0.0.1:57384","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5434,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-05-19T19:16:28.239621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"555.519898ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-19T19:16:28.239638Z","caller":"traceutil/trace.go:171","msg":"trace[719381769] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2183; }","duration":"349.533782ms","start":"2026-05-19T19:16:27.890086Z","end":"2026-05-19T19:16:28.23962Z","steps":["trace[719381769] 'agreement among raft nodes before linearized reading' (duration: 349.303077ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:16:28.239663Z","caller":"traceutil/trace.go:171","msg":"trace[813369929] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2183; }","duration":"572.408494ms","start":"2026-05-19T19:16:27.667237Z","end":"2026-05-19T19:16:28.239645Z","steps":["trace[813369929] 'agreement among raft nodes before linearized reading' (duration: 572.23429ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:16:28.239668Z","caller":"traceutil/trace.go:171","msg":"trace[807313840] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2183; }","duration":"555.58873ms","start":"2026-05-19T19:16:27.684067Z","end":"2026-05-19T19:16:28.239656Z","steps":["trace[807313840] 'agreement among raft nodes before linearized reading' (duration: 555.399056ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:16:28.23969Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:16:27.890064Z","time spent":"349.612605ms","remote":"127.0.0.1:49458","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-05-19T19:16:28.239702Z","caller":"traceutil/trace.go:171","msg":"trace[1719903794] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2183; }","duration":"555.552229ms","start":"2026-05-19T19:16:27.684131Z","end":"2026-05-19T19:16:28.239683Z","steps":["trace[1719903794] 'agreement among raft nodes before linearized reading' (duration: 555.239091ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:16:28.239779Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:16:27.684089Z","time spent":"555.676272ms","remote":"127.0.0.1:49458","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-19T19:16:28.239465Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:16:27.832016Z","time spent":"407.34129ms","remote":"127.0.0.1:49458","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T19:16:28.239716Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:16:27.684056Z","time spent":"555.652911ms","remote":"127.0.0.1:49458","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-19T19:16:28.239715Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:16:27.667218Z","time spent":"572.486115ms","remote":"127.0.0.1:49458","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":"warn","ts":"2026-05-19T19:16:28.239578Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:16:27.663157Z","time spent":"576.365529ms","remote":"127.0.0.1:49534","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":23,"response size":29,"request content":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true "} {"level":"info","ts":"2026-05-19T19:16:28.353701Z","caller":"traceutil/trace.go:171","msg":"trace[173658193] transaction","detail":"{read_only:false; response_revision:2184; number_of_response:1; }","duration":"109.454056ms","start":"2026-05-19T19:16:28.244208Z","end":"2026-05-19T19:16:28.353662Z","steps":["trace[173658193] 'process raft request' (duration: 27.864128ms)","trace[173658193] 'compare' (duration: 81.391724ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T19:16:28.405072Z","caller":"traceutil/trace.go:171","msg":"trace[1205690922] transaction","detail":"{read_only:false; response_revision:2186; number_of_response:1; }","duration":"160.470812ms","start":"2026-05-19T19:16:28.244577Z","end":"2026-05-19T19:16:28.405048Z","steps":["trace[1205690922] 'process raft request' (duration: 160.395701ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:16:28.405091Z","caller":"traceutil/trace.go:171","msg":"trace[358296244] transaction","detail":"{read_only:false; response_revision:2185; number_of_response:1; }","duration":"160.78235ms","start":"2026-05-19T19:16:28.244279Z","end":"2026-05-19T19:16:28.405061Z","steps":["trace[358296244] 'process raft request' (duration: 160.558544ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:16:28.405202Z","caller":"traceutil/trace.go:171","msg":"trace[4791532] linearizableReadLoop","detail":"{readStateIndex:2273; appliedIndex:2269; }","duration":"139.93342ms","start":"2026-05-19T19:16:28.265233Z","end":"2026-05-19T19:16:28.405166Z","steps":["trace[4791532] 'read index received' (duration: 6.788403ms)","trace[4791532] 'applied index is now lower than readState.Index' (duration: 133.142497ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T19:16:28.405307Z","caller":"traceutil/trace.go:171","msg":"trace[301777988] transaction","detail":"{read_only:false; response_revision:2187; number_of_response:1; }","duration":"160.621255ms","start":"2026-05-19T19:16:28.244668Z","end":"2026-05-19T19:16:28.405289Z","steps":["trace[301777988] 'process raft request' (duration: 160.346779ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:16:28.405369Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.121215ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:528"} {"level":"info","ts":"2026-05-19T19:16:28.40541Z","caller":"traceutil/trace.go:171","msg":"trace[85411752] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:2187; }","duration":"140.209727ms","start":"2026-05-19T19:16:28.265189Z","end":"2026-05-19T19:16:28.405399Z","steps":["trace[85411752] 'agreement among raft nodes before linearized reading' (duration: 140.077554ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:16:28.405427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.214199ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/policies/\" range_end:\"/registry/rabbitmq.com/policies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T19:16:28.405486Z","caller":"traceutil/trace.go:171","msg":"trace[681596224] range","detail":"{range_begin:/registry/rabbitmq.com/policies/; range_end:/registry/rabbitmq.com/policies0; response_count:0; response_revision:2187; }","duration":"138.30844ms","start":"2026-05-19T19:16:28.26716Z","end":"2026-05-19T19:16:28.405469Z","steps":["trace[681596224] 'agreement among raft nodes before linearized reading' (duration: 138.191268ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:16:29.748101Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11521226276576884848,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-19T19:16:29.80678Z","caller":"traceutil/trace.go:171","msg":"trace[165685799] transaction","detail":"{read_only:false; response_revision:2189; number_of_response:1; }","duration":"859.728582ms","start":"2026-05-19T19:16:28.947029Z","end":"2026-05-19T19:16:29.806758Z","steps":["trace[165685799] 'process raft request' (duration: 859.576358ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:16:29.806958Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:16:28.947007Z","time spent":"859.841025ms","remote":"127.0.0.1:49458","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T19:16:30.67492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"854.589798ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-19T19:16:30.675108Z","caller":"traceutil/trace.go:171","msg":"trace[521688521] linearizableReadLoop","detail":"{readStateIndex:2276; appliedIndex:2274; }","duration":"1.427457293s","start":"2026-05-19T19:16:29.247613Z","end":"2026-05-19T19:16:30.67507Z","steps":["trace[521688521] 'read index received' (duration: 558.974961ms)","trace[521688521] 'applied index is now lower than readState.Index' (duration: 868.480242ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T19:16:30.675185Z","caller":"traceutil/trace.go:171","msg":"trace[1007376721] transaction","detail":"{read_only:false; response_revision:2190; number_of_response:1; }","duration":"1.163239619s","start":"2026-05-19T19:16:29.511899Z","end":"2026-05-19T19:16:30.675138Z","steps":["trace[1007376721] 'process raft request' (duration: 308.319463ms)","trace[1007376721] 'compare' (duration: 854.210949ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T19:16:30.675393Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:16:29.51188Z","time spent":"1.163400933s","remote":"127.0.0.1:49458","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T19:16:30.675406Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.427781471s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-05-19T19:16:30.675476Z","caller":"traceutil/trace.go:171","msg":"trace[1751976940] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2190; }","duration":"1.427883273s","start":"2026-05-19T19:16:29.247572Z","end":"2026-05-19T19:16:30.675455Z","steps":["trace[1751976940] 'agreement among raft nodes before linearized reading' (duration: 1.427659698s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:16:30.67554Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:16:29.24755Z","time spent":"1.427971986s","remote":"127.0.0.1:57384","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5434,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"info","ts":"2026-05-19T19:16:30.870067Z","caller":"traceutil/trace.go:171","msg":"trace[17706461] transaction","detail":"{read_only:false; response_revision:2191; number_of_response:1; }","duration":"652.117457ms","start":"2026-05-19T19:16:30.217901Z","end":"2026-05-19T19:16:30.870018Z","steps":["trace[17706461] 'process raft request' (duration: 651.942513ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:16:30.870215Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:16:30.217875Z","time spent":"652.25976ms","remote":"127.0.0.1:49458","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T19:16:30.871657Z","caller":"traceutil/trace.go:171","msg":"trace[1244310114] transaction","detail":"{read_only:false; response_revision:2192; number_of_response:1; }","duration":"627.059346ms","start":"2026-05-19T19:16:30.244561Z","end":"2026-05-19T19:16:30.871621Z","steps":["trace[1244310114] 'process raft request' (duration: 626.722638ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:16:30.871881Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:16:30.244535Z","time spent":"627.23202ms","remote":"127.0.0.1:49458","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T19:16:30.871917Z","caller":"traceutil/trace.go:171","msg":"trace[716073957] linearizableReadLoop","detail":"{readStateIndex:2279; appliedIndex:2276; }","duration":"196.685752ms","start":"2026-05-19T19:16:30.675193Z","end":"2026-05-19T19:16:30.871878Z","steps":["trace[716073957] 'read index received' (duration: 194.632363ms)","trace[716073957] 'applied index is now lower than readState.Index' (duration: 2.035209ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T19:16:30.872216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.507454974s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:559"} {"level":"info","ts":"2026-05-19T19:16:30.872279Z","caller":"traceutil/trace.go:171","msg":"trace[1533189707] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:2193; }","duration":"1.507569526s","start":"2026-05-19T19:16:29.36469Z","end":"2026-05-19T19:16:30.87226Z","steps":["trace[1533189707] 'agreement among raft nodes before linearized reading' (duration: 1.50730262s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:16:30.872385Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:16:29.364656Z","time spent":"1.507676619s","remote":"127.0.0.1:49458","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":581,"request content":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" "} {"level":"warn","ts":"2026-05-19T19:16:30.872425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.151319684s","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":"warn","ts":"2026-05-19T19:16:30.872445Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"514.484933ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-05-19T19:16:30.872491Z","caller":"traceutil/trace.go:171","msg":"trace[1124279611] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:2193; }","duration":"1.151432106s","start":"2026-05-19T19:16:29.721041Z","end":"2026-05-19T19:16:30.872473Z","steps":["trace[1124279611] 'agreement among raft nodes before linearized reading' (duration: 1.151312733s)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:16:30.872502Z","caller":"traceutil/trace.go:171","msg":"trace[1841284224] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2193; }","duration":"514.575005ms","start":"2026-05-19T19:16:30.357908Z","end":"2026-05-19T19:16:30.872483Z","steps":["trace[1841284224] 'agreement among raft nodes before linearized reading' (duration: 514.36026ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:16:30.872538Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:16:29.72102Z","time spent":"1.151505468s","remote":"127.0.0.1:49576","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":0,"response size":27,"request content":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true "} {"level":"warn","ts":"2026-05-19T19:16:30.872547Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:16:30.357889Z","time spent":"514.646906ms","remote":"127.0.0.1:49458","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":"warn","ts":"2026-05-19T19:16:30.872563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"462.828642ms","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-05-19T19:16:30.872618Z","caller":"traceutil/trace.go:171","msg":"trace[526734623] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2193; }","duration":"462.933195ms","start":"2026-05-19T19:16:30.409668Z","end":"2026-05-19T19:16:30.872601Z","steps":["trace[526734623] 'agreement among raft nodes before linearized reading' (duration: 462.73121ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:16:30.87266Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:16:30.409635Z","time spent":"463.013507ms","remote":"127.0.0.1:49458","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-19T19:16:30.872627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"463.034478ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-05-19T19:16:30.872658Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.350507965s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/percona-xtradb-haproxy-0.18b10d7e723bf7cc\" ","response":"range_response_count:1 size:846"} {"level":"info","ts":"2026-05-19T19:16:30.872725Z","caller":"traceutil/trace.go:171","msg":"trace[872784815] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2193; }","duration":"463.16049ms","start":"2026-05-19T19:16:30.409548Z","end":"2026-05-19T19:16:30.872708Z","steps":["trace[872784815] 'agreement among raft nodes before linearized reading' (duration: 462.869413ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:16:30.872728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"463.15506ms","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":"warn","ts":"2026-05-19T19:16:30.872773Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:16:30.409533Z","time spent":"463.227123ms","remote":"127.0.0.1:49458","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-19T19:16:30.872724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.496314557s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/\" range_end:\"/registry/cert-manager.io/certificates0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-19T19:16:30.872834Z","caller":"traceutil/trace.go:171","msg":"trace[516046936] transaction","detail":"{read_only:false; response_revision:2193; number_of_response:1; }","duration":"627.843905ms","start":"2026-05-19T19:16:30.244977Z","end":"2026-05-19T19:16:30.872821Z","steps":["trace[516046936] 'process raft request' (duration: 626.554694ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:16:30.872857Z","caller":"traceutil/trace.go:171","msg":"trace[1070724348] range","detail":"{range_begin:/registry/cert-manager.io/certificates/; range_end:/registry/cert-manager.io/certificates0; response_count:0; response_revision:2193; }","duration":"1.496492061s","start":"2026-05-19T19:16:29.376335Z","end":"2026-05-19T19:16:30.872827Z","steps":["trace[1070724348] 'agreement among raft nodes before linearized reading' (duration: 1.496208724s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:16:30.87286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.08494693s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T19:16:30.872914Z","caller":"traceutil/trace.go:171","msg":"trace[460716827] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2193; }","duration":"1.085046452s","start":"2026-05-19T19:16:29.787855Z","end":"2026-05-19T19:16:30.872902Z","steps":["trace[460716827] 'agreement among raft nodes before linearized reading' (duration: 1.08496333s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:16:30.872922Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:16:29.376285Z","time spent":"1.496624744s","remote":"127.0.0.1:36562","response type":"/etcdserverpb.KV/Range","request count":0,"request size":84,"response count":2,"response size":29,"request content":"key:\"/registry/cert-manager.io/certificates/\" range_end:\"/registry/cert-manager.io/certificates0\" count_only:true "} {"level":"warn","ts":"2026-05-19T19:16:30.872925Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:16:30.244958Z","time spent":"627.911046ms","remote":"127.0.0.1:49458","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T19:16:30.872923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"617.180679ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12383"} {"level":"warn","ts":"2026-05-19T19:16:30.872955Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:16:29.787834Z","time spent":"1.085111724s","remote":"127.0.0.1:43602","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-19T19:16:30.872758Z","caller":"traceutil/trace.go:171","msg":"trace[709575780] range","detail":"{range_begin:/registry/events/openstack/percona-xtradb-haproxy-0.18b10d7e723bf7cc; range_end:; response_count:1; response_revision:2193; }","duration":"1.350717181s","start":"2026-05-19T19:16:29.522006Z","end":"2026-05-19T19:16:30.872723Z","steps":["trace[709575780] 'agreement among raft nodes before linearized reading' (duration: 1.350443684s)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:16:30.872992Z","caller":"traceutil/trace.go:171","msg":"trace[163437971] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2193; }","duration":"617.282731ms","start":"2026-05-19T19:16:30.255693Z","end":"2026-05-19T19:16:30.872976Z","steps":["trace[163437971] 'agreement among raft nodes before linearized reading' (duration: 617.073006ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:16:30.87305Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:16:30.25568Z","time spent":"617.357393ms","remote":"127.0.0.1:43794","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12405,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-05-19T19:16:30.873054Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:16:29.521993Z","time spent":"1.351041088s","remote":"127.0.0.1:43676","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":868,"request content":"key:\"/registry/events/openstack/percona-xtradb-haproxy-0.18b10d7e723bf7cc\" "} {"level":"info","ts":"2026-05-19T19:16:30.872775Z","caller":"traceutil/trace.go:171","msg":"trace[1061978890] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2193; }","duration":"463.234203ms","start":"2026-05-19T19:16:30.409528Z","end":"2026-05-19T19:16:30.872762Z","steps":["trace[1061978890] 'agreement among raft nodes before linearized reading' (duration: 463.104709ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:16:30.87316Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:16:30.409508Z","time spent":"463.635512ms","remote":"127.0.0.1:49458","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-05-19T19:16:34.653266Z","caller":"traceutil/trace.go:171","msg":"trace[1159013242] transaction","detail":"{read_only:false; response_revision:2213; number_of_response:1; }","duration":"130.402851ms","start":"2026-05-19T19:16:34.522835Z","end":"2026-05-19T19:16:34.653238Z","steps":["trace[1159013242] 'process raft request' (duration: 105.304639ms)","trace[1159013242] 'compare' (duration: 24.971339ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T19:16:35.042385Z","caller":"traceutil/trace.go:171","msg":"trace[756928338] transaction","detail":"{read_only:false; response_revision:2219; number_of_response:1; }","duration":"100.000851ms","start":"2026-05-19T19:16:34.942338Z","end":"2026-05-19T19:16:35.042339Z","steps":["trace[756928338] 'process raft request' (duration: 43.33271ms)","trace[756928338] 'compare' (duration: 56.436385ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T19:17:06.729111Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.167677ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-05-19T19:17:06.729245Z","caller":"traceutil/trace.go:171","msg":"trace[684250723] linearizableReadLoop","detail":"{readStateIndex:2495; appliedIndex:2494; }","duration":"132.407784ms","start":"2026-05-19T19:17:06.596818Z","end":"2026-05-19T19:17:06.729226Z","steps":["trace[684250723] 'read index received' (duration: 10.042831ms)","trace[684250723] 'applied index is now lower than readState.Index' (duration: 122.363353ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T19:17:06.729323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.495717ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/percona-xtradb-haproxy-metrics\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T19:17:06.729357Z","caller":"traceutil/trace.go:171","msg":"trace[1032824484] range","detail":"{range_begin:/registry/services/specs/openstack/percona-xtradb-haproxy-metrics; range_end:; response_count:0; response_revision:2400; }","duration":"132.562038ms","start":"2026-05-19T19:17:06.596783Z","end":"2026-05-19T19:17:06.729345Z","steps":["trace[1032824484] 'agreement among raft nodes before linearized reading' (duration: 132.489956ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:17:07.023591Z","caller":"traceutil/trace.go:171","msg":"trace[1141422473] transaction","detail":"{read_only:false; response_revision:2405; number_of_response:1; }","duration":"201.424604ms","start":"2026-05-19T19:17:06.82214Z","end":"2026-05-19T19:17:07.023565Z","steps":["trace[1141422473] 'process raft request' (duration: 109.112924ms)","trace[1141422473] 'compare' (duration: 92.040613ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T19:17:19.480141Z","caller":"traceutil/trace.go:171","msg":"trace[932546662] transaction","detail":"{read_only:false; response_revision:2625; number_of_response:1; }","duration":"411.213749ms","start":"2026-05-19T19:17:19.068896Z","end":"2026-05-19T19:17:19.480109Z","steps":["trace[932546662] 'process raft request' (duration: 411.022874ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:17:19.480322Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:17:19.068873Z","time spent":"411.361233ms","remote":"127.0.0.1:49458","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T19:17:19.804066Z","caller":"traceutil/trace.go:171","msg":"trace[924603153] transaction","detail":"{read_only:false; response_revision:2627; number_of_response:1; }","duration":"682.901392ms","start":"2026-05-19T19:17:19.121139Z","end":"2026-05-19T19:17:19.80404Z","steps":["trace[924603153] 'process raft request' (duration: 682.79176ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:17:19.804201Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:17:19.121114Z","time spent":"683.020634ms","remote":"127.0.0.1:49458","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T19:17:19.80427Z","caller":"traceutil/trace.go:171","msg":"trace[173271090] transaction","detail":"{read_only:false; response_revision:2626; number_of_response:1; }","duration":"696.029588ms","start":"2026-05-19T19:17:19.108029Z","end":"2026-05-19T19:17:19.804058Z","steps":["trace[173271090] 'process raft request' (duration: 695.327551ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:17:19.80436Z","caller":"traceutil/trace.go:171","msg":"trace[434773263] transaction","detail":"{read_only:false; response_revision:2628; number_of_response:1; }","duration":"673.790443ms","start":"2026-05-19T19:17:19.130509Z","end":"2026-05-19T19:17:19.804299Z","steps":["trace[434773263] 'process raft request' (duration: 673.497436ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:17:19.804399Z","caller":"traceutil/trace.go:171","msg":"trace[54561107] transaction","detail":"{read_only:false; response_revision:2629; number_of_response:1; }","duration":"653.70144ms","start":"2026-05-19T19:17:19.150664Z","end":"2026-05-19T19:17:19.804366Z","steps":["trace[54561107] 'process raft request' (duration: 653.574137ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:17:19.804348Z","caller":"traceutil/trace.go:171","msg":"trace[742253386] linearizableReadLoop","detail":"{readStateIndex:2731; appliedIndex:2726; }","duration":"625.536552ms","start":"2026-05-19T19:17:19.178795Z","end":"2026-05-19T19:17:19.804331Z","steps":["trace[742253386] 'read index received' (duration: 301.206633ms)","trace[742253386] 'applied index is now lower than readState.Index' (duration: 324.328979ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T19:17:19.804515Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:17:19.130487Z","time spent":"673.950137ms","remote":"127.0.0.1:49458","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T19:17:19.804529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"625.722208ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-05-19T19:17:19.804589Z","caller":"traceutil/trace.go:171","msg":"trace[419924845] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2629; }","duration":"625.821049ms","start":"2026-05-19T19:17:19.178752Z","end":"2026-05-19T19:17:19.804573Z","steps":["trace[419924845] 'agreement among raft nodes before linearized reading' (duration: 625.631815ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:17:19.804499Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:17:19.150651Z","time spent":"653.803542ms","remote":"127.0.0.1:49458","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T19:17:19.804624Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:17:19.178735Z","time spent":"625.880201ms","remote":"127.0.0.1:49458","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-05-19T19:17:19.804494Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:17:19.108003Z","time spent":"696.395877ms","remote":"127.0.0.1:49458","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T19:17:19.804798Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"494.124822ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-19T19:17:19.804849Z","caller":"traceutil/trace.go:171","msg":"trace[1922087194] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2629; }","duration":"494.202414ms","start":"2026-05-19T19:17:19.310632Z","end":"2026-05-19T19:17:19.804834Z","steps":["trace[1922087194] 'agreement among raft nodes before linearized reading' (duration: 494.0333ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:17:19.804886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"467.332748ms","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":"warn","ts":"2026-05-19T19:17:19.804896Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:17:19.310611Z","time spent":"494.273397ms","remote":"127.0.0.1:49458","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-19T19:17:19.804923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.821302ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-19T19:17:19.804929Z","caller":"traceutil/trace.go:171","msg":"trace[1190803502] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2629; }","duration":"467.371429ms","start":"2026-05-19T19:17:19.337542Z","end":"2026-05-19T19:17:19.804914Z","steps":["trace[1190803502] 'agreement among raft nodes before linearized reading' (duration: 467.262287ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:17:19.80498Z","caller":"traceutil/trace.go:171","msg":"trace[114213618] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; response_count:0; response_revision:2629; }","duration":"208.925045ms","start":"2026-05-19T19:17:19.596041Z","end":"2026-05-19T19:17:19.804966Z","steps":["trace[114213618] 'agreement among raft nodes before linearized reading' (duration: 208.820192ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:17:19.804994Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:17:19.337505Z","time spent":"467.474802ms","remote":"127.0.0.1:49458","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-19T19:17:19.805037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"482.720438ms","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-05-19T19:17:19.805087Z","caller":"traceutil/trace.go:171","msg":"trace[97921460] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2629; }","duration":"482.78998ms","start":"2026-05-19T19:17:19.322286Z","end":"2026-05-19T19:17:19.805076Z","steps":["trace[97921460] 'agreement among raft nodes before linearized reading' (duration: 482.632376ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:17:19.805117Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:17:19.322271Z","time spent":"482.839211ms","remote":"127.0.0.1:49458","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-19T19:17:19.80513Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.396669ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"} {"level":"info","ts":"2026-05-19T19:17:19.8057Z","caller":"traceutil/trace.go:171","msg":"trace[1407220795] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2629; }","duration":"127.150607ms","start":"2026-05-19T19:17:19.678519Z","end":"2026-05-19T19:17:19.805669Z","steps":["trace[1407220795] 'agreement among raft nodes before linearized reading' (duration: 126.155333ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:17:53.820188Z","caller":"traceutil/trace.go:171","msg":"trace[893964920] linearizableReadLoop","detail":"{readStateIndex:2942; appliedIndex:2941; }","duration":"141.070403ms","start":"2026-05-19T19:17:53.679093Z","end":"2026-05-19T19:17:53.820163Z","steps":["trace[893964920] 'read index received' (duration: 95.483237ms)","trace[893964920] 'applied index is now lower than readState.Index' (duration: 45.586186ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T19:17:53.820249Z","caller":"traceutil/trace.go:171","msg":"trace[25922858] transaction","detail":"{read_only:false; response_revision:2832; number_of_response:1; }","duration":"188.976794ms","start":"2026-05-19T19:17:53.63124Z","end":"2026-05-19T19:17:53.820217Z","steps":["trace[25922858] 'process raft request' (duration: 143.399578ms)","trace[25922858] 'compare' (duration: 45.31528ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T19:17:53.820445Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.333729ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"} {"level":"info","ts":"2026-05-19T19:17:53.820503Z","caller":"traceutil/trace.go:171","msg":"trace[36562495] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2832; }","duration":"141.438412ms","start":"2026-05-19T19:17:53.679051Z","end":"2026-05-19T19:17:53.820489Z","steps":["trace[36562495] 'agreement among raft nodes before linearized reading' (duration: 141.252697ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:17:54.211052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.252125ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-19T19:17:54.211164Z","caller":"traceutil/trace.go:171","msg":"trace[784122400] transaction","detail":"{read_only:false; response_revision:2833; number_of_response:1; }","duration":"288.096107ms","start":"2026-05-19T19:17:53.923048Z","end":"2026-05-19T19:17:54.211144Z","steps":["trace[784122400] 'process raft request' (duration: 129.649577ms)","trace[784122400] 'compare' (duration: 157.876786ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T19:17:54.293798Z","caller":"traceutil/trace.go:171","msg":"trace[2038388223] transaction","detail":"{read_only:false; response_revision:2834; number_of_response:1; }","duration":"367.411244ms","start":"2026-05-19T19:17:53.926363Z","end":"2026-05-19T19:17:54.293775Z","steps":["trace[2038388223] 'process raft request' (duration: 367.23767ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:17:54.294005Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:17:53.92635Z","time spent":"367.521387ms","remote":"127.0.0.1:49458","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T19:17:54.29412Z","caller":"traceutil/trace.go:171","msg":"trace[1480112943] transaction","detail":"{read_only:false; response_revision:2835; number_of_response:1; }","duration":"367.602398ms","start":"2026-05-19T19:17:53.926483Z","end":"2026-05-19T19:17:54.294086Z","steps":["trace[1480112943] 'process raft request' (duration: 367.25042ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:17:54.294383Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:17:53.926455Z","time spent":"367.812664ms","remote":"127.0.0.1:49458","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T19:17:54.294496Z","caller":"traceutil/trace.go:171","msg":"trace[606748905] linearizableReadLoop","detail":"{readStateIndex:2945; appliedIndex:2942; }","duration":"281.907518ms","start":"2026-05-19T19:17:54.012565Z","end":"2026-05-19T19:17:54.294473Z","steps":["trace[606748905] 'read index received' (duration: 40.065403ms)","trace[606748905] 'applied index is now lower than readState.Index' (duration: 241.840395ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T19:17:54.294688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.117893ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-05-19T19:17:54.29472Z","caller":"traceutil/trace.go:171","msg":"trace[1744252988] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2835; }","duration":"282.197025ms","start":"2026-05-19T19:17:54.012513Z","end":"2026-05-19T19:17:54.29471Z","steps":["trace[1744252988] 'agreement among raft nodes before linearized reading' (duration: 282.083223ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:17:54.295019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.354097ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-19T19:17:54.295072Z","caller":"traceutil/trace.go:171","msg":"trace[449801102] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2835; }","duration":"232.437549ms","start":"2026-05-19T19:17:54.06262Z","end":"2026-05-19T19:17:54.295057Z","steps":["trace[449801102] 'agreement among raft nodes before linearized reading' (duration: 232.276475ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:17:54.295176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.892662ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-05-19T19:17:54.295202Z","caller":"traceutil/trace.go:171","msg":"trace[681590282] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2835; }","duration":"235.953933ms","start":"2026-05-19T19:17:54.059241Z","end":"2026-05-19T19:17:54.295195Z","steps":["trace[681590282] 'agreement among raft nodes before linearized reading' (duration: 235.890442ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:17:54.295209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.701828ms","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-05-19T19:17:54.295292Z","caller":"traceutil/trace.go:171","msg":"trace[341413192] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2835; }","duration":"260.819511ms","start":"2026-05-19T19:17:54.034459Z","end":"2026-05-19T19:17:54.295279Z","steps":["trace[341413192] 'agreement among raft nodes before linearized reading' (duration: 260.151775ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:17:54.495519Z","caller":"traceutil/trace.go:171","msg":"trace[1024248182] transaction","detail":"{read_only:false; response_revision:2836; number_of_response:1; }","duration":"197.330975ms","start":"2026-05-19T19:17:54.298169Z","end":"2026-05-19T19:17:54.4955Z","steps":["trace[1024248182] 'process raft request' (duration: 125.525778ms)","trace[1024248182] 'compare' (duration: 71.674104ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T19:17:54.49576Z","caller":"traceutil/trace.go:171","msg":"trace[2062936151] transaction","detail":"{read_only:false; response_revision:2837; number_of_response:1; }","duration":"197.003697ms","start":"2026-05-19T19:17:54.298733Z","end":"2026-05-19T19:17:54.495736Z","steps":["trace[2062936151] 'process raft request' (duration: 196.739351ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:17:54.496017Z","caller":"traceutil/trace.go:171","msg":"trace[1656840060] transaction","detail":"{read_only:false; response_revision:2838; number_of_response:1; }","duration":"197.10563ms","start":"2026-05-19T19:17:54.298882Z","end":"2026-05-19T19:17:54.495988Z","steps":["trace[1656840060] 'process raft request' (duration: 196.761081ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:17:54.496175Z","caller":"traceutil/trace.go:171","msg":"trace[725863645] transaction","detail":"{read_only:false; response_revision:2840; number_of_response:1; }","duration":"196.28282ms","start":"2026-05-19T19:17:54.299881Z","end":"2026-05-19T19:17:54.496163Z","steps":["trace[725863645] 'process raft request' (duration: 196.215178ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:17:54.496181Z","caller":"traceutil/trace.go:171","msg":"trace[195581216] transaction","detail":"{read_only:false; response_revision:2839; number_of_response:1; }","duration":"197.195022ms","start":"2026-05-19T19:17:54.298978Z","end":"2026-05-19T19:17:54.496173Z","steps":["trace[195581216] 'process raft request' (duration: 196.941396ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:21:43.650658Z","caller":"traceutil/trace.go:171","msg":"trace[207660693] transaction","detail":"{read_only:false; number_of_response:1; response_revision:4784; }","duration":"166.921891ms","start":"2026-05-19T19:21:43.483702Z","end":"2026-05-19T19:21:43.650624Z","steps":["trace[207660693] 'process raft request' (duration: 149.164195ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:21:48.149455Z","caller":"traceutil/trace.go:171","msg":"trace[1961959065] linearizableReadLoop","detail":"{readStateIndex:5069; appliedIndex:5068; }","duration":"302.579713ms","start":"2026-05-19T19:21:47.846853Z","end":"2026-05-19T19:21:48.149433Z","steps":["trace[1961959065] 'read index received' (duration: 302.356408ms)","trace[1961959065] 'applied index is now lower than readState.Index' (duration: 222.495µs)"],"step_count":2} {"level":"info","ts":"2026-05-19T19:21:48.149786Z","caller":"traceutil/trace.go:171","msg":"trace[2092817975] transaction","detail":"{read_only:false; response_revision:4882; number_of_response:1; }","duration":"315.045571ms","start":"2026-05-19T19:21:47.834729Z","end":"2026-05-19T19:21:48.149774Z","steps":["trace[2092817975] 'process raft request' (duration: 314.57022ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:21:48.149887Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:21:47.834714Z","time spent":"315.106983ms","remote":"127.0.0.1:49458","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T19:21:48.150009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.675645ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"warn","ts":"2026-05-19T19:21:48.150026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.156907ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-19T19:21:48.150117Z","caller":"traceutil/trace.go:171","msg":"trace[588393945] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4882; }","duration":"302.817319ms","start":"2026-05-19T19:21:47.847282Z","end":"2026-05-19T19:21:48.150099Z","steps":["trace[588393945] 'agreement among raft nodes before linearized reading' (duration: 302.566163ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:21:48.150123Z","caller":"traceutil/trace.go:171","msg":"trace[1799077693] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4882; }","duration":"303.28653ms","start":"2026-05-19T19:21:47.846822Z","end":"2026-05-19T19:21:48.150108Z","steps":["trace[1799077693] 'agreement among raft nodes before linearized reading' (duration: 303.037594ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:21:48.150162Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:21:47.847275Z","time spent":"302.87802ms","remote":"127.0.0.1:49458","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-19T19:21:48.150196Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:21:47.846804Z","time spent":"303.379852ms","remote":"127.0.0.1:49458","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-05-19T19:21:50.864218Z","caller":"traceutil/trace.go:171","msg":"trace[1616371631] transaction","detail":"{read_only:false; number_of_response:0; response_revision:4998; }","duration":"173.748274ms","start":"2026-05-19T19:21:50.690446Z","end":"2026-05-19T19:21:50.864194Z","steps":["trace[1616371631] 'process raft request' (duration: 173.666522ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:21:50.864266Z","caller":"traceutil/trace.go:171","msg":"trace[75998521] linearizableReadLoop","detail":"{readStateIndex:5188; appliedIndex:5188; }","duration":"126.509492ms","start":"2026-05-19T19:21:50.737706Z","end":"2026-05-19T19:21:50.864216Z","steps":["trace[75998521] 'read index received' (duration: 126.480401ms)","trace[75998521] 'applied index is now lower than readState.Index' (duration: 25.951µs)"],"step_count":2} {"level":"warn","ts":"2026-05-19T19:21:50.864507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.750708ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-05674c6f-42aa-48a4-b265-a0742035415f\" ","response":"range_response_count:1 size:3601"} {"level":"info","ts":"2026-05-19T19:21:50.86458Z","caller":"traceutil/trace.go:171","msg":"trace[1416051212] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-05674c6f-42aa-48a4-b265-a0742035415f; range_end:; response_count:1; response_revision:4998; }","duration":"126.900382ms","start":"2026-05-19T19:21:50.737655Z","end":"2026-05-19T19:21:50.864555Z","steps":["trace[1416051212] 'agreement among raft nodes before linearized reading' (duration: 126.642206ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:21:51.114372Z","caller":"traceutil/trace.go:171","msg":"trace[122565865] linearizableReadLoop","detail":"{readStateIndex:5189; appliedIndex:5188; }","duration":"249.999942ms","start":"2026-05-19T19:21:50.864346Z","end":"2026-05-19T19:21:51.114346Z","steps":["trace[122565865] 'read index received' (duration: 249.930161ms)","trace[122565865] 'applied index is now lower than readState.Index' (duration: 68.671µs)"],"step_count":2} {"level":"info","ts":"2026-05-19T19:21:51.114452Z","caller":"traceutil/trace.go:171","msg":"trace[1840182013] transaction","detail":"{read_only:false; response_revision:4999; number_of_response:1; }","duration":"313.32109ms","start":"2026-05-19T19:21:50.801109Z","end":"2026-05-19T19:21:51.11443Z","steps":["trace[1840182013] 'process raft request' (duration: 313.086955ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:21:51.114583Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:21:50.801092Z","time spent":"313.411182ms","remote":"127.0.0.1:49458","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T19:21:51.114608Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.145614ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-6r9xm\" ","response":"range_response_count:1 size:6445"} {"level":"info","ts":"2026-05-19T19:21:51.114644Z","caller":"traceutil/trace.go:171","msg":"trace[83720274] range","detail":"{range_begin:/registry/pods/openstack/keepalived-6r9xm; range_end:; response_count:1; response_revision:4999; }","duration":"310.208475ms","start":"2026-05-19T19:21:50.804423Z","end":"2026-05-19T19:21:51.114632Z","steps":["trace[83720274] 'agreement among raft nodes before linearized reading' (duration: 310.051711ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:21:51.114683Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:21:50.804414Z","time spent":"310.262007ms","remote":"127.0.0.1:43794","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6467,"request content":"key:\"/registry/pods/openstack/keepalived-6r9xm\" "} {"level":"warn","ts":"2026-05-19T19:21:51.114702Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.566736ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/monitoring/kube-prometheus-stack-prometheus-node-exporter-mfrbr-tls\" ","response":"range_response_count:1 size:1967"} {"level":"warn","ts":"2026-05-19T19:21:51.114715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.989378ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/monitoring\" ","response":"range_response_count:1 size:372"} {"level":"warn","ts":"2026-05-19T19:21:51.114745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.651654ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T19:21:51.114778Z","caller":"traceutil/trace.go:171","msg":"trace[664295110] range","detail":"{range_begin:/registry/cert-manager.io/certificates/monitoring/kube-prometheus-stack-prometheus-node-exporter-mfrbr-tls; range_end:; response_count:1; response_revision:4999; }","duration":"162.697629ms","start":"2026-05-19T19:21:50.952064Z","end":"2026-05-19T19:21:51.114761Z","steps":["trace[664295110] 'agreement among raft nodes before linearized reading' (duration: 162.496684ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:21:51.114799Z","caller":"traceutil/trace.go:171","msg":"trace[1196722690] range","detail":"{range_begin:/registry/namespaces/monitoring; range_end:; response_count:1; response_revision:4999; }","duration":"249.120922ms","start":"2026-05-19T19:21:50.865656Z","end":"2026-05-19T19:21:51.114776Z","steps":["trace[1196722690] 'agreement among raft nodes before linearized reading' (duration: 248.894766ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:21:51.114827Z","caller":"traceutil/trace.go:171","msg":"trace[272576757] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4999; }","duration":"327.753956ms","start":"2026-05-19T19:21:50.78705Z","end":"2026-05-19T19:21:51.114804Z","steps":["trace[272576757] 'agreement among raft nodes before linearized reading' (duration: 327.657614ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:21:51.114928Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:21:50.787029Z","time spent":"327.851018ms","remote":"127.0.0.1:43602","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-19T19:21:51.114635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"368.261637ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/permissions/\" range_end:\"/registry/rabbitmq.com/permissions0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T19:21:51.114998Z","caller":"traceutil/trace.go:171","msg":"trace[867940426] range","detail":"{range_begin:/registry/rabbitmq.com/permissions/; range_end:/registry/rabbitmq.com/permissions0; response_count:0; response_revision:4999; }","duration":"368.693338ms","start":"2026-05-19T19:21:50.746286Z","end":"2026-05-19T19:21:51.11498Z","steps":["trace[867940426] 'agreement among raft nodes before linearized reading' (duration: 368.216376ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:21:51.115053Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:21:50.746276Z","time spent":"368.761469ms","remote":"127.0.0.1:51866","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":27,"request content":"key:\"/registry/rabbitmq.com/permissions/\" range_end:\"/registry/rabbitmq.com/permissions0\" count_only:true "} {"level":"info","ts":"2026-05-19T19:21:51.297651Z","caller":"traceutil/trace.go:171","msg":"trace[1784963574] transaction","detail":"{read_only:false; response_revision:5000; number_of_response:1; }","duration":"170.564559ms","start":"2026-05-19T19:21:51.127054Z","end":"2026-05-19T19:21:51.297618Z","steps":["trace[1784963574] 'process raft request' (duration: 147.198478ms)","trace[1784963574] 'compare' (duration: 23.232397ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T19:21:51.299553Z","caller":"traceutil/trace.go:171","msg":"trace[1077892549] transaction","detail":"{read_only:false; response_revision:5001; number_of_response:1; }","duration":"167.896924ms","start":"2026-05-19T19:21:51.13163Z","end":"2026-05-19T19:21:51.299527Z","steps":["trace[1077892549] 'process raft request' (duration: 167.607977ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:21:51.299635Z","caller":"traceutil/trace.go:171","msg":"trace[72252916] transaction","detail":"{read_only:false; response_revision:5002; number_of_response:1; }","duration":"149.434112ms","start":"2026-05-19T19:21:51.150174Z","end":"2026-05-19T19:21:51.299608Z","steps":["trace[72252916] 'process raft request' (duration: 149.247638ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:21:51.299672Z","caller":"traceutil/trace.go:171","msg":"trace[832937515] transaction","detail":"{read_only:false; response_revision:5003; number_of_response:1; }","duration":"144.125355ms","start":"2026-05-19T19:21:51.155505Z","end":"2026-05-19T19:21:51.299631Z","steps":["trace[832937515] 'process raft request' (duration: 143.981911ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:21:51.65124Z","caller":"traceutil/trace.go:171","msg":"trace[286145301] transaction","detail":"{read_only:false; response_revision:5014; number_of_response:1; }","duration":"202.487054ms","start":"2026-05-19T19:21:51.448713Z","end":"2026-05-19T19:21:51.6512Z","steps":["trace[286145301] 'process raft request' (duration: 153.122561ms)","trace[286145301] 'compare' (duration: 49.138817ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T19:21:51.693542Z","caller":"traceutil/trace.go:171","msg":"trace[1831759234] linearizableReadLoop","detail":"{readStateIndex:5206; appliedIndex:5204; }","duration":"222.279468ms","start":"2026-05-19T19:21:51.471239Z","end":"2026-05-19T19:21:51.693518Z","steps":["trace[1831759234] 'read index received' (duration: 130.614811ms)","trace[1831759234] 'applied index is now lower than readState.Index' (duration: 91.663267ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T19:21:51.693659Z","caller":"traceutil/trace.go:171","msg":"trace[520324737] transaction","detail":"{read_only:false; response_revision:5015; number_of_response:1; }","duration":"231.241014ms","start":"2026-05-19T19:21:51.46241Z","end":"2026-05-19T19:21:51.693651Z","steps":["trace[520324737] 'process raft request' (duration: 230.984277ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:21:51.693944Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.320692ms","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-05-19T19:21:51.694016Z","caller":"traceutil/trace.go:171","msg":"trace[750734240] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:5015; }","duration":"210.469225ms","start":"2026-05-19T19:21:51.483528Z","end":"2026-05-19T19:21:51.693997Z","steps":["trace[750734240] 'agreement among raft nodes before linearized reading' (duration: 210.304511ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:21:51.694247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.002485ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-05674c6f-42aa-48a4-b265-a0742035415f\" ","response":"range_response_count:1 size:3601"} {"level":"info","ts":"2026-05-19T19:21:51.694288Z","caller":"traceutil/trace.go:171","msg":"trace[2116571493] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-05674c6f-42aa-48a4-b265-a0742035415f; range_end:; response_count:1; response_revision:5015; }","duration":"223.076608ms","start":"2026-05-19T19:21:51.4712Z","end":"2026-05-19T19:21:51.694277Z","steps":["trace[2116571493] 'agreement among raft nodes before linearized reading' (duration: 222.945184ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:21:51.694308Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.041643ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/storage-loki-0.18b10dced168c9b0\" ","response":"range_response_count:1 size:943"} {"level":"info","ts":"2026-05-19T19:21:51.694334Z","caller":"traceutil/trace.go:171","msg":"trace[1771995597] range","detail":"{range_begin:/registry/events/monitoring/storage-loki-0.18b10dced168c9b0; range_end:; response_count:1; response_revision:5015; }","duration":"139.118975ms","start":"2026-05-19T19:21:51.555207Z","end":"2026-05-19T19:21:51.694326Z","steps":["trace[1771995597] 'agreement among raft nodes before linearized reading' (duration: 138.995452ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:21:53.468015Z","caller":"traceutil/trace.go:171","msg":"trace[2132169261] transaction","detail":"{read_only:false; response_revision:5044; number_of_response:1; }","duration":"163.961141ms","start":"2026-05-19T19:21:53.304029Z","end":"2026-05-19T19:21:53.46799Z","steps":["trace[2132169261] 'process raft request' (duration: 163.786337ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:21:53.492499Z","caller":"traceutil/trace.go:171","msg":"trace[764826441] transaction","detail":"{read_only:false; response_revision:5046; number_of_response:1; }","duration":"186.565992ms","start":"2026-05-19T19:21:53.305909Z","end":"2026-05-19T19:21:53.492475Z","steps":["trace[764826441] 'process raft request' (duration: 186.520931ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:21:53.492631Z","caller":"traceutil/trace.go:171","msg":"trace[50634387] transaction","detail":"{read_only:false; response_revision:5045; number_of_response:1; }","duration":"187.689219ms","start":"2026-05-19T19:21:53.304888Z","end":"2026-05-19T19:21:53.492577Z","steps":["trace[50634387] 'process raft request' (duration: 187.408442ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:21:53.735536Z","caller":"traceutil/trace.go:171","msg":"trace[1016559572] linearizableReadLoop","detail":"{readStateIndex:5240; appliedIndex:5238; }","duration":"179.753378ms","start":"2026-05-19T19:21:53.555761Z","end":"2026-05-19T19:21:53.735515Z","steps":["trace[1016559572] 'read index received' (duration: 14.811645ms)","trace[1016559572] 'applied index is now lower than readState.Index' (duration: 164.940573ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T19:21:53.735593Z","caller":"traceutil/trace.go:171","msg":"trace[1028167182] transaction","detail":"{read_only:false; response_revision:5049; number_of_response:1; }","duration":"203.328164ms","start":"2026-05-19T19:21:53.532227Z","end":"2026-05-19T19:21:53.735555Z","steps":["trace[1028167182] 'process raft request' (duration: 163.991531ms)","trace[1028167182] 'compare' (duration: 39.20339ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T19:21:53.735772Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.986814ms","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-05-19T19:21:53.735831Z","caller":"traceutil/trace.go:171","msg":"trace[64215549] 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:5049; }","duration":"180.057755ms","start":"2026-05-19T19:21:53.555755Z","end":"2026-05-19T19:21:53.735813Z","steps":["trace[64215549] 'agreement among raft nodes before linearized reading' (duration: 179.83829ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:21:53.747291Z","caller":"traceutil/trace.go:171","msg":"trace[1807450611] transaction","detail":"{read_only:false; response_revision:5051; number_of_response:1; }","duration":"170.920797ms","start":"2026-05-19T19:21:53.576349Z","end":"2026-05-19T19:21:53.74727Z","steps":["trace[1807450611] 'process raft request' (duration: 170.807744ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:21:53.7473Z","caller":"traceutil/trace.go:171","msg":"trace[911883522] transaction","detail":"{read_only:false; response_revision:5052; number_of_response:1; }","duration":"170.036735ms","start":"2026-05-19T19:21:53.577247Z","end":"2026-05-19T19:21:53.747284Z","steps":["trace[911883522] 'process raft request' (duration: 169.962483ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:21:53.747293Z","caller":"traceutil/trace.go:171","msg":"trace[1644600628] transaction","detail":"{read_only:false; response_revision:5050; number_of_response:1; }","duration":"170.972218ms","start":"2026-05-19T19:21:53.576284Z","end":"2026-05-19T19:21:53.747256Z","steps":["trace[1644600628] 'process raft request' (duration: 170.743183ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:21:53.747508Z","caller":"traceutil/trace.go:171","msg":"trace[723413486] transaction","detail":"{read_only:false; response_revision:5053; number_of_response:1; }","duration":"170.136348ms","start":"2026-05-19T19:21:53.577349Z","end":"2026-05-19T19:21:53.747485Z","steps":["trace[723413486] 'process raft request' (duration: 169.902602ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:22:02.623252Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.371778ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-19T19:22:02.623588Z","caller":"traceutil/trace.go:171","msg":"trace[622913951] transaction","detail":"{read_only:false; response_revision:5232; number_of_response:1; }","duration":"208.756744ms","start":"2026-05-19T19:22:02.414797Z","end":"2026-05-19T19:22:02.623554Z","steps":["trace[622913951] 'process raft request' (duration: 52.023407ms)","trace[622913951] 'compare' (duration: 156.02291ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T19:22:02.624323Z","caller":"traceutil/trace.go:171","msg":"trace[317019422] transaction","detail":"{read_only:false; response_revision:5233; number_of_response:1; }","duration":"209.291467ms","start":"2026-05-19T19:22:02.414934Z","end":"2026-05-19T19:22:02.624226Z","steps":["trace[317019422] 'process raft request' (duration: 209.135793ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:22:02.792764Z","caller":"traceutil/trace.go:171","msg":"trace[779506866] transaction","detail":"{read_only:false; response_revision:5236; number_of_response:1; }","duration":"113.541752ms","start":"2026-05-19T19:22:02.679187Z","end":"2026-05-19T19:22:02.792729Z","steps":["trace[779506866] 'process raft request' (duration: 101.959194ms)","trace[779506866] 'compare' (duration: 11.357702ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T19:22:02.792865Z","caller":"traceutil/trace.go:171","msg":"trace[1197823468] transaction","detail":"{read_only:false; response_revision:5237; number_of_response:1; }","duration":"111.181095ms","start":"2026-05-19T19:22:02.681646Z","end":"2026-05-19T19:22:02.792827Z","steps":["trace[1197823468] 'process raft request' (duration: 110.994371ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:22:02.793058Z","caller":"traceutil/trace.go:171","msg":"trace[405190037] transaction","detail":"{read_only:false; response_revision:5238; number_of_response:1; }","duration":"109.021303ms","start":"2026-05-19T19:22:02.684014Z","end":"2026-05-19T19:22:02.793036Z","steps":["trace[405190037] 'process raft request' (duration: 108.675835ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:22:06.791529Z","caller":"traceutil/trace.go:171","msg":"trace[2128183826] transaction","detail":"{read_only:false; response_revision:5287; number_of_response:1; }","duration":"131.156934ms","start":"2026-05-19T19:22:06.660323Z","end":"2026-05-19T19:22:06.79148Z","steps":["trace[2128183826] 'process raft request' (duration: 130.931289ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:22:10.94336Z","caller":"traceutil/trace.go:171","msg":"trace[1528768252] linearizableReadLoop","detail":"{readStateIndex:5608; appliedIndex:5607; }","duration":"213.043027ms","start":"2026-05-19T19:22:10.730294Z","end":"2026-05-19T19:22:10.943337Z","steps":["trace[1528768252] 'read index received' (duration: 212.793781ms)","trace[1528768252] 'applied index is now lower than readState.Index' (duration: 248.236µs)"],"step_count":2} {"level":"info","ts":"2026-05-19T19:22:10.943434Z","caller":"traceutil/trace.go:171","msg":"trace[995396772] transaction","detail":"{read_only:false; response_revision:5406; number_of_response:1; }","duration":"250.507224ms","start":"2026-05-19T19:22:10.692889Z","end":"2026-05-19T19:22:10.943396Z","steps":["trace[995396772] 'process raft request' (duration: 250.295639ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:22:10.943608Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.297643ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"} {"level":"info","ts":"2026-05-19T19:22:10.943648Z","caller":"traceutil/trace.go:171","msg":"trace[486249049] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5406; }","duration":"213.397225ms","start":"2026-05-19T19:22:10.730241Z","end":"2026-05-19T19:22:10.943639Z","steps":["trace[486249049] 'agreement among raft nodes before linearized reading' (duration: 213.219401ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:22:10.943661Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.522678ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T19:22:10.943686Z","caller":"traceutil/trace.go:171","msg":"trace[615808845] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5406; }","duration":"155.589469ms","start":"2026-05-19T19:22:10.788089Z","end":"2026-05-19T19:22:10.943678Z","steps":["trace[615808845] 'agreement among raft nodes before linearized reading' (duration: 155.517257ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:22:11.063594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.096541ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:18611"} {"level":"info","ts":"2026-05-19T19:22:11.063658Z","caller":"traceutil/trace.go:171","msg":"trace[382910653] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:5406; }","duration":"113.170703ms","start":"2026-05-19T19:22:10.950472Z","end":"2026-05-19T19:22:11.063643Z","steps":["trace[382910653] 'range keys from in-memory index tree' (duration: 112.929757ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:22:11.933544Z","caller":"traceutil/trace.go:171","msg":"trace[1609925515] transaction","detail":"{read_only:false; response_revision:5411; number_of_response:1; }","duration":"379.776622ms","start":"2026-05-19T19:22:11.55372Z","end":"2026-05-19T19:22:11.933497Z","steps":["trace[1609925515] 'process raft request' (duration: 379.610148ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:22:11.933621Z","caller":"traceutil/trace.go:171","msg":"trace[527495316] transaction","detail":"{read_only:false; response_revision:5410; number_of_response:1; }","duration":"380.819738ms","start":"2026-05-19T19:22:11.552777Z","end":"2026-05-19T19:22:11.933597Z","steps":["trace[527495316] 'process raft request' (duration: 380.48412ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:22:11.933698Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:22:11.553709Z","time spent":"379.913155ms","remote":"127.0.0.1:49458","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T19:22:11.933725Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:22:11.552752Z","time spent":"380.917159ms","remote":"127.0.0.1:49458","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T19:22:11.933701Z","caller":"traceutil/trace.go:171","msg":"trace[1796075238] transaction","detail":"{read_only:false; response_revision:5409; number_of_response:1; }","duration":"409.763711ms","start":"2026-05-19T19:22:11.523882Z","end":"2026-05-19T19:22:11.933646Z","steps":["trace[1796075238] 'process raft request' (duration: 409.29863ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:22:11.93329Z","caller":"traceutil/trace.go:171","msg":"trace[931582995] transaction","detail":"{read_only:false; response_revision:5408; number_of_response:1; }","duration":"596.037606ms","start":"2026-05-19T19:22:11.337215Z","end":"2026-05-19T19:22:11.933252Z","steps":["trace[931582995] 'process raft request' (duration: 509.731839ms)","trace[931582995] 'compare' (duration: 85.706633ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T19:22:11.933964Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:22:11.523859Z","time spent":"409.983106ms","remote":"127.0.0.1:49458","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T19:22:11.934022Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:22:11.337198Z","time spent":"596.738123ms","remote":"127.0.0.1:43628","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T19:22:14.053782Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.455923ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/storage-loki-0\" ","response":"range_response_count:1 size:1781"} {"level":"warn","ts":"2026-05-19T19:22:14.053856Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.095129ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T19:22:14.053877Z","caller":"traceutil/trace.go:171","msg":"trace[738249519] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/storage-loki-0; range_end:; response_count:1; response_revision:5429; }","duration":"255.604046ms","start":"2026-05-19T19:22:13.798251Z","end":"2026-05-19T19:22:14.053855Z","steps":["trace[738249519] 'range keys from in-memory index tree' (duration: 255.259668ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:22:14.053924Z","caller":"traceutil/trace.go:171","msg":"trace[1569409448] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5429; }","duration":"266.214672ms","start":"2026-05-19T19:22:13.78769Z","end":"2026-05-19T19:22:14.053905Z","steps":["trace[1569409448] 'range keys from in-memory index tree' (duration: 266.009507ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:22:14.054122Z","caller":"traceutil/trace.go:171","msg":"trace[475591278] transaction","detail":"{read_only:false; response_revision:5430; number_of_response:1; }","duration":"114.498065ms","start":"2026-05-19T19:22:13.939593Z","end":"2026-05-19T19:22:14.054091Z","steps":["trace[475591278] 'process raft request' (duration: 108.992673ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:22:14.054132Z","caller":"traceutil/trace.go:171","msg":"trace[2059064494] transaction","detail":"{read_only:false; response_revision:5431; number_of_response:1; }","duration":"114.28707ms","start":"2026-05-19T19:22:13.93982Z","end":"2026-05-19T19:22:14.054108Z","steps":["trace[2059064494] 'process raft request' (duration: 114.103465ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:22:14.054292Z","caller":"traceutil/trace.go:171","msg":"trace[146181977] linearizableReadLoop","detail":"{readStateIndex:5635; appliedIndex:5632; }","duration":"107.906806ms","start":"2026-05-19T19:22:13.946363Z","end":"2026-05-19T19:22:14.05427Z","steps":["trace[146181977] 'read index received' (duration: 102.385864ms)","trace[146181977] 'applied index is now lower than readState.Index' (duration: 5.519072ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T19:22:14.054315Z","caller":"traceutil/trace.go:171","msg":"trace[280708954] transaction","detail":"{read_only:false; response_revision:5432; number_of_response:1; }","duration":"114.099025ms","start":"2026-05-19T19:22:13.940179Z","end":"2026-05-19T19:22:14.054278Z","steps":["trace[280708954] 'process raft request' (duration: 113.836648ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:22:14.054572Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.192493ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-05-19T19:22:14.054632Z","caller":"traceutil/trace.go:171","msg":"trace[1698776009] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5432; }","duration":"108.284286ms","start":"2026-05-19T19:22:13.946333Z","end":"2026-05-19T19:22:14.054617Z","steps":["trace[1698776009] 'agreement among raft nodes before linearized reading' (duration: 108.073381ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:22:14.054988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.938543ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-05-19T19:22:14.055277Z","caller":"traceutil/trace.go:171","msg":"trace[1967935144] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5432; }","duration":"107.162689ms","start":"2026-05-19T19:22:13.947929Z","end":"2026-05-19T19:22:14.055091Z","steps":["trace[1967935144] 'agreement among raft nodes before linearized reading' (duration: 106.660567ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:22:23.458406Z","caller":"traceutil/trace.go:171","msg":"trace[1564201208] transaction","detail":"{read_only:false; response_revision:5568; number_of_response:1; }","duration":"109.401432ms","start":"2026-05-19T19:22:23.348971Z","end":"2026-05-19T19:22:23.458372Z","steps":["trace[1564201208] 'process raft request' (duration: 109.014913ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:23:27.588664Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3018} {"level":"info","ts":"2026-05-19T19:23:27.673791Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3018,"took":"83.697896ms","hash":947586605,"current-db-size-bytes":58380288,"current-db-size":"58 MB","current-db-size-in-use-bytes":31469568,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-05-19T19:23:27.673869Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":947586605,"revision":3018,"compact-revision":-1} {"level":"info","ts":"2026-05-19T19:27:32.121701Z","caller":"traceutil/trace.go:171","msg":"trace[1924219952] transaction","detail":"{read_only:false; response_revision:7806; number_of_response:1; }","duration":"134.645228ms","start":"2026-05-19T19:27:31.987011Z","end":"2026-05-19T19:27:32.121656Z","steps":["trace[1924219952] 'process raft request' (duration: 134.579527ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:27:32.121762Z","caller":"traceutil/trace.go:171","msg":"trace[1427269286] transaction","detail":"{read_only:false; response_revision:7805; number_of_response:1; }","duration":"134.74447ms","start":"2026-05-19T19:27:31.986965Z","end":"2026-05-19T19:27:32.121709Z","steps":["trace[1427269286] 'process raft request' (duration: 125.597402ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:27:32.336864Z","caller":"traceutil/trace.go:171","msg":"trace[235460722] transaction","detail":"{read_only:false; response_revision:7807; number_of_response:1; }","duration":"138.671594ms","start":"2026-05-19T19:27:32.198155Z","end":"2026-05-19T19:27:32.336827Z","steps":["trace[235460722] 'process raft request' (duration: 47.087945ms)","trace[235460722] 'compare' (duration: 91.449416ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T19:27:44.458073Z","caller":"traceutil/trace.go:171","msg":"trace[23913296] transaction","detail":"{read_only:false; response_revision:7892; number_of_response:1; }","duration":"264.697555ms","start":"2026-05-19T19:27:44.193319Z","end":"2026-05-19T19:27:44.458017Z","steps":["trace[23913296] 'process raft request' (duration: 263.611509ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:27:44.902672Z","caller":"traceutil/trace.go:171","msg":"trace[79154264] linearizableReadLoop","detail":"{readStateIndex:8171; appliedIndex:8170; }","duration":"114.484406ms","start":"2026-05-19T19:27:44.78817Z","end":"2026-05-19T19:27:44.902655Z","steps":["trace[79154264] 'read index received' (duration: 114.353273ms)","trace[79154264] 'applied index is now lower than readState.Index' (duration: 130.563µs)"],"step_count":2} {"level":"info","ts":"2026-05-19T19:27:44.902702Z","caller":"traceutil/trace.go:171","msg":"trace[1453887301] transaction","detail":"{read_only:false; response_revision:7893; number_of_response:1; }","duration":"208.209445ms","start":"2026-05-19T19:27:44.694479Z","end":"2026-05-19T19:27:44.902688Z","steps":["trace[1453887301] 'process raft request' (duration: 208.079182ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:27:44.902859Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.64737ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T19:27:44.902966Z","caller":"traceutil/trace.go:171","msg":"trace[1568229151] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:7893; }","duration":"114.798164ms","start":"2026-05-19T19:27:44.788141Z","end":"2026-05-19T19:27:44.902939Z","steps":["trace[1568229151] 'agreement among raft nodes before linearized reading' (duration: 114.604119ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:27:46.248422Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11521226276576898895,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-19T19:27:46.748973Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11521226276576898895,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-19T19:27:47.249496Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11521226276576898895,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-19T19:27:47.276153Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.542981384s","expected-duration":"1s"} {"level":"info","ts":"2026-05-19T19:27:47.276564Z","caller":"traceutil/trace.go:171","msg":"trace[1224758096] transaction","detail":"{read_only:false; response_revision:7897; number_of_response:1; }","duration":"1.543463475s","start":"2026-05-19T19:27:45.733075Z","end":"2026-05-19T19:27:47.276539Z","steps":["trace[1224758096] 'process raft request' (duration: 1.543320311s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:27:47.276719Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:27:45.733053Z","time spent":"1.543588978s","remote":"127.0.0.1:49458","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T19:27:47.296522Z","caller":"traceutil/trace.go:171","msg":"trace[378211869] linearizableReadLoop","detail":"{readStateIndex:8178; appliedIndex:8174; }","duration":"1.54912828s","start":"2026-05-19T19:27:45.747375Z","end":"2026-05-19T19:27:47.296504Z","steps":["trace[378211869] 'read index received' (duration: 1.52905416s)","trace[378211869] 'applied index is now lower than readState.Index' (duration: 20.07313ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T19:27:47.296573Z","caller":"traceutil/trace.go:171","msg":"trace[914175884] transaction","detail":"{read_only:false; response_revision:7898; number_of_response:1; }","duration":"472.352428ms","start":"2026-05-19T19:27:46.824175Z","end":"2026-05-19T19:27:47.296528Z","steps":["trace[914175884] 'process raft request' (duration: 472.179264ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:27:47.296719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.549329445s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-05-19T19:27:47.296758Z","caller":"traceutil/trace.go:171","msg":"trace[88649217] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:7899; }","duration":"1.549409137s","start":"2026-05-19T19:27:45.747339Z","end":"2026-05-19T19:27:47.296748Z","steps":["trace[88649217] 'agreement among raft nodes before linearized reading' (duration: 1.549334285s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:27:47.296794Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:27:45.74732Z","time spent":"1.549466539s","remote":"127.0.0.1:49458","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-19T19:27:47.296873Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.508589461s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T19:27:47.296915Z","caller":"traceutil/trace.go:171","msg":"trace[1719933619] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:7899; }","duration":"1.508655363s","start":"2026-05-19T19:27:45.78825Z","end":"2026-05-19T19:27:47.296905Z","steps":["trace[1719933619] 'agreement among raft nodes before linearized reading' (duration: 1.508577482s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:27:47.296937Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:27:45.788238Z","time spent":"1.508695594s","remote":"127.0.0.1:43602","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-19T19:27:47.296802Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:27:46.82415Z","time spent":"472.544292ms","remote":"127.0.0.1:49458","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T19:27:47.297149Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"388.837432ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/barbican-ks-user\" ","response":"range_response_count:1 size:7328"} {"level":"info","ts":"2026-05-19T19:27:47.297175Z","caller":"traceutil/trace.go:171","msg":"trace[965634375] range","detail":"{range_begin:/registry/jobs/openstack/barbican-ks-user; range_end:; response_count:1; response_revision:7899; }","duration":"388.903034ms","start":"2026-05-19T19:27:46.908266Z","end":"2026-05-19T19:27:47.297169Z","steps":["trace[965634375] 'agreement among raft nodes before linearized reading' (duration: 388.809061ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:27:47.297193Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:27:46.908244Z","time spent":"388.944645ms","remote":"127.0.0.1:49420","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":7350,"request content":"key:\"/registry/jobs/openstack/barbican-ks-user\" "} {"level":"warn","ts":"2026-05-19T19:27:47.297279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.105635922s","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-05-19T19:27:47.296654Z","caller":"traceutil/trace.go:171","msg":"trace[1986590391] transaction","detail":"{read_only:false; response_revision:7899; number_of_response:1; }","duration":"388.76529ms","start":"2026-05-19T19:27:46.907878Z","end":"2026-05-19T19:27:47.296643Z","steps":["trace[1986590391] 'process raft request' (duration: 388.580886ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:27:47.297328Z","caller":"traceutil/trace.go:171","msg":"trace[48750277] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:7899; }","duration":"1.105719734s","start":"2026-05-19T19:27:46.191596Z","end":"2026-05-19T19:27:47.297316Z","steps":["trace[48750277] 'agreement among raft nodes before linearized reading' (duration: 1.10553016s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:27:47.297354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.192092488s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-05-19T19:27:47.297368Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:27:46.191576Z","time spent":"1.105785345s","remote":"127.0.0.1:49458","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-19T19:27:47.297416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.451170979s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-19T19:27:47.297433Z","caller":"traceutil/trace.go:171","msg":"trace[1009555461] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:7899; }","duration":"1.451224751s","start":"2026-05-19T19:27:45.846204Z","end":"2026-05-19T19:27:47.297428Z","steps":["trace[1009555461] 'agreement among raft nodes before linearized reading' (duration: 1.45118517s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:27:47.297452Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:27:45.846184Z","time spent":"1.451263221s","remote":"127.0.0.1:43722","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":12,"response size":29,"request content":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true "} {"level":"warn","ts":"2026-05-19T19:27:47.297411Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:27:46.907853Z","time spent":"389.495928ms","remote":"127.0.0.1:49458","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T19:27:47.297521Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"471.804325ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-19T19:27:47.297554Z","caller":"traceutil/trace.go:171","msg":"trace[1271691735] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:7899; }","duration":"471.863257ms","start":"2026-05-19T19:27:46.825682Z","end":"2026-05-19T19:27:47.297546Z","steps":["trace[1271691735] 'agreement among raft nodes before linearized reading' (duration: 471.760284ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:27:47.297585Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:27:46.825667Z","time spent":"471.911247ms","remote":"127.0.0.1:49550","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":99,"response size":29,"request content":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true "} {"level":"info","ts":"2026-05-19T19:27:47.297375Z","caller":"traceutil/trace.go:171","msg":"trace[342882503] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:7899; }","duration":"1.192149219s","start":"2026-05-19T19:27:46.10522Z","end":"2026-05-19T19:27:47.297369Z","steps":["trace[342882503] 'agreement among raft nodes before linearized reading' (duration: 1.192089868s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:27:47.29767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"923.456067ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:559"} {"level":"warn","ts":"2026-05-19T19:27:47.297677Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:27:46.1052Z","time spent":"1.192459976s","remote":"127.0.0.1:49458","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-19T19:27:47.297746Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"834.787899ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-05-19T19:27:47.297765Z","caller":"traceutil/trace.go:171","msg":"trace[851610180] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:7899; }","duration":"834.844431ms","start":"2026-05-19T19:27:46.462917Z","end":"2026-05-19T19:27:47.297761Z","steps":["trace[851610180] 'agreement among raft nodes before linearized reading' (duration: 834.79252ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:27:47.297698Z","caller":"traceutil/trace.go:171","msg":"trace[1338106887] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:7899; }","duration":"923.518739ms","start":"2026-05-19T19:27:46.374171Z","end":"2026-05-19T19:27:47.297689Z","steps":["trace[1338106887] 'agreement among raft nodes before linearized reading' (duration: 923.454358ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:27:47.297783Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:27:46.462894Z","time spent":"834.884881ms","remote":"127.0.0.1:49458","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-19T19:27:47.297802Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:27:46.374147Z","time spent":"923.641992ms","remote":"127.0.0.1:49458","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":581,"request content":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" "} {"level":"info","ts":"2026-05-19T19:27:49.430101Z","caller":"traceutil/trace.go:171","msg":"trace[130834445] linearizableReadLoop","detail":"{readStateIndex:8189; appliedIndex:8188; }","duration":"114.990708ms","start":"2026-05-19T19:27:49.315088Z","end":"2026-05-19T19:27:49.430079Z","steps":["trace[130834445] 'read index received' (duration: 114.826344ms)","trace[130834445] 'applied index is now lower than readState.Index' (duration: 161.004µs)"],"step_count":2} {"level":"info","ts":"2026-05-19T19:27:49.430279Z","caller":"traceutil/trace.go:171","msg":"trace[1838591901] transaction","detail":"{read_only:false; response_revision:7910; number_of_response:1; }","duration":"127.738733ms","start":"2026-05-19T19:27:49.30246Z","end":"2026-05-19T19:27:49.430199Z","steps":["trace[1838591901] 'process raft request' (duration: 127.449866ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:27:49.430314Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.208753ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-05-19T19:27:49.430552Z","caller":"traceutil/trace.go:171","msg":"trace[948355555] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:7910; }","duration":"115.48485ms","start":"2026-05-19T19:27:49.315049Z","end":"2026-05-19T19:27:49.430533Z","steps":["trace[948355555] 'agreement among raft nodes before linearized reading' (duration: 115.135732ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:27:49.439959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.062777ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-05-19T19:27:49.44005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.982192ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-05-19T19:27:49.440117Z","caller":"traceutil/trace.go:171","msg":"trace[1957772592] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:7913; }","duration":"116.092855ms","start":"2026-05-19T19:27:49.324007Z","end":"2026-05-19T19:27:49.4401Z","steps":["trace[1957772592] 'agreement among raft nodes before linearized reading' (duration: 115.969982ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:27:49.440033Z","caller":"traceutil/trace.go:171","msg":"trace[33355689] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:7913; }","duration":"117.179611ms","start":"2026-05-19T19:27:49.322837Z","end":"2026-05-19T19:27:49.440016Z","steps":["trace[33355689] 'agreement among raft nodes before linearized reading' (duration: 116.952595ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:27:49.440567Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.97029ms","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-05-19T19:27:49.440624Z","caller":"traceutil/trace.go:171","msg":"trace[702135155] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:7913; }","duration":"108.064463ms","start":"2026-05-19T19:27:49.332546Z","end":"2026-05-19T19:27:49.44061Z","steps":["trace[702135155] 'agreement among raft nodes before linearized reading' (duration: 107.307875ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:28:27.594794Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6106} {"level":"info","ts":"2026-05-19T19:28:27.697128Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6106,"took":"100.291816ms","hash":2492205609,"current-db-size-bytes":58380288,"current-db-size":"58 MB","current-db-size-in-use-bytes":23261184,"current-db-size-in-use":"23 MB"} {"level":"info","ts":"2026-05-19T19:28:27.697202Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2492205609,"revision":6106,"compact-revision":3018} {"level":"info","ts":"2026-05-19T19:28:32.791344Z","caller":"traceutil/trace.go:171","msg":"trace[1418387292] linearizableReadLoop","detail":"{readStateIndex:8611; appliedIndex:8610; }","duration":"446.9ms","start":"2026-05-19T19:28:32.34442Z","end":"2026-05-19T19:28:32.79132Z","steps":["trace[1418387292] 'read index received' (duration: 446.704465ms)","trace[1418387292] 'applied index is now lower than readState.Index' (duration: 194.595µs)"],"step_count":2} {"level":"info","ts":"2026-05-19T19:28:32.791435Z","caller":"traceutil/trace.go:171","msg":"trace[1209367728] transaction","detail":"{read_only:false; response_revision:8318; number_of_response:1; }","duration":"450.161357ms","start":"2026-05-19T19:28:32.341256Z","end":"2026-05-19T19:28:32.791417Z","steps":["trace[1209367728] 'process raft request' (duration: 449.932922ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:28:32.791531Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.553651ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/topicpermissions/\" range_end:\"/registry/rabbitmq.com/topicpermissions0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-19T19:28:32.791539Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:28:32.341232Z","time spent":"450.24117ms","remote":"127.0.0.1:49458","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T19:28:32.791581Z","caller":"traceutil/trace.go:171","msg":"trace[2104868397] range","detail":"{range_begin:/registry/rabbitmq.com/topicpermissions/; range_end:/registry/rabbitmq.com/topicpermissions0; response_count:0; response_revision:8318; }","duration":"369.657184ms","start":"2026-05-19T19:28:32.421911Z","end":"2026-05-19T19:28:32.791569Z","steps":["trace[2104868397] 'agreement among raft nodes before linearized reading' (duration: 369.545421ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:28:32.791626Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:28:32.421887Z","time spent":"369.726685ms","remote":"127.0.0.1:51894","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":0,"response size":27,"request content":"key:\"/registry/rabbitmq.com/topicpermissions/\" range_end:\"/registry/rabbitmq.com/topicpermissions0\" count_only:true "} {"level":"warn","ts":"2026-05-19T19:28:32.791786Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"447.31851ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:559"} {"level":"info","ts":"2026-05-19T19:28:32.791877Z","caller":"traceutil/trace.go:171","msg":"trace[2124397301] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:8318; }","duration":"447.486284ms","start":"2026-05-19T19:28:32.344367Z","end":"2026-05-19T19:28:32.791853Z","steps":["trace[2124397301] 'agreement among raft nodes before linearized reading' (duration: 447.086094ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:28:32.791958Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:28:32.344342Z","time spent":"447.603647ms","remote":"127.0.0.1:49458","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":581,"request content":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" "} {"level":"warn","ts":"2026-05-19T19:28:33.870947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.169098ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-19T19:28:33.87109Z","caller":"traceutil/trace.go:171","msg":"trace[2125748140] transaction","detail":"{read_only:false; response_revision:8322; number_of_response:1; }","duration":"216.900733ms","start":"2026-05-19T19:28:33.654159Z","end":"2026-05-19T19:28:33.87106Z","steps":["trace[2125748140] 'process raft request' (duration: 61.515849ms)","trace[2125748140] 'compare' (duration: 155.060196ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T19:28:34.033202Z","caller":"traceutil/trace.go:171","msg":"trace[1042326014] linearizableReadLoop","detail":"{readStateIndex:8618; appliedIndex:8614; }","duration":"333.275995ms","start":"2026-05-19T19:28:33.699896Z","end":"2026-05-19T19:28:34.033172Z","steps":["trace[1042326014] 'read index received' (duration: 15.754807ms)","trace[1042326014] 'applied index is now lower than readState.Index' (duration: 317.520058ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T19:28:34.033246Z","caller":"traceutil/trace.go:171","msg":"trace[1655548226] transaction","detail":"{read_only:false; response_revision:8323; number_of_response:1; }","duration":"379.037898ms","start":"2026-05-19T19:28:33.654173Z","end":"2026-05-19T19:28:34.033211Z","steps":["trace[1655548226] 'process raft request' (duration: 341.47112ms)","trace[1655548226] 'compare' (duration: 37.262401ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T19:28:34.033271Z","caller":"traceutil/trace.go:171","msg":"trace[810317162] transaction","detail":"{read_only:false; response_revision:8324; number_of_response:1; }","duration":"378.994447ms","start":"2026-05-19T19:28:33.654247Z","end":"2026-05-19T19:28:34.033241Z","steps":["trace[810317162] 'process raft request' (duration: 378.810862ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:28:34.033349Z","caller":"traceutil/trace.go:171","msg":"trace[455343210] transaction","detail":"{read_only:false; response_revision:8325; number_of_response:1; }","duration":"378.798272ms","start":"2026-05-19T19:28:33.654509Z","end":"2026-05-19T19:28:34.033307Z","steps":["trace[455343210] 'process raft request' (duration: 378.595537ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:28:34.033395Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:28:33.654145Z","time spent":"379.171751ms","remote":"127.0.0.1:49458","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T19:28:34.033492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.695549ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-05-19T19:28:34.033536Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.995187ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-05-19T19:28:34.033538Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:28:33.654498Z","time spent":"378.941025ms","remote":"127.0.0.1:49458","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T19:28:34.033568Z","caller":"traceutil/trace.go:171","msg":"trace[2067034456] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8325; }","duration":"302.040658ms","start":"2026-05-19T19:28:33.73152Z","end":"2026-05-19T19:28:34.03356Z","steps":["trace[2067034456] 'agreement among raft nodes before linearized reading' (duration: 301.899685ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:28:34.033551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.731646ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-6r9xm\" ","response":"range_response_count:1 size:6445"} {"level":"warn","ts":"2026-05-19T19:28:34.033587Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:28:33.731514Z","time spent":"302.069969ms","remote":"127.0.0.1:49458","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-19T19:28:34.033541Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.130227ms","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-05-19T19:28:34.033607Z","caller":"traceutil/trace.go:171","msg":"trace[113528741] range","detail":"{range_begin:/registry/pods/openstack/keepalived-6r9xm; range_end:; response_count:1; response_revision:8325; }","duration":"269.814488ms","start":"2026-05-19T19:28:33.763779Z","end":"2026-05-19T19:28:34.033593Z","steps":["trace[113528741] 'agreement among raft nodes before linearized reading' (duration: 269.624824ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:28:34.033637Z","caller":"traceutil/trace.go:171","msg":"trace[2083421729] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:8325; }","duration":"237.23107ms","start":"2026-05-19T19:28:33.796387Z","end":"2026-05-19T19:28:34.033618Z","steps":["trace[2083421729] 'agreement among raft nodes before linearized reading' (duration: 237.055105ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:28:34.03363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.001772ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-19T19:28:34.033678Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:28:33.654238Z","time spent":"379.09326ms","remote":"127.0.0.1:49458","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T19:28:34.033664Z","caller":"traceutil/trace.go:171","msg":"trace[1244308990] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8325; }","duration":"329.768471ms","start":"2026-05-19T19:28:33.70376Z","end":"2026-05-19T19:28:34.033528Z","steps":["trace[1244308990] 'agreement among raft nodes before linearized reading' (duration: 329.598986ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:28:34.033697Z","caller":"traceutil/trace.go:171","msg":"trace[149622812] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8325; }","duration":"244.091933ms","start":"2026-05-19T19:28:33.789588Z","end":"2026-05-19T19:28:34.03368Z","steps":["trace[149622812] 'agreement among raft nodes before linearized reading' (duration: 243.935349ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:28:34.033722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.691704ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-05-19T19:28:34.033764Z","caller":"traceutil/trace.go:171","msg":"trace[2052373003] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8325; }","duration":"302.772636ms","start":"2026-05-19T19:28:33.730978Z","end":"2026-05-19T19:28:34.033751Z","steps":["trace[2052373003] 'agreement among raft nodes before linearized reading' (duration: 302.630022ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:28:34.033766Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:28:33.70375Z","time spent":"329.999877ms","remote":"127.0.0.1:49458","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-19T19:28:34.033808Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:28:33.730958Z","time spent":"302.837297ms","remote":"127.0.0.1:49458","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-19T19:28:34.033772Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.161301ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-05-19T19:28:34.033921Z","caller":"traceutil/trace.go:171","msg":"trace[732775052] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8325; }","duration":"302.346816ms","start":"2026-05-19T19:28:33.731556Z","end":"2026-05-19T19:28:34.033902Z","steps":["trace[732775052] 'agreement among raft nodes before linearized reading' (duration: 301.971487ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:28:34.033978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"333.51176ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-19T19:28:34.03402Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:28:33.731536Z","time spent":"302.466988ms","remote":"127.0.0.1:49458","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-05-19T19:28:34.034099Z","caller":"traceutil/trace.go:171","msg":"trace[905283023] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:8325; }","duration":"334.248638ms","start":"2026-05-19T19:28:33.699833Z","end":"2026-05-19T19:28:34.034082Z","steps":["trace[905283023] 'agreement among raft nodes before linearized reading' (duration: 333.51565ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:28:34.034152Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:28:33.699812Z","time spent":"334.32759ms","remote":"127.0.0.1:49652","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":0,"response size":27,"request content":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" "} {"level":"info","ts":"2026-05-19T19:28:34.23496Z","caller":"traceutil/trace.go:171","msg":"trace[346233242] transaction","detail":"{read_only:false; response_revision:8327; number_of_response:1; }","duration":"196.851995ms","start":"2026-05-19T19:28:34.038085Z","end":"2026-05-19T19:28:34.234937Z","steps":["trace[346233242] 'process raft request' (duration: 196.638959ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:28:34.235282Z","caller":"traceutil/trace.go:171","msg":"trace[1683461501] transaction","detail":"{read_only:false; response_revision:8329; number_of_response:1; }","duration":"196.476075ms","start":"2026-05-19T19:28:34.038788Z","end":"2026-05-19T19:28:34.235264Z","steps":["trace[1683461501] 'process raft request' (duration: 196.335322ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:28:34.235281Z","caller":"traceutil/trace.go:171","msg":"trace[582686919] linearizableReadLoop","detail":"{readStateIndex:8621; appliedIndex:8618; }","duration":"196.659119ms","start":"2026-05-19T19:28:34.038597Z","end":"2026-05-19T19:28:34.235256Z","steps":["trace[582686919] 'read index received' (duration: 38.5265ms)","trace[582686919] 'applied index is now lower than readState.Index' (duration: 158.131549ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T19:28:34.235314Z","caller":"traceutil/trace.go:171","msg":"trace[1253423855] transaction","detail":"{read_only:false; response_revision:8328; number_of_response:1; }","duration":"197.10317ms","start":"2026-05-19T19:28:34.038164Z","end":"2026-05-19T19:28:34.235267Z","steps":["trace[1253423855] 'process raft request' (duration: 196.731142ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:28:34.235535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.698352ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"} {"level":"info","ts":"2026-05-19T19:28:34.23562Z","caller":"traceutil/trace.go:171","msg":"trace[349163717] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:8329; }","duration":"194.797635ms","start":"2026-05-19T19:28:34.040796Z","end":"2026-05-19T19:28:34.235594Z","steps":["trace[349163717] 'agreement among raft nodes before linearized reading' (duration: 194.605621ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:28:34.235748Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.131551ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:25 size:222790"} {"level":"info","ts":"2026-05-19T19:28:34.235813Z","caller":"traceutil/trace.go:171","msg":"trace[2048771537] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:25; response_revision:8329; }","duration":"197.238203ms","start":"2026-05-19T19:28:34.038561Z","end":"2026-05-19T19:28:34.235799Z","steps":["trace[2048771537] 'agreement among raft nodes before linearized reading' (duration: 196.812013ms)"],"step_count":1}