{"level":"warn","ts":"2026-04-20T14:18:29.893368Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-20T14:18:29.893505Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.174:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.174:2380","--initial-cluster=instance=https://199.19.213.174:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.174:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.174:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-04-20T14:18:29.893589Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-20T14:18:29.893623Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.174:2380"]} {"level":"info","ts":"2026-04-20T14:18:29.893658Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-20T14:18:29.894288Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.174:2379"]} {"level":"info","ts":"2026-04-20T14:18:29.894381Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.174:2380"],"listen-peer-urls":["https://199.19.213.174:2380"],"advertise-client-urls":["https://199.19.213.174:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.174:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.174:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-04-20T14:18:29.8987Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.091552ms"} {"level":"info","ts":"2026-04-20T14:18:29.906087Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"b3617fc4a93ad58b","cluster-id":"2f224b65169306de"} {"level":"info","ts":"2026-04-20T14:18:29.906219Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b3617fc4a93ad58b switched to configuration voters=()"} {"level":"info","ts":"2026-04-20T14:18:29.906258Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b3617fc4a93ad58b became follower at term 0"} {"level":"info","ts":"2026-04-20T14:18:29.906304Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft b3617fc4a93ad58b [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-20T14:18:29.906331Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b3617fc4a93ad58b became follower at term 1"} {"level":"info","ts":"2026-04-20T14:18:29.90639Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b3617fc4a93ad58b switched to configuration voters=(12925752888159557003)"} {"level":"warn","ts":"2026-04-20T14:18:29.913135Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-20T14:18:29.914704Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-20T14:18:29.916065Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-04-20T14:18:29.918897Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"b3617fc4a93ad58b","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-20T14:18:29.919069Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"b3617fc4a93ad58b","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-20T14:18:29.919345Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-20T14:18:29.91969Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-20T14:18:29.919706Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-20T14:18:29.920586Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b3617fc4a93ad58b switched to configuration voters=(12925752888159557003)"} {"level":"info","ts":"2026-04-20T14:18:29.920887Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"2f224b65169306de","local-member-id":"b3617fc4a93ad58b","added-peer-id":"b3617fc4a93ad58b","added-peer-peer-urls":["https://199.19.213.174:2380"]} {"level":"info","ts":"2026-04-20T14:18:29.925529Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-20T14:18:29.925802Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"b3617fc4a93ad58b","initial-advertise-peer-urls":["https://199.19.213.174:2380"],"listen-peer-urls":["https://199.19.213.174:2380"],"advertise-client-urls":["https://199.19.213.174:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.174:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-20T14:18:29.925836Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-20T14:18:29.92592Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.174:2380"} {"level":"info","ts":"2026-04-20T14:18:29.92594Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.174:2380"} {"level":"info","ts":"2026-04-20T14:18:30.407441Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b3617fc4a93ad58b is starting a new election at term 1"} {"level":"info","ts":"2026-04-20T14:18:30.407634Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b3617fc4a93ad58b became pre-candidate at term 1"} {"level":"info","ts":"2026-04-20T14:18:30.407744Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b3617fc4a93ad58b received MsgPreVoteResp from b3617fc4a93ad58b at term 1"} {"level":"info","ts":"2026-04-20T14:18:30.407816Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b3617fc4a93ad58b became candidate at term 2"} {"level":"info","ts":"2026-04-20T14:18:30.407852Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b3617fc4a93ad58b received MsgVoteResp from b3617fc4a93ad58b at term 2"} {"level":"info","ts":"2026-04-20T14:18:30.407899Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b3617fc4a93ad58b became leader at term 2"} {"level":"info","ts":"2026-04-20T14:18:30.407939Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: b3617fc4a93ad58b elected leader b3617fc4a93ad58b at term 2"} {"level":"info","ts":"2026-04-20T14:18:30.409228Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T14:18:30.41025Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"b3617fc4a93ad58b","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.174:2379]}","request-path":"/0/members/b3617fc4a93ad58b/attributes","cluster-id":"2f224b65169306de","publish-timeout":"7s"} {"level":"info","ts":"2026-04-20T14:18:30.410266Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-20T14:18:30.410383Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-20T14:18:30.410825Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-20T14:18:30.410878Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-20T14:18:30.413944Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.174:2379"} {"level":"info","ts":"2026-04-20T14:18:30.414171Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"2f224b65169306de","local-member-id":"b3617fc4a93ad58b","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T14:18:30.414373Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T14:18:30.414456Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T14:18:30.414754Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-20T14:19:00.7328Z","caller":"traceutil/trace.go:171","msg":"trace[1630507762] transaction","detail":"{read_only:false; response_revision:440; number_of_response:1; }","duration":"272.935135ms","start":"2026-04-20T14:19:00.459838Z","end":"2026-04-20T14:19:00.732773Z","steps":["trace[1630507762] 'process raft request' (duration: 265.657151ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:19:00.74517Z","caller":"traceutil/trace.go:171","msg":"trace[1786835708] linearizableReadLoop","detail":"{readStateIndex:461; appliedIndex:459; }","duration":"265.297712ms","start":"2026-04-20T14:19:00.479843Z","end":"2026-04-20T14:19:00.74514Z","steps":["trace[1786835708] 'read index received' (duration: 245.656239ms)","trace[1786835708] 'applied index is now lower than readState.Index' (duration: 19.640443ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T14:19:00.745287Z","caller":"traceutil/trace.go:171","msg":"trace[2054189846] transaction","detail":"{read_only:false; response_revision:441; number_of_response:1; }","duration":"283.198629ms","start":"2026-04-20T14:19:00.462056Z","end":"2026-04-20T14:19:00.745255Z","steps":["trace[2054189846] 'process raft request' (duration: 282.934212ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:19:00.745388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.499317ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T14:19:00.745434Z","caller":"traceutil/trace.go:171","msg":"trace[1451307831] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:441; }","duration":"265.62471ms","start":"2026-04-20T14:19:00.479799Z","end":"2026-04-20T14:19:00.745424Z","steps":["trace[1451307831] 'agreement among raft nodes before linearized reading' (duration: 265.488167ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:19:00.775832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.876949ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-20T14:19:00.775967Z","caller":"traceutil/trace.go:171","msg":"trace[336540751] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:442; }","duration":"224.057664ms","start":"2026-04-20T14:19:00.551878Z","end":"2026-04-20T14:19:00.775936Z","steps":["trace[336540751] 'agreement among raft nodes before linearized reading' (duration: 223.808818ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:19:00.775855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.225331ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T14:19:00.77612Z","caller":"traceutil/trace.go:171","msg":"trace[1670249260] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:442; }","duration":"179.453977ms","start":"2026-04-20T14:19:00.59657Z","end":"2026-04-20T14:19:00.776024Z","steps":["trace[1670249260] 'agreement among raft nodes before linearized reading' (duration: 179.19699ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:19:02.769222Z","caller":"traceutil/trace.go:171","msg":"trace[66750872] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"140.213276ms","start":"2026-04-20T14:19:02.62896Z","end":"2026-04-20T14:19:02.769174Z","steps":["trace[66750872] 'process raft request' (duration: 132.556206ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:19:02.769272Z","caller":"traceutil/trace.go:171","msg":"trace[1026620871] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"133.972114ms","start":"2026-04-20T14:19:02.635276Z","end":"2026-04-20T14:19:02.769248Z","steps":["trace[1026620871] 'process raft request' (duration: 133.798609ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:19:02.997146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.218089ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-20T14:19:02.997258Z","caller":"traceutil/trace.go:171","msg":"trace[563425855] transaction","detail":"{read_only:false; response_revision:506; number_of_response:1; }","duration":"152.906197ms","start":"2026-04-20T14:19:02.844333Z","end":"2026-04-20T14:19:02.997239Z","steps":["trace[563425855] 'process raft request' (duration: 37.995721ms)","trace[563425855] 'compare' (duration: 114.095885ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T14:19:02.99972Z","caller":"traceutil/trace.go:171","msg":"trace[1922857494] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"128.207093ms","start":"2026-04-20T14:19:02.871496Z","end":"2026-04-20T14:19:02.999703Z","steps":["trace[1922857494] 'process raft request' (duration: 128.0826ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:19:03.000163Z","caller":"traceutil/trace.go:171","msg":"trace[954583648] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"148.39156ms","start":"2026-04-20T14:19:02.851752Z","end":"2026-04-20T14:19:03.000143Z","steps":["trace[954583648] 'process raft request' (duration: 147.663891ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:19:03.00031Z","caller":"traceutil/trace.go:171","msg":"trace[1834141496] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"146.11132ms","start":"2026-04-20T14:19:02.854187Z","end":"2026-04-20T14:19:03.000298Z","steps":["trace[1834141496] 'process raft request' (duration: 145.33161ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:19:04.529504Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.164121ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-20T14:19:04.529601Z","caller":"traceutil/trace.go:171","msg":"trace[2121522543] linearizableReadLoop","detail":"{readStateIndex:569; appliedIndex:568; }","duration":"442.516088ms","start":"2026-04-20T14:19:04.087073Z","end":"2026-04-20T14:19:04.529589Z","steps":["trace[2121522543] 'read index received' (duration: 167.101401ms)","trace[2121522543] 'applied index is now lower than readState.Index' (duration: 275.413537ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T14:19:04.529706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"442.629851ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/backends.gateway.envoyproxy.io\" ","response":"range_response_count:1 size:18056"} {"level":"info","ts":"2026-04-20T14:19:04.529731Z","caller":"traceutil/trace.go:171","msg":"trace[1999607512] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/backends.gateway.envoyproxy.io; range_end:; response_count:1; response_revision:546; }","duration":"442.690053ms","start":"2026-04-20T14:19:04.087033Z","end":"2026-04-20T14:19:04.529723Z","steps":["trace[1999607512] 'agreement among raft nodes before linearized reading' (duration: 442.58709ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:19:04.529756Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:19:04.087013Z","time spent":"442.736863ms","remote":"127.0.0.1:56634","response type":"/etcdserverpb.KV/Range","request count":0,"request size":89,"response count":1,"response size":18079,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/backends.gateway.envoyproxy.io\" "} {"level":"info","ts":"2026-04-20T14:19:04.529834Z","caller":"traceutil/trace.go:171","msg":"trace[263115891] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"448.010969ms","start":"2026-04-20T14:19:04.081786Z","end":"2026-04-20T14:19:04.529797Z","steps":["trace[263115891] 'process raft request' (duration: 172.468778ms)","trace[263115891] 'compare' (duration: 275.018447ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T14:19:04.529992Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:19:04.081772Z","time spent":"448.133281ms","remote":"127.0.0.1:56634","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":15673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T14:19:09.270007Z","caller":"traceutil/trace.go:171","msg":"trace[88298705] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"225.809439ms","start":"2026-04-20T14:19:09.044178Z","end":"2026-04-20T14:19:09.269987Z","steps":["trace[88298705] 'process raft request' (duration: 225.645615ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:19:09.270447Z","caller":"traceutil/trace.go:171","msg":"trace[990974211] linearizableReadLoop","detail":"{readStateIndex:599; appliedIndex:599; }","duration":"181.928243ms","start":"2026-04-20T14:19:09.08851Z","end":"2026-04-20T14:19:09.270438Z","steps":["trace[990974211] 'read index received' (duration: 181.924903ms)","trace[990974211] 'applied index is now lower than readState.Index' (duration: 2.73µs)"],"step_count":2} {"level":"warn","ts":"2026-04-20T14:19:09.270526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.002865ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-20T14:19:09.270549Z","caller":"traceutil/trace.go:171","msg":"trace[1544194143] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:575; }","duration":"182.062157ms","start":"2026-04-20T14:19:09.08848Z","end":"2026-04-20T14:19:09.270542Z","steps":["trace[1544194143] 'agreement among raft nodes before linearized reading' (duration: 182.006165ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:19:10.09889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"750.222867ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-20T14:19:10.099133Z","caller":"traceutil/trace.go:171","msg":"trace[1405476582] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"855.823354ms","start":"2026-04-20T14:19:09.243291Z","end":"2026-04-20T14:19:10.099114Z","steps":["trace[1405476582] 'process raft request' (duration: 105.3055ms)","trace[1405476582] 'compare' (duration: 749.93646ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T14:19:10.099302Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:19:09.243267Z","time spent":"855.99708ms","remote":"127.0.0.1:56668","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036281,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T14:19:10.09938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"985.365845ms","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":"warn","ts":"2026-04-20T14:19:10.099391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"997.745476ms","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-04-20T14:19:10.099405Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"854.591866ms","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":"warn","ts":"2026-04-20T14:19:10.099448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"997.835619ms","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":"warn","ts":"2026-04-20T14:19:10.099469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"985.430666ms","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-04-20T14:19:10.099476Z","caller":"traceutil/trace.go:171","msg":"trace[740432364] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:577; }","duration":"997.875639ms","start":"2026-04-20T14:19:09.101594Z","end":"2026-04-20T14:19:10.099469Z","steps":["trace[740432364] 'agreement among raft nodes before linearized reading' (duration: 997.838409ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:19:10.099477Z","caller":"traceutil/trace.go:171","msg":"trace[837196102] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:577; }","duration":"854.647357ms","start":"2026-04-20T14:19:09.244795Z","end":"2026-04-20T14:19:10.099442Z","steps":["trace[837196102] 'agreement among raft nodes before linearized reading' (duration: 854.589225ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:19:10.099495Z","caller":"traceutil/trace.go:171","msg":"trace[221363190] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:577; }","duration":"985.464817ms","start":"2026-04-20T14:19:09.114021Z","end":"2026-04-20T14:19:10.099486Z","steps":["trace[221363190] 'agreement among raft nodes before linearized reading' (duration: 985.402735ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:19:10.099521Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:19:09.244789Z","time spent":"854.721708ms","remote":"127.0.0.1:54868","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:500 "} {"level":"warn","ts":"2026-04-20T14:19:10.099539Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:19:09.114017Z","time spent":"985.511898ms","remote":"127.0.0.1:54854","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:10000 "} {"level":"info","ts":"2026-04-20T14:19:10.099221Z","caller":"traceutil/trace.go:171","msg":"trace[1558727742] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"822.098664ms","start":"2026-04-20T14:19:09.277113Z","end":"2026-04-20T14:19:10.099212Z","steps":["trace[1558727742] 'process raft request' (duration: 821.874769ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:19:10.099861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"855.291183ms","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":"warn","ts":"2026-04-20T14:19:10.099353Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"997.89656ms","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":"warn","ts":"2026-04-20T14:19:10.099907Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:19:09.101587Z","time spent":"997.90712ms","remote":"127.0.0.1:54848","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:10000 "} {"level":"info","ts":"2026-04-20T14:19:10.09992Z","caller":"traceutil/trace.go:171","msg":"trace[239263029] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:577; }","duration":"855.349603ms","start":"2026-04-20T14:19:09.244545Z","end":"2026-04-20T14:19:10.099895Z","steps":["trace[239263029] 'agreement among raft nodes before linearized reading' (duration: 855.300992ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:19:10.099924Z","caller":"traceutil/trace.go:171","msg":"trace[1207864549] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:577; }","duration":"998.484974ms","start":"2026-04-20T14:19:09.101428Z","end":"2026-04-20T14:19:10.099913Z","steps":["trace[1207864549] 'agreement among raft nodes before linearized reading' (duration: 997.819177ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:19:10.099947Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:19:09.244532Z","time spent":"855.406836ms","remote":"127.0.0.1:54868","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:10000 "} {"level":"warn","ts":"2026-04-20T14:19:10.099963Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:19:09.101381Z","time spent":"998.567556ms","remote":"127.0.0.1:54848","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:500 "} {"level":"info","ts":"2026-04-20T14:19:10.099204Z","caller":"traceutil/trace.go:171","msg":"trace[1623972302] linearizableReadLoop","detail":"{readStateIndex:600; appliedIndex:599; }","duration":"828.714835ms","start":"2026-04-20T14:19:09.270468Z","end":"2026-04-20T14:19:10.099183Z","steps":["trace[1623972302] 'read index received' (duration: 78.006085ms)","trace[1623972302] 'applied index is now lower than readState.Index' (duration: 750.70717ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T14:19:10.100096Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:19:09.277096Z","time spent":"822.790981ms","remote":"127.0.0.1:56824","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T14:19:10.09941Z","caller":"traceutil/trace.go:171","msg":"trace[196999393] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:577; }","duration":"985.420336ms","start":"2026-04-20T14:19:09.113981Z","end":"2026-04-20T14:19:10.099402Z","steps":["trace[196999393] 'agreement among raft nodes before linearized reading' (duration: 985.262361ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:19:10.09935Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"984.921824ms","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-04-20T14:19:10.10023Z","caller":"traceutil/trace.go:171","msg":"trace[1665245550] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:577; }","duration":"985.830465ms","start":"2026-04-20T14:19:09.114392Z","end":"2026-04-20T14:19:10.100222Z","steps":["trace[1665245550] 'agreement among raft nodes before linearized reading' (duration: 984.837061ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:19:10.10026Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:19:09.114386Z","time spent":"985.865576ms","remote":"127.0.0.1:54854","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:500 "} {"level":"warn","ts":"2026-04-20T14:19:10.099772Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"855.170299ms","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-04-20T14:19:10.100362Z","caller":"traceutil/trace.go:171","msg":"trace[84029219] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:577; }","duration":"855.773533ms","start":"2026-04-20T14:19:09.244582Z","end":"2026-04-20T14:19:10.100355Z","steps":["trace[84029219] 'agreement among raft nodes before linearized reading' (duration: 855.163959ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:19:10.100384Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:19:09.244577Z","time spent":"855.799774ms","remote":"127.0.0.1:54868","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true "} {"level":"warn","ts":"2026-04-20T14:19:10.099833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"909.015238ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-20T14:19:10.100504Z","caller":"traceutil/trace.go:171","msg":"trace[561276671] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:577; }","duration":"909.719615ms","start":"2026-04-20T14:19:09.190778Z","end":"2026-04-20T14:19:10.100497Z","steps":["trace[561276671] 'agreement among raft nodes before linearized reading' (duration: 909.010108ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:19:10.100525Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:19:09.190763Z","time spent":"909.754135ms","remote":"127.0.0.1:56824","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-04-20T14:19:10.100187Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:19:09.113968Z","time spent":"986.208784ms","remote":"127.0.0.1:54854","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true "} {"level":"info","ts":"2026-04-20T14:19:10.099419Z","caller":"traceutil/trace.go:171","msg":"trace[587581416] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:577; }","duration":"997.788917ms","start":"2026-04-20T14:19:09.101622Z","end":"2026-04-20T14:19:10.099411Z","steps":["trace[587581416] 'agreement among raft nodes before linearized reading' (duration: 997.747996ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:19:10.100715Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:19:09.101618Z","time spent":"999.086568ms","remote":"127.0.0.1:54848","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-20T14:19:10.100963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"809.776905ms","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":"info","ts":"2026-04-20T14:19:10.100988Z","caller":"traceutil/trace.go:171","msg":"trace[1278438921] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:577; }","duration":"809.863386ms","start":"2026-04-20T14:19:09.291119Z","end":"2026-04-20T14:19:10.100982Z","steps":["trace[1278438921] 'agreement among raft nodes before linearized reading' (duration: 809.812255ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:19:10.101006Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:19:09.291097Z","time spent":"809.904398ms","remote":"127.0.0.1:54878","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 "} {"level":"warn","ts":"2026-04-20T14:19:10.10128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.778062ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T14:19:10.101306Z","caller":"traceutil/trace.go:171","msg":"trace[723507391] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:577; }","duration":"324.817953ms","start":"2026-04-20T14:19:09.776482Z","end":"2026-04-20T14:19:10.1013Z","steps":["trace[723507391] 'agreement among raft nodes before linearized reading' (duration: 324.769222ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:19:10.101333Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:19:09.776473Z","time spent":"324.846453ms","remote":"127.0.0.1:43504","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:10000 "} {"level":"warn","ts":"2026-04-20T14:19:10.101326Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"657.770829ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T14:19:10.101377Z","caller":"traceutil/trace.go:171","msg":"trace[181040311] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:577; }","duration":"657.84467ms","start":"2026-04-20T14:19:09.443517Z","end":"2026-04-20T14:19:10.101362Z","steps":["trace[181040311] 'agreement among raft nodes before linearized reading' (duration: 657.747428ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:19:10.101417Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:19:09.443513Z","time spent":"657.896741ms","remote":"127.0.0.1:54926","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-20T14:19:10.10147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"657.965804ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T14:19:10.101494Z","caller":"traceutil/trace.go:171","msg":"trace[2034441542] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:577; }","duration":"658.011844ms","start":"2026-04-20T14:19:09.443476Z","end":"2026-04-20T14:19:10.101488Z","steps":["trace[2034441542] 'agreement among raft nodes before linearized reading' (duration: 657.947523ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:19:10.101512Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:19:09.44346Z","time spent":"658.047156ms","remote":"127.0.0.1:54926","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-04-20T14:19:10.101548Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.08279ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T14:19:10.101575Z","caller":"traceutil/trace.go:171","msg":"trace[1421768176] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:577; }","duration":"325.10992ms","start":"2026-04-20T14:19:09.776457Z","end":"2026-04-20T14:19:10.101567Z","steps":["trace[1421768176] 'agreement among raft nodes before linearized reading' (duration: 325.071779ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:19:10.101594Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:19:09.776412Z","time spent":"325.177272ms","remote":"127.0.0.1:43504","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true "} {"level":"warn","ts":"2026-04-20T14:19:10.101604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"713.207916ms","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":"info","ts":"2026-04-20T14:19:10.101623Z","caller":"traceutil/trace.go:171","msg":"trace[1502210103] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:577; }","duration":"713.243117ms","start":"2026-04-20T14:19:09.388373Z","end":"2026-04-20T14:19:10.101616Z","steps":["trace[1502210103] 'agreement among raft nodes before linearized reading' (duration: 713.214437ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:19:10.10164Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:19:09.388367Z","time spent":"713.268658ms","remote":"127.0.0.1:54912","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:500 "} {"level":"warn","ts":"2026-04-20T14:19:10.101687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.34377ms","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":"info","ts":"2026-04-20T14:19:10.101714Z","caller":"traceutil/trace.go:171","msg":"trace[1677645535] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:577; }","duration":"340.401781ms","start":"2026-04-20T14:19:09.761306Z","end":"2026-04-20T14:19:10.101708Z","steps":["trace[1677645535] 'agreement among raft nodes before linearized reading' (duration: 340.363881ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:19:10.101739Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"714.263512ms","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-04-20T14:19:10.101744Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:19:09.761287Z","time spent":"340.440742ms","remote":"127.0.0.1:43498","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:500 "} {"level":"info","ts":"2026-04-20T14:19:10.101761Z","caller":"traceutil/trace.go:171","msg":"trace[1972267888] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:577; }","duration":"714.302494ms","start":"2026-04-20T14:19:09.387453Z","end":"2026-04-20T14:19:10.101755Z","steps":["trace[1972267888] 'agreement among raft nodes before linearized reading' (duration: 714.270353ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:19:10.101778Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:19:09.387443Z","time spent":"714.331524ms","remote":"127.0.0.1:54912","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-20T14:19:10.101844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.657823ms","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":"warn","ts":"2026-04-20T14:19:10.101865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"714.389335ms","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":"info","ts":"2026-04-20T14:19:10.101868Z","caller":"traceutil/trace.go:171","msg":"trace[1369522750] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:577; }","duration":"341.682633ms","start":"2026-04-20T14:19:09.760179Z","end":"2026-04-20T14:19:10.101862Z","steps":["trace[1369522750] 'agreement among raft nodes before linearized reading' (duration: 341.643402ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:19:10.101882Z","caller":"traceutil/trace.go:171","msg":"trace[2104507708] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:577; }","duration":"714.430687ms","start":"2026-04-20T14:19:09.387447Z","end":"2026-04-20T14:19:10.101877Z","steps":["trace[2104507708] 'agreement among raft nodes before linearized reading' (duration: 714.401786ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:19:10.101887Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:19:09.760161Z","time spent":"341.720624ms","remote":"127.0.0.1:43498","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true "} {"level":"warn","ts":"2026-04-20T14:19:10.101907Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:19:09.38743Z","time spent":"714.470007ms","remote":"127.0.0.1:54912","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-04-20T14:19:10.101969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.815577ms","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":"info","ts":"2026-04-20T14:19:10.101991Z","caller":"traceutil/trace.go:171","msg":"trace[871366730] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:577; }","duration":"342.019951ms","start":"2026-04-20T14:19:09.759965Z","end":"2026-04-20T14:19:10.101985Z","steps":["trace[871366730] 'agreement among raft nodes before linearized reading' (duration: 341.98839ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:19:10.10201Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:19:09.759948Z","time spent":"342.055572ms","remote":"127.0.0.1:43498","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:10000 "} {"level":"warn","ts":"2026-04-20T14:19:10.102034Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"758.347593ms","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":"info","ts":"2026-04-20T14:19:10.102064Z","caller":"traceutil/trace.go:171","msg":"trace[924758700] 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:577; }","duration":"758.388025ms","start":"2026-04-20T14:19:09.343664Z","end":"2026-04-20T14:19:10.102052Z","steps":["trace[924758700] 'agreement among raft nodes before linearized reading' (duration: 758.351074ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:19:10.102089Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:19:09.343656Z","time spent":"758.427636ms","remote":"127.0.0.1:54902","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 "} {"level":"warn","ts":"2026-04-20T14:19:10.102099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"392.777167ms","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-04-20T14:19:10.102125Z","caller":"traceutil/trace.go:171","msg":"trace[2042491123] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:577; }","duration":"392.828147ms","start":"2026-04-20T14:19:09.709292Z","end":"2026-04-20T14:19:10.10212Z","steps":["trace[2042491123] 'agreement among raft nodes before linearized reading' (duration: 392.786446ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:19:10.102147Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:19:09.709282Z","time spent":"392.859978ms","remote":"127.0.0.1:43490","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:500 "} {"level":"warn","ts":"2026-04-20T14:19:10.102264Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"758.813446ms","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":"warn","ts":"2026-04-20T14:19:10.102269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"393.669468ms","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":"info","ts":"2026-04-20T14:19:10.102289Z","caller":"traceutil/trace.go:171","msg":"trace[1812878452] 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:577; }","duration":"758.841596ms","start":"2026-04-20T14:19:09.343442Z","end":"2026-04-20T14:19:10.102284Z","steps":["trace[1812878452] 'agreement among raft nodes before linearized reading' (duration: 758.799435ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:19:10.102292Z","caller":"traceutil/trace.go:171","msg":"trace[1946426365] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:577; }","duration":"393.737489ms","start":"2026-04-20T14:19:09.708548Z","end":"2026-04-20T14:19:10.102286Z","steps":["trace[1946426365] 'agreement among raft nodes before linearized reading' (duration: 393.696278ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:19:10.102312Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:19:09.70851Z","time spent":"393.796831ms","remote":"127.0.0.1:43492","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"warn","ts":"2026-04-20T14:19:10.102419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"394.037686ms","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-04-20T14:19:10.102437Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:19:09.343424Z","time spent":"758.880328ms","remote":"127.0.0.1:54902","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 "} {"level":"info","ts":"2026-04-20T14:19:10.102447Z","caller":"traceutil/trace.go:171","msg":"trace[1256662068] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:577; }","duration":"394.066647ms","start":"2026-04-20T14:19:09.708375Z","end":"2026-04-20T14:19:10.102441Z","steps":["trace[1256662068] 'agreement among raft nodes before linearized reading' (duration: 394.027806ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:19:10.102466Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:19:09.708335Z","time spent":"394.126208ms","remote":"127.0.0.1:43492","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 "} {"level":"warn","ts":"2026-04-20T14:19:10.102536Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"759.122833ms","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":"info","ts":"2026-04-20T14:19:10.102558Z","caller":"traceutil/trace.go:171","msg":"trace[271756030] 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:577; }","duration":"759.170625ms","start":"2026-04-20T14:19:09.343382Z","end":"2026-04-20T14:19:10.102553Z","steps":["trace[271756030] 'agreement among raft nodes before linearized reading' (duration: 759.136694ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:19:10.102579Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:19:09.343366Z","time spent":"759.205385ms","remote":"127.0.0.1:54902","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true "} {"level":"warn","ts":"2026-04-20T14:19:10.10263Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"641.114784ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T14:19:10.102685Z","caller":"traceutil/trace.go:171","msg":"trace[584721495] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:577; }","duration":"641.200075ms","start":"2026-04-20T14:19:09.46147Z","end":"2026-04-20T14:19:10.10267Z","steps":["trace[584721495] 'agreement among raft nodes before linearized reading' (duration: 641.104743ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:19:10.102726Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:19:09.461463Z","time spent":"641.252516ms","remote":"127.0.0.1:54930","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-20T14:19:10.102784Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"780.849731ms","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-04-20T14:19:10.102785Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"640.683003ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-20T14:19:10.102844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"781.857585ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T14:19:10.102868Z","caller":"traceutil/trace.go:171","msg":"trace[1539547061] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:577; }","duration":"781.890136ms","start":"2026-04-20T14:19:09.32097Z","end":"2026-04-20T14:19:10.10286Z","steps":["trace[1539547061] 'agreement among raft nodes before linearized reading' (duration: 781.859295ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:19:10.102813Z","caller":"traceutil/trace.go:171","msg":"trace[651827108] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:577; }","duration":"780.903873ms","start":"2026-04-20T14:19:09.321903Z","end":"2026-04-20T14:19:10.102807Z","steps":["trace[651827108] 'agreement among raft nodes before linearized reading' (duration: 780.80286ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:19:10.102875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"512.329922ms","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-04-20T14:19:10.102889Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:19:09.320963Z","time spent":"781.921266ms","remote":"127.0.0.1:54890","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"info","ts":"2026-04-20T14:19:10.102903Z","caller":"traceutil/trace.go:171","msg":"trace[337404652] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:577; }","duration":"512.392694ms","start":"2026-04-20T14:19:09.590504Z","end":"2026-04-20T14:19:10.102897Z","steps":["trace[337404652] 'agreement among raft nodes before linearized reading' (duration: 512.350703ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:19:10.102902Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:19:09.321888Z","time spent":"781.004755ms","remote":"127.0.0.1:54890","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:500 "} {"level":"warn","ts":"2026-04-20T14:19:10.102903Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"641.639986ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-20T14:19:10.102924Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:19:09.590488Z","time spent":"512.430624ms","remote":"127.0.0.1:43490","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"info","ts":"2026-04-20T14:19:10.102941Z","caller":"traceutil/trace.go:171","msg":"trace[1080553930] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:577; }","duration":"641.707207ms","start":"2026-04-20T14:19:09.461221Z","end":"2026-04-20T14:19:10.102929Z","steps":["trace[1080553930] 'agreement among raft nodes before linearized reading' (duration: 641.651246ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:19:10.102986Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:19:09.461205Z","time spent":"641.770649ms","remote":"127.0.0.1:54930","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-04-20T14:19:10.10302Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"811.783663ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T14:19:10.103042Z","caller":"traceutil/trace.go:171","msg":"trace[2071912353] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:577; }","duration":"811.808564ms","start":"2026-04-20T14:19:09.291228Z","end":"2026-04-20T14:19:10.103036Z","steps":["trace[2071912353] 'agreement among raft nodes before linearized reading' (duration: 811.775083ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:19:10.103059Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:19:09.291193Z","time spent":"811.860965ms","remote":"127.0.0.1:54878","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"warn","ts":"2026-04-20T14:19:10.103131Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"659.384927ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-20T14:19:10.101277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.724591ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T14:19:10.103166Z","caller":"traceutil/trace.go:171","msg":"trace[286743502] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:577; }","duration":"659.430449ms","start":"2026-04-20T14:19:09.443726Z","end":"2026-04-20T14:19:10.103156Z","steps":["trace[286743502] 'agreement among raft nodes before linearized reading' (duration: 659.369397ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:19:10.103186Z","caller":"traceutil/trace.go:171","msg":"trace[821580027] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:577; }","duration":"326.643797ms","start":"2026-04-20T14:19:09.776535Z","end":"2026-04-20T14:19:10.103178Z","steps":["trace[821580027] 'agreement among raft nodes before linearized reading' (duration: 324.6989ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:19:10.103165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"512.876575ms","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-04-20T14:19:10.103196Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:19:09.443721Z","time spent":"659.4664ms","remote":"127.0.0.1:54926","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:500 "} {"level":"warn","ts":"2026-04-20T14:19:10.103213Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:19:09.776506Z","time spent":"326.699229ms","remote":"127.0.0.1:43504","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:500 "} {"level":"info","ts":"2026-04-20T14:19:10.103216Z","caller":"traceutil/trace.go:171","msg":"trace[99224401] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:577; }","duration":"512.957507ms","start":"2026-04-20T14:19:09.590251Z","end":"2026-04-20T14:19:10.103208Z","steps":["trace[99224401] 'agreement among raft nodes before linearized reading' (duration: 512.887185ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:19:10.103264Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:19:09.590234Z","time spent":"513.021928ms","remote":"127.0.0.1:43490","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 "} {"level":"warn","ts":"2026-04-20T14:19:10.102992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"782.252035ms","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-04-20T14:19:10.103314Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.673518ms","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-04-20T14:19:10.103359Z","caller":"traceutil/trace.go:171","msg":"trace[1868617361] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:577; }","duration":"782.653294ms","start":"2026-04-20T14:19:09.320696Z","end":"2026-04-20T14:19:10.103349Z","steps":["trace[1868617361] 'agreement among raft nodes before linearized reading' (duration: 782.279336ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:19:10.103394Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:19:09.320667Z","time spent":"782.715945ms","remote":"127.0.0.1:54890","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 "} {"level":"info","ts":"2026-04-20T14:19:10.103405Z","caller":"traceutil/trace.go:171","msg":"trace[275460776] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:577; }","duration":"143.759741ms","start":"2026-04-20T14:19:09.95962Z","end":"2026-04-20T14:19:10.10338Z","steps":["trace[275460776] 'agreement among raft nodes before linearized reading' (duration: 143.651929ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:19:10.103057Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.400512ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T14:19:10.103464Z","caller":"traceutil/trace.go:171","msg":"trace[917377004] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:577; }","duration":"143.809462ms","start":"2026-04-20T14:19:09.95964Z","end":"2026-04-20T14:19:10.10345Z","steps":["trace[917377004] 'agreement among raft nodes before linearized reading' (duration: 143.399062ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:19:10.103593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.96604ms","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-04-20T14:19:10.102862Z","caller":"traceutil/trace.go:171","msg":"trace[932369864] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:577; }","duration":"640.841566ms","start":"2026-04-20T14:19:09.461996Z","end":"2026-04-20T14:19:10.102838Z","steps":["trace[932369864] 'agreement among raft nodes before linearized reading' (duration: 640.524969ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:19:10.103626Z","caller":"traceutil/trace.go:171","msg":"trace[1815364702] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:577; }","duration":"275.009202ms","start":"2026-04-20T14:19:09.828609Z","end":"2026-04-20T14:19:10.103618Z","steps":["trace[1815364702] 'agreement among raft nodes before linearized reading' (duration: 274.960831ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:19:10.103631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.582655ms","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-04-20T14:19:10.103648Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:19:09.461972Z","time spent":"641.664566ms","remote":"127.0.0.1:54930","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:500 "} {"level":"info","ts":"2026-04-20T14:19:10.103668Z","caller":"traceutil/trace.go:171","msg":"trace[558289947] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:577; }","duration":"298.767699ms","start":"2026-04-20T14:19:09.804878Z","end":"2026-04-20T14:19:10.103646Z","steps":["trace[558289947] 'agreement among raft nodes before linearized reading' (duration: 298.737829ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:19:10.103862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.386664ms","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":"warn","ts":"2026-04-20T14:19:10.10387Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.430341ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T14:19:10.103901Z","caller":"traceutil/trace.go:171","msg":"trace[2093465896] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:577; }","duration":"117.457961ms","start":"2026-04-20T14:19:09.986432Z","end":"2026-04-20T14:19:10.10389Z","steps":["trace[2093465896] 'agreement among raft nodes before linearized reading' (duration: 117.42218ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:19:10.10394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.735242ms","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":"warn","ts":"2026-04-20T14:19:10.103996Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.574495ms","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-04-20T14:19:10.104016Z","caller":"traceutil/trace.go:171","msg":"trace[301861491] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:577; }","duration":"117.596975ms","start":"2026-04-20T14:19:09.986414Z","end":"2026-04-20T14:19:10.104011Z","steps":["trace[301861491] 'agreement among raft nodes before linearized reading' (duration: 117.565134ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:19:10.10401Z","caller":"traceutil/trace.go:171","msg":"trace[1802122509] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:577; }","duration":"299.827665ms","start":"2026-04-20T14:19:09.804175Z","end":"2026-04-20T14:19:10.104002Z","steps":["trace[1802122509] 'agreement among raft nodes before linearized reading' (duration: 299.744603ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:19:10.10389Z","caller":"traceutil/trace.go:171","msg":"trace[1110832522] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:577; }","duration":"299.441235ms","start":"2026-04-20T14:19:09.804441Z","end":"2026-04-20T14:19:10.103883Z","steps":["trace[1110832522] 'agreement among raft nodes before linearized reading' (duration: 299.388924ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:19:10.10413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.284815ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-20T14:19:10.104139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.518599ms","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":"info","ts":"2026-04-20T14:19:10.104164Z","caller":"traceutil/trace.go:171","msg":"trace[1390891641] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:577; }","duration":"242.332507ms","start":"2026-04-20T14:19:09.861822Z","end":"2026-04-20T14:19:10.104154Z","steps":["trace[1390891641] 'agreement among raft nodes before linearized reading' (duration: 242.268805ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:19:10.10418Z","caller":"traceutil/trace.go:171","msg":"trace[890374642] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:577; }","duration":"144.57335ms","start":"2026-04-20T14:19:09.959586Z","end":"2026-04-20T14:19:10.10416Z","steps":["trace[890374642] 'agreement among raft nodes before linearized reading' (duration: 144.426636ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:19:10.104332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.624074ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-20T14:19:10.103602Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.007551ms","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":"info","ts":"2026-04-20T14:19:10.104394Z","caller":"traceutil/trace.go:171","msg":"trace[46231889] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:577; }","duration":"275.819471ms","start":"2026-04-20T14:19:09.828566Z","end":"2026-04-20T14:19:10.104385Z","steps":["trace[46231889] 'agreement among raft nodes before linearized reading' (duration: 275.012592ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:19:10.104391Z","caller":"traceutil/trace.go:171","msg":"trace[1277022280] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:577; }","duration":"203.685737ms","start":"2026-04-20T14:19:09.900689Z","end":"2026-04-20T14:19:10.104374Z","steps":["trace[1277022280] 'agreement among raft nodes before linearized reading' (duration: 203.616985ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:19:10.104432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.680725ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T14:19:10.10446Z","caller":"traceutil/trace.go:171","msg":"trace[1783557655] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:577; }","duration":"242.732166ms","start":"2026-04-20T14:19:09.861721Z","end":"2026-04-20T14:19:10.104453Z","steps":["trace[1783557655] 'agreement among raft nodes before linearized reading' (duration: 242.686835ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:19:10.104499Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.856302ms","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":"info","ts":"2026-04-20T14:19:10.104529Z","caller":"traceutil/trace.go:171","msg":"trace[1443950623] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:577; }","duration":"275.883592ms","start":"2026-04-20T14:19:09.828635Z","end":"2026-04-20T14:19:10.104519Z","steps":["trace[1443950623] 'agreement among raft nodes before linearized reading' (duration: 275.838411ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:19:10.1046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.916702ms","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":"info","ts":"2026-04-20T14:19:10.104638Z","caller":"traceutil/trace.go:171","msg":"trace[767818267] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:577; }","duration":"203.975013ms","start":"2026-04-20T14:19:09.900654Z","end":"2026-04-20T14:19:10.104629Z","steps":["trace[767818267] 'agreement among raft nodes before linearized reading' (duration: 203.912151ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:19:10.104771Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.9162ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T14:19:10.104827Z","caller":"traceutil/trace.go:171","msg":"trace[398466109] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:577; }","duration":"242.982002ms","start":"2026-04-20T14:19:09.861835Z","end":"2026-04-20T14:19:10.104817Z","steps":["trace[398466109] 'agreement among raft nodes before linearized reading' (duration: 242.90529ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:19:26.890644Z","caller":"traceutil/trace.go:171","msg":"trace[667467837] linearizableReadLoop","detail":"{readStateIndex:775; appliedIndex:774; }","duration":"289.376288ms","start":"2026-04-20T14:19:26.60124Z","end":"2026-04-20T14:19:26.890616Z","steps":["trace[667467837] 'read index received' (duration: 289.149113ms)","trace[667467837] 'applied index is now lower than readState.Index' (duration: 225.795µs)"],"step_count":2} {"level":"info","ts":"2026-04-20T14:19:26.890723Z","caller":"traceutil/trace.go:171","msg":"trace[1472772073] transaction","detail":"{read_only:false; response_revision:747; number_of_response:1; }","duration":"410.180785ms","start":"2026-04-20T14:19:26.480492Z","end":"2026-04-20T14:19:26.890673Z","steps":["trace[1472772073] 'process raft request' (duration: 409.95432ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:19:26.890797Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.533152ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T14:19:26.890854Z","caller":"traceutil/trace.go:171","msg":"trace[1676102446] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:747; }","duration":"289.638554ms","start":"2026-04-20T14:19:26.6012Z","end":"2026-04-20T14:19:26.890838Z","steps":["trace[1676102446] 'agreement among raft nodes before linearized reading' (duration: 289.534782ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:19:26.890882Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:19:26.480469Z","time spent":"410.332089ms","remote":"127.0.0.1:56824","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T14:19:45.454506Z","caller":"traceutil/trace.go:171","msg":"trace[1582636187] transaction","detail":"{read_only:false; response_revision:1047; number_of_response:1; }","duration":"110.659675ms","start":"2026-04-20T14:19:45.343804Z","end":"2026-04-20T14:19:45.454464Z","steps":["trace[1582636187] 'process raft request' (duration: 45.244803ms)","trace[1582636187] 'compare' (duration: 64.888143ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T14:20:13.431157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.702471ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/ingress-nginx/ingress-nginx-admission-create-dgb24\" ","response":"range_response_count:1 size:4197"} {"level":"info","ts":"2026-04-20T14:20:13.43127Z","caller":"traceutil/trace.go:171","msg":"trace[1571144239] range","detail":"{range_begin:/registry/pods/ingress-nginx/ingress-nginx-admission-create-dgb24; range_end:; response_count:1; response_revision:1285; }","duration":"115.822832ms","start":"2026-04-20T14:20:13.315395Z","end":"2026-04-20T14:20:13.431218Z","steps":["trace[1571144239] 'range keys from in-memory index tree' (duration: 115.503958ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:20:46.281984Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"360.176871ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-20T14:20:46.282113Z","caller":"traceutil/trace.go:171","msg":"trace[239102490] linearizableReadLoop","detail":"{readStateIndex:1894; appliedIndex:1893; }","duration":"288.2304ms","start":"2026-04-20T14:20:45.993862Z","end":"2026-04-20T14:20:46.282093Z","steps":["trace[239102490] 'read index received' (duration: 47.01µs)","trace[239102490] 'applied index is now lower than readState.Index' (duration: 288.18155ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T14:20:46.282355Z","caller":"traceutil/trace.go:171","msg":"trace[2042141037] transaction","detail":"{read_only:false; response_revision:1821; number_of_response:1; }","duration":"596.81276ms","start":"2026-04-20T14:20:45.68552Z","end":"2026-04-20T14:20:46.282332Z","steps":["trace[2042141037] 'process raft request' (duration: 236.191114ms)","trace[2042141037] 'compare' (duration: 360.041079ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T14:20:46.282366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.506595ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-20T14:20:46.282416Z","caller":"traceutil/trace.go:171","msg":"trace[322987811] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1821; }","duration":"288.599465ms","start":"2026-04-20T14:20:45.993803Z","end":"2026-04-20T14:20:46.282402Z","steps":["trace[322987811] 'agreement among raft nodes before linearized reading' (duration: 288.346882ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:20:46.282426Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:20:45.685504Z","time spent":"596.889011ms","remote":"127.0.0.1:56824","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T14:20:47.008411Z","caller":"traceutil/trace.go:171","msg":"trace[206387877] transaction","detail":"{read_only:false; response_revision:1824; number_of_response:1; }","duration":"265.179564ms","start":"2026-04-20T14:20:46.743186Z","end":"2026-04-20T14:20:47.008366Z","steps":["trace[206387877] 'process raft request' (duration: 205.237887ms)","trace[206387877] 'compare' (duration: 59.716574ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T14:20:47.008496Z","caller":"traceutil/trace.go:171","msg":"trace[1118628995] linearizableReadLoop","detail":"{readStateIndex:1897; appliedIndex:1896; }","duration":"263.844906ms","start":"2026-04-20T14:20:46.744643Z","end":"2026-04-20T14:20:47.008487Z","steps":["trace[1118628995] 'read index received' (duration: 203.802748ms)","trace[1118628995] 'applied index is now lower than readState.Index' (duration: 60.041088ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T14:20:47.008668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.005578ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-20T14:20:47.008438Z","caller":"traceutil/trace.go:171","msg":"trace[1010387931] transaction","detail":"{read_only:false; response_revision:1825; number_of_response:1; }","duration":"261.906532ms","start":"2026-04-20T14:20:46.746505Z","end":"2026-04-20T14:20:47.008412Z","steps":["trace[1010387931] 'process raft request' (duration: 261.810861ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:20:47.008756Z","caller":"traceutil/trace.go:171","msg":"trace[1292580218] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1826; }","duration":"264.10693ms","start":"2026-04-20T14:20:46.744599Z","end":"2026-04-20T14:20:47.008706Z","steps":["trace[1292580218] 'agreement among raft nodes before linearized reading' (duration: 263.929448ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:21:17.248385Z","caller":"traceutil/trace.go:171","msg":"trace[2120602852] transaction","detail":"{read_only:false; response_revision:2045; number_of_response:1; }","duration":"126.641816ms","start":"2026-04-20T14:21:17.121713Z","end":"2026-04-20T14:21:17.248355Z","steps":["trace[2120602852] 'process raft request' (duration: 126.445404ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:21:17.323446Z","caller":"traceutil/trace.go:171","msg":"trace[296102388] linearizableReadLoop","detail":"{readStateIndex:2126; appliedIndex:2124; }","duration":"136.935492ms","start":"2026-04-20T14:21:17.186487Z","end":"2026-04-20T14:21:17.323422Z","steps":["trace[296102388] 'read index received' (duration: 61.714611ms)","trace[296102388] 'applied index is now lower than readState.Index' (duration: 75.219691ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T14:21:17.323836Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.78513ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-20T14:21:17.323919Z","caller":"traceutil/trace.go:171","msg":"trace[1969700116] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2046; }","duration":"135.898461ms","start":"2026-04-20T14:21:17.188002Z","end":"2026-04-20T14:21:17.323901Z","steps":["trace[1969700116] 'agreement among raft nodes before linearized reading' (duration: 135.696538ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:21:17.323615Z","caller":"traceutil/trace.go:171","msg":"trace[897391141] transaction","detail":"{read_only:false; response_revision:2046; number_of_response:1; }","duration":"156.745173ms","start":"2026-04-20T14:21:17.166741Z","end":"2026-04-20T14:21:17.323486Z","steps":["trace[897391141] 'process raft request' (duration: 113.305207ms)","trace[897391141] 'compare' (duration: 43.257794ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T14:21:17.323851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.339237ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-20T14:21:17.32473Z","caller":"traceutil/trace.go:171","msg":"trace[859676100] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2046; }","duration":"138.265366ms","start":"2026-04-20T14:21:17.186444Z","end":"2026-04-20T14:21:17.324709Z","steps":["trace[859676100] 'agreement among raft nodes before linearized reading' (duration: 137.110644ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:21:17.470381Z","caller":"traceutil/trace.go:171","msg":"trace[2072710607] transaction","detail":"{read_only:false; response_revision:2047; number_of_response:1; }","duration":"142.025069ms","start":"2026-04-20T14:21:17.328317Z","end":"2026-04-20T14:21:17.470342Z","steps":["trace[2072710607] 'process raft request' (duration: 118.101031ms)","trace[2072710607] 'compare' (duration: 23.661795ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T14:21:17.470454Z","caller":"traceutil/trace.go:171","msg":"trace[521179697] transaction","detail":"{read_only:false; response_revision:2048; number_of_response:1; }","duration":"141.780425ms","start":"2026-04-20T14:21:17.328628Z","end":"2026-04-20T14:21:17.470408Z","steps":["trace[521179697] 'process raft request' (duration: 141.564053ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:21:17.470521Z","caller":"traceutil/trace.go:171","msg":"trace[1575725171] transaction","detail":"{read_only:false; response_revision:2050; number_of_response:1; }","duration":"110.050011ms","start":"2026-04-20T14:21:17.360431Z","end":"2026-04-20T14:21:17.470481Z","steps":["trace[1575725171] 'process raft request' (duration: 109.92526ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:21:17.470709Z","caller":"traceutil/trace.go:171","msg":"trace[1415361250] transaction","detail":"{read_only:false; response_revision:2049; number_of_response:1; }","duration":"142.001898ms","start":"2026-04-20T14:21:17.328686Z","end":"2026-04-20T14:21:17.470688Z","steps":["trace[1415361250] 'process raft request' (duration: 141.549493ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:21:19.482655Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.129489ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-20T14:21:19.483109Z","caller":"traceutil/trace.go:171","msg":"trace[1180095608] transaction","detail":"{read_only:false; response_revision:2059; number_of_response:1; }","duration":"153.386026ms","start":"2026-04-20T14:21:19.32968Z","end":"2026-04-20T14:21:19.483066Z","steps":["trace[1180095608] 'process raft request' (duration: 31.755372ms)","trace[1180095608] 'compare' (duration: 120.708163ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T14:21:19.483337Z","caller":"traceutil/trace.go:171","msg":"trace[61757490] transaction","detail":"{read_only:false; response_revision:2060; number_of_response:1; }","duration":"139.734745ms","start":"2026-04-20T14:21:19.343588Z","end":"2026-04-20T14:21:19.483323Z","steps":["trace[61757490] 'process raft request' (duration: 139.174619ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:21:21.065083Z","caller":"traceutil/trace.go:171","msg":"trace[1120794227] transaction","detail":"{read_only:false; response_revision:2067; number_of_response:1; }","duration":"186.996061ms","start":"2026-04-20T14:21:20.87806Z","end":"2026-04-20T14:21:21.065056Z","steps":["trace[1120794227] 'process raft request' (duration: 186.787729ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:21:21.938739Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.514922ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T14:21:21.938825Z","caller":"traceutil/trace.go:171","msg":"trace[255461410] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:2073; }","duration":"119.646123ms","start":"2026-04-20T14:21:21.819159Z","end":"2026-04-20T14:21:21.938805Z","steps":["trace[255461410] 'count revisions from in-memory index tree' (duration: 119.366909ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:21:21.939228Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.908199ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"info","ts":"2026-04-20T14:21:21.939279Z","caller":"traceutil/trace.go:171","msg":"trace[1606221974] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2073; }","duration":"112.995469ms","start":"2026-04-20T14:21:21.826272Z","end":"2026-04-20T14:21:21.939267Z","steps":["trace[1606221974] 'range keys from in-memory index tree' (duration: 112.715537ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:21:22.146548Z","caller":"traceutil/trace.go:171","msg":"trace[73422378] transaction","detail":"{read_only:false; response_revision:2074; number_of_response:1; }","duration":"135.476024ms","start":"2026-04-20T14:21:22.011046Z","end":"2026-04-20T14:21:22.146522Z","steps":["trace[73422378] 'process raft request' (duration: 135.330743ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:21:22.619042Z","caller":"traceutil/trace.go:171","msg":"trace[142413036] linearizableReadLoop","detail":"{readStateIndex:2156; appliedIndex:2155; }","duration":"115.177841ms","start":"2026-04-20T14:21:22.503841Z","end":"2026-04-20T14:21:22.619018Z","steps":["trace[142413036] 'read index received' (duration: 114.978679ms)","trace[142413036] 'applied index is now lower than readState.Index' (duration: 198.072µs)"],"step_count":2} {"level":"info","ts":"2026-04-20T14:21:22.619135Z","caller":"traceutil/trace.go:171","msg":"trace[270252551] transaction","detail":"{read_only:false; response_revision:2075; number_of_response:1; }","duration":"199.744663ms","start":"2026-04-20T14:21:22.419367Z","end":"2026-04-20T14:21:22.619112Z","steps":["trace[270252551] 'process raft request' (duration: 199.509391ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:21:22.619368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.511684ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-20T14:21:22.619442Z","caller":"traceutil/trace.go:171","msg":"trace[1295877956] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2075; }","duration":"115.645725ms","start":"2026-04-20T14:21:22.50378Z","end":"2026-04-20T14:21:22.619426Z","steps":["trace[1295877956] 'agreement among raft nodes before linearized reading' (duration: 115.362862ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:21:22.755525Z","caller":"traceutil/trace.go:171","msg":"trace[563783907] transaction","detail":"{read_only:false; response_revision:2076; number_of_response:1; }","duration":"131.795454ms","start":"2026-04-20T14:21:22.623682Z","end":"2026-04-20T14:21:22.755478Z","steps":["trace[563783907] 'process raft request' (duration: 129.463968ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:22:24.670548Z","caller":"traceutil/trace.go:171","msg":"trace[252869104] transaction","detail":"{read_only:false; response_revision:2513; number_of_response:1; }","duration":"210.824851ms","start":"2026-04-20T14:22:24.459695Z","end":"2026-04-20T14:22:24.67052Z","steps":["trace[252869104] 'process raft request' (duration: 210.66615ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:22:46.242816Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.743533ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"} {"level":"info","ts":"2026-04-20T14:22:46.242901Z","caller":"traceutil/trace.go:171","msg":"trace[1012102510] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2633; }","duration":"101.883885ms","start":"2026-04-20T14:22:46.140998Z","end":"2026-04-20T14:22:46.242881Z","steps":["trace[1012102510] 'range keys from in-memory index tree' (duration: 101.531681ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:22:47.033427Z","caller":"traceutil/trace.go:171","msg":"trace[1068751069] transaction","detail":"{read_only:false; response_revision:2637; number_of_response:1; }","duration":"126.863527ms","start":"2026-04-20T14:22:46.906538Z","end":"2026-04-20T14:22:47.033401Z","steps":["trace[1068751069] 'process raft request' (duration: 78.318137ms)","trace[1068751069] 'compare' (duration: 48.353898ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T14:22:58.570386Z","caller":"traceutil/trace.go:171","msg":"trace[125935258] transaction","detail":"{read_only:false; response_revision:2700; number_of_response:1; }","duration":"217.048428ms","start":"2026-04-20T14:22:58.353304Z","end":"2026-04-20T14:22:58.570353Z","steps":["trace[125935258] 'process raft request' (duration: 202.345048ms)","trace[125935258] 'compare' (duration: 14.279566ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T14:22:59.091415Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"333.01399ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-04-20T14:22:59.091551Z","caller":"traceutil/trace.go:171","msg":"trace[891123447] linearizableReadLoop","detail":"{readStateIndex:2804; appliedIndex:2803; }","duration":"161.294364ms","start":"2026-04-20T14:22:58.930232Z","end":"2026-04-20T14:22:59.091527Z","steps":["trace[891123447] 'read index received' (duration: 30.26µs)","trace[891123447] 'applied index is now lower than readState.Index' (duration: 161.262254ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T14:22:59.091975Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.723208ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-04-20T14:22:59.092038Z","caller":"traceutil/trace.go:171","msg":"trace[2117105067] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2700; }","duration":"161.815649ms","start":"2026-04-20T14:22:58.930203Z","end":"2026-04-20T14:22:59.092019Z","steps":["trace[2117105067] 'agreement among raft nodes before linearized reading' (duration: 161.446666ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:22:59.092354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.883937ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:1853"} {"level":"info","ts":"2026-04-20T14:22:59.092444Z","caller":"traceutil/trace.go:171","msg":"trace[913719543] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2700; }","duration":"145.997438ms","start":"2026-04-20T14:22:58.946427Z","end":"2026-04-20T14:22:59.092425Z","steps":["trace[913719543] 'agreement among raft nodes before linearized reading' (duration: 145.815486ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:22:59.409292Z","caller":"traceutil/trace.go:171","msg":"trace[485248762] transaction","detail":"{read_only:false; response_revision:2701; number_of_response:1; }","duration":"305.064681ms","start":"2026-04-20T14:22:59.104202Z","end":"2026-04-20T14:22:59.409267Z","steps":["trace[485248762] 'process raft request' (duration: 304.864419ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:22:59.409437Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:22:59.104189Z","time spent":"305.176002ms","remote":"127.0.0.1:56824","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T14:22:59.414283Z","caller":"traceutil/trace.go:171","msg":"trace[313515524] linearizableReadLoop","detail":"{readStateIndex:2806; appliedIndex:2805; }","duration":"190.565074ms","start":"2026-04-20T14:22:59.223702Z","end":"2026-04-20T14:22:59.414267Z","steps":["trace[313515524] 'read index received' (duration: 186.039711ms)","trace[313515524] 'applied index is now lower than readState.Index' (duration: 4.524683ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T14:22:59.41436Z","caller":"traceutil/trace.go:171","msg":"trace[146670984] transaction","detail":"{read_only:false; response_revision:2702; number_of_response:1; }","duration":"272.397628ms","start":"2026-04-20T14:22:59.141949Z","end":"2026-04-20T14:22:59.414346Z","steps":["trace[146670984] 'process raft request' (duration: 272.167926ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:22:59.414425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.710436ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T14:22:59.41458Z","caller":"traceutil/trace.go:171","msg":"trace[1676970522] range","detail":"{range_begin:/registry/csistoragecapacities/; range_end:/registry/csistoragecapacities0; response_count:0; response_revision:2702; }","duration":"190.880367ms","start":"2026-04-20T14:22:59.223688Z","end":"2026-04-20T14:22:59.414568Z","steps":["trace[1676970522] 'agreement among raft nodes before linearized reading' (duration: 190.692825ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:23:07.749821Z","caller":"traceutil/trace.go:171","msg":"trace[1328480260] transaction","detail":"{read_only:false; response_revision:2747; number_of_response:1; }","duration":"102.509966ms","start":"2026-04-20T14:23:07.647293Z","end":"2026-04-20T14:23:07.749803Z","steps":["trace[1328480260] 'process raft request' (duration: 41.815979ms)","trace[1328480260] 'compare' (duration: 60.186056ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T14:23:11.861193Z","caller":"traceutil/trace.go:171","msg":"trace[1383568759] transaction","detail":"{read_only:false; response_revision:2767; number_of_response:1; }","duration":"196.361764ms","start":"2026-04-20T14:23:11.664812Z","end":"2026-04-20T14:23:11.861174Z","steps":["trace[1383568759] 'process raft request' (duration: 195.99729ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:23:49.102212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.803722ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-04-20T14:25:50.328865Z","caller":"traceutil/trace.go:171","msg":"trace[1950910467] transaction","detail":"{read_only:false; response_revision:3694; number_of_response:1; }","duration":"138.97387ms","start":"2026-04-20T14:25:50.189868Z","end":"2026-04-20T14:25:50.328842Z","steps":["trace[1950910467] 'process raft request' (duration: 138.838227ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:25:56.605807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.507172ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-04-20T14:25:56.605912Z","caller":"traceutil/trace.go:171","msg":"trace[1404449373] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:3728; }","duration":"117.706776ms","start":"2026-04-20T14:25:56.488183Z","end":"2026-04-20T14:25:56.60589Z","steps":["trace[1404449373] 'range keys from in-memory index tree' (duration: 117.281457ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:25:56.60639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.608757ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/issuers/\" range_end:\"/registry/cert-manager.io/issuers0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-20T14:25:56.606547Z","caller":"traceutil/trace.go:171","msg":"trace[59344530] range","detail":"{range_begin:/registry/cert-manager.io/issuers/; range_end:/registry/cert-manager.io/issuers0; response_count:0; response_revision:3728; }","duration":"126.78405ms","start":"2026-04-20T14:25:56.479703Z","end":"2026-04-20T14:25:56.606487Z","steps":["trace[59344530] 'count revisions from in-memory index tree' (duration: 126.525006ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:26:00.165787Z","caller":"traceutil/trace.go:171","msg":"trace[647683197] transaction","detail":"{read_only:false; response_revision:3786; number_of_response:1; }","duration":"118.421793ms","start":"2026-04-20T14:26:00.047336Z","end":"2026-04-20T14:26:00.165758Z","steps":["trace[647683197] 'process raft request' (duration: 52.494847ms)","trace[647683197] 'compare' (duration: 65.268723ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T14:26:00.166354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.023215ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/prometheusagents.monitoring.coreos.com\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T14:26:00.166498Z","caller":"traceutil/trace.go:171","msg":"trace[1626655696] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/prometheusagents.monitoring.coreos.com; range_end:; response_count:0; response_revision:3787; }","duration":"117.195498ms","start":"2026-04-20T14:26:00.049288Z","end":"2026-04-20T14:26:00.166483Z","steps":["trace[1626655696] 'agreement among raft nodes before linearized reading' (duration: 117.018415ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:26:00.166835Z","caller":"traceutil/trace.go:171","msg":"trace[2135077721] linearizableReadLoop","detail":"{readStateIndex:3936; appliedIndex:3935; }","duration":"116.77535ms","start":"2026-04-20T14:26:00.049311Z","end":"2026-04-20T14:26:00.166086Z","steps":["trace[2135077721] 'read index received' (duration: 50.537158ms)","trace[2135077721] 'applied index is now lower than readState.Index' (duration: 66.237372ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T14:26:00.666226Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.922452ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-20T14:26:00.666581Z","caller":"traceutil/trace.go:171","msg":"trace[1262298324] transaction","detail":"{read_only:false; response_revision:3791; number_of_response:1; }","duration":"229.971596ms","start":"2026-04-20T14:26:00.436354Z","end":"2026-04-20T14:26:00.666326Z","steps":["trace[1262298324] 'process raft request' (duration: 111.83721ms)","trace[1262298324] 'compare' (duration: 117.539085ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T14:26:00.670047Z","caller":"traceutil/trace.go:171","msg":"trace[871471185] transaction","detail":"{read_only:false; response_revision:3792; number_of_response:1; }","duration":"232.341494ms","start":"2026-04-20T14:26:00.437686Z","end":"2026-04-20T14:26:00.670027Z","steps":["trace[871471185] 'process raft request' (duration: 231.64861ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:26:00.670371Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.982076ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/prometheuses.monitoring.coreos.com\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T14:26:00.670448Z","caller":"traceutil/trace.go:171","msg":"trace[56317718] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/prometheuses.monitoring.coreos.com; range_end:; response_count:0; response_revision:3792; }","duration":"216.13265ms","start":"2026-04-20T14:26:00.454296Z","end":"2026-04-20T14:26:00.670428Z","steps":["trace[56317718] 'agreement among raft nodes before linearized reading' (duration: 215.977937ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:26:00.67051Z","caller":"traceutil/trace.go:171","msg":"trace[1489861084] linearizableReadLoop","detail":"{readStateIndex:3942; appliedIndex:3940; }","duration":"215.614018ms","start":"2026-04-20T14:26:00.454371Z","end":"2026-04-20T14:26:00.669985Z","steps":["trace[1489861084] 'read index received' (duration: 93.795728ms)","trace[1489861084] 'applied index is now lower than readState.Index' (duration: 121.81688ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T14:26:17.677096Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15387565910710465897,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-20T14:26:18.178143Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15387565910710465897,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-20T14:26:18.679304Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15387565910710465897,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-20T14:26:18.961622Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.995407606s","expected-duration":"1s"} {"level":"info","ts":"2026-04-20T14:26:18.961999Z","caller":"traceutil/trace.go:171","msg":"trace[580054592] transaction","detail":"{read_only:false; response_revision:3908; number_of_response:1; }","duration":"1.995912346s","start":"2026-04-20T14:26:16.966065Z","end":"2026-04-20T14:26:18.961977Z","steps":["trace[580054592] 'process raft request' (duration: 1.995784833s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:26:18.962104Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:26:16.96604Z","time spent":"1.995990907s","remote":"127.0.0.1:56824","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T14:26:18.966037Z","caller":"traceutil/trace.go:171","msg":"trace[655277142] transaction","detail":"{read_only:false; response_revision:3909; number_of_response:1; }","duration":"1.074710713s","start":"2026-04-20T14:26:17.891297Z","end":"2026-04-20T14:26:18.966008Z","steps":["trace[655277142] 'process raft request' (duration: 1.074180322s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:26:18.96637Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:26:17.891266Z","time spent":"1.075012669s","remote":"127.0.0.1:56824","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T14:26:18.974778Z","caller":"traceutil/trace.go:171","msg":"trace[937990327] linearizableReadLoop","detail":"{readStateIndex:4063; appliedIndex:4060; }","duration":"1.798163073s","start":"2026-04-20T14:26:17.176599Z","end":"2026-04-20T14:26:18.974762Z","steps":["trace[937990327] 'read index received' (duration: 1.785181484s)","trace[937990327] 'applied index is now lower than readState.Index' (duration: 12.980549ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T14:26:18.974873Z","caller":"traceutil/trace.go:171","msg":"trace[878523657] transaction","detail":"{read_only:false; response_revision:3910; number_of_response:1; }","duration":"254.290324ms","start":"2026-04-20T14:26:18.720575Z","end":"2026-04-20T14:26:18.974866Z","steps":["trace[878523657] 'process raft request' (duration: 254.06794ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:26:18.975025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.280492817s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-04-20T14:26:18.975053Z","caller":"traceutil/trace.go:171","msg":"trace[499842476] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:3911; }","duration":"1.280558518s","start":"2026-04-20T14:26:17.694483Z","end":"2026-04-20T14:26:18.975042Z","steps":["trace[499842476] 'agreement among raft nodes before linearized reading' (duration: 1.280463737s)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:26:18.975034Z","caller":"traceutil/trace.go:171","msg":"trace[1993405462] transaction","detail":"{read_only:false; response_revision:3911; number_of_response:1; }","duration":"103.514564ms","start":"2026-04-20T14:26:18.871494Z","end":"2026-04-20T14:26:18.975009Z","steps":["trace[1993405462] 'process raft request' (duration: 103.238439ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:26:18.975092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.278516759s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T14:26:18.975108Z","caller":"traceutil/trace.go:171","msg":"trace[788869083] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:3911; }","duration":"1.278552591s","start":"2026-04-20T14:26:17.696551Z","end":"2026-04-20T14:26:18.975104Z","steps":["trace[788869083] 'agreement among raft nodes before linearized reading' (duration: 1.27852869s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:26:18.975131Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:26:17.696542Z","time spent":"1.278585541s","remote":"127.0.0.1:56562","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-20T14:26:18.975069Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:26:17.694465Z","time spent":"1.280599779s","remote":"127.0.0.1:56824","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-20T14:26:18.975147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.798527251s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-20T14:26:18.975196Z","caller":"traceutil/trace.go:171","msg":"trace[981340888] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:3911; }","duration":"1.798622932s","start":"2026-04-20T14:26:17.176561Z","end":"2026-04-20T14:26:18.975184Z","steps":["trace[981340888] 'agreement among raft nodes before linearized reading' (duration: 1.798381178s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:26:18.975299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.904649ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"warn","ts":"2026-04-20T14:26:18.975306Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"781.682341ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:558"} {"level":"info","ts":"2026-04-20T14:26:18.975341Z","caller":"traceutil/trace.go:171","msg":"trace[538441897] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:3911; }","duration":"781.761103ms","start":"2026-04-20T14:26:18.19357Z","end":"2026-04-20T14:26:18.975331Z","steps":["trace[538441897] 'agreement among raft nodes before linearized reading' (duration: 781.642711ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:26:18.975342Z","caller":"traceutil/trace.go:171","msg":"trace[1492690036] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:3911; }","duration":"154.028402ms","start":"2026-04-20T14:26:18.821301Z","end":"2026-04-20T14:26:18.975329Z","steps":["trace[1492690036] 'agreement among raft nodes before linearized reading' (duration: 153.888479ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:26:18.975144Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.21287ms","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-04-20T14:26:18.975366Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:26:18.19355Z","time spent":"781.804134ms","remote":"127.0.0.1:56824","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-04-20T14:26:18.975385Z","caller":"traceutil/trace.go:171","msg":"trace[184538528] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:3911; }","duration":"125.505246ms","start":"2026-04-20T14:26:18.849874Z","end":"2026-04-20T14:26:18.975379Z","steps":["trace[184538528] 'agreement among raft nodes before linearized reading' (duration: 125.154069ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:26:18.975208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.274540893s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/kube-prometheus-stack-dashboard-rbd-overview\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T14:26:18.975429Z","caller":"traceutil/trace.go:171","msg":"trace[61030328] range","detail":"{range_begin:/registry/configmaps/monitoring/kube-prometheus-stack-dashboard-rbd-overview; range_end:; response_count:0; response_revision:3911; }","duration":"1.274845438s","start":"2026-04-20T14:26:17.700575Z","end":"2026-04-20T14:26:18.97542Z","steps":["trace[61030328] 'agreement among raft nodes before linearized reading' (duration: 1.274496212s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:26:18.97547Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:26:17.700559Z","time spent":"1.274903889s","remote":"127.0.0.1:56676","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":28,"request content":"key:\"/registry/configmaps/monitoring/kube-prometheus-stack-dashboard-rbd-overview\" "} {"level":"warn","ts":"2026-04-20T14:26:18.975515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.264795526s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-20T14:26:18.975337Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:26:17.176544Z","time spent":"1.798767725s","remote":"127.0.0.1:56824","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":"info","ts":"2026-04-20T14:26:18.97563Z","caller":"traceutil/trace.go:171","msg":"trace[1437574102] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:3911; }","duration":"1.264967629s","start":"2026-04-20T14:26:17.710595Z","end":"2026-04-20T14:26:18.975563Z","steps":["trace[1437574102] 'agreement among raft nodes before linearized reading' (duration: 1.264655813s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:26:18.976304Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:26:17.710547Z","time spent":"1.265743884s","remote":"127.0.0.1:57950","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":30,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "} {"level":"warn","ts":"2026-04-20T14:26:18.975759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.281178539s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"warn","ts":"2026-04-20T14:26:18.975828Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.153492137s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-04-20T14:26:18.977227Z","caller":"traceutil/trace.go:171","msg":"trace[133303192] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:3911; }","duration":"1.154929485s","start":"2026-04-20T14:26:17.822285Z","end":"2026-04-20T14:26:18.977215Z","steps":["trace[133303192] 'agreement among raft nodes before linearized reading' (duration: 1.152686482s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:26:18.977305Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:26:17.822262Z","time spent":"1.155028237s","remote":"127.0.0.1:56824","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-20T14:26:18.977692Z","caller":"traceutil/trace.go:171","msg":"trace[1051692300] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:3911; }","duration":"1.283178098s","start":"2026-04-20T14:26:17.694504Z","end":"2026-04-20T14:26:18.977682Z","steps":["trace[1051692300] 'agreement among raft nodes before linearized reading' (duration: 1.280718701s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:26:18.977769Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:26:17.694481Z","time spent":"1.28327723s","remote":"127.0.0.1:56824","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":578,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"info","ts":"2026-04-20T14:26:54.560366Z","caller":"traceutil/trace.go:171","msg":"trace[1455893072] transaction","detail":"{read_only:false; response_revision:4641; number_of_response:1; }","duration":"101.0757ms","start":"2026-04-20T14:26:54.459262Z","end":"2026-04-20T14:26:54.560337Z","steps":["trace[1455893072] 'process raft request' (duration: 84.531319ms)","trace[1455893072] 'compare' (duration: 16.261186ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T14:26:54.7725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.871022ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:3506"} {"level":"info","ts":"2026-04-20T14:26:54.772613Z","caller":"traceutil/trace.go:171","msg":"trace[1667558279] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:4641; }","duration":"110.968563ms","start":"2026-04-20T14:26:54.661594Z","end":"2026-04-20T14:26:54.772562Z","steps":["trace[1667558279] 'range keys from in-memory index tree' (duration: 110.71856ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:27:02.190569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"922.397284ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-20T14:27:02.19066Z","caller":"traceutil/trace.go:171","msg":"trace[1091795073] linearizableReadLoop","detail":"{readStateIndex:4930; appliedIndex:4929; }","duration":"938.933131ms","start":"2026-04-20T14:27:01.251712Z","end":"2026-04-20T14:27:02.190646Z","steps":["trace[1091795073] 'read index received' (duration: 16.175891ms)","trace[1091795073] 'applied index is now lower than readState.Index' (duration: 922.7564ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T14:27:02.190731Z","caller":"traceutil/trace.go:171","msg":"trace[1397575261] transaction","detail":"{read_only:false; response_revision:4749; number_of_response:1; }","duration":"943.024971ms","start":"2026-04-20T14:27:01.247698Z","end":"2026-04-20T14:27:02.190723Z","steps":["trace[1397575261] 'process raft request' (duration: 20.258451ms)","trace[1397575261] 'compare' (duration: 921.983997ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T14:27:02.190827Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:27:01.247681Z","time spent":"943.119282ms","remote":"127.0.0.1:56824","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T14:27:02.191027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"939.310908ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-20T14:27:02.191052Z","caller":"traceutil/trace.go:171","msg":"trace[791339185] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4749; }","duration":"939.357529ms","start":"2026-04-20T14:27:01.251688Z","end":"2026-04-20T14:27:02.191045Z","steps":["trace[791339185] 'agreement among raft nodes before linearized reading' (duration: 939.267397ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:27:02.191072Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:27:01.251674Z","time spent":"939.39377ms","remote":"127.0.0.1:56824","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-20T14:27:02.191183Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"934.091237ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T14:27:02.191206Z","caller":"traceutil/trace.go:171","msg":"trace[43855755] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:4749; }","duration":"934.133068ms","start":"2026-04-20T14:27:01.257067Z","end":"2026-04-20T14:27:02.1912Z","steps":["trace[43855755] 'agreement among raft nodes before linearized reading' (duration: 934.093348ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:27:02.191225Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:27:01.257055Z","time spent":"934.165269ms","remote":"127.0.0.1:56992","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":0,"response size":28,"request content":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" "} {"level":"warn","ts":"2026-04-20T14:27:02.191369Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"861.745912ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"info","ts":"2026-04-20T14:27:02.191394Z","caller":"traceutil/trace.go:171","msg":"trace[1577112020] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4749; }","duration":"861.798782ms","start":"2026-04-20T14:27:01.329589Z","end":"2026-04-20T14:27:02.191387Z","steps":["trace[1577112020] 'agreement among raft nodes before linearized reading' (duration: 861.732331ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:27:02.191413Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:27:01.329571Z","time spent":"861.836313ms","remote":"127.0.0.1:56824","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":578,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"warn","ts":"2026-04-20T14:27:02.19143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"576.984368ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-20T14:27:02.191528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"862.549456ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-04-20T14:27:02.19153Z","caller":"traceutil/trace.go:171","msg":"trace[1394981590] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:4749; }","duration":"577.136591ms","start":"2026-04-20T14:27:01.614373Z","end":"2026-04-20T14:27:02.19151Z","steps":["trace[1394981590] 'agreement among raft nodes before linearized reading' (duration: 576.890137ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:27:02.191557Z","caller":"traceutil/trace.go:171","msg":"trace[2095203791] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4749; }","duration":"862.588046ms","start":"2026-04-20T14:27:01.328962Z","end":"2026-04-20T14:27:02.19155Z","steps":["trace[2095203791] 'agreement among raft nodes before linearized reading' (duration: 862.524275ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:27:02.191573Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:27:01.614349Z","time spent":"577.215092ms","remote":"127.0.0.1:56668","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":50,"response size":30,"request content":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true "} {"level":"warn","ts":"2026-04-20T14:27:02.191921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"898.051252ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"warn","ts":"2026-04-20T14:27:02.192075Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"502.842912ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-746f0973-6b52-4596-92b2-b5b2dd38d425\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-04-20T14:27:02.192125Z","caller":"traceutil/trace.go:171","msg":"trace[1451738801] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-746f0973-6b52-4596-92b2-b5b2dd38d425; range_end:; response_count:1; response_revision:4749; }","duration":"502.930454ms","start":"2026-04-20T14:27:01.689182Z","end":"2026-04-20T14:27:02.192113Z","steps":["trace[1451738801] 'agreement among raft nodes before linearized reading' (duration: 502.741241ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:27:02.192165Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:27:01.689162Z","time spent":"502.995254ms","remote":"127.0.0.1:56766","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3669,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-746f0973-6b52-4596-92b2-b5b2dd38d425\" "} {"level":"warn","ts":"2026-04-20T14:27:02.191581Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:27:01.328956Z","time spent":"862.619907ms","remote":"127.0.0.1:56824","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-20T14:27:02.192067Z","caller":"traceutil/trace.go:171","msg":"trace[1021743605] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4749; }","duration":"898.177774ms","start":"2026-04-20T14:27:01.293815Z","end":"2026-04-20T14:27:02.191992Z","steps":["trace[1021743605] 'agreement among raft nodes before linearized reading' (duration: 897.828928ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:27:02.194464Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:27:01.2938Z","time spent":"900.629046ms","remote":"127.0.0.1:56824","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-20T14:27:02.19212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"863.96155ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-04-20T14:27:02.194633Z","caller":"traceutil/trace.go:171","msg":"trace[1152231706] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4749; }","duration":"866.462223ms","start":"2026-04-20T14:27:01.328137Z","end":"2026-04-20T14:27:02.1946Z","steps":["trace[1152231706] 'agreement among raft nodes before linearized reading' (duration: 863.454741ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:27:02.194661Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:27:01.328128Z","time spent":"866.526754ms","remote":"127.0.0.1:56824","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-20T14:27:02.200852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"874.166907ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2193165"} {"level":"info","ts":"2026-04-20T14:27:02.200932Z","caller":"traceutil/trace.go:171","msg":"trace[1005129797] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:4749; }","duration":"874.275468ms","start":"2026-04-20T14:27:01.326631Z","end":"2026-04-20T14:27:02.200907Z","steps":["trace[1005129797] 'agreement among raft nodes before linearized reading' (duration: 865.185521ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:27:02.200984Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:27:01.326617Z","time spent":"874.35989ms","remote":"127.0.0.1:56676","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":47,"response size":2193188,"request content":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" "} {"level":"warn","ts":"2026-04-20T14:27:02.650051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"337.341883ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T14:27:02.650126Z","caller":"traceutil/trace.go:171","msg":"trace[351640969] transaction","detail":"{read_only:false; response_revision:4750; number_of_response:1; }","duration":"452.336424ms","start":"2026-04-20T14:27:02.197768Z","end":"2026-04-20T14:27:02.650104Z","steps":["trace[351640969] 'process raft request' (duration: 445.188771ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:27:02.650203Z","caller":"traceutil/trace.go:171","msg":"trace[522091712] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:4749; }","duration":"337.508326ms","start":"2026-04-20T14:27:02.312672Z","end":"2026-04-20T14:27:02.65018Z","steps":["trace[522091712] 'range keys from in-memory index tree' (duration: 337.321292ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:27:02.650255Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:27:02.197724Z","time spent":"452.466727ms","remote":"127.0.0.1:56824","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T14:27:02.680562Z","caller":"traceutil/trace.go:171","msg":"trace[1813860394] transaction","detail":"{read_only:false; response_revision:4752; number_of_response:1; }","duration":"476.574735ms","start":"2026-04-20T14:27:02.203961Z","end":"2026-04-20T14:27:02.680536Z","steps":["trace[1813860394] 'process raft request' (duration: 476.505803ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:27:02.680709Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:27:02.203946Z","time spent":"476.689157ms","remote":"127.0.0.1:56824","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T14:27:02.680958Z","caller":"traceutil/trace.go:171","msg":"trace[1681602356] transaction","detail":"{read_only:false; response_revision:4753; number_of_response:1; }","duration":"476.966851ms","start":"2026-04-20T14:27:02.203963Z","end":"2026-04-20T14:27:02.68093Z","steps":["trace[1681602356] 'process raft request' (duration: 476.538104ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:27:02.681108Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:27:02.203946Z","time spent":"477.086274ms","remote":"127.0.0.1:56824","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":539,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T14:27:02.680623Z","caller":"traceutil/trace.go:171","msg":"trace[1192483506] transaction","detail":"{read_only:false; response_revision:4751; number_of_response:1; }","duration":"482.826263ms","start":"2026-04-20T14:27:02.197774Z","end":"2026-04-20T14:27:02.6806Z","steps":["trace[1192483506] 'process raft request' (duration: 482.557738ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:27:02.681337Z","caller":"traceutil/trace.go:171","msg":"trace[176803857] linearizableReadLoop","detail":"{readStateIndex:4934; appliedIndex:4930; }","duration":"477.327499ms","start":"2026-04-20T14:27:02.203987Z","end":"2026-04-20T14:27:02.681314Z","steps":["trace[176803857] 'read index received' (duration: 438.992744ms)","trace[176803857] 'applied index is now lower than readState.Index' (duration: 38.333445ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T14:27:02.681322Z","caller":"traceutil/trace.go:171","msg":"trace[1195273056] transaction","detail":"{read_only:false; response_revision:4754; number_of_response:1; }","duration":"477.270838ms","start":"2026-04-20T14:27:02.204039Z","end":"2026-04-20T14:27:02.68131Z","steps":["trace[1195273056] 'process raft request' (duration: 476.915901ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:27:02.681515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"477.524782ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"} {"level":"warn","ts":"2026-04-20T14:27:02.681513Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:27:02.204021Z","time spent":"477.40729ms","remote":"127.0.0.1:56824","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T14:27:02.681557Z","caller":"traceutil/trace.go:171","msg":"trace[388528235] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4755; }","duration":"477.591073ms","start":"2026-04-20T14:27:02.203957Z","end":"2026-04-20T14:27:02.681548Z","steps":["trace[388528235] 'agreement among raft nodes before linearized reading' (duration: 477.43863ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:27:02.681582Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:27:02.20394Z","time spent":"477.635444ms","remote":"127.0.0.1:56766","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12236,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-04-20T14:27:02.681593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"457.046337ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1817"} {"level":"info","ts":"2026-04-20T14:27:02.681645Z","caller":"traceutil/trace.go:171","msg":"trace[1416040339] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:4755; }","duration":"457.138068ms","start":"2026-04-20T14:27:02.224488Z","end":"2026-04-20T14:27:02.681627Z","steps":["trace[1416040339] 'agreement among raft nodes before linearized reading' (duration: 456.965455ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:27:02.681689Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:27:02.224469Z","time spent":"457.20853ms","remote":"127.0.0.1:56668","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":1840,"request content":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" "} {"level":"info","ts":"2026-04-20T14:27:02.681361Z","caller":"traceutil/trace.go:171","msg":"trace[1051213345] transaction","detail":"{read_only:false; response_revision:4755; number_of_response:1; }","duration":"127.856355ms","start":"2026-04-20T14:27:02.553496Z","end":"2026-04-20T14:27:02.681353Z","steps":["trace[1051213345] 'process raft request' (duration: 127.622772ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:27:02.681918Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.868382ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:12975"} {"level":"info","ts":"2026-04-20T14:27:02.681944Z","caller":"traceutil/trace.go:171","msg":"trace[787661519] range","detail":"{range_begin:/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4755; }","duration":"128.928113ms","start":"2026-04-20T14:27:02.553006Z","end":"2026-04-20T14:27:02.681935Z","steps":["trace[787661519] 'agreement among raft nodes before linearized reading' (duration: 128.855162ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:27:02.682007Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:27:02.197748Z","time spent":"483.632918ms","remote":"127.0.0.1:56824","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T14:27:03.051689Z","caller":"traceutil/trace.go:171","msg":"trace[2078914268] transaction","detail":"{read_only:false; response_revision:4762; number_of_response:1; }","duration":"209.272124ms","start":"2026-04-20T14:27:02.842384Z","end":"2026-04-20T14:27:03.051656Z","steps":["trace[2078914268] 'process raft request' (duration: 146.168332ms)","trace[2078914268] 'compare' (duration: 62.870088ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T14:27:03.369479Z","caller":"traceutil/trace.go:171","msg":"trace[978688320] transaction","detail":"{read_only:false; response_revision:4765; number_of_response:1; }","duration":"158.360687ms","start":"2026-04-20T14:27:03.21109Z","end":"2026-04-20T14:27:03.369451Z","steps":["trace[978688320] 'process raft request' (duration: 157.34989ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:27:14.426426Z","caller":"traceutil/trace.go:171","msg":"trace[953111531] transaction","detail":"{read_only:false; response_revision:4909; number_of_response:1; }","duration":"166.73275ms","start":"2026-04-20T14:27:14.259667Z","end":"2026-04-20T14:27:14.4264Z","steps":["trace[953111531] 'process raft request' (duration: 166.556747ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:27:14.569369Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.56734ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/alertmanagerconfigs/\" range_end:\"/registry/monitoring.coreos.com/alertmanagerconfigs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T14:27:14.569455Z","caller":"traceutil/trace.go:171","msg":"trace[393730896] range","detail":"{range_begin:/registry/monitoring.coreos.com/alertmanagerconfigs/; range_end:/registry/monitoring.coreos.com/alertmanagerconfigs0; response_count:0; response_revision:4909; }","duration":"110.721342ms","start":"2026-04-20T14:27:14.458713Z","end":"2026-04-20T14:27:14.569434Z","steps":["trace[393730896] 'count revisions from in-memory index tree' (duration: 110.456908ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:27:40.981883Z","caller":"traceutil/trace.go:171","msg":"trace[1096927645] transaction","detail":"{read_only:false; response_revision:5171; number_of_response:1; }","duration":"100.159949ms","start":"2026-04-20T14:27:40.881708Z","end":"2026-04-20T14:27:40.981868Z","steps":["trace[1096927645] 'process raft request' (duration: 99.972886ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:27:53.519885Z","caller":"traceutil/trace.go:171","msg":"trace[195919645] transaction","detail":"{read_only:false; response_revision:5272; number_of_response:1; }","duration":"104.732929ms","start":"2026-04-20T14:27:53.415128Z","end":"2026-04-20T14:27:53.519861Z","steps":["trace[195919645] 'process raft request' (duration: 80.937132ms)","trace[195919645] 'compare' (duration: 23.605854ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T14:28:03.374974Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15387565910710469178,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-20T14:28:03.876129Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15387565910710469178,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-20T14:28:04.377154Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15387565910710469178,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-20T14:28:04.877703Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15387565910710469178,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-20T14:28:05.377922Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15387565910710469178,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-20T14:28:05.598575Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000365946s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-04-20T14:28:05.598659Z","caller":"traceutil/trace.go:171","msg":"trace[911791597] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000502659s","start":"2026-04-20T14:28:03.598136Z","end":"2026-04-20T14:28:05.598639Z","steps":["trace[911791597] 'agreement among raft nodes before linearized reading' (duration: 2.000395797s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:28:05.598706Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:28:03.598116Z","time spent":"2.0005806s","remote":"127.0.0.1:56562","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/04/20 14:28:05 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-04-20T14:28:05.878685Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15387565910710469178,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-20T14:28:06.379452Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15387565910710469178,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-20T14:28:06.88024Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15387565910710469178,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-20T14:28:07.380715Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15387565910710469178,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-20T14:28:07.599106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000053076s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-04-20T14:28:07.59921Z","caller":"traceutil/trace.go:171","msg":"trace[1102775144] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000234449s","start":"2026-04-20T14:28:05.598952Z","end":"2026-04-20T14:28:07.599187Z","steps":["trace[1102775144] 'agreement among raft nodes before linearized reading' (duration: 2.000084486s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:28:07.599263Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:28:05.598933Z","time spent":"2.000319081s","remote":"127.0.0.1:56566","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-20T14:28:07.674099Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:28:02.675259Z","time spent":"4.998835047s","remote":"127.0.0.1:56824","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""} 2026/04/20 14:28:07 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-04-20T14:28:07.881702Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15387565910710469178,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-20T14:28:08.067298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.999026408s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-04-20T14:28:08.067385Z","caller":"traceutil/trace.go:171","msg":"trace[224962549] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; }","duration":"4.999169961s","start":"2026-04-20T14:28:03.068193Z","end":"2026-04-20T14:28:08.067363Z","steps":["trace[224962549] 'agreement among raft nodes before linearized reading' (duration: 4.999065049s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:28:08.067473Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:28:03.068171Z","time spent":"4.999252112s","remote":"127.0.0.1:56824","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} 2026/04/20 14:28:08 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-04-20T14:28:08.073425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.999323753s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-04-20T14:28:08.073508Z","caller":"traceutil/trace.go:171","msg":"trace[1935761675] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; }","duration":"4.999445415s","start":"2026-04-20T14:28:03.074041Z","end":"2026-04-20T14:28:08.073487Z","steps":["trace[1935761675] 'agreement among raft nodes before linearized reading' (duration: 4.999342494s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:28:08.073555Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:28:03.074028Z","time spent":"4.999516266s","remote":"127.0.0.1:56824","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} 2026/04/20 14:28:08 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-04-20T14:28:08.382328Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15387565910710469178,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-20T14:28:08.51167Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:28:03.512666Z","time spent":"4.99899412s","remote":"127.0.0.1:56824","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""} 2026/04/20 14:28:08 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-04-20T14:28:08.551063Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:28:03.552721Z","time spent":"4.998334927s","remote":"127.0.0.1:56824","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""} 2026/04/20 14:28:08 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-04-20T14:28:08.882508Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15387565910710469178,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-20T14:28:09.142069Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"6.466651202s","expected-duration":"1s"} {"level":"info","ts":"2026-04-20T14:28:09.152372Z","caller":"traceutil/trace.go:171","msg":"trace[844056185] transaction","detail":"{read_only:false; response_revision:5342; number_of_response:1; }","duration":"5.507552403s","start":"2026-04-20T14:28:03.644788Z","end":"2026-04-20T14:28:09.152341Z","steps":["trace[844056185] 'process raft request' (duration: 5.507254249s)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:28:09.15251Z","caller":"traceutil/trace.go:171","msg":"trace[71865218] transaction","detail":"{read_only:false; response_revision:5343; number_of_response:1; }","duration":"5.085938789s","start":"2026-04-20T14:28:04.06655Z","end":"2026-04-20T14:28:09.152488Z","steps":["trace[71865218] 'process raft request' (duration: 5.085712216s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:28:09.152537Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:28:03.644771Z","time spent":"5.507679605s","remote":"127.0.0.1:56824","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T14:28:09.152642Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:28:04.066522Z","time spent":"5.086049852s","remote":"127.0.0.1:56824","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T14:28:09.152824Z","caller":"traceutil/trace.go:171","msg":"trace[1956319403] transaction","detail":"{read_only:false; response_revision:5344; number_of_response:1; }","duration":"4.429133404s","start":"2026-04-20T14:28:04.723682Z","end":"2026-04-20T14:28:09.152816Z","steps":["trace[1956319403] 'process raft request' (duration: 4.428749989s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:28:09.152872Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:28:04.723653Z","time spent":"4.429196276s","remote":"127.0.0.1:56824","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T14:28:09.15301Z","caller":"traceutil/trace.go:171","msg":"trace[1637732180] transaction","detail":"{read_only:false; response_revision:5345; number_of_response:1; }","duration":"3.202306609s","start":"2026-04-20T14:28:05.950693Z","end":"2026-04-20T14:28:09.153Z","steps":["trace[1637732180] 'process raft request' (duration: 3.202057505s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:28:09.153065Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:28:05.950667Z","time spent":"3.202371111s","remote":"127.0.0.1:56752","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":12031,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T14:28:09.15323Z","caller":"traceutil/trace.go:171","msg":"trace[477646738] transaction","detail":"{read_only:false; response_revision:5346; number_of_response:1; }","duration":"1.755030014s","start":"2026-04-20T14:28:07.398159Z","end":"2026-04-20T14:28:09.153189Z","steps":["trace[477646738] 'process raft request' (duration: 1.754801151s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:28:09.153887Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:28:07.398142Z","time spent":"1.755649183s","remote":"127.0.0.1:56824","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T14:28:09.153333Z","caller":"traceutil/trace.go:171","msg":"trace[1877588771] transaction","detail":"{read_only:false; response_revision:5347; number_of_response:1; }","duration":"1.550400636s","start":"2026-04-20T14:28:07.602913Z","end":"2026-04-20T14:28:09.153314Z","steps":["trace[1877588771] 'process raft request' (duration: 1.550210323s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:28:09.154391Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:28:07.602883Z","time spent":"1.551251238s","remote":"127.0.0.1:56654","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":759,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-20T14:28:09.17385Z","caller":"traceutil/trace.go:171","msg":"trace[274673848] linearizableReadLoop","detail":"{readStateIndex:5546; appliedIndex:5536; }","duration":"6.299494152s","start":"2026-04-20T14:28:02.874325Z","end":"2026-04-20T14:28:09.17382Z","steps":["trace[274673848] 'read index received' (duration: 6.267994975s)","trace[274673848] 'applied index is now lower than readState.Index' (duration: 31.497157ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T14:28:09.174183Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"5.246466502s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/keystone-db-sync\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-20T14:28:09.174241Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"5.653802595s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.174\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T14:28:09.17431Z","caller":"traceutil/trace.go:171","msg":"trace[638308954] range","detail":"{range_begin:/registry/masterleases/199.19.213.174; range_end:; response_count:0; response_revision:5348; }","duration":"5.653933288s","start":"2026-04-20T14:28:03.520364Z","end":"2026-04-20T14:28:09.174298Z","steps":["trace[638308954] 'agreement among raft nodes before linearized reading' (duration: 5.653793786s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:28:09.174321Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"6.056723058s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-04-20T14:28:09.174351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"5.247774243s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/keystone-fernet-setup\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T14:28:09.174381Z","caller":"traceutil/trace.go:171","msg":"trace[836669012] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5348; }","duration":"6.056819419s","start":"2026-04-20T14:28:03.117546Z","end":"2026-04-20T14:28:09.174365Z","steps":["trace[836669012] 'agreement among raft nodes before linearized reading' (duration: 6.056687737s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:28:09.174426Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"660.713807ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/08db1feb.percona.com\" ","response":"range_response_count:1 size:526"} {"level":"info","ts":"2026-04-20T14:28:09.174445Z","caller":"traceutil/trace.go:171","msg":"trace[150825794] range","detail":"{range_begin:/registry/leases/openstack/08db1feb.percona.com; range_end:; response_count:1; response_revision:5348; }","duration":"660.758947ms","start":"2026-04-20T14:28:08.513682Z","end":"2026-04-20T14:28:09.174441Z","steps":["trace[150825794] 'agreement among raft nodes before linearized reading' (duration: 660.670915ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:28:09.174427Z","caller":"traceutil/trace.go:171","msg":"trace[1418691818] range","detail":"{range_begin:/registry/jobs/openstack/keystone-fernet-setup; range_end:; response_count:0; response_revision:5348; }","duration":"5.247891235s","start":"2026-04-20T14:28:03.926518Z","end":"2026-04-20T14:28:09.17441Z","steps":["trace[1418691818] 'agreement among raft nodes before linearized reading' (duration: 5.247777734s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:28:09.174438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"5.391893563s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"} {"level":"warn","ts":"2026-04-20T14:28:09.174481Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:28:03.926503Z","time spent":"5.247966156s","remote":"127.0.0.1:56798","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/openstack/keystone-fernet-setup\" "} {"level":"warn","ts":"2026-04-20T14:28:09.17452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.56932315s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-20T14:28:09.174534Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"5.983710697s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T14:28:09.174538Z","caller":"traceutil/trace.go:171","msg":"trace[791522991] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5348; }","duration":"1.56936766s","start":"2026-04-20T14:28:07.605166Z","end":"2026-04-20T14:28:09.174534Z","steps":["trace[791522991] 'agreement among raft nodes before linearized reading' (duration: 1.56934193s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:28:09.174551Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:28:07.605153Z","time spent":"1.569395991s","remote":"127.0.0.1:56562","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-20T14:28:09.174552Z","caller":"traceutil/trace.go:171","msg":"trace[722681583] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:5348; }","duration":"5.983773938s","start":"2026-04-20T14:28:03.190772Z","end":"2026-04-20T14:28:09.174546Z","steps":["trace[722681583] 'agreement among raft nodes before linearized reading' (duration: 5.983739808s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:28:09.174569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.651852957s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:530"} {"level":"info","ts":"2026-04-20T14:28:09.174394Z","caller":"traceutil/trace.go:171","msg":"trace[733932171] range","detail":"{range_begin:/registry/jobs/openstack/keystone-db-sync; range_end:; response_count:0; response_revision:5348; }","duration":"5.246635195s","start":"2026-04-20T14:28:03.927651Z","end":"2026-04-20T14:28:09.174286Z","steps":["trace[733932171] 'agreement among raft nodes before linearized reading' (duration: 5.246446763s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:28:09.174706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"5.288137143s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T14:28:09.174729Z","caller":"traceutil/trace.go:171","msg":"trace[1731117744] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:5348; }","duration":"5.288162414s","start":"2026-04-20T14:28:03.886561Z","end":"2026-04-20T14:28:09.174724Z","steps":["trace[1731117744] 'agreement among raft nodes before linearized reading' (duration: 5.288125274s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:28:09.174772Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:28:03.927611Z","time spent":"5.247102052s","remote":"127.0.0.1:56798","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/openstack/keystone-db-sync\" "} {"level":"warn","ts":"2026-04-20T14:28:09.17485Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:28:03.88654Z","time spent":"5.288201224s","remote":"127.0.0.1:54848","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-20T14:28:09.174337Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:28:03.520349Z","time spent":"5.653983738s","remote":"127.0.0.1:56616","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":0,"response size":28,"request content":"key:\"/registry/masterleases/199.19.213.174\" "} {"level":"warn","ts":"2026-04-20T14:28:09.174634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"5.116649267s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:558"} {"level":"info","ts":"2026-04-20T14:28:09.175033Z","caller":"traceutil/trace.go:171","msg":"trace[2071352550] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:5348; }","duration":"5.117060892s","start":"2026-04-20T14:28:04.057953Z","end":"2026-04-20T14:28:09.175014Z","steps":["trace[2071352550] 'agreement among raft nodes before linearized reading' (duration: 5.116545845s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:28:09.175094Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:28:04.057938Z","time spent":"5.117139244s","remote":"127.0.0.1:56824","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-04-20T14:28:09.17458Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:28:03.190748Z","time spent":"5.983826899s","remote":"127.0.0.1:43540","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"info","ts":"2026-04-20T14:28:09.174491Z","caller":"traceutil/trace.go:171","msg":"trace[2012879337] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5348; }","duration":"5.391987885s","start":"2026-04-20T14:28:03.782491Z","end":"2026-04-20T14:28:09.174478Z","steps":["trace[2012879337] 'agreement among raft nodes before linearized reading' (duration: 5.391814543s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:28:09.175513Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:28:03.782473Z","time spent":"5.393018371s","remote":"127.0.0.1:56766","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12236,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-04-20T14:28:09.174458Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:28:08.513665Z","time spent":"660.790757ms","remote":"127.0.0.1:56824","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":549,"request content":"key:\"/registry/leases/openstack/08db1feb.percona.com\" "} {"level":"warn","ts":"2026-04-20T14:28:09.174203Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"6.057296327s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-20T14:28:09.175802Z","caller":"traceutil/trace.go:171","msg":"trace[584753982] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5348; }","duration":"6.058928222s","start":"2026-04-20T14:28:03.116856Z","end":"2026-04-20T14:28:09.175784Z","steps":["trace[584753982] 'agreement among raft nodes before linearized reading' (duration: 6.057160894s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:28:09.175955Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:28:03.116836Z","time spent":"6.059099874s","remote":"127.0.0.1:56824","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-20T14:28:09.174889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"6.300515049s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-20T14:28:09.174439Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:28:03.117526Z","time spent":"6.056899941s","remote":"127.0.0.1:56824","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-20T14:28:09.174625Z","caller":"traceutil/trace.go:171","msg":"trace[2095077971] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:5348; }","duration":"4.651941008s","start":"2026-04-20T14:28:04.522669Z","end":"2026-04-20T14:28:09.17461Z","steps":["trace[2095077971] 'agreement among raft nodes before linearized reading' (duration: 4.651804486s)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:28:09.176162Z","caller":"traceutil/trace.go:171","msg":"trace[559704766] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:5348; }","duration":"6.301825958s","start":"2026-04-20T14:28:02.874276Z","end":"2026-04-20T14:28:09.176102Z","steps":["trace[559704766] 'agreement among raft nodes before linearized reading' (duration: 6.299710935s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:28:09.176217Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:28:04.522649Z","time spent":"4.653516912s","remote":"127.0.0.1:56824","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":553,"request content":"key:\"/registry/leases/cert-manager/cert-manager-controller\" "} {"level":"warn","ts":"2026-04-20T14:28:09.174665Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"621.813712ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" ","response":"range_response_count:1 size:550"} {"level":"warn","ts":"2026-04-20T14:28:09.176295Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:28:02.874254Z","time spent":"6.302002021s","remote":"127.0.0.1:43588","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":24,"response size":30,"request content":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true "} {"level":"info","ts":"2026-04-20T14:28:09.176332Z","caller":"traceutil/trace.go:171","msg":"trace[906183478] range","detail":"{range_begin:/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io; range_end:; response_count:1; response_revision:5348; }","duration":"623.500678ms","start":"2026-04-20T14:28:08.552813Z","end":"2026-04-20T14:28:09.176314Z","steps":["trace[906183478] 'agreement among raft nodes before linearized reading' (duration: 621.66941ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:28:09.176383Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:28:08.552798Z","time spent":"623.571659ms","remote":"127.0.0.1:56824","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":573,"request content":"key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" "} {"level":"warn","ts":"2026-04-20T14:28:09.176596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"6.058476744s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:554"} {"level":"info","ts":"2026-04-20T14:28:09.176708Z","caller":"traceutil/trace.go:171","msg":"trace[134556845] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5348; }","duration":"6.058571975s","start":"2026-04-20T14:28:03.118074Z","end":"2026-04-20T14:28:09.176646Z","steps":["trace[134556845] 'agreement among raft nodes before linearized reading' (duration: 6.056168759s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:28:09.176801Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:28:03.118062Z","time spent":"6.058719888s","remote":"127.0.0.1:56824","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":577,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"info","ts":"2026-04-20T14:28:30.45775Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2866} {"level":"info","ts":"2026-04-20T14:28:30.533102Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2866,"took":"74.002906ms","hash":3796044425,"current-db-size-bytes":53215232,"current-db-size":"53 MB","current-db-size-in-use-bytes":28860416,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-04-20T14:28:30.533152Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3796044425,"revision":2866,"compact-revision":-1} {"level":"warn","ts":"2026-04-20T14:28:35.740603Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15387565910710469688,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-20T14:28:36.104885Z","caller":"traceutil/trace.go:171","msg":"trace[1855260863] transaction","detail":"{read_only:false; response_revision:5541; number_of_response:1; }","duration":"865.343521ms","start":"2026-04-20T14:28:35.239504Z","end":"2026-04-20T14:28:36.104848Z","steps":["trace[1855260863] 'process raft request' (duration: 865.106808ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:28:36.105091Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:28:35.239481Z","time spent":"865.516334ms","remote":"127.0.0.1:56824","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T14:28:36.533236Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.942665ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-20T14:28:36.533516Z","caller":"traceutil/trace.go:171","msg":"trace[1075953603] linearizableReadLoop","detail":"{readStateIndex:5748; appliedIndex:5745; }","duration":"1.293524009s","start":"2026-04-20T14:28:35.239941Z","end":"2026-04-20T14:28:36.533465Z","steps":["trace[1075953603] 'read index received' (duration: 864.148174ms)","trace[1075953603] 'applied index is now lower than readState.Index' (duration: 429.374725ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T14:28:36.533628Z","caller":"traceutil/trace.go:171","msg":"trace[457360294] transaction","detail":"{read_only:false; response_revision:5542; number_of_response:1; }","duration":"1.250527043s","start":"2026-04-20T14:28:35.283088Z","end":"2026-04-20T14:28:36.533615Z","steps":["trace[457360294] 'process raft request' (duration: 978.104761ms)","trace[457360294] 'compare' (duration: 271.59992ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T14:28:36.533699Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:28:35.283064Z","time spent":"1.250598614s","remote":"127.0.0.1:56824","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T14:28:36.533825Z","caller":"traceutil/trace.go:171","msg":"trace[339950395] transaction","detail":"{read_only:false; response_revision:5543; number_of_response:1; }","duration":"1.244035286s","start":"2026-04-20T14:28:35.28978Z","end":"2026-04-20T14:28:36.533815Z","steps":["trace[339950395] 'process raft request' (duration: 1.243566909s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:28:36.534487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.23031807s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-04-20T14:28:36.534587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"709.610727ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-04-20T14:28:36.534606Z","caller":"traceutil/trace.go:171","msg":"trace[2021112668] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5543; }","duration":"1.230490242s","start":"2026-04-20T14:28:35.30409Z","end":"2026-04-20T14:28:36.53458Z","steps":["trace[2021112668] 'agreement among raft nodes before linearized reading' (duration: 1.230100917s)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:28:36.534639Z","caller":"traceutil/trace.go:171","msg":"trace[682130187] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5543; }","duration":"709.729359ms","start":"2026-04-20T14:28:35.824896Z","end":"2026-04-20T14:28:36.534625Z","steps":["trace[682130187] 'agreement among raft nodes before linearized reading' (duration: 709.551566ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:28:36.534681Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:28:35.824866Z","time spent":"709.804521ms","remote":"127.0.0.1:56824","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-20T14:28:36.534651Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:28:35.304079Z","time spent":"1.230563373s","remote":"127.0.0.1:56824","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-20T14:28:36.535238Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.225377997s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"info","ts":"2026-04-20T14:28:36.535282Z","caller":"traceutil/trace.go:171","msg":"trace[1012495143] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5543; }","duration":"1.225435517s","start":"2026-04-20T14:28:35.309833Z","end":"2026-04-20T14:28:36.535269Z","steps":["trace[1012495143] 'agreement among raft nodes before linearized reading' (duration: 1.225328366s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:28:36.535303Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:28:35.309826Z","time spent":"1.225472058s","remote":"127.0.0.1:56824","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":578,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"warn","ts":"2026-04-20T14:28:36.535569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.21088795s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"warn","ts":"2026-04-20T14:28:36.535654Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.183956ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"warn","ts":"2026-04-20T14:28:36.535677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"937.944143ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-20T14:28:36.535636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.691568ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-04-20T14:28:36.535892Z","caller":"traceutil/trace.go:171","msg":"trace[2083678051] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5543; }","duration":"235.025872ms","start":"2026-04-20T14:28:36.300855Z","end":"2026-04-20T14:28:36.535881Z","steps":["trace[2083678051] 'agreement among raft nodes before linearized reading' (duration: 234.727278ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:28:36.540206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.300232519s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/keystone-db-sync\" ","response":"range_response_count:1 size:8317"} {"level":"info","ts":"2026-04-20T14:28:36.540326Z","caller":"traceutil/trace.go:171","msg":"trace[803811109] range","detail":"{range_begin:/registry/jobs/openstack/keystone-db-sync; range_end:; response_count:1; response_revision:5543; }","duration":"1.300383861s","start":"2026-04-20T14:28:35.239898Z","end":"2026-04-20T14:28:36.540282Z","steps":["trace[803811109] 'agreement among raft nodes before linearized reading' (duration: 1.295807333s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:28:36.540436Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:28:35.239887Z","time spent":"1.300536083s","remote":"127.0.0.1:56798","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":8340,"request content":"key:\"/registry/jobs/openstack/keystone-db-sync\" "} {"level":"info","ts":"2026-04-20T14:28:36.540955Z","caller":"traceutil/trace.go:171","msg":"trace[1030624738] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5543; }","duration":"1.211116683s","start":"2026-04-20T14:28:35.324573Z","end":"2026-04-20T14:28:36.53569Z","steps":["trace[1030624738] 'agreement among raft nodes before linearized reading' (duration: 1.209909604s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:28:36.541122Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:28:35.324559Z","time spent":"1.216544844s","remote":"127.0.0.1:56824","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-20T14:28:36.541363Z","caller":"traceutil/trace.go:171","msg":"trace[944761529] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5543; }","duration":"197.423359ms","start":"2026-04-20T14:28:36.338383Z","end":"2026-04-20T14:28:36.535806Z","steps":["trace[944761529] 'agreement among raft nodes before linearized reading' (duration: 197.127655ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:28:36.535845Z","caller":"traceutil/trace.go:171","msg":"trace[562719172] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5543; }","duration":"938.124217ms","start":"2026-04-20T14:28:35.597705Z","end":"2026-04-20T14:28:36.535829Z","steps":["trace[562719172] 'agreement among raft nodes before linearized reading' (duration: 937.954614ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:28:36.541587Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:28:35.59769Z","time spent":"943.879393ms","remote":"127.0.0.1:56562","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-20T14:28:36.533884Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:28:35.289746Z","time spent":"1.244107857s","remote":"127.0.0.1:56824","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T14:28:36.905119Z","caller":"traceutil/trace.go:171","msg":"trace[1503368084] linearizableReadLoop","detail":"{readStateIndex:5749; appliedIndex:5748; }","duration":"358.537963ms","start":"2026-04-20T14:28:36.546546Z","end":"2026-04-20T14:28:36.905083Z","steps":["trace[1503368084] 'read index received' (duration: 339.881273ms)","trace[1503368084] 'applied index is now lower than readState.Index' (duration: 18.65546ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T14:28:36.905165Z","caller":"traceutil/trace.go:171","msg":"trace[638011542] transaction","detail":"{read_only:false; response_revision:5544; number_of_response:1; }","duration":"363.59331ms","start":"2026-04-20T14:28:36.541546Z","end":"2026-04-20T14:28:36.90514Z","steps":["trace[638011542] 'process raft request' (duration: 344.859668ms)","trace[638011542] 'compare' (duration: 18.522768ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T14:28:36.905255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"358.708886ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T14:28:36.905283Z","caller":"traceutil/trace.go:171","msg":"trace[209352932] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5544; }","duration":"358.778777ms","start":"2026-04-20T14:28:36.546495Z","end":"2026-04-20T14:28:36.905274Z","steps":["trace[209352932] 'agreement among raft nodes before linearized reading' (duration: 358.707645ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:28:36.905305Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:28:36.546475Z","time spent":"358.824637ms","remote":"127.0.0.1:56566","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-20T14:28:36.905347Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:28:36.541524Z","time spent":"363.733091ms","remote":"127.0.0.1:56824","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T14:28:36.922077Z","caller":"traceutil/trace.go:171","msg":"trace[179174603] transaction","detail":"{read_only:false; response_revision:5545; number_of_response:1; }","duration":"368.2887ms","start":"2026-04-20T14:28:36.55375Z","end":"2026-04-20T14:28:36.922039Z","steps":["trace[179174603] 'process raft request' (duration: 367.935325ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:28:36.922242Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:28:36.553732Z","time spent":"368.426523ms","remote":"127.0.0.1:56824","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":539,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T14:28:36.922339Z","caller":"traceutil/trace.go:171","msg":"trace[192726001] transaction","detail":"{read_only:false; response_revision:5546; number_of_response:1; }","duration":"368.487523ms","start":"2026-04-20T14:28:36.553828Z","end":"2026-04-20T14:28:36.922315Z","steps":["trace[192726001] 'process raft request' (duration: 368.073027ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:28:36.922477Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:28:36.553819Z","time spent":"368.574184ms","remote":"127.0.0.1:56824","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T14:28:36.9228Z","caller":"traceutil/trace.go:171","msg":"trace[1670623916] transaction","detail":"{read_only:false; response_revision:5547; number_of_response:1; }","duration":"368.917559ms","start":"2026-04-20T14:28:36.553875Z","end":"2026-04-20T14:28:36.922793Z","steps":["trace[1670623916] 'process raft request' (duration: 368.358791ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:28:36.922854Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:28:36.553871Z","time spent":"368.960699ms","remote":"127.0.0.1:56824","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T14:28:36.923085Z","caller":"traceutil/trace.go:171","msg":"trace[1303755570] transaction","detail":"{read_only:false; response_revision:5548; number_of_response:1; }","duration":"369.128662ms","start":"2026-04-20T14:28:36.553947Z","end":"2026-04-20T14:28:36.923076Z","steps":["trace[1303755570] 'process raft request' (duration: 368.812137ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:28:36.923136Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:28:36.553935Z","time spent":"369.177444ms","remote":"127.0.0.1:56824","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T14:28:36.923207Z","caller":"traceutil/trace.go:171","msg":"trace[1635556171] transaction","detail":"{read_only:false; response_revision:5549; number_of_response:1; }","duration":"369.179163ms","start":"2026-04-20T14:28:36.554021Z","end":"2026-04-20T14:28:36.9232Z","steps":["trace[1635556171] 'process raft request' (duration: 368.98992ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:28:36.92325Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:28:36.553996Z","time spent":"369.233084ms","remote":"127.0.0.1:56824","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T14:28:38.220944Z","caller":"traceutil/trace.go:171","msg":"trace[1960629901] transaction","detail":"{read_only:false; response_revision:5550; number_of_response:1; }","duration":"105.347564ms","start":"2026-04-20T14:28:38.11554Z","end":"2026-04-20T14:28:38.220888Z","steps":["trace[1960629901] 'process raft request' (duration: 105.130611ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:28:40.721976Z","caller":"traceutil/trace.go:171","msg":"trace[143621479] linearizableReadLoop","detail":"{readStateIndex:5773; appliedIndex:5772; }","duration":"116.65808ms","start":"2026-04-20T14:28:40.605294Z","end":"2026-04-20T14:28:40.721952Z","steps":["trace[143621479] 'read index received' (duration: 69.461325ms)","trace[143621479] 'applied index is now lower than readState.Index' (duration: 47.195765ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T14:28:40.722073Z","caller":"traceutil/trace.go:171","msg":"trace[2088966899] transaction","detail":"{read_only:false; response_revision:5567; number_of_response:1; }","duration":"145.639013ms","start":"2026-04-20T14:28:40.576386Z","end":"2026-04-20T14:28:40.722025Z","steps":["trace[2088966899] 'process raft request' (duration: 98.425648ms)","trace[2088966899] 'compare' (duration: 47.026932ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T14:28:40.72228Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.135918ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T14:28:40.722367Z","caller":"traceutil/trace.go:171","msg":"trace[1331634491] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5567; }","duration":"123.417861ms","start":"2026-04-20T14:28:40.598932Z","end":"2026-04-20T14:28:40.72235Z","steps":["trace[1331634491] 'agreement among raft nodes before linearized reading' (duration: 123.109857ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:28:41.11996Z","caller":"traceutil/trace.go:171","msg":"trace[891940952] transaction","detail":"{read_only:false; response_revision:5569; number_of_response:1; }","duration":"102.422666ms","start":"2026-04-20T14:28:41.017512Z","end":"2026-04-20T14:28:41.119935Z","steps":["trace[891940952] 'process raft request' (duration: 50.780516ms)","trace[891940952] 'compare' (duration: 51.368236ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T14:28:41.416862Z","caller":"traceutil/trace.go:171","msg":"trace[1203883413] transaction","detail":"{read_only:false; response_revision:5571; number_of_response:1; }","duration":"292.907735ms","start":"2026-04-20T14:28:41.123928Z","end":"2026-04-20T14:28:41.416836Z","steps":["trace[1203883413] 'process raft request' (duration: 252.206039ms)","trace[1203883413] 'compare' (duration: 40.465352ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T14:28:41.417169Z","caller":"traceutil/trace.go:171","msg":"trace[1643411057] transaction","detail":"{read_only:false; response_revision:5573; number_of_response:1; }","duration":"291.594766ms","start":"2026-04-20T14:28:41.125548Z","end":"2026-04-20T14:28:41.417143Z","steps":["trace[1643411057] 'process raft request' (duration: 291.472644ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:28:41.417288Z","caller":"traceutil/trace.go:171","msg":"trace[1926282623] transaction","detail":"{read_only:false; response_revision:5572; number_of_response:1; }","duration":"292.045782ms","start":"2026-04-20T14:28:41.125223Z","end":"2026-04-20T14:28:41.417269Z","steps":["trace[1926282623] 'process raft request' (duration: 291.537555ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:28:43.006092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.619896ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-20T14:28:43.006469Z","caller":"traceutil/trace.go:171","msg":"trace[1459276650] transaction","detail":"{read_only:false; response_revision:5576; number_of_response:1; }","duration":"278.998185ms","start":"2026-04-20T14:28:42.727435Z","end":"2026-04-20T14:28:43.006433Z","steps":["trace[1459276650] 'process raft request' (duration: 34.87215ms)","trace[1459276650] 'compare' (duration: 243.22025ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T14:28:43.432246Z","caller":"traceutil/trace.go:171","msg":"trace[271869930] transaction","detail":"{read_only:false; response_revision:5579; number_of_response:1; }","duration":"219.213131ms","start":"2026-04-20T14:28:43.213007Z","end":"2026-04-20T14:28:43.43222Z","steps":["trace[271869930] 'process raft request' (duration: 141.782379ms)","trace[271869930] 'compare' (duration: 77.165268ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T14:28:44.68721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"918.56399ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-20T14:28:44.687288Z","caller":"traceutil/trace.go:171","msg":"trace[404622519] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:5583; }","duration":"918.676393ms","start":"2026-04-20T14:28:43.768582Z","end":"2026-04-20T14:28:44.687259Z","steps":["trace[404622519] 'count revisions from in-memory index tree' (duration: 918.484409ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:28:44.687331Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:28:43.768566Z","time spent":"918.752383ms","remote":"127.0.0.1:57938","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":30,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "} {"level":"info","ts":"2026-04-20T14:28:44.783514Z","caller":"traceutil/trace.go:171","msg":"trace[1168220946] linearizableReadLoop","detail":"{readStateIndex:5791; appliedIndex:5790; }","duration":"429.580852ms","start":"2026-04-20T14:28:44.353916Z","end":"2026-04-20T14:28:44.783497Z","steps":["trace[1168220946] 'read index received' (duration: 429.45017ms)","trace[1168220946] 'applied index is now lower than readState.Index' (duration: 130.142µs)"],"step_count":2} {"level":"info","ts":"2026-04-20T14:28:44.783589Z","caller":"traceutil/trace.go:171","msg":"trace[1008474106] transaction","detail":"{read_only:false; response_revision:5584; number_of_response:1; }","duration":"516.885768ms","start":"2026-04-20T14:28:44.266698Z","end":"2026-04-20T14:28:44.783583Z","steps":["trace[1008474106] 'process raft request' (duration: 516.673815ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:28:44.783663Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:28:44.266665Z","time spent":"516.939609ms","remote":"127.0.0.1:56824","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T14:28:44.783691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"429.747314ms","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-04-20T14:28:44.783809Z","caller":"traceutil/trace.go:171","msg":"trace[1282255599] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:5584; }","duration":"429.897846ms","start":"2026-04-20T14:28:44.353876Z","end":"2026-04-20T14:28:44.783773Z","steps":["trace[1282255599] 'agreement among raft nodes before linearized reading' (duration: 429.731583ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:28:44.783862Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:28:44.353857Z","time spent":"429.994418ms","remote":"127.0.0.1:56692","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":12,"response size":30,"request content":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true "} {"level":"info","ts":"2026-04-20T14:28:44.81486Z","caller":"traceutil/trace.go:171","msg":"trace[366515612] transaction","detail":"{read_only:false; response_revision:5585; number_of_response:1; }","duration":"131.843088ms","start":"2026-04-20T14:28:44.682991Z","end":"2026-04-20T14:28:44.814834Z","steps":["trace[366515612] 'process raft request' (duration: 114.533631ms)","trace[366515612] 'compare' (duration: 17.054004ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T14:28:44.814913Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.013366ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-20T14:28:44.814978Z","caller":"traceutil/trace.go:171","msg":"trace[482178009] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:5585; }","duration":"339.121828ms","start":"2026-04-20T14:28:44.475836Z","end":"2026-04-20T14:28:44.814958Z","steps":["trace[482178009] 'agreement among raft nodes before linearized reading' (duration: 338.939425ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:28:44.815037Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:28:44.475821Z","time spent":"339.200189ms","remote":"127.0.0.1:57922","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":30,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "} {"level":"warn","ts":"2026-04-20T14:28:44.815184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.013585ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/keystone-db-sync\" ","response":"range_response_count:1 size:8317"} {"level":"info","ts":"2026-04-20T14:28:44.815341Z","caller":"traceutil/trace.go:171","msg":"trace[977445537] range","detail":"{range_begin:/registry/jobs/openstack/keystone-db-sync; range_end:; response_count:1; response_revision:5585; }","duration":"131.116597ms","start":"2026-04-20T14:28:44.684125Z","end":"2026-04-20T14:28:44.815242Z","steps":["trace[977445537] 'agreement among raft nodes before linearized reading' (duration: 130.707791ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:29:17.396767Z","caller":"traceutil/trace.go:171","msg":"trace[281084733] linearizableReadLoop","detail":"{readStateIndex:6013; appliedIndex:6012; }","duration":"120.259071ms","start":"2026-04-20T14:29:17.276487Z","end":"2026-04-20T14:29:17.396746Z","steps":["trace[281084733] 'read index received' (duration: 119.964607ms)","trace[281084733] 'applied index is now lower than readState.Index' (duration: 293.464µs)"],"step_count":2} {"level":"info","ts":"2026-04-20T14:29:17.396821Z","caller":"traceutil/trace.go:171","msg":"trace[772033550] transaction","detail":"{read_only:false; response_revision:5799; number_of_response:1; }","duration":"242.106536ms","start":"2026-04-20T14:29:17.154686Z","end":"2026-04-20T14:29:17.396792Z","steps":["trace[772033550] 'process raft request' (duration: 241.784931ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:29:17.397013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.501314ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-20T14:29:17.397055Z","caller":"traceutil/trace.go:171","msg":"trace[359967054] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5799; }","duration":"120.587226ms","start":"2026-04-20T14:29:17.276459Z","end":"2026-04-20T14:29:17.397047Z","steps":["trace[359967054] 'agreement among raft nodes before linearized reading' (duration: 120.367343ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:30:34.251606Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15387565910710471538,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-20T14:30:34.262356Z","caller":"traceutil/trace.go:171","msg":"trace[2009907147] linearizableReadLoop","detail":"{readStateIndex:6496; appliedIndex:6495; }","duration":"511.330704ms","start":"2026-04-20T14:30:33.751006Z","end":"2026-04-20T14:30:34.262337Z","steps":["trace[2009907147] 'read index received' (duration: 511.255773ms)","trace[2009907147] 'applied index is now lower than readState.Index' (duration: 74.251µs)"],"step_count":2} {"level":"info","ts":"2026-04-20T14:30:34.262471Z","caller":"traceutil/trace.go:171","msg":"trace[1020687084] transaction","detail":"{read_only:false; response_revision:6263; number_of_response:1; }","duration":"579.805912ms","start":"2026-04-20T14:30:33.682631Z","end":"2026-04-20T14:30:34.262437Z","steps":["trace[1020687084] 'process raft request' (duration: 579.607309ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:30:34.262759Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:30:33.682611Z","time spent":"580.010555ms","remote":"127.0.0.1:56824","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T14:30:34.262879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"511.851062ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-20T14:30:34.26292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"484.524576ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-04-20T14:30:34.263006Z","caller":"traceutil/trace.go:171","msg":"trace[820213620] range","detail":"{range_begin:/registry/endpointslices/; range_end:/registry/endpointslices0; response_count:0; response_revision:6263; }","duration":"511.936022ms","start":"2026-04-20T14:30:33.75097Z","end":"2026-04-20T14:30:34.262906Z","steps":["trace[820213620] 'agreement among raft nodes before linearized reading' (duration: 511.455286ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:30:34.263037Z","caller":"traceutil/trace.go:171","msg":"trace[2102314952] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:6263; }","duration":"484.673499ms","start":"2026-04-20T14:30:33.778338Z","end":"2026-04-20T14:30:34.263011Z","steps":["trace[2102314952] 'agreement among raft nodes before linearized reading' (duration: 484.140142ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:30:34.2631Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:30:33.778324Z","time spent":"484.76045ms","remote":"127.0.0.1:56824","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-20T14:30:34.263215Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:30:33.750954Z","time spent":"512.248386ms","remote":"127.0.0.1:56830","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":38,"response size":30,"request content":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true "} {"level":"warn","ts":"2026-04-20T14:30:34.263622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"442.778865ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-04-20T14:30:34.263701Z","caller":"traceutil/trace.go:171","msg":"trace[1885832964] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:6263; }","duration":"442.851796ms","start":"2026-04-20T14:30:33.820831Z","end":"2026-04-20T14:30:34.263682Z","steps":["trace[1885832964] 'agreement among raft nodes before linearized reading' (duration: 441.737351ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:30:34.263747Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:30:33.820773Z","time spent":"442.961516ms","remote":"127.0.0.1:56824","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-20T14:31:14.502453Z","caller":"traceutil/trace.go:171","msg":"trace[1002588637] transaction","detail":"{read_only:false; response_revision:6645; number_of_response:1; }","duration":"117.353561ms","start":"2026-04-20T14:31:14.385077Z","end":"2026-04-20T14:31:14.50243Z","steps":["trace[1002588637] 'process raft request' (duration: 102.970647ms)","trace[1002588637] 'compare' (duration: 13.931638ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T14:31:14.669303Z","caller":"traceutil/trace.go:171","msg":"trace[407767650] linearizableReadLoop","detail":"{readStateIndex:6891; appliedIndex:6890; }","duration":"126.966559ms","start":"2026-04-20T14:31:14.542317Z","end":"2026-04-20T14:31:14.669284Z","steps":["trace[407767650] 'read index received' (duration: 70.483079ms)","trace[407767650] 'applied index is now lower than readState.Index' (duration: 56.4827ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T14:31:14.669587Z","caller":"traceutil/trace.go:171","msg":"trace[96639954] transaction","detail":"{read_only:false; response_revision:6647; number_of_response:1; }","duration":"147.122172ms","start":"2026-04-20T14:31:14.522454Z","end":"2026-04-20T14:31:14.669577Z","steps":["trace[96639954] 'process raft request' (duration: 90.389028ms)","trace[96639954] 'compare' (duration: 56.347229ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T14:31:14.669802Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.458885ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-04-20T14:31:14.669831Z","caller":"traceutil/trace.go:171","msg":"trace[1981628406] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:6647; }","duration":"127.547217ms","start":"2026-04-20T14:31:14.542276Z","end":"2026-04-20T14:31:14.669823Z","steps":["trace[1981628406] 'agreement among raft nodes before linearized reading' (duration: 127.433035ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:31:14.669981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.772157ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-04-20T14:31:14.670022Z","caller":"traceutil/trace.go:171","msg":"trace[935957802] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:6647; }","duration":"100.861758ms","start":"2026-04-20T14:31:14.569151Z","end":"2026-04-20T14:31:14.670013Z","steps":["trace[935957802] 'agreement among raft nodes before linearized reading' (duration: 100.782807ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:31:24.482312Z","caller":"traceutil/trace.go:171","msg":"trace[2105678470] transaction","detail":"{read_only:false; response_revision:6696; number_of_response:1; }","duration":"102.874341ms","start":"2026-04-20T14:31:24.379412Z","end":"2026-04-20T14:31:24.482286Z","steps":["trace[2105678470] 'process raft request' (duration: 102.680808ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:33:30.464308Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5514} {"level":"info","ts":"2026-04-20T14:33:30.563405Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5514,"took":"97.868924ms","hash":3713139555,"current-db-size-bytes":53215232,"current-db-size":"53 MB","current-db-size-in-use-bytes":18305024,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-04-20T14:33:30.564931Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3713139555,"revision":5514,"compact-revision":2866}