{"level":"warn","ts":"2026-07-14T16:50:39.306932Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-14T16:50:39.307076Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.240:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.240:2380","--initial-cluster=instance=https://199.204.45.240:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.240:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.240: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-07-14T16:50:39.309031Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-14T16:50:39.309066Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.240:2380"]} {"level":"info","ts":"2026-07-14T16:50:39.309232Z","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-07-14T16:50:39.312029Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.240:2379"]} {"level":"info","ts":"2026-07-14T16:50:39.312147Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.240:2380"],"listen-peer-urls":["https://199.204.45.240:2380"],"advertise-client-urls":["https://199.204.45.240:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.240:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.240: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-07-14T16:50:39.315853Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.50039ms"} {"level":"info","ts":"2026-07-14T16:50:39.321567Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"4e46287fb5aa4785","cluster-id":"cae704afa9813e87"} {"level":"info","ts":"2026-07-14T16:50:39.321624Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 switched to configuration voters=()"} {"level":"info","ts":"2026-07-14T16:50:39.321641Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 became follower at term 0"} {"level":"info","ts":"2026-07-14T16:50:39.321652Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 4e46287fb5aa4785 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-14T16:50:39.321659Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 became follower at term 1"} {"level":"info","ts":"2026-07-14T16:50:39.321693Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 switched to configuration voters=(5640240112301918085)"} {"level":"warn","ts":"2026-07-14T16:50:39.325939Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-14T16:50:39.32696Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-14T16:50:39.327932Z","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-07-14T16:50:39.329453Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"4e46287fb5aa4785","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-14T16:50:39.332464Z","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-07-14T16:50:39.33255Z","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-07-14T16:50:39.33258Z","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-07-14T16:50:39.332366Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"4e46287fb5aa4785","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-14T16:50:39.333551Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 switched to configuration voters=(5640240112301918085)"} {"level":"info","ts":"2026-07-14T16:50:39.333714Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"cae704afa9813e87","local-member-id":"4e46287fb5aa4785","added-peer-id":"4e46287fb5aa4785","added-peer-peer-urls":["https://199.204.45.240:2380"]} {"level":"info","ts":"2026-07-14T16:50:39.333914Z","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-07-14T16:50:39.334069Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"4e46287fb5aa4785","initial-advertise-peer-urls":["https://199.204.45.240:2380"],"listen-peer-urls":["https://199.204.45.240:2380"],"advertise-client-urls":["https://199.204.45.240:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.240:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-14T16:50:39.334093Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-14T16:50:39.334141Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.240:2380"} {"level":"info","ts":"2026-07-14T16:50:39.334242Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.240:2380"} {"level":"info","ts":"2026-07-14T16:50:39.721814Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 is starting a new election at term 1"} {"level":"info","ts":"2026-07-14T16:50:39.721856Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 became pre-candidate at term 1"} {"level":"info","ts":"2026-07-14T16:50:39.721871Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 received MsgPreVoteResp from 4e46287fb5aa4785 at term 1"} {"level":"info","ts":"2026-07-14T16:50:39.721881Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 became candidate at term 2"} {"level":"info","ts":"2026-07-14T16:50:39.721887Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 received MsgVoteResp from 4e46287fb5aa4785 at term 2"} {"level":"info","ts":"2026-07-14T16:50:39.721895Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 became leader at term 2"} {"level":"info","ts":"2026-07-14T16:50:39.721903Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 4e46287fb5aa4785 elected leader 4e46287fb5aa4785 at term 2"} {"level":"info","ts":"2026-07-14T16:50:39.722692Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-14T16:50:39.723327Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"4e46287fb5aa4785","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.240:2379]}","request-path":"/0/members/4e46287fb5aa4785/attributes","cluster-id":"cae704afa9813e87","publish-timeout":"7s"} {"level":"info","ts":"2026-07-14T16:50:39.723417Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-14T16:50:39.723333Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-14T16:50:39.723856Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"cae704afa9813e87","local-member-id":"4e46287fb5aa4785","cluster-version":"3.5"} {"level":"info","ts":"2026-07-14T16:50:39.723988Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-14T16:50:39.724057Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-14T16:50:39.724506Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-14T16:50:39.724568Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-14T16:50:39.725709Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.240:2379"} {"level":"info","ts":"2026-07-14T16:50:39.726824Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-14T16:50:55.186889Z","caller":"traceutil/trace.go:171","msg":"trace[33999373] linearizableReadLoop","detail":"{readStateIndex:388; appliedIndex:387; }","duration":"162.548231ms","start":"2026-07-14T16:50:55.024312Z","end":"2026-07-14T16:50:55.18686Z","steps":["trace[33999373] 'read index received' (duration: 162.248673ms)","trace[33999373] 'applied index is now lower than readState.Index' (duration: 297.998µs)"],"step_count":2} {"level":"warn","ts":"2026-07-14T16:50:55.18708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.745406ms","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-07-14T16:50:55.187188Z","caller":"traceutil/trace.go:171","msg":"trace[1443972757] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:373; }","duration":"162.9017ms","start":"2026-07-14T16:50:55.024264Z","end":"2026-07-14T16:50:55.187165Z","steps":["trace[1443972757] 'agreement among raft nodes before linearized reading' (duration: 162.747526ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T16:50:55.187416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.791791ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-07-14T16:50:55.187564Z","caller":"traceutil/trace.go:171","msg":"trace[1613253576] transaction","detail":"{read_only:false; response_revision:373; number_of_response:1; }","duration":"213.239086ms","start":"2026-07-14T16:50:54.974304Z","end":"2026-07-14T16:50:55.187543Z","steps":["trace[1613253576] 'process raft request' (duration: 212.381014ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T16:50:55.18758Z","caller":"traceutil/trace.go:171","msg":"trace[1647581551] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:373; }","duration":"159.009257ms","start":"2026-07-14T16:50:55.028541Z","end":"2026-07-14T16:50:55.18755Z","steps":["trace[1647581551] 'agreement among raft nodes before linearized reading' (duration: 158.706429ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T16:51:19.768476Z","caller":"traceutil/trace.go:171","msg":"trace[1421674612] linearizableReadLoop","detail":"{readStateIndex:612; appliedIndex:611; }","duration":"157.066025ms","start":"2026-07-14T16:51:19.61139Z","end":"2026-07-14T16:51:19.768456Z","steps":["trace[1421674612] 'read index received' (duration: 155.831549ms)","trace[1421674612] 'applied index is now lower than readState.Index' (duration: 1.233666ms)"],"step_count":2} {"level":"warn","ts":"2026-07-14T16:51:19.768641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.174446ms","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-07-14T16:51:19.768616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.188308ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-14T16:51:19.768675Z","caller":"traceutil/trace.go:171","msg":"trace[51746547] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:589; }","duration":"157.232478ms","start":"2026-07-14T16:51:19.611434Z","end":"2026-07-14T16:51:19.768667Z","steps":["trace[51746547] 'agreement among raft nodes before linearized reading' (duration: 157.160607ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T16:51:19.768719Z","caller":"traceutil/trace.go:171","msg":"trace[1892777520] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:589; }","duration":"157.33875ms","start":"2026-07-14T16:51:19.611357Z","end":"2026-07-14T16:51:19.768696Z","steps":["trace[1892777520] 'agreement among raft nodes before linearized reading' (duration: 157.174427ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T16:51:19.768512Z","caller":"traceutil/trace.go:171","msg":"trace[1535631270] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"192.496718ms","start":"2026-07-14T16:51:19.575998Z","end":"2026-07-14T16:51:19.768495Z","steps":["trace[1535631270] 'process raft request' (duration: 191.464047ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T16:51:20.215643Z","caller":"traceutil/trace.go:171","msg":"trace[126649562] linearizableReadLoop","detail":"{readStateIndex:613; appliedIndex:612; }","duration":"365.173702ms","start":"2026-07-14T16:51:19.850442Z","end":"2026-07-14T16:51:20.215616Z","steps":["trace[126649562] 'read index received' (duration: 365.010428ms)","trace[126649562] 'applied index is now lower than readState.Index' (duration: 162.154µs)"],"step_count":2} {"level":"info","ts":"2026-07-14T16:51:20.215775Z","caller":"traceutil/trace.go:171","msg":"trace[398305605] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"391.407392ms","start":"2026-07-14T16:51:19.824332Z","end":"2026-07-14T16:51:20.215739Z","steps":["trace[398305605] 'process raft request' (duration: 391.156746ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T16:51:20.215857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"365.389737ms","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":"info","ts":"2026-07-14T16:51:20.215929Z","caller":"traceutil/trace.go:171","msg":"trace[1161569699] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:590; }","duration":"365.491378ms","start":"2026-07-14T16:51:19.850422Z","end":"2026-07-14T16:51:20.215914Z","steps":["trace[1161569699] 'agreement among raft nodes before linearized reading' (duration: 365.341025ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T16:51:20.215975Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T16:51:19.850401Z","time spent":"365.564259ms","remote":"127.0.0.1:48424","response type":"/etcdserverpb.KV/Range","request count":0,"request size":114,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true "} {"level":"warn","ts":"2026-07-14T16:51:20.216029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"365.478988ms","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":"warn","ts":"2026-07-14T16:51:20.216059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.454688ms","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-07-14T16:51:20.216138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.866017ms","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-07-14T16:51:20.216162Z","caller":"traceutil/trace.go:171","msg":"trace[1231601859] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:590; }","duration":"149.923528ms","start":"2026-07-14T16:51:20.066232Z","end":"2026-07-14T16:51:20.216156Z","steps":["trace[1231601859] 'agreement among raft nodes before linearized reading' (duration: 149.887418ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T16:51:20.216239Z","caller":"traceutil/trace.go:171","msg":"trace[378559672] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:590; }","duration":"149.618932ms","start":"2026-07-14T16:51:20.066527Z","end":"2026-07-14T16:51:20.216146Z","steps":["trace[378559672] 'agreement among raft nodes before linearized reading' (duration: 149.410238ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T16:51:20.216338Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.735976ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-14T16:51:20.216377Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.658446ms","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-07-14T16:51:20.21638Z","caller":"traceutil/trace.go:171","msg":"trace[2035209075] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:590; }","duration":"307.803628ms","start":"2026-07-14T16:51:19.908567Z","end":"2026-07-14T16:51:20.216371Z","steps":["trace[2035209075] 'agreement among raft nodes before linearized reading' (duration: 307.742436ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T16:51:20.216386Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.768028ms","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-07-14T16:51:20.216416Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T16:51:19.908555Z","time spent":"307.852728ms","remote":"127.0.0.1:48438","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:500 "} {"level":"info","ts":"2026-07-14T16:51:20.216428Z","caller":"traceutil/trace.go:171","msg":"trace[1795282044] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:590; }","duration":"308.712796ms","start":"2026-07-14T16:51:19.907687Z","end":"2026-07-14T16:51:20.2164Z","steps":["trace[1795282044] 'agreement among raft nodes before linearized reading' (duration: 308.663825ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T16:51:20.216457Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T16:51:19.907676Z","time spent":"308.773827ms","remote":"127.0.0.1:48450","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":"warn","ts":"2026-07-14T16:51:20.216501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.745818ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-14T16:51:20.216534Z","caller":"traceutil/trace.go:171","msg":"trace[808218693] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:590; }","duration":"192.781239ms","start":"2026-07-14T16:51:20.023745Z","end":"2026-07-14T16:51:20.216526Z","steps":["trace[808218693] 'agreement among raft nodes before linearized reading' (duration: 192.732908ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T16:51:20.216564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.012256ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-14T16:51:20.216605Z","caller":"traceutil/trace.go:171","msg":"trace[161019867] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:590; }","duration":"282.072808ms","start":"2026-07-14T16:51:19.934522Z","end":"2026-07-14T16:51:20.216595Z","steps":["trace[161019867] 'agreement among raft nodes before linearized reading' (duration: 282.018077ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T16:51:20.21674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.117756ms","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-07-14T16:51:20.216768Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.380805ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-14T16:51:20.216778Z","caller":"traceutil/trace.go:171","msg":"trace[1747332637] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:590; }","duration":"194.167227ms","start":"2026-07-14T16:51:20.022602Z","end":"2026-07-14T16:51:20.216769Z","steps":["trace[1747332637] 'agreement among raft nodes before linearized reading' (duration: 194.110546ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T16:51:20.2168Z","caller":"traceutil/trace.go:171","msg":"trace[74646420] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:590; }","duration":"282.431165ms","start":"2026-07-14T16:51:19.93436Z","end":"2026-07-14T16:51:20.216791Z","steps":["trace[74646420] 'agreement among raft nodes before linearized reading' (duration: 282.365384ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T16:51:20.216926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.878385ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-14T16:51:20.21696Z","caller":"traceutil/trace.go:171","msg":"trace[1523424852] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:590; }","duration":"282.943586ms","start":"2026-07-14T16:51:19.934008Z","end":"2026-07-14T16:51:20.216952Z","steps":["trace[1523424852] 'agreement among raft nodes before linearized reading' (duration: 282.896175ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T16:51:20.217089Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"365.910027ms","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-07-14T16:51:20.217157Z","caller":"traceutil/trace.go:171","msg":"trace[1385006208] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:590; }","duration":"365.965008ms","start":"2026-07-14T16:51:19.851164Z","end":"2026-07-14T16:51:20.217129Z","steps":["trace[1385006208] 'agreement among raft nodes before linearized reading' (duration: 365.889637ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T16:51:20.216645Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.975322ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-14T16:51:20.217197Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T16:51:19.851141Z","time spent":"366.045369ms","remote":"127.0.0.1:48424","response type":"/etcdserverpb.KV/Range","request count":0,"request size":115,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:500 "} {"level":"info","ts":"2026-07-14T16:51:20.217244Z","caller":"traceutil/trace.go:171","msg":"trace[1912451328] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:590; }","duration":"309.549793ms","start":"2026-07-14T16:51:19.907641Z","end":"2026-07-14T16:51:20.217191Z","steps":["trace[1912451328] 'agreement among raft nodes before linearized reading' (duration: 308.978092ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T16:51:20.217313Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T16:51:19.90763Z","time spent":"309.644515ms","remote":"127.0.0.1:48450","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 "} {"level":"warn","ts":"2026-07-14T16:51:20.217349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"333.387744ms","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-07-14T16:51:20.217386Z","caller":"traceutil/trace.go:171","msg":"trace[1524409794] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:590; }","duration":"333.449695ms","start":"2026-07-14T16:51:19.883926Z","end":"2026-07-14T16:51:20.217376Z","steps":["trace[1524409794] 'agreement among raft nodes before linearized reading' (duration: 333.393974ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T16:51:20.21742Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T16:51:19.883915Z","time spent":"333.498046ms","remote":"127.0.0.1:48438","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-07-14T16:51:20.216455Z","caller":"traceutil/trace.go:171","msg":"trace[457589119] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:590; }","duration":"193.867481ms","start":"2026-07-14T16:51:20.022569Z","end":"2026-07-14T16:51:20.216437Z","steps":["trace[457589119] 'agreement among raft nodes before linearized reading' (duration: 193.742898ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T16:51:20.21752Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T16:51:19.824316Z","time spent":"391.545734ms","remote":"127.0.0.1:42344","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-14T16:51:20.217548Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"333.607899ms","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-07-14T16:51:20.2161Z","caller":"traceutil/trace.go:171","msg":"trace[1959509406] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:590; }","duration":"365.600541ms","start":"2026-07-14T16:51:19.850484Z","end":"2026-07-14T16:51:20.216085Z","steps":["trace[1959509406] 'agreement among raft nodes before linearized reading' (duration: 365.444918ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T16:51:20.218013Z","caller":"traceutil/trace.go:171","msg":"trace[46915812] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:590; }","duration":"334.079829ms","start":"2026-07-14T16:51:19.883904Z","end":"2026-07-14T16:51:20.217984Z","steps":["trace[46915812] 'agreement among raft nodes before linearized reading' (duration: 333.621809ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T16:51:20.218161Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T16:51:19.850474Z","time spent":"367.663363ms","remote":"127.0.0.1:48424","response type":"/etcdserverpb.KV/Range","request count":0,"request size":115,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-07-14T16:51:20.218223Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T16:51:19.883889Z","time spent":"334.309573ms","remote":"127.0.0.1:48438","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 "} {"level":"warn","ts":"2026-07-14T16:51:20.218114Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.502009ms","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-07-14T16:51:20.218509Z","caller":"traceutil/trace.go:171","msg":"trace[1715115973] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:590; }","duration":"112.924248ms","start":"2026-07-14T16:51:20.105573Z","end":"2026-07-14T16:51:20.218498Z","steps":["trace[1715115973] 'agreement among raft nodes before linearized reading' (duration: 112.506249ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T16:51:20.21859Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.206687ms","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-07-14T16:51:20.218715Z","caller":"traceutil/trace.go:171","msg":"trace[1900812860] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:590; }","duration":"115.323519ms","start":"2026-07-14T16:51:20.103361Z","end":"2026-07-14T16:51:20.218684Z","steps":["trace[1900812860] 'agreement among raft nodes before linearized reading' (duration: 115.189626ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T16:51:20.220003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.643876ms","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-07-14T16:51:20.220037Z","caller":"traceutil/trace.go:171","msg":"trace[1391088868] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:590; }","duration":"116.696287ms","start":"2026-07-14T16:51:20.103332Z","end":"2026-07-14T16:51:20.220028Z","steps":["trace[1391088868] 'agreement among raft nodes before linearized reading' (duration: 116.644325ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T16:51:35.453854Z","caller":"traceutil/trace.go:171","msg":"trace[2101320957] transaction","detail":"{read_only:false; response_revision:750; number_of_response:1; }","duration":"160.692618ms","start":"2026-07-14T16:51:35.293139Z","end":"2026-07-14T16:51:35.453831Z","steps":["trace[2101320957] 'process raft request' (duration: 160.562916ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T16:51:35.460946Z","caller":"traceutil/trace.go:171","msg":"trace[1371889092] transaction","detail":"{read_only:false; response_revision:751; number_of_response:1; }","duration":"165.912946ms","start":"2026-07-14T16:51:35.295014Z","end":"2026-07-14T16:51:35.460927Z","steps":["trace[1371889092] 'process raft request' (duration: 165.845664ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T16:52:47.982988Z","caller":"traceutil/trace.go:171","msg":"trace[290690439] linearizableReadLoop","detail":"{readStateIndex:1863; appliedIndex:1862; }","duration":"143.741543ms","start":"2026-07-14T16:52:47.839213Z","end":"2026-07-14T16:52:47.982955Z","steps":["trace[290690439] 'read index received' (duration: 132.622608ms)","trace[290690439] 'applied index is now lower than readState.Index' (duration: 11.117325ms)"],"step_count":2} {"level":"info","ts":"2026-07-14T16:52:47.983004Z","caller":"traceutil/trace.go:171","msg":"trace[1582287422] transaction","detail":"{read_only:false; response_revision:1794; number_of_response:1; }","duration":"164.224962ms","start":"2026-07-14T16:52:47.818746Z","end":"2026-07-14T16:52:47.982971Z","steps":["trace[1582287422] 'process raft request' (duration: 153.091357ms)","trace[1582287422] 'compare' (duration: 10.856762ms)"],"step_count":2} {"level":"warn","ts":"2026-07-14T16:52:47.983222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.998306ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-07-14T16:52:47.983269Z","caller":"traceutil/trace.go:171","msg":"trace[485368202] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1794; }","duration":"144.062227ms","start":"2026-07-14T16:52:47.839197Z","end":"2026-07-14T16:52:47.98326Z","steps":["trace[485368202] 'agreement among raft nodes before linearized reading' (duration: 143.866625ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T16:52:48.023117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.031347ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-07-14T16:52:48.023135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.962487ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-07-14T16:52:48.023168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.862459ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-07-14T16:52:48.023202Z","caller":"traceutil/trace.go:171","msg":"trace[1212015450] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1794; }","duration":"182.18066ms","start":"2026-07-14T16:52:47.841003Z","end":"2026-07-14T16:52:48.023184Z","steps":["trace[1212015450] 'agreement among raft nodes before linearized reading' (duration: 181.944077ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T16:52:48.023212Z","caller":"traceutil/trace.go:171","msg":"trace[1049321799] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1794; }","duration":"178.078079ms","start":"2026-07-14T16:52:47.845117Z","end":"2026-07-14T16:52:48.023195Z","steps":["trace[1049321799] 'agreement among raft nodes before linearized reading' (duration: 177.871226ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T16:52:48.023235Z","caller":"traceutil/trace.go:171","msg":"trace[1272927700] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1794; }","duration":"178.9523ms","start":"2026-07-14T16:52:47.844266Z","end":"2026-07-14T16:52:48.023219Z","steps":["trace[1272927700] 'agreement among raft nodes before linearized reading' (duration: 178.717417ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T16:53:16.234105Z","caller":"traceutil/trace.go:171","msg":"trace[46802920] transaction","detail":"{read_only:false; response_revision:2005; number_of_response:1; }","duration":"119.843074ms","start":"2026-07-14T16:53:16.11424Z","end":"2026-07-14T16:53:16.234083Z","steps":["trace[46802920] 'process raft request' (duration: 119.538481ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T16:53:22.454548Z","caller":"traceutil/trace.go:171","msg":"trace[1433618524] transaction","detail":"{read_only:false; response_revision:2038; number_of_response:1; }","duration":"113.120711ms","start":"2026-07-14T16:53:22.341401Z","end":"2026-07-14T16:53:22.454522Z","steps":["trace[1433618524] 'process raft request' (duration: 112.923439ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T16:53:22.454786Z","caller":"traceutil/trace.go:171","msg":"trace[1011899574] transaction","detail":"{read_only:false; response_revision:2040; number_of_response:1; }","duration":"111.844837ms","start":"2026-07-14T16:53:22.342915Z","end":"2026-07-14T16:53:22.45476Z","steps":["trace[1011899574] 'process raft request' (duration: 111.734026ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T16:53:22.454856Z","caller":"traceutil/trace.go:171","msg":"trace[11021556] transaction","detail":"{read_only:false; response_revision:2039; number_of_response:1; }","duration":"112.545434ms","start":"2026-07-14T16:53:22.342226Z","end":"2026-07-14T16:53:22.454772Z","steps":["trace[11021556] 'process raft request' (duration: 112.257331ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T16:53:22.659193Z","caller":"traceutil/trace.go:171","msg":"trace[1016323782] linearizableReadLoop","detail":"{readStateIndex:2118; appliedIndex:2117; }","duration":"111.524403ms","start":"2026-07-14T16:53:22.547641Z","end":"2026-07-14T16:53:22.659165Z","steps":["trace[1016323782] 'read index received' (duration: 91.390244ms)","trace[1016323782] 'applied index is now lower than readState.Index' (duration: 20.132649ms)"],"step_count":2} {"level":"info","ts":"2026-07-14T16:53:22.659303Z","caller":"traceutil/trace.go:171","msg":"trace[1489995704] transaction","detail":"{read_only:false; response_revision:2041; number_of_response:1; }","duration":"150.980072ms","start":"2026-07-14T16:53:22.508239Z","end":"2026-07-14T16:53:22.659219Z","steps":["trace[1489995704] 'process raft request' (duration: 130.956855ms)","trace[1489995704] 'compare' (duration: 19.799425ms)"],"step_count":2} {"level":"warn","ts":"2026-07-14T16:53:22.659634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.974409ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.240\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-07-14T16:53:22.659687Z","caller":"traceutil/trace.go:171","msg":"trace[1016980572] range","detail":"{range_begin:/registry/masterleases/199.204.45.240; range_end:; response_count:1; response_revision:2041; }","duration":"112.085399ms","start":"2026-07-14T16:53:22.547587Z","end":"2026-07-14T16:53:22.659672Z","steps":["trace[1016980572] 'agreement among raft nodes before linearized reading' (duration: 111.680445ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T16:54:26.804416Z","caller":"traceutil/trace.go:171","msg":"trace[1542939808] linearizableReadLoop","detail":"{readStateIndex:2574; appliedIndex:2573; }","duration":"155.817238ms","start":"2026-07-14T16:54:26.648572Z","end":"2026-07-14T16:54:26.80439Z","steps":["trace[1542939808] 'read index received' (duration: 155.60194ms)","trace[1542939808] 'applied index is now lower than readState.Index' (duration: 214.278µs)"],"step_count":2} {"level":"info","ts":"2026-07-14T16:54:26.804791Z","caller":"traceutil/trace.go:171","msg":"trace[2111107711] transaction","detail":"{read_only:false; response_revision:2482; number_of_response:1; }","duration":"186.851051ms","start":"2026-07-14T16:54:26.617925Z","end":"2026-07-14T16:54:26.804776Z","steps":["trace[2111107711] 'process raft request' (duration: 186.320371ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T16:54:26.805128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.535196ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-07-14T16:54:26.805178Z","caller":"traceutil/trace.go:171","msg":"trace[1211521644] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2482; }","duration":"156.623079ms","start":"2026-07-14T16:54:26.648542Z","end":"2026-07-14T16:54:26.805165Z","steps":["trace[1211521644] 'agreement among raft nodes before linearized reading' (duration: 156.449443ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T16:54:59.192397Z","caller":"traceutil/trace.go:171","msg":"trace[1374506252] transaction","detail":"{read_only:false; response_revision:2665; number_of_response:1; }","duration":"112.461578ms","start":"2026-07-14T16:54:59.079909Z","end":"2026-07-14T16:54:59.19237Z","steps":["trace[1374506252] 'process raft request' (duration: 112.291073ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T16:54:59.215351Z","caller":"traceutil/trace.go:171","msg":"trace[1392434911] transaction","detail":"{read_only:false; response_revision:2666; number_of_response:1; }","duration":"135.01694ms","start":"2026-07-14T16:54:59.080309Z","end":"2026-07-14T16:54:59.215326Z","steps":["trace[1392434911] 'process raft request' (duration: 117.535141ms)","trace[1392434911] 'compare' (duration: 17.384126ms)"],"step_count":2} {"level":"warn","ts":"2026-07-14T16:54:59.559592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.111962ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-14T16:54:59.559933Z","caller":"traceutil/trace.go:171","msg":"trace[487405105] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2666; }","duration":"224.504104ms","start":"2026-07-14T16:54:59.335404Z","end":"2026-07-14T16:54:59.559908Z","steps":["trace[487405105] 'range keys from in-memory index tree' (duration: 224.013368ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T16:54:59.560277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.378473ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-14T16:54:59.560395Z","caller":"traceutil/trace.go:171","msg":"trace[1006979153] transaction","detail":"{read_only:false; response_revision:2667; number_of_response:1; }","duration":"189.348459ms","start":"2026-07-14T16:54:59.371025Z","end":"2026-07-14T16:54:59.560373Z","steps":["trace[1006979153] 'process raft request' (duration: 32.535062ms)","trace[1006979153] 'compare' (duration: 156.25508ms)"],"step_count":2} {"level":"info","ts":"2026-07-14T16:58:48.548713Z","caller":"traceutil/trace.go:171","msg":"trace[710725105] transaction","detail":"{read_only:false; response_revision:4651; number_of_response:1; }","duration":"210.566683ms","start":"2026-07-14T16:58:48.338101Z","end":"2026-07-14T16:58:48.548668Z","steps":["trace[710725105] 'process raft request' (duration: 210.325919ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T16:58:48.635922Z","caller":"traceutil/trace.go:171","msg":"trace[425532677] transaction","detail":"{read_only:false; response_revision:4652; number_of_response:1; }","duration":"294.078338ms","start":"2026-07-14T16:58:48.341806Z","end":"2026-07-14T16:58:48.635885Z","steps":["trace[425532677] 'process raft request' (duration: 258.778745ms)","trace[425532677] 'compare' (duration: 35.056899ms)"],"step_count":2} {"level":"info","ts":"2026-07-14T16:58:48.635893Z","caller":"traceutil/trace.go:171","msg":"trace[1316537792] linearizableReadLoop","detail":"{readStateIndex:4831; appliedIndex:4829; }","duration":"241.497426ms","start":"2026-07-14T16:58:48.394345Z","end":"2026-07-14T16:58:48.635842Z","steps":["trace[1316537792] 'read index received' (duration: 154.084269ms)","trace[1316537792] 'applied index is now lower than readState.Index' (duration: 87.411527ms)"],"step_count":2} {"level":"warn","ts":"2026-07-14T16:58:48.636159Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.76543ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/acme.cert-manager.io/orders/\" range_end:\"/registry/acme.cert-manager.io/orders0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-14T16:58:48.636263Z","caller":"traceutil/trace.go:171","msg":"trace[1027641089] range","detail":"{range_begin:/registry/acme.cert-manager.io/orders/; range_end:/registry/acme.cert-manager.io/orders0; response_count:0; response_revision:4652; }","duration":"241.897742ms","start":"2026-07-14T16:58:48.394337Z","end":"2026-07-14T16:58:48.636235Z","steps":["trace[1027641089] 'agreement among raft nodes before linearized reading' (duration: 241.657228ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T16:59:00.62258Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.392247ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/users/\" range_end:\"/registry/rabbitmq.com/users0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-14T16:59:00.622659Z","caller":"traceutil/trace.go:171","msg":"trace[268392897] range","detail":"{range_begin:/registry/rabbitmq.com/users/; range_end:/registry/rabbitmq.com/users0; response_count:0; response_revision:4824; }","duration":"165.515299ms","start":"2026-07-14T16:59:00.457129Z","end":"2026-07-14T16:59:00.622644Z","steps":["trace[268392897] 'count revisions from in-memory index tree' (duration: 165.343247ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T16:59:00.623199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.41121ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:10392"} {"level":"info","ts":"2026-07-14T16:59:00.623284Z","caller":"traceutil/trace.go:171","msg":"trace[109842244] range","detail":"{range_begin:/registry/pods/openstack/rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4824; }","duration":"171.527811ms","start":"2026-07-14T16:59:00.451744Z","end":"2026-07-14T16:59:00.623272Z","steps":["trace[109842244] 'range keys from in-memory index tree' (duration: 171.256237ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T16:59:00.850512Z","caller":"traceutil/trace.go:171","msg":"trace[502784887] transaction","detail":"{read_only:false; response_revision:4825; number_of_response:1; }","duration":"216.289678ms","start":"2026-07-14T16:59:00.634193Z","end":"2026-07-14T16:59:00.850482Z","steps":["trace[502784887] 'process raft request' (duration: 216.117936ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T17:00:39.752036Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2876} {"level":"info","ts":"2026-07-14T17:00:39.828333Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2876,"took":"74.9601ms","hash":859388247,"current-db-size-bytes":53616640,"current-db-size":"54 MB","current-db-size-in-use-bytes":29962240,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-07-14T17:00:39.828439Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":859388247,"revision":2876,"compact-revision":-1} {"level":"warn","ts":"2026-07-14T17:03:10.039567Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.193522827s","expected-duration":"1s"} {"level":"warn","ts":"2026-07-14T17:03:10.49713Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.728192943s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:572"} {"level":"info","ts":"2026-07-14T17:03:10.497254Z","caller":"traceutil/trace.go:171","msg":"trace[1212099056] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:6623; }","duration":"1.728392661s","start":"2026-07-14T17:03:08.76883Z","end":"2026-07-14T17:03:10.497222Z","steps":["trace[1212099056] 'range keys from in-memory index tree' (duration: 1.727944613s)"],"step_count":1} {"level":"warn","ts":"2026-07-14T17:03:10.497317Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:03:08.7688Z","time spent":"1.728499195s","remote":"127.0.0.1:42128","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":595,"request content":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" "} {"level":"warn","ts":"2026-07-14T17:03:10.497396Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"457.471298ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-14T17:03:10.497605Z","caller":"traceutil/trace.go:171","msg":"trace[1388188143] transaction","detail":"{read_only:false; response_revision:6624; number_of_response:1; }","duration":"1.651595378s","start":"2026-07-14T17:03:08.845901Z","end":"2026-07-14T17:03:10.497496Z","steps":["trace[1388188143] 'process raft request' (duration: 1.193924302s)","trace[1388188143] 'compare' (duration: 457.048681ms)"],"step_count":2} {"level":"warn","ts":"2026-07-14T17:03:10.497761Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:03:08.845865Z","time spent":"1.651789346s","remote":"127.0.0.1:42128","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-14T17:03:10.49805Z","caller":"traceutil/trace.go:171","msg":"trace[112413153] linearizableReadLoop","detail":"{readStateIndex:6872; appliedIndex:6870; }","duration":"541.557987ms","start":"2026-07-14T17:03:09.95647Z","end":"2026-07-14T17:03:10.498028Z","steps":["trace[112413153] 'read index received' (duration: 83.373931ms)","trace[112413153] 'applied index is now lower than readState.Index' (duration: 458.183035ms)"],"step_count":2} {"level":"info","ts":"2026-07-14T17:03:10.498158Z","caller":"traceutil/trace.go:171","msg":"trace[1763317401] transaction","detail":"{read_only:false; response_revision:6625; number_of_response:1; }","duration":"1.650093809s","start":"2026-07-14T17:03:08.848049Z","end":"2026-07-14T17:03:10.498143Z","steps":["trace[1763317401] 'process raft request' (duration: 1.649795237s)"],"step_count":1} {"level":"warn","ts":"2026-07-14T17:03:10.498298Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:03:08.848026Z","time spent":"1.650164752s","remote":"127.0.0.1:42128","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-14T17:03:10.498615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"542.136219ms","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-07-14T17:03:10.498662Z","caller":"traceutil/trace.go:171","msg":"trace[1512410012] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:6625; }","duration":"542.212112ms","start":"2026-07-14T17:03:09.956435Z","end":"2026-07-14T17:03:10.498647Z","steps":["trace[1512410012] 'agreement among raft nodes before linearized reading' (duration: 542.055885ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T17:03:10.498711Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:03:09.956416Z","time spent":"542.284855ms","remote":"127.0.0.1:42128","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-07-14T17:03:10.499204Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"532.854945ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/alertmanagers/\" range_end:\"/registry/monitoring.coreos.com/alertmanagers0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-14T17:03:10.499271Z","caller":"traceutil/trace.go:171","msg":"trace[1351342817] range","detail":"{range_begin:/registry/monitoring.coreos.com/alertmanagers/; range_end:/registry/monitoring.coreos.com/alertmanagers0; response_count:0; response_revision:6625; }","duration":"533.054653ms","start":"2026-07-14T17:03:09.966198Z","end":"2026-07-14T17:03:10.499252Z","steps":["trace[1351342817] 'agreement among raft nodes before linearized reading' (duration: 532.883966ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T17:03:10.499284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"542.529042ms","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-07-14T17:03:10.499347Z","caller":"traceutil/trace.go:171","msg":"trace[763770913] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:6625; }","duration":"542.604416ms","start":"2026-07-14T17:03:09.956726Z","end":"2026-07-14T17:03:10.499331Z","steps":["trace[763770913] 'agreement among raft nodes before linearized reading' (duration: 542.418149ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T17:03:10.49935Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:03:09.966173Z","time spent":"533.146457ms","remote":"127.0.0.1:43648","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":1,"response size":30,"request content":"key:\"/registry/monitoring.coreos.com/alertmanagers/\" range_end:\"/registry/monitoring.coreos.com/alertmanagers0\" count_only:true "} {"level":"warn","ts":"2026-07-14T17:03:10.499374Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:03:09.956721Z","time spent":"542.647197ms","remote":"127.0.0.1:42128","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-07-14T17:03:10.499436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"542.698469ms","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-07-14T17:03:10.499509Z","caller":"traceutil/trace.go:171","msg":"trace[730721918] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:6625; }","duration":"542.776992ms","start":"2026-07-14T17:03:09.956712Z","end":"2026-07-14T17:03:10.499489Z","steps":["trace[730721918] 'agreement among raft nodes before linearized reading' (duration: 542.601655ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T17:03:10.499533Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"542.73168ms","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-07-14T17:03:10.499557Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:03:09.956691Z","time spent":"542.851065ms","remote":"127.0.0.1:42128","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-07-14T17:03:10.49959Z","caller":"traceutil/trace.go:171","msg":"trace[1348762821] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:6625; }","duration":"542.846545ms","start":"2026-07-14T17:03:09.95673Z","end":"2026-07-14T17:03:10.499576Z","steps":["trace[1348762821] 'agreement among raft nodes before linearized reading' (duration: 542.719101ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T17:03:10.499637Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:03:09.956698Z","time spent":"542.927988ms","remote":"127.0.0.1:42128","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-07-14T17:03:10.499645Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"543.016352ms","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-07-14T17:03:10.499703Z","caller":"traceutil/trace.go:171","msg":"trace[2126268144] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:6625; }","duration":"543.086254ms","start":"2026-07-14T17:03:09.956607Z","end":"2026-07-14T17:03:10.499693Z","steps":["trace[2126268144] 'agreement among raft nodes before linearized reading' (duration: 542.092446ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T17:03:10.499424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"354.731044ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/openstack/percona-xtradb\" ","response":"range_response_count:1 size:724"} {"level":"info","ts":"2026-07-14T17:03:10.499842Z","caller":"traceutil/trace.go:171","msg":"trace[1873257514] range","detail":"{range_begin:/registry/secrets/openstack/percona-xtradb; range_end:; response_count:1; response_revision:6625; }","duration":"355.38069ms","start":"2026-07-14T17:03:10.144438Z","end":"2026-07-14T17:03:10.499819Z","steps":["trace[1873257514] 'agreement among raft nodes before linearized reading' (duration: 354.662312ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T17:03:10.500023Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:03:10.144422Z","time spent":"355.582568ms","remote":"127.0.0.1:41940","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":747,"request content":"key:\"/registry/secrets/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-07-14T17:03:10.499749Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:03:09.956599Z","time spent":"543.142227ms","remote":"127.0.0.1:42128","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-07-14T17:03:10.500255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"527.719175ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-14T17:03:10.500293Z","caller":"traceutil/trace.go:171","msg":"trace[1764991262] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:6625; }","duration":"527.84515ms","start":"2026-07-14T17:03:09.972437Z","end":"2026-07-14T17:03:10.500282Z","steps":["trace[1764991262] 'agreement among raft nodes before linearized reading' (duration: 526.820239ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T17:03:10.500316Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:03:09.972425Z","time spent":"527.883921ms","remote":"127.0.0.1:41854","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-07-14T17:03:35.115021Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5153700589865572707,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-14T17:03:35.615867Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5153700589865572707,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-14T17:03:36.116433Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5153700589865572707,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-14T17:03:36.61731Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5153700589865572707,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-14T17:03:37.118448Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5153700589865572707,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-14T17:03:37.346189Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.010067878s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-07-14T17:03:37.34626Z","caller":"traceutil/trace.go:171","msg":"trace[1930146027] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.010191603s","start":"2026-07-14T17:03:35.336056Z","end":"2026-07-14T17:03:37.346247Z","steps":["trace[1930146027] 'agreement among raft nodes before linearized reading' (duration: 2.010094279s)"],"step_count":1} {"level":"warn","ts":"2026-07-14T17:03:37.346297Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:03:35.33604Z","time spent":"2.010250265s","remote":"127.0.0.1:41854","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/07/14 17:03:37 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-07-14T17:03:39.337375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.99081274s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-07-14T17:03:39.337464Z","caller":"traceutil/trace.go:171","msg":"trace[1890279248] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"1.990978115s","start":"2026-07-14T17:03:37.346468Z","end":"2026-07-14T17:03:39.337446Z","steps":["trace[1890279248] 'agreement among raft nodes before linearized reading' (duration: 1.990874702s)"],"step_count":1} {"level":"warn","ts":"2026-07-14T17:03:39.337526Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:03:37.346449Z","time spent":"1.991067359s","remote":"127.0.0.1:41856","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/07/14 17:03:39 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-07-14T17:03:39.583946Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:03:34.585325Z","time spent":"4.998616348s","remote":"127.0.0.1:42128","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""} 2026/07/14 17:03:39 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-07-14T17:03:39.588714Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:03:34.59009Z","time spent":"4.998616846s","remote":"127.0.0.1:42128","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""} 2026/07/14 17:03:39 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-07-14T17:03:39.617747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.99987296s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-07-14T17:03:39.61787Z","caller":"traceutil/trace.go:171","msg":"trace[156898801] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; }","duration":"5.000043275s","start":"2026-07-14T17:03:34.617782Z","end":"2026-07-14T17:03:39.617825Z","steps":["trace[156898801] 'agreement among raft nodes before linearized reading' (duration: 4.99988914s)"],"step_count":1} {"level":"warn","ts":"2026-07-14T17:03:39.61795Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:03:34.617773Z","time spent":"5.000165371s","remote":"127.0.0.1:42128","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/07/14 17:03:39 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-07-14T17:03:39.620338Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"5.000199681s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-07-14T17:03:39.620444Z","caller":"traceutil/trace.go:171","msg":"trace[260697364] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; }","duration":"5.000346516s","start":"2026-07-14T17:03:34.620087Z","end":"2026-07-14T17:03:39.620433Z","steps":["trace[260697364] 'agreement among raft nodes before linearized reading' (duration: 5.000236672s)"],"step_count":1} {"level":"warn","ts":"2026-07-14T17:03:39.620481Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:03:34.620068Z","time spent":"5.000403529s","remote":"127.0.0.1:42128","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/07/14 17:03:39 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-07-14T17:03:39.667586Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"5.035575847s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-07-14T17:03:39.66767Z","caller":"traceutil/trace.go:171","msg":"trace[1426695477] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; }","duration":"5.035708003s","start":"2026-07-14T17:03:34.631942Z","end":"2026-07-14T17:03:39.66765Z","steps":["trace[1426695477] 'agreement among raft nodes before linearized reading' (duration: 5.035611209s)"],"step_count":1} {"level":"warn","ts":"2026-07-14T17:03:39.667712Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:03:34.631924Z","time spent":"5.035779565s","remote":"127.0.0.1:42128","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} 2026/07/14 17:03:39 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-07-14T17:03:39.670407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.04160077s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-07-14T17:03:39.670458Z","caller":"traceutil/trace.go:171","msg":"trace[1565859854] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.041679073s","start":"2026-07-14T17:03:37.628768Z","end":"2026-07-14T17:03:39.670447Z","steps":["trace[1565859854] 'agreement among raft nodes before linearized reading' (duration: 2.041624531s)"],"step_count":1} {"level":"warn","ts":"2026-07-14T17:03:39.670499Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:03:37.628755Z","time spent":"2.041733784s","remote":"127.0.0.1:41854","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/07/14 17:03:39 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-07-14T17:03:39.670795Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5153700589865572707,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-14T17:03:45.439782Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"5.849291413s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-07-14T17:03:45.439885Z","caller":"traceutil/trace.go:171","msg":"trace[591954770] range","detail":"{range_begin:/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io; range_end:; }","duration":"5.849434217s","start":"2026-07-14T17:03:39.590427Z","end":"2026-07-14T17:03:45.439861Z","steps":["trace[591954770] 'agreement among raft nodes before linearized reading' (duration: 5.849299132s)"],"step_count":1} {"level":"warn","ts":"2026-07-14T17:03:45.439934Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:03:39.590416Z","time spent":"5.849508s","remote":"127.0.0.1:42128","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":0,"response size":0,"request content":"key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" "} {"level":"warn","ts":"2026-07-14T17:03:45.440164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"6.095744046s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-07-14T17:03:45.440193Z","caller":"traceutil/trace.go:171","msg":"trace[2109109402] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"6.095802988s","start":"2026-07-14T17:03:39.344381Z","end":"2026-07-14T17:03:45.440184Z","steps":["trace[2109109402] 'agreement among raft nodes before linearized reading' (duration: 6.095774117s)"],"step_count":1} {"level":"warn","ts":"2026-07-14T17:03:45.440218Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:03:39.344366Z","time spent":"6.095846029s","remote":"127.0.0.1:41854","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-07-14T17:03:45.440263Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:03:34.278316Z","time spent":"11.161944399s","remote":"127.0.0.1:42022","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""} {"level":"warn","ts":"2026-07-14T17:03:45.441095Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:03:36.573145Z","time spent":"8.86794718s","remote":"127.0.0.1:41936","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""} {"level":"warn","ts":"2026-07-14T17:03:45.441352Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"10.813857199s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-07-14T17:03:45.441394Z","caller":"traceutil/trace.go:171","msg":"trace[220740008] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; }","duration":"10.813932731s","start":"2026-07-14T17:03:34.62745Z","end":"2026-07-14T17:03:45.441383Z","steps":["trace[220740008] 'agreement among raft nodes before linearized reading' (duration: 10.813885459s)"],"step_count":1} {"level":"warn","ts":"2026-07-14T17:03:45.441428Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:03:34.627406Z","time spent":"10.814013004s","remote":"127.0.0.1:42128","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":0,"response size":0,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} 2026/07/14 17:03:45 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-07-14T17:03:45.440439Z","caller":"etcdserver/v3_server.go:909","msg":"timed out waiting for read index response (local node might have slow network)","timeout":"7s"} {"level":"warn","ts":"2026-07-14T17:03:45.441524Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"10.804145589s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-07-14T17:03:45.441549Z","caller":"traceutil/trace.go:171","msg":"trace[606639584] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; }","duration":"10.804191421s","start":"2026-07-14T17:03:34.637351Z","end":"2026-07-14T17:03:45.441543Z","steps":["trace[606639584] 'agreement among raft nodes before linearized reading' (duration: 10.80416497s)"],"step_count":1} {"level":"warn","ts":"2026-07-14T17:03:45.441574Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:03:34.637341Z","time spent":"10.804227462s","remote":"127.0.0.1:42128","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} 2026/07/14 17:03:45 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-07-14T17:03:45.441631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"10.803666291s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-07-14T17:03:45.44165Z","caller":"traceutil/trace.go:171","msg":"trace[229942501] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; }","duration":"10.803703722s","start":"2026-07-14T17:03:34.637941Z","end":"2026-07-14T17:03:45.441645Z","steps":["trace[229942501] 'agreement among raft nodes before linearized reading' (duration: 10.803683432s)"],"step_count":1} {"level":"warn","ts":"2026-07-14T17:03:45.441673Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:03:34.637932Z","time spent":"10.803734923s","remote":"127.0.0.1:42128","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} 2026/07/14 17:03:45 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-07-14T17:03:45.442151Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:03:35.493522Z","time spent":"9.948622715s","remote":"127.0.0.1:42128","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""} {"level":"warn","ts":"2026-07-14T17:03:45.442875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"10.827933487s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"","error":"etcdserver: request timed out"} {"level":"info","ts":"2026-07-14T17:03:45.442903Z","caller":"traceutil/trace.go:171","msg":"trace[321580113] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; }","duration":"10.828005969s","start":"2026-07-14T17:03:34.614889Z","end":"2026-07-14T17:03:45.442895Z","steps":["trace[321580113] 'agreement among raft nodes before linearized reading' (duration: 10.827971988s)"],"step_count":1} {"level":"warn","ts":"2026-07-14T17:03:45.442961Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:03:34.614868Z","time spent":"10.828084642s","remote":"127.0.0.1:42128","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":0,"request content":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" "} {"level":"warn","ts":"2026-07-14T17:03:45.446648Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:03:36.357017Z","time spent":"9.08962621s","remote":"127.0.0.1:42128","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""} {"level":"warn","ts":"2026-07-14T17:03:45.469942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"8.23086782s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-07-14T17:03:45.470019Z","caller":"traceutil/trace.go:171","msg":"trace[2119434514] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; }","duration":"8.231000115s","start":"2026-07-14T17:03:37.238999Z","end":"2026-07-14T17:03:45.469999Z","steps":["trace[2119434514] 'agreement among raft nodes before linearized reading' (duration: 8.230902372s)"],"step_count":1} {"level":"warn","ts":"2026-07-14T17:03:45.470059Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:03:37.238982Z","time spent":"8.231065868s","remote":"127.0.0.1:42022","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":0,"response size":0,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} 2026/07/14 17:03:45 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-07-14T17:03:45.474272Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"11.19585261s","expected-duration":"1s"} {"level":"info","ts":"2026-07-14T17:03:45.805925Z","caller":"traceutil/trace.go:171","msg":"trace[705313361] transaction","detail":"{read_only:false; response_revision:6760; number_of_response:1; }","duration":"6.83331555s","start":"2026-07-14T17:03:38.972585Z","end":"2026-07-14T17:03:45.8059Z","steps":["trace[705313361] 'process raft request' (duration: 6.833237417s)"],"step_count":1} {"level":"warn","ts":"2026-07-14T17:03:45.806064Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:03:38.972565Z","time spent":"6.833427494s","remote":"127.0.0.1:42128","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-14T17:03:45.93928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.385718ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-07-14T17:03:45.939807Z","caller":"traceutil/trace.go:171","msg":"trace[506386471] transaction","detail":"{read_only:false; response_revision:6761; number_of_response:1; }","duration":"497.846162ms","start":"2026-07-14T17:03:45.441907Z","end":"2026-07-14T17:03:45.939754Z","steps":["trace[506386471] 'process raft request' (duration: 497.470188ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T17:03:45.94001Z","caller":"traceutil/trace.go:171","msg":"trace[365099388] transaction","detail":"{read_only:false; response_revision:6763; number_of_response:1; }","duration":"497.946344ms","start":"2026-07-14T17:03:45.442046Z","end":"2026-07-14T17:03:45.939992Z","steps":["trace[365099388] 'process raft request' (duration: 497.726286ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T17:03:45.940184Z","caller":"traceutil/trace.go:171","msg":"trace[549208496] transaction","detail":"{read_only:false; response_revision:6764; number_of_response:1; }","duration":"498.08673ms","start":"2026-07-14T17:03:45.442087Z","end":"2026-07-14T17:03:45.940173Z","steps":["trace[549208496] 'process raft request' (duration: 497.836551ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T17:03:45.940105Z","caller":"traceutil/trace.go:171","msg":"trace[1975468944] transaction","detail":"{read_only:false; response_revision:6762; number_of_response:1; }","duration":"497.983287ms","start":"2026-07-14T17:03:45.441999Z","end":"2026-07-14T17:03:45.939982Z","steps":["trace[1975468944] 'process raft request' (duration: 497.50272ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T17:03:45.940349Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:03:45.442038Z","time spent":"498.042968ms","remote":"127.0.0.1:42128","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":458,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-14T17:03:45.940195Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:03:45.441896Z","time spent":"498.113322ms","remote":"127.0.0.1:42128","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":411,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-14T17:03:45.940277Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:03:45.442081Z","time spent":"498.134661ms","remote":"127.0.0.1:42128","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":415,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-14T17:03:45.940684Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:03:45.441993Z","time spent":"498.409272ms","remote":"127.0.0.1:42128","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-07-14T17:03:45.940759Z","caller":"traceutil/trace.go:171","msg":"trace[1833115729] linearizableReadLoop","detail":"{readStateIndex:7013; appliedIndex:7006; }","duration":"499.208551ms","start":"2026-07-14T17:03:45.441536Z","end":"2026-07-14T17:03:45.940744Z","steps":["trace[1833115729] 'read index received' (duration: 33.362132ms)","trace[1833115729] 'applied index is now lower than readState.Index' (duration: 465.845539ms)"],"step_count":2} {"level":"info","ts":"2026-07-14T17:03:45.940762Z","caller":"traceutil/trace.go:171","msg":"trace[2102131603] transaction","detail":"{read_only:false; response_revision:6765; number_of_response:1; }","duration":"495.718795ms","start":"2026-07-14T17:03:45.445019Z","end":"2026-07-14T17:03:45.940738Z","steps":["trace[2102131603] 'process raft request' (duration: 495.102872ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T17:03:45.940798Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"6.272554889s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/acme.cert-manager.io/orders/\" range_end:\"/registry/acme.cert-manager.io/orders0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-14T17:03:45.940827Z","caller":"traceutil/trace.go:171","msg":"trace[1715077212] range","detail":"{range_begin:/registry/acme.cert-manager.io/orders/; range_end:/registry/acme.cert-manager.io/orders0; response_count:0; response_revision:6766; }","duration":"6.272625163s","start":"2026-07-14T17:03:39.668193Z","end":"2026-07-14T17:03:45.940819Z","steps":["trace[1715077212] 'agreement among raft nodes before linearized reading' (duration: 6.27255489s)"],"step_count":1} {"level":"warn","ts":"2026-07-14T17:03:45.940854Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:03:39.668176Z","time spent":"6.272671554s","remote":"127.0.0.1:57552","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":28,"request content":"key:\"/registry/acme.cert-manager.io/orders/\" range_end:\"/registry/acme.cert-manager.io/orders0\" count_only:true "} {"level":"warn","ts":"2026-07-14T17:03:45.940867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"10.110249093s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-07-14T17:03:45.940883Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:03:45.444993Z","time spent":"495.826499ms","remote":"127.0.0.1:41936","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":905,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-14T17:03:45.940895Z","caller":"traceutil/trace.go:171","msg":"trace[316078572] range","detail":"{range_begin:/registry/ingressclasses/; range_end:/registry/ingressclasses0; response_count:0; response_revision:6766; }","duration":"10.110319605s","start":"2026-07-14T17:03:35.830567Z","end":"2026-07-14T17:03:45.940887Z","steps":["trace[316078572] 'agreement among raft nodes before linearized reading' (duration: 10.110268253s)"],"step_count":1} {"level":"warn","ts":"2026-07-14T17:03:45.940924Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:03:35.830545Z","time spent":"10.110371127s","remote":"127.0.0.1:42158","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":30,"request content":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true "} {"level":"warn","ts":"2026-07-14T17:03:45.940982Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"5.909050223s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/federations/\" range_end:\"/registry/rabbitmq.com/federations0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-14T17:03:45.941006Z","caller":"traceutil/trace.go:171","msg":"trace[1618454571] range","detail":"{range_begin:/registry/rabbitmq.com/federations/; range_end:/registry/rabbitmq.com/federations0; response_count:0; response_revision:6766; }","duration":"5.909074434s","start":"2026-07-14T17:03:40.031924Z","end":"2026-07-14T17:03:45.940999Z","steps":["trace[1618454571] 'agreement among raft nodes before linearized reading' (duration: 5.909034803s)"],"step_count":1} {"level":"warn","ts":"2026-07-14T17:03:45.941021Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:03:40.031847Z","time spent":"5.909170188s","remote":"127.0.0.1:47324","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":28,"request content":"key:\"/registry/rabbitmq.com/federations/\" range_end:\"/registry/rabbitmq.com/federations0\" count_only:true "} {"level":"warn","ts":"2026-07-14T17:03:45.941096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"10.683149119s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-14T17:03:45.941131Z","caller":"traceutil/trace.go:171","msg":"trace[1752390732] range","detail":"{range_begin:/registry/networkpolicies/; range_end:/registry/networkpolicies0; response_count:0; response_revision:6766; }","duration":"10.683226292s","start":"2026-07-14T17:03:35.257897Z","end":"2026-07-14T17:03:45.941124Z","steps":["trace[1752390732] 'agreement among raft nodes before linearized reading' (duration: 10.68317116s)"],"step_count":1} {"level":"warn","ts":"2026-07-14T17:03:45.941159Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:03:35.257878Z","time spent":"10.683275024s","remote":"127.0.0.1:42146","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":3,"response size":30,"request content":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true "} {"level":"info","ts":"2026-07-14T17:03:45.941183Z","caller":"traceutil/trace.go:171","msg":"trace[1075242422] transaction","detail":"{read_only:false; response_revision:6766; number_of_response:1; }","duration":"494.363296ms","start":"2026-07-14T17:03:45.446812Z","end":"2026-07-14T17:03:45.941176Z","steps":["trace[1075242422] 'process raft request' (duration: 493.846538ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T17:03:45.941062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"500.265019ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/passwords/\" range_end:\"/registry/secretgen.k14s.io/passwords0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-07-14T17:03:45.941218Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:03:45.446802Z","time spent":"494.395738ms","remote":"127.0.0.1:41936","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":759,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-14T17:03:45.941221Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"499.410429ms","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-07-14T17:03:45.941232Z","caller":"traceutil/trace.go:171","msg":"trace[976639495] range","detail":"{range_begin:/registry/secretgen.k14s.io/passwords/; range_end:/registry/secretgen.k14s.io/passwords0; response_count:0; response_revision:6766; }","duration":"500.438466ms","start":"2026-07-14T17:03:45.440771Z","end":"2026-07-14T17:03:45.941209Z","steps":["trace[976639495] 'agreement among raft nodes before linearized reading' (duration: 500.225678ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T17:03:45.941256Z","caller":"traceutil/trace.go:171","msg":"trace[1439778584] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:6766; }","duration":"499.466461ms","start":"2026-07-14T17:03:45.441779Z","end":"2026-07-14T17:03:45.941246Z","steps":["trace[1439778584] 'agreement among raft nodes before linearized reading' (duration: 499.339196ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T17:03:45.941289Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:03:45.440708Z","time spent":"500.56722ms","remote":"127.0.0.1:40306","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":5,"response size":30,"request content":"key:\"/registry/secretgen.k14s.io/passwords/\" range_end:\"/registry/secretgen.k14s.io/passwords0\" count_only:true "} {"level":"warn","ts":"2026-07-14T17:03:45.941294Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:03:45.441772Z","time spent":"499.515612ms","remote":"127.0.0.1:42128","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-07-14T17:03:45.941366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"6.468150773s","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-07-14T17:03:45.941391Z","caller":"traceutil/trace.go:171","msg":"trace[202176478] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:6766; }","duration":"6.468178494s","start":"2026-07-14T17:03:39.473205Z","end":"2026-07-14T17:03:45.941383Z","steps":["trace[202176478] 'agreement among raft nodes before linearized reading' (duration: 6.468137072s)"],"step_count":1} {"level":"warn","ts":"2026-07-14T17:03:45.941395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"10.826078917s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-07-14T17:03:45.941407Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:03:39.473171Z","time spent":"6.468231445s","remote":"127.0.0.1:47494","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-07-14T17:03:45.94142Z","caller":"traceutil/trace.go:171","msg":"trace[1321023252] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:6766; }","duration":"10.826135329s","start":"2026-07-14T17:03:35.115277Z","end":"2026-07-14T17:03:45.941412Z","steps":["trace[1321023252] 'agreement among raft nodes before linearized reading' (duration: 10.826080207s)"],"step_count":1} {"level":"warn","ts":"2026-07-14T17:03:45.941452Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:03:35.115261Z","time spent":"10.826183871s","remote":"127.0.0.1:42280","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":8,"response size":30,"request content":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true "} {"level":"warn","ts":"2026-07-14T17:03:45.94148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"7.055092553s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-14T17:03:45.941518Z","caller":"traceutil/trace.go:171","msg":"trace[1224134438] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:6766; }","duration":"7.055167795s","start":"2026-07-14T17:03:38.886341Z","end":"2026-07-14T17:03:45.941509Z","steps":["trace[1224134438] 'agreement among raft nodes before linearized reading' (duration: 7.055104513s)"],"step_count":1} {"level":"warn","ts":"2026-07-14T17:03:45.94155Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:03:38.88632Z","time spent":"7.055223267s","remote":"127.0.0.1:42100","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":9,"response size":30,"request content":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true "} {"level":"warn","ts":"2026-07-14T17:03:45.941612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"499.640617ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:559"} {"level":"info","ts":"2026-07-14T17:03:45.941489Z","caller":"traceutil/trace.go:171","msg":"trace[611587505] transaction","detail":"{read_only:false; number_of_response:1; response_revision:6766; }","duration":"493.047569ms","start":"2026-07-14T17:03:45.44814Z","end":"2026-07-14T17:03:45.941188Z","steps":["trace[611587505] 'process raft request' (duration: 492.565602ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T17:03:45.941629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"499.706609ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-14T17:03:45.941657Z","caller":"traceutil/trace.go:171","msg":"trace[77055833] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:6766; }","duration":"499.74871ms","start":"2026-07-14T17:03:45.441899Z","end":"2026-07-14T17:03:45.941648Z","steps":["trace[77055833] 'agreement among raft nodes before linearized reading' (duration: 499.669667ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T17:03:45.94169Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"499.338805ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-14T17:03:45.941691Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:03:45.441894Z","time spent":"499.790292ms","remote":"127.0.0.1:42036","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":40,"response size":30,"request content":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true "} {"level":"info","ts":"2026-07-14T17:03:45.941706Z","caller":"traceutil/trace.go:171","msg":"trace[1983135596] 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:6766; }","duration":"499.355275ms","start":"2026-07-14T17:03:45.442347Z","end":"2026-07-14T17:03:45.941702Z","steps":["trace[1983135596] 'agreement among raft nodes before linearized reading' (duration: 499.326424ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T17:03:45.941723Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:03:45.442326Z","time spent":"499.392997ms","remote":"127.0.0.1:48536","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-07-14T17:03:45.941661Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"499.21848ms","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":"info","ts":"2026-07-14T17:03:45.941813Z","caller":"traceutil/trace.go:171","msg":"trace[560401831] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:6766; }","duration":"499.379567ms","start":"2026-07-14T17:03:45.442424Z","end":"2026-07-14T17:03:45.941804Z","steps":["trace[560401831] 'agreement among raft nodes before linearized reading' (duration: 499.220511ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T17:03:45.941839Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:03:45.442419Z","time spent":"499.412418ms","remote":"127.0.0.1:48424","response type":"/etcdserverpb.KV/Range","request count":0,"request size":114,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true "} {"level":"warn","ts":"2026-07-14T17:03:45.941837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"499.587384ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-14T17:03:45.941871Z","caller":"traceutil/trace.go:171","msg":"trace[1143092012] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:6766; }","duration":"499.636016ms","start":"2026-07-14T17:03:45.442226Z","end":"2026-07-14T17:03:45.941862Z","steps":["trace[1143092012] 'agreement among raft nodes before linearized reading' (duration: 499.582014ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T17:03:45.941904Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:03:45.442219Z","time spent":"499.679827ms","remote":"127.0.0.1:41856","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-07-14T17:03:45.941834Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:03:45.44812Z","time spent":"493.553317ms","remote":"127.0.0.1:42128","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":69,"response count":0,"response size":721,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-14T17:03:45.94164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"499.086206ms","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-07-14T17:03:45.941952Z","caller":"traceutil/trace.go:171","msg":"trace[1968302711] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:6766; }","duration":"499.431299ms","start":"2026-07-14T17:03:45.442513Z","end":"2026-07-14T17:03:45.941944Z","steps":["trace[1968302711] 'agreement among raft nodes before linearized reading' (duration: 499.014474ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T17:03:45.941977Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:03:45.442506Z","time spent":"499.46303ms","remote":"127.0.0.1:47432","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-07-14T17:03:45.941634Z","caller":"traceutil/trace.go:171","msg":"trace[1967203314] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:6766; }","duration":"499.675458ms","start":"2026-07-14T17:03:45.441953Z","end":"2026-07-14T17:03:45.941628Z","steps":["trace[1967203314] 'agreement among raft nodes before linearized reading' (duration: 499.590845ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T17:03:45.942088Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:03:45.441947Z","time spent":"500.130735ms","remote":"127.0.0.1:42128","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":582,"request content":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" "} {"level":"warn","ts":"2026-07-14T17:03:45.942137Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"494.347595ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/horizon-6848f9c668-2d8tr\" ","response":"range_response_count:1 size:9762"} {"level":"info","ts":"2026-07-14T17:03:45.942153Z","caller":"traceutil/trace.go:171","msg":"trace[888577596] range","detail":"{range_begin:/registry/pods/openstack/horizon-6848f9c668-2d8tr; range_end:; response_count:1; response_revision:6766; }","duration":"494.412307ms","start":"2026-07-14T17:03:45.447736Z","end":"2026-07-14T17:03:45.942149Z","steps":["trace[888577596] 'agreement among raft nodes before linearized reading' (duration: 494.369015ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T17:03:45.942155Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"490.709914ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-14T17:03:45.942173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"500.296201ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-07-14T17:03:45.942192Z","caller":"traceutil/trace.go:171","msg":"trace[177782363] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:6766; }","duration":"490.756215ms","start":"2026-07-14T17:03:45.451424Z","end":"2026-07-14T17:03:45.94218Z","steps":["trace[177782363] 'agreement among raft nodes before linearized reading' (duration: 490.706723ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T17:03:45.942206Z","caller":"traceutil/trace.go:171","msg":"trace[1847544383] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:6766; }","duration":"500.351512ms","start":"2026-07-14T17:03:45.441847Z","end":"2026-07-14T17:03:45.942199Z","steps":["trace[1847544383] 'agreement among raft nodes before linearized reading' (duration: 499.937177ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T17:03:45.942213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"491.482981ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" ","response":"range_response_count:1 size:489"} {"level":"warn","ts":"2026-07-14T17:03:45.942214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.86532ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/alertmanagerconfigs.monitoring.coreos.com\" ","response":"range_response_count:1 size:156059"} {"level":"warn","ts":"2026-07-14T17:03:45.942267Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"499.47539ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/permissions/\" range_end:\"/registry/rabbitmq.com/permissions0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-14T17:03:45.942289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"499.611075ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-07-14T17:03:45.942283Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"496.053317ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.240\" ","response":"range_response_count:1 size:135"} {"level":"warn","ts":"2026-07-14T17:03:45.942223Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:03:45.451419Z","time spent":"490.794147ms","remote":"127.0.0.1:42076","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":28,"request content":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true "} {"level":"info","ts":"2026-07-14T17:03:45.942326Z","caller":"traceutil/trace.go:171","msg":"trace[1560257699] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:6766; }","duration":"499.658396ms","start":"2026-07-14T17:03:45.442657Z","end":"2026-07-14T17:03:45.942316Z","steps":["trace[1560257699] 'agreement among raft nodes before linearized reading' (duration: 499.587083ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T17:03:45.942336Z","caller":"traceutil/trace.go:171","msg":"trace[1972043645] range","detail":"{range_begin:/registry/masterleases/199.204.45.240; range_end:; response_count:1; response_revision:6766; }","duration":"496.116139ms","start":"2026-07-14T17:03:45.446211Z","end":"2026-07-14T17:03:45.942327Z","steps":["trace[1972043645] 'agreement among raft nodes before linearized reading' (duration: 496.018106ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T17:03:45.942333Z","caller":"traceutil/trace.go:171","msg":"trace[413626651] range","detail":"{range_begin:/registry/rabbitmq.com/permissions/; range_end:/registry/rabbitmq.com/permissions0; response_count:0; response_revision:6766; }","duration":"499.598644ms","start":"2026-07-14T17:03:45.442717Z","end":"2026-07-14T17:03:45.942315Z","steps":["trace[413626651] 'agreement among raft nodes before linearized reading' (duration: 499.47399ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T17:03:45.942356Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:03:45.446204Z","time spent":"496.1481ms","remote":"127.0.0.1:41896","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.204.45.240\" "} {"level":"warn","ts":"2026-07-14T17:03:45.942352Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:03:45.44265Z","time spent":"499.696248ms","remote":"127.0.0.1:41992","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":40,"response size":30,"request content":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true "} {"level":"warn","ts":"2026-07-14T17:03:45.942169Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:03:45.447727Z","time spent":"494.437979ms","remote":"127.0.0.1:42022","response type":"/etcdserverpb.KV/Range","request count":0,"request size":51,"response count":1,"response size":9785,"request content":"key:\"/registry/pods/openstack/horizon-6848f9c668-2d8tr\" "} {"level":"info","ts":"2026-07-14T17:03:45.94223Z","caller":"traceutil/trace.go:171","msg":"trace[1037509450] range","detail":"{range_begin:/registry/leases/ingress-nginx/ingress-nginx-leader; range_end:; response_count:1; response_revision:6766; }","duration":"491.524993ms","start":"2026-07-14T17:03:45.450699Z","end":"2026-07-14T17:03:45.942224Z","steps":["trace[1037509450] 'agreement among raft nodes before linearized reading' (duration: 491.479151ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T17:03:45.942228Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:03:45.441837Z","time spent":"500.385654ms","remote":"127.0.0.1:42356","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":672,"response size":31,"request content":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true "} {"level":"warn","ts":"2026-07-14T17:03:45.94257Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:03:45.450687Z","time spent":"491.836824ms","remote":"127.0.0.1:42128","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":1,"response size":512,"request content":"key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" "} {"level":"warn","ts":"2026-07-14T17:03:45.94143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"10.036761314s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-14T17:03:45.942835Z","caller":"traceutil/trace.go:171","msg":"trace[1861790978] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:6766; }","duration":"10.038260347s","start":"2026-07-14T17:03:35.90453Z","end":"2026-07-14T17:03:45.94279Z","steps":["trace[1861790978] 'agreement among raft nodes before linearized reading' (duration: 10.036339068s)"],"step_count":1} {"level":"warn","ts":"2026-07-14T17:03:45.942956Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:03:35.904513Z","time spent":"10.038424203s","remote":"127.0.0.1:42218","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":72,"response size":30,"request content":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true "} {"level":"info","ts":"2026-07-14T17:03:45.942296Z","caller":"traceutil/trace.go:171","msg":"trace[1417829733] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/alertmanagerconfigs.monitoring.coreos.com; range_end:; response_count:1; response_revision:6766; }","duration":"274.002015ms","start":"2026-07-14T17:03:45.668277Z","end":"2026-07-14T17:03:45.942279Z","steps":["trace[1417829733] 'agreement among raft nodes before linearized reading' (duration: 273.406433ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T17:03:45.946738Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:03:45.4427Z","time spent":"499.658277ms","remote":"127.0.0.1:47330","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":28,"request content":"key:\"/registry/rabbitmq.com/permissions/\" range_end:\"/registry/rabbitmq.com/permissions0\" count_only:true "} {"level":"info","ts":"2026-07-14T17:03:46.669689Z","caller":"traceutil/trace.go:171","msg":"trace[2147249160] linearizableReadLoop","detail":"{readStateIndex:7041; appliedIndex:7039; }","duration":"106.187309ms","start":"2026-07-14T17:03:46.563474Z","end":"2026-07-14T17:03:46.669662Z","steps":["trace[2147249160] 'read index received' (duration: 67.939263ms)","trace[2147249160] 'applied index is now lower than readState.Index' (duration: 38.240685ms)"],"step_count":2} {"level":"info","ts":"2026-07-14T17:03:46.669717Z","caller":"traceutil/trace.go:171","msg":"trace[976137325] transaction","detail":"{read_only:false; response_revision:6786; number_of_response:1; }","duration":"121.127676ms","start":"2026-07-14T17:03:46.548555Z","end":"2026-07-14T17:03:46.669683Z","steps":["trace[976137325] 'process raft request' (duration: 120.95895ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T17:03:46.670079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.567502ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/podmonitors.monitoring.coreos.com\" ","response":"range_response_count:1 size:25392"} {"level":"info","ts":"2026-07-14T17:03:46.670192Z","caller":"traceutil/trace.go:171","msg":"trace[1395602173] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/podmonitors.monitoring.coreos.com; range_end:; response_count:1; response_revision:6786; }","duration":"106.704747ms","start":"2026-07-14T17:03:46.563461Z","end":"2026-07-14T17:03:46.670166Z","steps":["trace[1395602173] 'agreement among raft nodes before linearized reading' (duration: 106.323123ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T17:05:39.758235Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5610} {"level":"info","ts":"2026-07-14T17:05:39.831192Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5610,"took":"71.517438ms","hash":866012335,"current-db-size-bytes":53616640,"current-db-size":"54 MB","current-db-size-in-use-bytes":18898944,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-07-14T17:05:39.831278Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":866012335,"revision":5610,"compact-revision":2876}