{"level":"warn","ts":"2026-04-10T13:50:11.903898Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-10T13:50:11.904029Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.227: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.227:2380","--initial-cluster=instance=https://199.204.45.227:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.227:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.227:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-04-10T13:50:11.90417Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-10T13:50:11.904187Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.227:2380"]} {"level":"info","ts":"2026-04-10T13:50:11.904269Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-10T13:50:11.904952Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.227:2379"]} {"level":"info","ts":"2026-04-10T13:50:11.905052Z","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.227:2380"],"listen-peer-urls":["https://199.204.45.227:2380"],"advertise-client-urls":["https://199.204.45.227:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.227:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.227:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-04-10T13:50:11.90925Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.906869ms"} {"level":"info","ts":"2026-04-10T13:50:11.915482Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"572db18442eba1c2","cluster-id":"fb1028a037bf3cd6"} {"level":"info","ts":"2026-04-10T13:50:11.915567Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 switched to configuration voters=()"} {"level":"info","ts":"2026-04-10T13:50:11.915595Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 became follower at term 0"} {"level":"info","ts":"2026-04-10T13:50:11.91561Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 572db18442eba1c2 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-10T13:50:11.915645Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 became follower at term 1"} {"level":"info","ts":"2026-04-10T13:50:11.915683Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 switched to configuration voters=(6281872236868248002)"} {"level":"warn","ts":"2026-04-10T13:50:11.922938Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-10T13:50:11.925918Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-10T13:50:11.927528Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-04-10T13:50:11.929807Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"572db18442eba1c2","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-10T13:50:11.929988Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"572db18442eba1c2","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-10T13:50:11.930187Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-10T13:50:11.930289Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-10T13:50:11.930495Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-10T13:50:11.930958Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 switched to configuration voters=(6281872236868248002)"} {"level":"info","ts":"2026-04-10T13:50:11.931142Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"fb1028a037bf3cd6","local-member-id":"572db18442eba1c2","added-peer-id":"572db18442eba1c2","added-peer-peer-urls":["https://199.204.45.227:2380"]} {"level":"info","ts":"2026-04-10T13:50:11.934769Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-10T13:50:11.934942Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.227:2380"} {"level":"info","ts":"2026-04-10T13:50:11.934998Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.227:2380"} {"level":"info","ts":"2026-04-10T13:50:11.936266Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"572db18442eba1c2","initial-advertise-peer-urls":["https://199.204.45.227:2380"],"listen-peer-urls":["https://199.204.45.227:2380"],"advertise-client-urls":["https://199.204.45.227:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.227:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-10T13:50:11.936332Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-10T13:50:12.416333Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 is starting a new election at term 1"} {"level":"info","ts":"2026-04-10T13:50:12.416397Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-10T13:50:12.416433Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 received MsgPreVoteResp from 572db18442eba1c2 at term 1"} {"level":"info","ts":"2026-04-10T13:50:12.416452Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 became candidate at term 2"} {"level":"info","ts":"2026-04-10T13:50:12.416463Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 received MsgVoteResp from 572db18442eba1c2 at term 2"} {"level":"info","ts":"2026-04-10T13:50:12.416479Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 became leader at term 2"} {"level":"info","ts":"2026-04-10T13:50:12.416492Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 572db18442eba1c2 elected leader 572db18442eba1c2 at term 2"} {"level":"info","ts":"2026-04-10T13:50:12.41732Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"572db18442eba1c2","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.227:2379]}","request-path":"/0/members/572db18442eba1c2/attributes","cluster-id":"fb1028a037bf3cd6","publish-timeout":"7s"} {"level":"info","ts":"2026-04-10T13:50:12.417367Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-10T13:50:12.417391Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-10T13:50:12.417787Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-10T13:50:12.41781Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-10T13:50:12.417701Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-10T13:50:12.418203Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"fb1028a037bf3cd6","local-member-id":"572db18442eba1c2","cluster-version":"3.5"} {"level":"info","ts":"2026-04-10T13:50:12.418316Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-10T13:50:12.418354Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-10T13:50:12.420763Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-10T13:50:12.422946Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.227:2379"} {"level":"info","ts":"2026-04-10T13:50:18.94285Z","caller":"traceutil/trace.go:171","msg":"trace[382274909] transaction","detail":"{read_only:false; response_revision:279; number_of_response:1; }","duration":"180.141355ms","start":"2026-04-10T13:50:18.762684Z","end":"2026-04-10T13:50:18.942826Z","steps":["trace[382274909] 'process raft request' (duration: 180.010464ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:50:21.832476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.593504ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" ","response":"range_response_count:1 size:197"} {"level":"info","ts":"2026-04-10T13:50:21.832631Z","caller":"traceutil/trace.go:171","msg":"trace[2022323464] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/bootstrap-signer; range_end:; response_count:1; response_revision:304; }","duration":"121.793879ms","start":"2026-04-10T13:50:21.710808Z","end":"2026-04-10T13:50:21.832602Z","steps":["trace[2022323464] 'range keys from in-memory index tree' (duration: 121.474031ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:50:21.832632Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.053369ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-04-10T13:50:21.832727Z","caller":"traceutil/trace.go:171","msg":"trace[1224582949] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-controller; range_end:; response_count:1; response_revision:304; }","duration":"172.191072ms","start":"2026-04-10T13:50:21.660517Z","end":"2026-04-10T13:50:21.832708Z","steps":["trace[1224582949] 'range keys from in-memory index tree' (duration: 171.968106ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:50:27.816459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.106111ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-10T13:50:27.816588Z","caller":"traceutil/trace.go:171","msg":"trace[185058038] transaction","detail":"{read_only:false; response_revision:370; number_of_response:1; }","duration":"536.002657ms","start":"2026-04-10T13:50:27.280547Z","end":"2026-04-10T13:50:27.81655Z","steps":["trace[185058038] 'process raft request' (duration: 257.230349ms)","trace[185058038] 'compare' (duration: 278.007469ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T13:50:27.816657Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:50:27.280529Z","time spent":"536.09741ms","remote":"127.0.0.1:33494","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T13:50:28.950525Z","caller":"traceutil/trace.go:171","msg":"trace[1055871474] linearizableReadLoop","detail":"{readStateIndex:385; appliedIndex:384; }","duration":"179.126649ms","start":"2026-04-10T13:50:28.771372Z","end":"2026-04-10T13:50:28.950498Z","steps":["trace[1055871474] 'read index received' (duration: 178.955405ms)","trace[1055871474] 'applied index is now lower than readState.Index' (duration: 170.264µs)"],"step_count":2} {"level":"warn","ts":"2026-04-10T13:50:28.950676Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.304013ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T13:50:28.950718Z","caller":"traceutil/trace.go:171","msg":"trace[2111816967] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:371; }","duration":"179.362985ms","start":"2026-04-10T13:50:28.771344Z","end":"2026-04-10T13:50:28.950707Z","steps":["trace[2111816967] 'agreement among raft nodes before linearized reading' (duration: 179.256492ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T13:50:28.950848Z","caller":"traceutil/trace.go:171","msg":"trace[1054284359] transaction","detail":"{read_only:false; response_revision:371; number_of_response:1; }","duration":"414.089681ms","start":"2026-04-10T13:50:28.536718Z","end":"2026-04-10T13:50:28.950808Z","steps":["trace[1054284359] 'process raft request' (duration: 413.62879ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:50:28.951043Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:50:28.536698Z","time spent":"414.254355ms","remote":"127.0.0.1:33494","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T13:50:29.20462Z","caller":"traceutil/trace.go:171","msg":"trace[325202131] linearizableReadLoop","detail":"{readStateIndex:386; appliedIndex:385; }","duration":"122.213451ms","start":"2026-04-10T13:50:29.082378Z","end":"2026-04-10T13:50:29.204591Z","steps":["trace[325202131] 'read index received' (duration: 121.939384ms)","trace[325202131] 'applied index is now lower than readState.Index' (duration: 273.087µs)"],"step_count":2} {"level":"info","ts":"2026-04-10T13:50:29.204693Z","caller":"traceutil/trace.go:171","msg":"trace[1870863458] transaction","detail":"{read_only:false; response_revision:372; number_of_response:1; }","duration":"239.721144ms","start":"2026-04-10T13:50:28.964946Z","end":"2026-04-10T13:50:29.204667Z","steps":["trace[1870863458] 'process raft request' (duration: 239.476248ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:50:29.205018Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.615962ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-10T13:50:29.205097Z","caller":"traceutil/trace.go:171","msg":"trace[578078886] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:372; }","duration":"122.746035ms","start":"2026-04-10T13:50:29.082333Z","end":"2026-04-10T13:50:29.205079Z","steps":["trace[578078886] 'agreement among raft nodes before linearized reading' (duration: 122.384745ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T13:50:44.066634Z","caller":"traceutil/trace.go:171","msg":"trace[2061411342] transaction","detail":"{read_only:false; response_revision:472; number_of_response:1; }","duration":"171.826529ms","start":"2026-04-10T13:50:43.89478Z","end":"2026-04-10T13:50:44.066607Z","steps":["trace[2061411342] 'process raft request' (duration: 171.595354ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T13:50:44.524611Z","caller":"traceutil/trace.go:171","msg":"trace[1208278407] linearizableReadLoop","detail":"{readStateIndex:490; appliedIndex:489; }","duration":"165.862028ms","start":"2026-04-10T13:50:44.358725Z","end":"2026-04-10T13:50:44.524587Z","steps":["trace[1208278407] 'read index received' (duration: 165.631223ms)","trace[1208278407] 'applied index is now lower than readState.Index' (duration: 229.925µs)"],"step_count":2} {"level":"info","ts":"2026-04-10T13:50:44.524651Z","caller":"traceutil/trace.go:171","msg":"trace[775551464] transaction","detail":"{read_only:false; response_revision:473; number_of_response:1; }","duration":"173.512735ms","start":"2026-04-10T13:50:44.351118Z","end":"2026-04-10T13:50:44.524631Z","steps":["trace[775551464] 'process raft request' (duration: 173.28033ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:50:44.524737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.995751ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T13:50:44.524772Z","caller":"traceutil/trace.go:171","msg":"trace[1248791566] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:0; response_revision:473; }","duration":"166.052212ms","start":"2026-04-10T13:50:44.358707Z","end":"2026-04-10T13:50:44.524759Z","steps":["trace[1248791566] 'agreement among raft nodes before linearized reading' (duration: 165.97459ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T13:50:45.272891Z","caller":"traceutil/trace.go:171","msg":"trace[121407444] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"391.654297ms","start":"2026-04-10T13:50:44.881198Z","end":"2026-04-10T13:50:45.272852Z","steps":["trace[121407444] 'process raft request' (duration: 384.133735ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T13:50:45.272948Z","caller":"traceutil/trace.go:171","msg":"trace[1671968723] linearizableReadLoop","detail":"{readStateIndex:532; appliedIndex:529; }","duration":"218.036418ms","start":"2026-04-10T13:50:45.054882Z","end":"2026-04-10T13:50:45.272919Z","steps":["trace[1671968723] 'read index received' (duration: 210.541816ms)","trace[1671968723] 'applied index is now lower than readState.Index' (duration: 7.493452ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T13:50:45.273051Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:50:44.881185Z","time spent":"391.784969ms","remote":"127.0.0.1:33260","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":31130,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T13:50:45.273047Z","caller":"traceutil/trace.go:171","msg":"trace[1983917744] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"347.140295ms","start":"2026-04-10T13:50:44.925873Z","end":"2026-04-10T13:50:45.273014Z","steps":["trace[1983917744] 'process raft request' (duration: 346.758227ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:50:45.273207Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:50:44.925852Z","time spent":"347.267318ms","remote":"127.0.0.1:33260","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":59607,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T13:50:45.273371Z","caller":"traceutil/trace.go:171","msg":"trace[1202990785] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"301.260063ms","start":"2026-04-10T13:50:44.972094Z","end":"2026-04-10T13:50:45.273354Z","steps":["trace[1202990785] 'process raft request' (duration: 300.773423ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:50:45.273484Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:50:44.972052Z","time spent":"301.353025ms","remote":"127.0.0.1:33260","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-10T13:50:45.273779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.871017ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-10T13:50:45.27394Z","caller":"traceutil/trace.go:171","msg":"trace[1508379391] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:512; }","duration":"219.080001ms","start":"2026-04-10T13:50:45.054835Z","end":"2026-04-10T13:50:45.273915Z","steps":["trace[1508379391] 'agreement among raft nodes before linearized reading' (duration: 218.680423ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:50:50.553705Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.412614ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/envoy-gateway-gateway-helm-certgen:envoy-gateway-system\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T13:50:50.553788Z","caller":"traceutil/trace.go:171","msg":"trace[2125317610] range","detail":"{range_begin:/registry/clusterrolebindings/envoy-gateway-gateway-helm-certgen:envoy-gateway-system; range_end:; response_count:0; response_revision:574; }","duration":"289.546976ms","start":"2026-04-10T13:50:50.264224Z","end":"2026-04-10T13:50:50.553771Z","steps":["trace[2125317610] 'range keys from in-memory index tree' (duration: 289.28282ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T13:50:51.315568Z","caller":"traceutil/trace.go:171","msg":"trace[1391669080] linearizableReadLoop","detail":"{readStateIndex:601; appliedIndex:600; }","duration":"210.096901ms","start":"2026-04-10T13:50:51.105451Z","end":"2026-04-10T13:50:51.315548Z","steps":["trace[1391669080] 'read index received' (duration: 209.294135ms)","trace[1391669080] 'applied index is now lower than readState.Index' (duration: 801.716µs)"],"step_count":2} {"level":"info","ts":"2026-04-10T13:50:51.315669Z","caller":"traceutil/trace.go:171","msg":"trace[1023895631] transaction","detail":"{read_only:false; response_revision:578; number_of_response:1; }","duration":"327.999054ms","start":"2026-04-10T13:50:50.987631Z","end":"2026-04-10T13:50:51.31563Z","steps":["trace[1023895631] 'process raft request' (duration: 327.378891ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:50:51.316209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.736985ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-c2j4r\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-04-10T13:50:51.316289Z","caller":"traceutil/trace.go:171","msg":"trace[1477476294] range","detail":"{range_begin:/registry/pods/kube-system/cilium-c2j4r; range_end:; response_count:1; response_revision:578; }","duration":"210.859798ms","start":"2026-04-10T13:50:51.105397Z","end":"2026-04-10T13:50:51.316257Z","steps":["trace[1477476294] 'agreement among raft nodes before linearized reading' (duration: 210.268285ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:50:51.316536Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:50:50.987605Z","time spent":"328.165647ms","remote":"127.0.0.1:33312","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036257,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-10T13:50:51.316767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.63345ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T13:50:51.316974Z","caller":"traceutil/trace.go:171","msg":"trace[570067271] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:578; }","duration":"141.786483ms","start":"2026-04-10T13:50:51.175055Z","end":"2026-04-10T13:50:51.316841Z","steps":["trace[570067271] 'agreement among raft nodes before linearized reading' (duration: 141.61ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:50:51.884527Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.813048ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T13:50:51.884661Z","caller":"traceutil/trace.go:171","msg":"trace[1084028271] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:579; }","duration":"312.963191ms","start":"2026-04-10T13:50:51.57168Z","end":"2026-04-10T13:50:51.884644Z","steps":["trace[1084028271] 'range keys from in-memory index tree' (duration: 312.795107ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T13:50:51.885121Z","caller":"traceutil/trace.go:171","msg":"trace[639664817] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"561.582357ms","start":"2026-04-10T13:50:51.323513Z","end":"2026-04-10T13:50:51.885095Z","steps":["trace[639664817] 'process raft request' (duration: 548.486217ms)","trace[639664817] 'compare' (duration: 12.391185ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T13:50:51.8852Z","caller":"traceutil/trace.go:171","msg":"trace[913051557] linearizableReadLoop","detail":"{readStateIndex:604; appliedIndex:601; }","duration":"539.740807ms","start":"2026-04-10T13:50:51.345433Z","end":"2026-04-10T13:50:51.885174Z","steps":["trace[913051557] 'read index received' (duration: 4.646786ms)","trace[913051557] 'applied index is now lower than readState.Index' (duration: 535.092831ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T13:50:51.885247Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:50:51.323501Z","time spent":"561.67912ms","remote":"127.0.0.1:33494","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T13:50:51.885353Z","caller":"traceutil/trace.go:171","msg":"trace[208326431] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"553.316428ms","start":"2026-04-10T13:50:51.332029Z","end":"2026-04-10T13:50:51.885345Z","steps":["trace[208326431] 'process raft request' (duration: 553.018211ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:50:51.885393Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:50:51.332008Z","time spent":"553.365938ms","remote":"127.0.0.1:33424","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-10T13:50:51.88553Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"540.096504ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-10T13:50:51.885557Z","caller":"traceutil/trace.go:171","msg":"trace[1953289376] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:581; }","duration":"540.147296ms","start":"2026-04-10T13:50:51.345402Z","end":"2026-04-10T13:50:51.88555Z","steps":["trace[1953289376] 'agreement among raft nodes before linearized reading' (duration: 540.042504ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:50:51.885575Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:50:51.345385Z","time spent":"540.185506ms","remote":"127.0.0.1:33494","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-10T13:50:51.902801Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.019855ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T13:50:51.90298Z","caller":"traceutil/trace.go:171","msg":"trace[759019951] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:582; }","duration":"283.185638ms","start":"2026-04-10T13:50:51.619745Z","end":"2026-04-10T13:50:51.902931Z","steps":["trace[759019951] 'agreement among raft nodes before linearized reading' (duration: 282.941093ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:50:51.903248Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.280917ms","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-04-10T13:50:51.903307Z","caller":"traceutil/trace.go:171","msg":"trace[2018550824] 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:582; }","duration":"133.365168ms","start":"2026-04-10T13:50:51.769931Z","end":"2026-04-10T13:50:51.903296Z","steps":["trace[2018550824] 'agreement among raft nodes before linearized reading' (duration: 133.290667ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T13:50:51.903434Z","caller":"traceutil/trace.go:171","msg":"trace[402789959] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"522.375779ms","start":"2026-04-10T13:50:51.381033Z","end":"2026-04-10T13:50:51.903409Z","steps":["trace[402789959] 'process raft request' (duration: 521.532281ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:50:51.904698Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:50:51.381008Z","time spent":"523.640045ms","remote":"127.0.0.1:33590","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-10T13:50:51.903919Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.091939ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T13:50:51.904825Z","caller":"traceutil/trace.go:171","msg":"trace[1889686711] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:582; }","duration":"158.024408ms","start":"2026-04-10T13:50:51.746788Z","end":"2026-04-10T13:50:51.904813Z","steps":["trace[1889686711] 'agreement among raft nodes before linearized reading' (duration: 157.103668ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:50:51.903999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.457635ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T13:50:51.904898Z","caller":"traceutil/trace.go:171","msg":"trace[1610423332] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:582; }","duration":"157.403564ms","start":"2026-04-10T13:50:51.747481Z","end":"2026-04-10T13:50:51.904884Z","steps":["trace[1610423332] 'agreement among raft nodes before linearized reading' (duration: 156.458924ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:50:51.903936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.134203ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T13:50:51.905017Z","caller":"traceutil/trace.go:171","msg":"trace[1782031664] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:582; }","duration":"212.281786ms","start":"2026-04-10T13:50:51.692729Z","end":"2026-04-10T13:50:51.905011Z","steps":["trace[1782031664] 'agreement among raft nodes before linearized reading' (duration: 211.160972ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:50:51.904054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.16459ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T13:50:51.905142Z","caller":"traceutil/trace.go:171","msg":"trace[1939300218] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:582; }","duration":"158.295384ms","start":"2026-04-10T13:50:51.746839Z","end":"2026-04-10T13:50:51.905134Z","steps":["trace[1939300218] 'agreement among raft nodes before linearized reading' (duration: 157.17368ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:50:51.904075Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.371195ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T13:50:51.90526Z","caller":"traceutil/trace.go:171","msg":"trace[501066338] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:582; }","duration":"176.55883ms","start":"2026-04-10T13:50:51.728694Z","end":"2026-04-10T13:50:51.905253Z","steps":["trace[501066338] 'agreement among raft nodes before linearized reading' (duration: 175.353055ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:50:51.90409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.685901ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T13:50:51.905388Z","caller":"traceutil/trace.go:171","msg":"trace[140721474] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:582; }","duration":"176.990788ms","start":"2026-04-10T13:50:51.728388Z","end":"2026-04-10T13:50:51.905379Z","steps":["trace[140721474] 'agreement among raft nodes before linearized reading' (duration: 175.686261ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:50:51.904113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.727062ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T13:50:51.905544Z","caller":"traceutil/trace.go:171","msg":"trace[1568955555] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:582; }","duration":"177.176933ms","start":"2026-04-10T13:50:51.72836Z","end":"2026-04-10T13:50:51.905537Z","steps":["trace[1568955555] 'agreement among raft nodes before linearized reading' (duration: 175.733892ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:50:51.904125Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.320398ms","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-04-10T13:50:51.905688Z","caller":"traceutil/trace.go:171","msg":"trace[659146068] 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:582; }","duration":"134.894681ms","start":"2026-04-10T13:50:51.770785Z","end":"2026-04-10T13:50:51.90568Z","steps":["trace[659146068] 'agreement among raft nodes before linearized reading' (duration: 133.325338ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:50:51.904159Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.382952ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T13:50:51.905839Z","caller":"traceutil/trace.go:171","msg":"trace[1466929388] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:582; }","duration":"286.087788ms","start":"2026-04-10T13:50:51.619744Z","end":"2026-04-10T13:50:51.905832Z","steps":["trace[1466929388] 'agreement among raft nodes before linearized reading' (duration: 284.400792ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:50:51.90416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.181353ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T13:50:51.905942Z","caller":"traceutil/trace.go:171","msg":"trace[534870264] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:582; }","duration":"260.00164ms","start":"2026-04-10T13:50:51.645935Z","end":"2026-04-10T13:50:51.905936Z","steps":["trace[534870264] 'agreement among raft nodes before linearized reading' (duration: 258.206872ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:50:51.904182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.366876ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T13:50:51.906051Z","caller":"traceutil/trace.go:171","msg":"trace[900482032] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:582; }","duration":"260.246865ms","start":"2026-04-10T13:50:51.645798Z","end":"2026-04-10T13:50:51.906045Z","steps":["trace[900482032] 'agreement among raft nodes before linearized reading' (duration: 258.371296ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:50:51.904195Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.587991ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T13:50:51.906152Z","caller":"traceutil/trace.go:171","msg":"trace[1433484827] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:582; }","duration":"213.545162ms","start":"2026-04-10T13:50:51.6926Z","end":"2026-04-10T13:50:51.906145Z","steps":["trace[1433484827] 'agreement among raft nodes before linearized reading' (duration: 211.577181ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:50:51.904231Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.580869ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T13:50:51.906289Z","caller":"traceutil/trace.go:171","msg":"trace[1728088488] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:582; }","duration":"259.658452ms","start":"2026-04-10T13:50:51.646624Z","end":"2026-04-10T13:50:51.906282Z","steps":["trace[1728088488] 'agreement among raft nodes before linearized reading' (duration: 257.589759ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:50:51.904245Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.169455ms","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-04-10T13:50:51.906443Z","caller":"traceutil/trace.go:171","msg":"trace[1118442603] 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:582; }","duration":"136.416812ms","start":"2026-04-10T13:50:51.769999Z","end":"2026-04-10T13:50:51.906416Z","steps":["trace[1118442603] 'agreement among raft nodes before linearized reading' (duration: 134.199146ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:50:52.270967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.380921ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-10T13:50:52.271066Z","caller":"traceutil/trace.go:171","msg":"trace[156116080] linearizableReadLoop","detail":"{readStateIndex:606; appliedIndex:605; }","duration":"356.593948ms","start":"2026-04-10T13:50:51.914456Z","end":"2026-04-10T13:50:52.27105Z","steps":["trace[156116080] 'read index received' (duration: 69.985853ms)","trace[156116080] 'applied index is now lower than readState.Index' (duration: 286.606835ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T13:50:52.271173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"356.714981ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T13:50:52.271209Z","caller":"traceutil/trace.go:171","msg":"trace[492361686] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system; range_end:; response_count:0; response_revision:583; }","duration":"356.752891ms","start":"2026-04-10T13:50:51.914446Z","end":"2026-04-10T13:50:52.271198Z","steps":["trace[492361686] 'agreement among raft nodes before linearized reading' (duration: 356.68949ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:50:52.271247Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:50:51.914434Z","time spent":"356.805332ms","remote":"127.0.0.1:33720","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":28,"request content":"key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" "} {"level":"info","ts":"2026-04-10T13:50:52.271152Z","caller":"traceutil/trace.go:171","msg":"trace[1010951947] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"380.305757ms","start":"2026-04-10T13:50:51.890819Z","end":"2026-04-10T13:50:52.271125Z","steps":["trace[1010951947] 'process raft request' (duration: 93.689232ms)","trace[1010951947] 'compare' (duration: 286.247218ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T13:50:52.271609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.427184ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T13:50:52.271653Z","caller":"traceutil/trace.go:171","msg":"trace[1137613699] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:583; }","duration":"123.485266ms","start":"2026-04-10T13:50:52.148158Z","end":"2026-04-10T13:50:52.271644Z","steps":["trace[1137613699] 'agreement among raft nodes before linearized reading' (duration: 123.419975ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:50:52.271572Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.369107ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T13:50:52.27189Z","caller":"traceutil/trace.go:171","msg":"trace[355270007] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:583; }","duration":"239.752145ms","start":"2026-04-10T13:50:52.032112Z","end":"2026-04-10T13:50:52.271864Z","steps":["trace[355270007] 'agreement among raft nodes before linearized reading' (duration: 239.243305ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:50:52.272146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.281503ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T13:50:52.272192Z","caller":"traceutil/trace.go:171","msg":"trace[795434992] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:583; }","duration":"124.337534ms","start":"2026-04-10T13:50:52.14784Z","end":"2026-04-10T13:50:52.272177Z","steps":["trace[795434992] 'agreement among raft nodes before linearized reading' (duration: 124.245292ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:50:52.272492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.994549ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-04-10T13:50:52.272533Z","caller":"traceutil/trace.go:171","msg":"trace[1615775693] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:583; }","duration":"152.092701ms","start":"2026-04-10T13:50:52.12043Z","end":"2026-04-10T13:50:52.272523Z","steps":["trace[1615775693] 'agreement among raft nodes before linearized reading' (duration: 151.973799ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:50:52.272678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.187365ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T13:50:52.272715Z","caller":"traceutil/trace.go:171","msg":"trace[959902546] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:583; }","duration":"158.298398ms","start":"2026-04-10T13:50:52.114407Z","end":"2026-04-10T13:50:52.272706Z","steps":["trace[959902546] 'agreement among raft nodes before linearized reading' (duration: 158.240726ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:50:52.272876Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.017513ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T13:50:52.272909Z","caller":"traceutil/trace.go:171","msg":"trace[1764759143] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:583; }","duration":"159.065423ms","start":"2026-04-10T13:50:52.113835Z","end":"2026-04-10T13:50:52.272901Z","steps":["trace[1764759143] 'agreement among raft nodes before linearized reading' (duration: 159.017043ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:50:52.273031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.293488ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T13:50:52.273066Z","caller":"traceutil/trace.go:171","msg":"trace[1348678224] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:583; }","duration":"159.34975ms","start":"2026-04-10T13:50:52.113708Z","end":"2026-04-10T13:50:52.273057Z","steps":["trace[1348678224] 'agreement among raft nodes before linearized reading' (duration: 159.298209ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:50:52.273181Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.709459ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T13:50:52.273214Z","caller":"traceutil/trace.go:171","msg":"trace[1376434620] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:583; }","duration":"186.75737ms","start":"2026-04-10T13:50:52.086449Z","end":"2026-04-10T13:50:52.273206Z","steps":["trace[1376434620] 'agreement among raft nodes before linearized reading' (duration: 186.706519ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:50:52.27334Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.74629ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T13:50:52.273518Z","caller":"traceutil/trace.go:171","msg":"trace[465986353] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:583; }","duration":"187.940625ms","start":"2026-04-10T13:50:52.085563Z","end":"2026-04-10T13:50:52.273503Z","steps":["trace[465986353] 'agreement among raft nodes before linearized reading' (duration: 187.623508ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:50:52.273963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.110449ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-10T13:50:52.271647Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:50:51.890792Z","time spent":"380.642964ms","remote":"127.0.0.1:33494","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-10T13:50:52.274157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.565319ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T13:50:52.274205Z","caller":"traceutil/trace.go:171","msg":"trace[424718891] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:583; }","duration":"215.6334ms","start":"2026-04-10T13:50:52.058561Z","end":"2026-04-10T13:50:52.274195Z","steps":["trace[424718891] 'agreement among raft nodes before linearized reading' (duration: 215.562369ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:50:52.27421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.870797ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T13:50:52.274245Z","caller":"traceutil/trace.go:171","msg":"trace[67359786] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:583; }","duration":"241.919889ms","start":"2026-04-10T13:50:52.032315Z","end":"2026-04-10T13:50:52.274235Z","steps":["trace[67359786] 'agreement among raft nodes before linearized reading' (duration: 241.864628ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:50:52.274353Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.749293ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-10T13:50:52.274385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.212865ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T13:50:52.274388Z","caller":"traceutil/trace.go:171","msg":"trace[318556784] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:583; }","duration":"215.866965ms","start":"2026-04-10T13:50:52.058513Z","end":"2026-04-10T13:50:52.27438Z","steps":["trace[318556784] 'agreement among raft nodes before linearized reading' (duration: 215.815724ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T13:50:52.274413Z","caller":"traceutil/trace.go:171","msg":"trace[2083000555] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:583; }","duration":"242.243016ms","start":"2026-04-10T13:50:52.032161Z","end":"2026-04-10T13:50:52.274404Z","steps":["trace[2083000555] 'agreement among raft nodes before linearized reading' (duration: 242.199445ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T13:50:52.274374Z","caller":"traceutil/trace.go:171","msg":"trace[1236115638] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:583; }","duration":"215.276493ms","start":"2026-04-10T13:50:52.058813Z","end":"2026-04-10T13:50:52.274089Z","steps":["trace[1236115638] 'agreement among raft nodes before linearized reading' (duration: 215.079158ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:50:52.272055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.312192ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T13:50:52.27475Z","caller":"traceutil/trace.go:171","msg":"trace[2028249615] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:583; }","duration":"189.079118ms","start":"2026-04-10T13:50:52.085661Z","end":"2026-04-10T13:50:52.27474Z","steps":["trace[2028249615] 'agreement among raft nodes before linearized reading' (duration: 186.297702ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:50:52.805596Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11656051922838605790,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-10T13:50:53.557469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"332.266763ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-10T13:50:53.557564Z","caller":"traceutil/trace.go:171","msg":"trace[41392805] transaction","detail":"{read_only:false; response_revision:584; number_of_response:1; }","duration":"1.277269088s","start":"2026-04-10T13:50:52.280275Z","end":"2026-04-10T13:50:53.557545Z","steps":["trace[41392805] 'process raft request' (duration: 944.847041ms)","trace[41392805] 'compare' (duration: 332.041719ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T13:50:53.557624Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:50:52.280262Z","time spent":"1.27733418s","remote":"127.0.0.1:33494","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T13:50:53.566483Z","caller":"traceutil/trace.go:171","msg":"trace[773747657] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"906.448953ms","start":"2026-04-10T13:50:52.660011Z","end":"2026-04-10T13:50:53.56646Z","steps":["trace[773747657] 'process raft request' (duration: 905.643907ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T13:50:53.566488Z","caller":"traceutil/trace.go:171","msg":"trace[2089700878] linearizableReadLoop","detail":"{readStateIndex:608; appliedIndex:606; }","duration":"1.260968994s","start":"2026-04-10T13:50:52.30549Z","end":"2026-04-10T13:50:53.566459Z","steps":["trace[2089700878] 'read index received' (duration: 919.640586ms)","trace[2089700878] 'applied index is now lower than readState.Index' (duration: 341.327238ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T13:50:53.566607Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:50:52.659984Z","time spent":"906.556464ms","remote":"127.0.0.1:33312","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036289,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-10T13:50:53.566717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.261201528s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-10T13:50:53.567037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"869.113648ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T13:50:53.567083Z","caller":"traceutil/trace.go:171","msg":"trace[500773196] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:585; }","duration":"869.192ms","start":"2026-04-10T13:50:52.697877Z","end":"2026-04-10T13:50:53.567069Z","steps":["trace[500773196] 'agreement among raft nodes before linearized reading' (duration: 869.141239ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:50:53.567076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.138991528s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-10T13:50:53.566818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.261264319s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T13:50:53.567165Z","caller":"traceutil/trace.go:171","msg":"trace[1831975207] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:585; }","duration":"1.139121801s","start":"2026-04-10T13:50:52.428027Z","end":"2026-04-10T13:50:53.567149Z","steps":["trace[1831975207] 'agreement among raft nodes before linearized reading' (duration: 1.139013809s)"],"step_count":1} {"level":"info","ts":"2026-04-10T13:50:53.567222Z","caller":"traceutil/trace.go:171","msg":"trace[172138020] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:585; }","duration":"1.261675587s","start":"2026-04-10T13:50:52.305513Z","end":"2026-04-10T13:50:53.567189Z","steps":["trace[172138020] 'agreement among raft nodes before linearized reading' (duration: 1.261240338s)"],"step_count":1} {"level":"info","ts":"2026-04-10T13:50:53.567049Z","caller":"traceutil/trace.go:171","msg":"trace[1595494387] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:585; }","duration":"1.261570365s","start":"2026-04-10T13:50:52.305465Z","end":"2026-04-10T13:50:53.567036Z","steps":["trace[1595494387] 'agreement among raft nodes before linearized reading' (duration: 1.261129596s)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:50:53.567259Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:50:52.428004Z","time spent":"1.139241123s","remote":"127.0.0.1:56218","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"warn","ts":"2026-04-10T13:50:53.567313Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:50:52.305454Z","time spent":"1.2618317s","remote":"127.0.0.1:56212","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-04-10T13:50:53.568004Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:50:52.305509Z","time spent":"1.261794319s","remote":"127.0.0.1:56212","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-04-10T13:50:53.566834Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.022426404s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-10T13:50:53.566827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"869.127818ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-10T13:50:53.566869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"891.249501ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-10T13:50:53.566864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.022489295s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-10T13:50:53.566902Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"892.298673ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-10T13:50:53.566902Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.260562235s","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":"warn","ts":"2026-04-10T13:50:53.566912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"837.886089ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-10T13:50:53.566926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"892.372645ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-10T13:50:53.566947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"391.372463ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-10T13:50:53.566951Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"853.07308ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-10T13:50:53.566951Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.021947534s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-10T13:50:53.566954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.499303ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-04-10T13:50:53.566975Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"837.535202ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-10T13:50:53.566974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.139186262s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-10T13:50:53.566996Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"853.258534ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-10T13:50:53.566989Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"852.769823ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-10T13:50:53.567012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"837.594283ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-10T13:50:53.567126Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:50:52.69787Z","time spent":"869.248311ms","remote":"127.0.0.1:56236","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"info","ts":"2026-04-10T13:50:53.570199Z","caller":"traceutil/trace.go:171","msg":"trace[2081014726] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:585; }","duration":"1.26376851s","start":"2026-04-10T13:50:52.306325Z","end":"2026-04-10T13:50:53.570094Z","steps":["trace[2081014726] 'agreement among raft nodes before linearized reading' (duration: 1.260559185s)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:50:53.570325Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:50:52.306321Z","time spent":"1.263941173s","remote":"127.0.0.1:56212","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-04-10T13:50:53.570339Z","caller":"traceutil/trace.go:171","msg":"trace[2121026445] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:585; }","duration":"841.304838ms","start":"2026-04-10T13:50:52.729014Z","end":"2026-04-10T13:50:53.570319Z","steps":["trace[2121026445] 'agreement among raft nodes before linearized reading' (duration: 837.858599ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:50:53.570515Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:50:52.728982Z","time spent":"841.516052ms","remote":"127.0.0.1:56260","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:10000 "} {"level":"info","ts":"2026-04-10T13:50:53.570641Z","caller":"traceutil/trace.go:171","msg":"trace[218148095] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:585; }","duration":"841.174285ms","start":"2026-04-10T13:50:52.729425Z","end":"2026-04-10T13:50:53.5706Z","steps":["trace[218148095] 'agreement among raft nodes before linearized reading' (duration: 837.535862ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:50:53.570801Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:50:52.729421Z","time spent":"841.312479ms","remote":"127.0.0.1:56260","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true "} {"level":"info","ts":"2026-04-10T13:50:53.571148Z","caller":"traceutil/trace.go:171","msg":"trace[1078596321] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:585; }","duration":"1.143366887s","start":"2026-04-10T13:50:52.427759Z","end":"2026-04-10T13:50:53.571126Z","steps":["trace[1078596321] 'agreement among raft nodes before linearized reading' (duration: 1.139127631s)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:50:53.571301Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:50:52.427754Z","time spent":"1.14350484s","remote":"127.0.0.1:56218","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 "} {"level":"info","ts":"2026-04-10T13:50:53.571593Z","caller":"traceutil/trace.go:171","msg":"trace[1051746728] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:585; }","duration":"897.043969ms","start":"2026-04-10T13:50:52.674531Z","end":"2026-04-10T13:50:53.571575Z","steps":["trace[1051746728] 'agreement among raft nodes before linearized reading' (duration: 892.382165ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:50:53.57164Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:50:52.674523Z","time spent":"897.09955ms","remote":"127.0.0.1:56226","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true "} {"level":"info","ts":"2026-04-10T13:50:53.571803Z","caller":"traceutil/trace.go:171","msg":"trace[1369891098] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:585; }","duration":"1.027431745s","start":"2026-04-10T13:50:52.544345Z","end":"2026-04-10T13:50:53.571776Z","steps":["trace[1369891098] 'agreement among raft nodes before linearized reading' (duration: 1.022497515s)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:50:53.571952Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:50:52.544326Z","time spent":"1.027571259s","remote":"127.0.0.1:56220","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 "} {"level":"info","ts":"2026-04-10T13:50:53.572192Z","caller":"traceutil/trace.go:171","msg":"trace[358532977] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:585; }","duration":"396.672761ms","start":"2026-04-10T13:50:53.175506Z","end":"2026-04-10T13:50:53.572179Z","steps":["trace[358532977] 'agreement among raft nodes before linearized reading' (duration: 391.426345ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:50:53.572235Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:50:53.175488Z","time spent":"396.738492ms","remote":"127.0.0.1:33220","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-10T13:50:53.572263Z","caller":"traceutil/trace.go:171","msg":"trace[91993056] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:585; }","duration":"897.662201ms","start":"2026-04-10T13:50:52.674571Z","end":"2026-04-10T13:50:53.572233Z","steps":["trace[91993056] 'agreement among raft nodes before linearized reading' (duration: 892.311653ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:50:53.572407Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:50:52.674553Z","time spent":"897.830165ms","remote":"127.0.0.1:56226","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:10000 "} {"level":"info","ts":"2026-04-10T13:50:53.572605Z","caller":"traceutil/trace.go:171","msg":"trace[1999411005] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:585; }","duration":"858.882248ms","start":"2026-04-10T13:50:52.713697Z","end":"2026-04-10T13:50:53.572579Z","steps":["trace[1999411005] 'agreement among raft nodes before linearized reading' (duration: 853.277525ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:50:53.572895Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:50:52.713672Z","time spent":"859.151113ms","remote":"127.0.0.1:56244","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 "} {"level":"info","ts":"2026-04-10T13:50:53.572987Z","caller":"traceutil/trace.go:171","msg":"trace[232750462] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:585; }","duration":"1.028584888s","start":"2026-04-10T13:50:52.544385Z","end":"2026-04-10T13:50:53.57297Z","steps":["trace[232750462] 'agreement among raft nodes before linearized reading' (duration: 1.022418103s)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:50:53.573146Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:50:52.544382Z","time spent":"1.028712622s","remote":"127.0.0.1:56220","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"info","ts":"2026-04-10T13:50:53.573738Z","caller":"traceutil/trace.go:171","msg":"trace[2057074115] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:585; }","duration":"876.030387ms","start":"2026-04-10T13:50:52.697659Z","end":"2026-04-10T13:50:53.57369Z","steps":["trace[2057074115] 'agreement among raft nodes before linearized reading' (duration: 869.112858ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:50:53.57385Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:50:52.697616Z","time spent":"876.211381ms","remote":"127.0.0.1:56236","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 "} {"level":"info","ts":"2026-04-10T13:50:53.574083Z","caller":"traceutil/trace.go:171","msg":"trace[607219849] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:585; }","duration":"898.476698ms","start":"2026-04-10T13:50:52.67558Z","end":"2026-04-10T13:50:53.574057Z","steps":["trace[607219849] 'agreement among raft nodes before linearized reading' (duration: 891.273811ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:50:53.574146Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:50:52.675562Z","time spent":"898.564209ms","remote":"127.0.0.1:56226","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:500 "} {"level":"info","ts":"2026-04-10T13:50:53.571342Z","caller":"traceutil/trace.go:171","msg":"trace[1451793822] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:585; }","duration":"857.4835ms","start":"2026-04-10T13:50:52.713824Z","end":"2026-04-10T13:50:53.571307Z","steps":["trace[1451793822] 'agreement among raft nodes before linearized reading' (duration: 853.107841ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:50:53.575103Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:50:52.713818Z","time spent":"861.268736ms","remote":"127.0.0.1:56244","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"info","ts":"2026-04-10T13:50:53.573011Z","caller":"traceutil/trace.go:171","msg":"trace[2119659881] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:585; }","duration":"843.605995ms","start":"2026-04-10T13:50:52.729391Z","end":"2026-04-10T13:50:53.572997Z","steps":["trace[2119659881] 'agreement among raft nodes before linearized reading' (duration: 837.597943ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:50:53.57524Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:50:52.729383Z","time spent":"845.84852ms","remote":"127.0.0.1:56260","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:500 "} {"level":"info","ts":"2026-04-10T13:50:53.572964Z","caller":"traceutil/trace.go:171","msg":"trace[714739380] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:585; }","duration":"858.758735ms","start":"2026-04-10T13:50:52.714188Z","end":"2026-04-10T13:50:53.572946Z","steps":["trace[714739380] 'agreement among raft nodes before linearized reading' (duration: 852.781154ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T13:50:53.575438Z","caller":"traceutil/trace.go:171","msg":"trace[814401420] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:585; }","duration":"222.007505ms","start":"2026-04-10T13:50:53.353417Z","end":"2026-04-10T13:50:53.575425Z","steps":["trace[814401420] 'agreement among raft nodes before linearized reading' (duration: 213.439811ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:50:53.5755Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:50:52.714173Z","time spent":"861.278526ms","remote":"127.0.0.1:56236","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:500 "} {"level":"info","ts":"2026-04-10T13:50:53.575379Z","caller":"traceutil/trace.go:171","msg":"trace[554579534] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:585; }","duration":"1.030353734s","start":"2026-04-10T13:50:52.544989Z","end":"2026-04-10T13:50:53.575342Z","steps":["trace[554579534] 'agreement among raft nodes before linearized reading' (duration: 1.021950274s)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:50:53.575637Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:50:52.544984Z","time spent":"1.03064198s","remote":"127.0.0.1:56218","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:500 "} {"level":"info","ts":"2026-04-10T13:50:55.46296Z","caller":"traceutil/trace.go:171","msg":"trace[463113365] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"226.905175ms","start":"2026-04-10T13:50:55.236032Z","end":"2026-04-10T13:50:55.462937Z","steps":["trace[463113365] 'process raft request' (duration: 187.877195ms)","trace[463113365] 'compare' (duration: 38.836556ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T13:51:11.153498Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"979.714587ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T13:51:11.153585Z","caller":"traceutil/trace.go:171","msg":"trace[1315456203] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:749; }","duration":"979.84019ms","start":"2026-04-10T13:51:10.173727Z","end":"2026-04-10T13:51:11.153567Z","steps":["trace[1315456203] 'range keys from in-memory index tree' (duration: 979.617176ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:51:11.153625Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:51:10.173708Z","time spent":"979.908561ms","remote":"127.0.0.1:33204","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-10T13:51:11.154016Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"939.772079ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-t8h6r\" ","response":"range_response_count:1 size:3965"} {"level":"info","ts":"2026-04-10T13:51:11.154051Z","caller":"traceutil/trace.go:171","msg":"trace[1261212436] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-t8h6r; range_end:; response_count:1; response_revision:749; }","duration":"939.83634ms","start":"2026-04-10T13:51:10.214203Z","end":"2026-04-10T13:51:11.154039Z","steps":["trace[1261212436] 'range keys from in-memory index tree' (duration: 939.631337ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:51:11.154079Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:51:10.214183Z","time spent":"939.889352ms","remote":"127.0.0.1:33424","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3988,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-t8h6r\" "} {"level":"warn","ts":"2026-04-10T13:51:11.154244Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"706.83685ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-10T13:51:11.154323Z","caller":"traceutil/trace.go:171","msg":"trace[862622160] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:749; }","duration":"706.978703ms","start":"2026-04-10T13:51:10.447324Z","end":"2026-04-10T13:51:11.154303Z","steps":["trace[862622160] 'range keys from in-memory index tree' (duration: 706.692947ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:51:11.154362Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:51:10.447305Z","time spent":"707.048153ms","remote":"127.0.0.1:33494","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-10T13:51:11.156222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.04829ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-04-10T13:51:11.156316Z","caller":"traceutil/trace.go:171","msg":"trace[583048481] linearizableReadLoop","detail":"{readStateIndex:777; appliedIndex:776; }","duration":"225.775285ms","start":"2026-04-10T13:51:10.930527Z","end":"2026-04-10T13:51:11.156303Z","steps":["trace[583048481] 'read index received' (duration: 9.563572ms)","trace[583048481] 'applied index is now lower than readState.Index' (duration: 216.209863ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T13:51:11.156482Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.959598ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-10T13:51:11.156521Z","caller":"traceutil/trace.go:171","msg":"trace[779040442] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:749; }","duration":"226.03556ms","start":"2026-04-10T13:51:10.930475Z","end":"2026-04-10T13:51:11.156511Z","steps":["trace[779040442] 'agreement among raft nodes before linearized reading' (duration: 225.922178ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T13:51:40.875445Z","caller":"traceutil/trace.go:171","msg":"trace[1391197396] transaction","detail":"{read_only:false; response_revision:1154; number_of_response:1; }","duration":"580.844485ms","start":"2026-04-10T13:51:40.29457Z","end":"2026-04-10T13:51:40.875414Z","steps":["trace[1391197396] 'process raft request' (duration: 580.656123ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:51:40.87563Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:51:40.294538Z","time spent":"581.005327ms","remote":"127.0.0.1:33494","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T13:51:56.116402Z","caller":"traceutil/trace.go:171","msg":"trace[1416281776] transaction","detail":"{read_only:false; response_revision:1290; number_of_response:1; }","duration":"217.756987ms","start":"2026-04-10T13:51:55.898596Z","end":"2026-04-10T13:51:56.116353Z","steps":["trace[1416281776] 'process raft request' (duration: 217.2806ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:51:56.116975Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.002172ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-10T13:51:56.117145Z","caller":"traceutil/trace.go:171","msg":"trace[921476007] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1290; }","duration":"204.244037ms","start":"2026-04-10T13:51:55.912867Z","end":"2026-04-10T13:51:56.117111Z","steps":["trace[921476007] 'agreement among raft nodes before linearized reading' (duration: 203.8004ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T13:51:56.116051Z","caller":"traceutil/trace.go:171","msg":"trace[1912491213] linearizableReadLoop","detail":"{readStateIndex:1334; appliedIndex:1333; }","duration":"203.10993ms","start":"2026-04-10T13:51:55.912914Z","end":"2026-04-10T13:51:56.116024Z","steps":["trace[1912491213] 'read index received' (duration: 203.036699ms)","trace[1912491213] 'applied index is now lower than readState.Index' (duration: 71.831µs)"],"step_count":2} {"level":"info","ts":"2026-04-10T13:52:14.383507Z","caller":"traceutil/trace.go:171","msg":"trace[1601510351] transaction","detail":"{read_only:false; response_revision:1603; number_of_response:1; }","duration":"171.646957ms","start":"2026-04-10T13:52:14.211834Z","end":"2026-04-10T13:52:14.383481Z","steps":["trace[1601510351] 'process raft request' (duration: 171.470105ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T13:52:14.385163Z","caller":"traceutil/trace.go:171","msg":"trace[419724299] transaction","detail":"{read_only:false; response_revision:1604; number_of_response:1; }","duration":"173.096808ms","start":"2026-04-10T13:52:14.21205Z","end":"2026-04-10T13:52:14.385147Z","steps":["trace[419724299] 'process raft request' (duration: 172.975016ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T13:52:26.568236Z","caller":"traceutil/trace.go:171","msg":"trace[1982988677] transaction","detail":"{read_only:false; response_revision:1804; number_of_response:1; }","duration":"120.790564ms","start":"2026-04-10T13:52:26.447422Z","end":"2026-04-10T13:52:26.568212Z","steps":["trace[1982988677] 'process raft request' (duration: 120.658692ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:52:27.096786Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11656051922838608112,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-10T13:52:27.492055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.894893ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-10T13:52:27.492209Z","caller":"traceutil/trace.go:171","msg":"trace[1676370206] linearizableReadLoop","detail":"{readStateIndex:1862; appliedIndex:1861; }","duration":"895.826023ms","start":"2026-04-10T13:52:26.59636Z","end":"2026-04-10T13:52:27.492186Z","steps":["trace[1676370206] 'read index received' (duration: 571.586455ms)","trace[1676370206] 'applied index is now lower than readState.Index' (duration: 324.237378ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T13:52:27.492222Z","caller":"traceutil/trace.go:171","msg":"trace[1285191912] transaction","detail":"{read_only:false; response_revision:1805; number_of_response:1; }","duration":"993.352783ms","start":"2026-04-10T13:52:26.498834Z","end":"2026-04-10T13:52:27.492187Z","steps":["trace[1285191912] 'process raft request' (duration: 669.191346ms)","trace[1285191912] 'compare' (duration: 323.724511ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T13:52:27.492492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"793.29848ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:4591"} {"level":"info","ts":"2026-04-10T13:52:27.49255Z","caller":"traceutil/trace.go:171","msg":"trace[939434376] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1805; }","duration":"793.397232ms","start":"2026-04-10T13:52:26.699138Z","end":"2026-04-10T13:52:27.492535Z","steps":["trace[939434376] 'agreement among raft nodes before linearized reading' (duration: 793.158899ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:52:27.49255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.443255ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:659"} {"level":"warn","ts":"2026-04-10T13:52:27.492558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.038563ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-04-10T13:52:27.492602Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:52:26.699115Z","time spent":"793.475592ms","remote":"127.0.0.1:60536","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":4614,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"info","ts":"2026-04-10T13:52:27.492632Z","caller":"traceutil/trace.go:171","msg":"trace[2135976997] range","detail":"{range_begin:/registry/configmaps/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:1805; }","duration":"244.552167ms","start":"2026-04-10T13:52:27.248047Z","end":"2026-04-10T13:52:27.492599Z","steps":["trace[2135976997] 'agreement among raft nodes before linearized reading' (duration: 244.370205ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T13:52:27.492639Z","caller":"traceutil/trace.go:171","msg":"trace[1146880002] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1805; }","duration":"307.70623ms","start":"2026-04-10T13:52:27.184901Z","end":"2026-04-10T13:52:27.492607Z","steps":["trace[1146880002] 'agreement among raft nodes before linearized reading' (duration: 307.545709ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:52:27.492642Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.775998ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-f8a0252b-d77f-4953-8868-adb256d4da7b\" ","response":"range_response_count:1 size:3627"} {"level":"warn","ts":"2026-04-10T13:52:27.492685Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:52:27.184885Z","time spent":"307.789611ms","remote":"127.0.0.1:33494","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-04-10T13:52:27.492725Z","caller":"traceutil/trace.go:171","msg":"trace[122300448] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-f8a0252b-d77f-4953-8868-adb256d4da7b; range_end:; response_count:1; response_revision:1805; }","duration":"127.978571ms","start":"2026-04-10T13:52:27.364732Z","end":"2026-04-10T13:52:27.492711Z","steps":["trace[122300448] 'agreement among raft nodes before linearized reading' (duration: 127.589576ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:52:27.493292Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:52:26.498815Z","time spent":"994.368616ms","remote":"127.0.0.1:33494","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-10T13:52:27.493335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"896.963947ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-f8a0252b-d77f-4953-8868-adb256d4da7b\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-04-10T13:52:27.493399Z","caller":"traceutil/trace.go:171","msg":"trace[1797993091] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-f8a0252b-d77f-4953-8868-adb256d4da7b; range_end:; response_count:1; response_revision:1805; }","duration":"897.031988ms","start":"2026-04-10T13:52:26.59635Z","end":"2026-04-10T13:52:27.493382Z","steps":["trace[1797993091] 'agreement among raft nodes before linearized reading' (duration: 895.969605ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:52:27.493479Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:52:26.596297Z","time spent":"897.14487ms","remote":"127.0.0.1:33424","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3650,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-f8a0252b-d77f-4953-8868-adb256d4da7b\" "} {"level":"info","ts":"2026-04-10T13:52:27.678748Z","caller":"traceutil/trace.go:171","msg":"trace[1392117112] transaction","detail":"{read_only:false; response_revision:1806; number_of_response:1; }","duration":"176.947475ms","start":"2026-04-10T13:52:27.501774Z","end":"2026-04-10T13:52:27.678722Z","steps":["trace[1392117112] 'process raft request' (duration: 169.550781ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T13:52:27.75792Z","caller":"traceutil/trace.go:171","msg":"trace[515415824] transaction","detail":"{read_only:false; response_revision:1807; number_of_response:1; }","duration":"255.999709ms","start":"2026-04-10T13:52:27.501891Z","end":"2026-04-10T13:52:27.757891Z","steps":["trace[515415824] 'process raft request' (duration: 255.745156ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T13:52:27.758224Z","caller":"traceutil/trace.go:171","msg":"trace[1574061381] linearizableReadLoop","detail":"{readStateIndex:1866; appliedIndex:1862; }","duration":"215.701173ms","start":"2026-04-10T13:52:27.542507Z","end":"2026-04-10T13:52:27.758209Z","steps":["trace[1574061381] 'read index received' (duration: 128.812269ms)","trace[1574061381] 'applied index is now lower than readState.Index' (duration: 86.888014ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T13:52:27.758236Z","caller":"traceutil/trace.go:171","msg":"trace[1605037067] transaction","detail":"{read_only:false; response_revision:1809; number_of_response:1; }","duration":"253.066714ms","start":"2026-04-10T13:52:27.505158Z","end":"2026-04-10T13:52:27.758224Z","steps":["trace[1605037067] 'process raft request' (duration: 252.937121ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:52:27.759204Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.163373ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-10T13:52:27.75926Z","caller":"traceutil/trace.go:171","msg":"trace[1239607805] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1810; }","duration":"210.271615ms","start":"2026-04-10T13:52:27.54898Z","end":"2026-04-10T13:52:27.759251Z","steps":["trace[1239607805] 'agreement among raft nodes before linearized reading' (duration: 210.099443ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T13:52:27.758268Z","caller":"traceutil/trace.go:171","msg":"trace[1589365098] transaction","detail":"{read_only:false; response_revision:1808; number_of_response:1; }","duration":"255.910589ms","start":"2026-04-10T13:52:27.502351Z","end":"2026-04-10T13:52:27.758262Z","steps":["trace[1589365098] 'process raft request' (duration: 255.470363ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T13:52:27.758371Z","caller":"traceutil/trace.go:171","msg":"trace[218260192] transaction","detail":"{read_only:false; response_revision:1810; number_of_response:1; }","duration":"151.184672ms","start":"2026-04-10T13:52:27.607174Z","end":"2026-04-10T13:52:27.758359Z","steps":["trace[218260192] 'process raft request' (duration: 150.987399ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:52:27.758456Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.937226ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-10T13:52:27.760274Z","caller":"traceutil/trace.go:171","msg":"trace[894588430] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1810; }","duration":"217.809729ms","start":"2026-04-10T13:52:27.542455Z","end":"2026-04-10T13:52:27.760265Z","steps":["trace[894588430] 'agreement among raft nodes before linearized reading' (duration: 215.899666ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:52:28.134345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.758516ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-10T13:52:28.134506Z","caller":"traceutil/trace.go:171","msg":"trace[1342844214] transaction","detail":"{read_only:false; response_revision:1811; number_of_response:1; }","duration":"370.493255ms","start":"2026-04-10T13:52:27.763976Z","end":"2026-04-10T13:52:28.134469Z","steps":["trace[1342844214] 'process raft request' (duration: 62.501566ms)","trace[1342844214] 'compare' (duration: 307.596564ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T13:52:28.134592Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:52:27.763964Z","time spent":"370.582316ms","remote":"127.0.0.1:33494","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T13:52:28.181573Z","caller":"traceutil/trace.go:171","msg":"trace[549687970] transaction","detail":"{read_only:false; response_revision:1813; number_of_response:1; }","duration":"415.42684ms","start":"2026-04-10T13:52:27.766123Z","end":"2026-04-10T13:52:28.181549Z","steps":["trace[549687970] 'process raft request' (duration: 415.356999ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:52:28.181725Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:52:27.766113Z","time spent":"415.534111ms","remote":"127.0.0.1:33494","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":537,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T13:52:28.181764Z","caller":"traceutil/trace.go:171","msg":"trace[209901106] transaction","detail":"{read_only:false; response_revision:1814; number_of_response:1; }","duration":"415.576171ms","start":"2026-04-10T13:52:27.76617Z","end":"2026-04-10T13:52:28.181746Z","steps":["trace[209901106] 'process raft request' (duration: 415.344868ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:52:28.181866Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:52:27.766154Z","time spent":"415.655683ms","remote":"127.0.0.1:33494","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":551,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T13:52:28.181973Z","caller":"traceutil/trace.go:171","msg":"trace[1835081655] transaction","detail":"{read_only:false; response_revision:1812; number_of_response:1; }","duration":"417.179001ms","start":"2026-04-10T13:52:27.764783Z","end":"2026-04-10T13:52:28.181962Z","steps":["trace[1835081655] 'process raft request' (duration: 416.555313ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:52:28.182033Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:52:27.764754Z","time spent":"417.245522ms","remote":"127.0.0.1:33494","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T13:52:28.182161Z","caller":"traceutil/trace.go:171","msg":"trace[888458142] transaction","detail":"{read_only:false; response_revision:1815; number_of_response:1; }","duration":"413.92907ms","start":"2026-04-10T13:52:27.768223Z","end":"2026-04-10T13:52:28.182152Z","steps":["trace[888458142] 'process raft request' (duration: 413.459534ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:52:28.182208Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:52:27.768213Z","time spent":"413.96837ms","remote":"127.0.0.1:33494","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T13:52:28.182361Z","caller":"traceutil/trace.go:171","msg":"trace[526580637] transaction","detail":"{read_only:false; response_revision:1816; number_of_response:1; }","duration":"366.577664ms","start":"2026-04-10T13:52:27.815769Z","end":"2026-04-10T13:52:28.182347Z","steps":["trace[526580637] 'process raft request' (duration: 366.344792ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:52:28.182577Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:52:27.815736Z","time spent":"366.775207ms","remote":"127.0.0.1:33282","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":840,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-10T13:52:32.293626Z","caller":"traceutil/trace.go:171","msg":"trace[411983468] linearizableReadLoop","detail":"{readStateIndex:1915; appliedIndex:1914; }","duration":"100.287033ms","start":"2026-04-10T13:52:32.193316Z","end":"2026-04-10T13:52:32.293603Z","steps":["trace[411983468] 'read index received' (duration: 100.08489ms)","trace[411983468] 'applied index is now lower than readState.Index' (duration: 201.013µs)"],"step_count":2} {"level":"warn","ts":"2026-04-10T13:52:32.293833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.500017ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-10T13:52:32.293908Z","caller":"traceutil/trace.go:171","msg":"trace[1442615785] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1855; }","duration":"100.588068ms","start":"2026-04-10T13:52:32.193309Z","end":"2026-04-10T13:52:32.293897Z","steps":["trace[1442615785] 'agreement among raft nodes before linearized reading' (duration: 100.393386ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T13:52:32.294463Z","caller":"traceutil/trace.go:171","msg":"trace[916306502] transaction","detail":"{read_only:false; response_revision:1855; number_of_response:1; }","duration":"136.24432ms","start":"2026-04-10T13:52:32.157428Z","end":"2026-04-10T13:52:32.293672Z","steps":["trace[916306502] 'process raft request' (duration: 136.025107ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:52:34.947304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.930184ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-10T13:52:34.94742Z","caller":"traceutil/trace.go:171","msg":"trace[1935358806] linearizableReadLoop","detail":"{readStateIndex:1949; appliedIndex:1948; }","duration":"268.630226ms","start":"2026-04-10T13:52:34.67877Z","end":"2026-04-10T13:52:34.9474Z","steps":["trace[1935358806] 'read index received' (duration: 31.406778ms)","trace[1935358806] 'applied index is now lower than readState.Index' (duration: 237.222088ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T13:52:34.947468Z","caller":"traceutil/trace.go:171","msg":"trace[1290669737] transaction","detail":"{read_only:false; response_revision:1889; number_of_response:1; }","duration":"293.897697ms","start":"2026-04-10T13:52:34.653523Z","end":"2026-04-10T13:52:34.947421Z","steps":["trace[1290669737] 'process raft request' (duration: 56.74163ms)","trace[1290669737] 'compare' (duration: 236.803533ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T13:52:34.94762Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.847088ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:1853"} {"level":"info","ts":"2026-04-10T13:52:34.947658Z","caller":"traceutil/trace.go:171","msg":"trace[1030726607] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:1889; }","duration":"268.917848ms","start":"2026-04-10T13:52:34.678727Z","end":"2026-04-10T13:52:34.947645Z","steps":["trace[1030726607] 'agreement among raft nodes before linearized reading' (duration: 268.776867ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:52:34.948142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.087924ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:11265"} {"level":"info","ts":"2026-04-10T13:52:34.948287Z","caller":"traceutil/trace.go:171","msg":"trace[933640898] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:1889; }","duration":"266.245906ms","start":"2026-04-10T13:52:34.682022Z","end":"2026-04-10T13:52:34.948268Z","steps":["trace[933640898] 'agreement among raft nodes before linearized reading' (duration: 265.494827ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:52:35.334115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.466287ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-10T13:52:35.334347Z","caller":"traceutil/trace.go:171","msg":"trace[50061876] transaction","detail":"{read_only:false; response_revision:1890; number_of_response:1; }","duration":"377.996625ms","start":"2026-04-10T13:52:34.956324Z","end":"2026-04-10T13:52:35.33432Z","steps":["trace[50061876] 'process raft request' (duration: 212.225195ms)","trace[50061876] 'compare' (duration: 165.329065ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T13:52:35.334486Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:52:34.95631Z","time spent":"378.092846ms","remote":"127.0.0.1:33400","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1144,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T13:52:35.334584Z","caller":"traceutil/trace.go:171","msg":"trace[1008085070] transaction","detail":"{read_only:false; response_revision:1891; number_of_response:1; }","duration":"378.220617ms","start":"2026-04-10T13:52:34.956345Z","end":"2026-04-10T13:52:35.334565Z","steps":["trace[1008085070] 'process raft request' (duration: 377.893883ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:52:35.334677Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:52:34.956334Z","time spent":"378.295859ms","remote":"127.0.0.1:33510","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1702,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T13:52:35.337558Z","caller":"traceutil/trace.go:171","msg":"trace[972402007] linearizableReadLoop","detail":"{readStateIndex:1954; appliedIndex:1951; }","duration":"162.572121ms","start":"2026-04-10T13:52:35.174963Z","end":"2026-04-10T13:52:35.337535Z","steps":["trace[972402007] 'read index received' (duration: 162.303778ms)","trace[972402007] 'applied index is now lower than readState.Index' (duration: 267.103µs)"],"step_count":2} {"level":"info","ts":"2026-04-10T13:52:35.337692Z","caller":"traceutil/trace.go:171","msg":"trace[334520671] transaction","detail":"{read_only:false; response_revision:1894; number_of_response:1; }","duration":"344.094466ms","start":"2026-04-10T13:52:34.993569Z","end":"2026-04-10T13:52:35.337663Z","steps":["trace[334520671] 'process raft request' (duration: 343.928594ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T13:52:35.337727Z","caller":"traceutil/trace.go:171","msg":"trace[1718355015] transaction","detail":"{read_only:false; response_revision:1893; number_of_response:1; }","duration":"381.269615ms","start":"2026-04-10T13:52:34.956436Z","end":"2026-04-10T13:52:35.337706Z","steps":["trace[1718355015] 'process raft request' (duration: 381.021252ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:52:35.337809Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.838064ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-10T13:52:35.337847Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:52:34.993545Z","time spent":"344.217199ms","remote":"127.0.0.1:33680","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":16381,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T13:52:35.337859Z","caller":"traceutil/trace.go:171","msg":"trace[1997450595] transaction","detail":"{read_only:false; response_revision:1892; number_of_response:1; }","duration":"381.465027ms","start":"2026-04-10T13:52:34.956374Z","end":"2026-04-10T13:52:35.337839Z","steps":["trace[1997450595] 'process raft request' (duration: 380.943801ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:52:35.33782Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:52:34.956418Z","time spent":"381.355567ms","remote":"127.0.0.1:33510","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1684,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T13:52:35.337868Z","caller":"traceutil/trace.go:171","msg":"trace[1849721082] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1894; }","duration":"162.943126ms","start":"2026-04-10T13:52:35.174916Z","end":"2026-04-10T13:52:35.337859Z","steps":["trace[1849721082] 'agreement among raft nodes before linearized reading' (duration: 162.812314ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:52:35.337945Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:52:34.956351Z","time spent":"381.548778ms","remote":"127.0.0.1:33400","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1139,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-10T13:52:35.337921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.527285ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-10T13:52:35.338087Z","caller":"traceutil/trace.go:171","msg":"trace[1544962109] range","detail":"{range_begin:/registry/daemonsets/; range_end:/registry/daemonsets0; response_count:0; response_revision:1894; }","duration":"147.752129ms","start":"2026-04-10T13:52:35.190259Z","end":"2026-04-10T13:52:35.338011Z","steps":["trace[1544962109] 'agreement among raft nodes before linearized reading' (duration: 147.531536ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T13:52:35.548319Z","caller":"traceutil/trace.go:171","msg":"trace[1439061144] transaction","detail":"{read_only:false; response_revision:1896; number_of_response:1; }","duration":"112.426993ms","start":"2026-04-10T13:52:35.435866Z","end":"2026-04-10T13:52:35.548293Z","steps":["trace[1439061144] 'process raft request' (duration: 27.937844ms)","trace[1439061144] 'compare' (duration: 84.349748ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T13:52:35.548307Z","caller":"traceutil/trace.go:171","msg":"trace[471887710] linearizableReadLoop","detail":"{readStateIndex:1958; appliedIndex:1957; }","duration":"110.163335ms","start":"2026-04-10T13:52:35.43812Z","end":"2026-04-10T13:52:35.548283Z","steps":["trace[471887710] 'read index received' (duration: 25.646936ms)","trace[471887710] 'applied index is now lower than readState.Index' (duration: 84.512589ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T13:52:35.548777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.640082ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:4591"} {"level":"info","ts":"2026-04-10T13:52:35.548869Z","caller":"traceutil/trace.go:171","msg":"trace[2116983797] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1896; }","duration":"110.755403ms","start":"2026-04-10T13:52:35.438095Z","end":"2026-04-10T13:52:35.54885Z","steps":["trace[2116983797] 'agreement among raft nodes before linearized reading' (duration: 110.329887ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T13:52:37.831082Z","caller":"traceutil/trace.go:171","msg":"trace[1591367409] transaction","detail":"{read_only:false; response_revision:1914; number_of_response:1; }","duration":"229.592842ms","start":"2026-04-10T13:52:37.601465Z","end":"2026-04-10T13:52:37.831058Z","steps":["trace[1591367409] 'process raft request' (duration: 229.40473ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:52:56.20793Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.6185ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-10T13:52:56.208179Z","caller":"traceutil/trace.go:171","msg":"trace[1571828761] transaction","detail":"{read_only:false; response_revision:2053; number_of_response:1; }","duration":"220.129205ms","start":"2026-04-10T13:52:55.987959Z","end":"2026-04-10T13:52:56.208088Z","steps":["trace[1571828761] 'process raft request' (duration: 16.262982ms)","trace[1571828761] 'compare' (duration: 203.466919ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T13:53:02.403299Z","caller":"traceutil/trace.go:171","msg":"trace[125396289] linearizableReadLoop","detail":"{readStateIndex:2164; appliedIndex:2163; }","duration":"226.322609ms","start":"2026-04-10T13:53:02.176947Z","end":"2026-04-10T13:53:02.403269Z","steps":["trace[125396289] 'read index received' (duration: 226.115887ms)","trace[125396289] 'applied index is now lower than readState.Index' (duration: 205.322µs)"],"step_count":2} {"level":"warn","ts":"2026-04-10T13:53:02.403564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.38984ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-04-10T13:53:02.403519Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.47235ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T13:53:02.403607Z","caller":"traceutil/trace.go:171","msg":"trace[1345241271] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2092; }","duration":"164.463171ms","start":"2026-04-10T13:53:02.239133Z","end":"2026-04-10T13:53:02.403596Z","steps":["trace[1345241271] 'agreement among raft nodes before linearized reading' (duration: 164.314559ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T13:53:02.403366Z","caller":"traceutil/trace.go:171","msg":"trace[327095425] transaction","detail":"{read_only:false; response_revision:2092; number_of_response:1; }","duration":"427.447356ms","start":"2026-04-10T13:53:01.975877Z","end":"2026-04-10T13:53:02.403325Z","steps":["trace[327095425] 'process raft request' (duration: 427.202673ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T13:53:02.403661Z","caller":"traceutil/trace.go:171","msg":"trace[503615781] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2092; }","duration":"226.727204ms","start":"2026-04-10T13:53:02.176883Z","end":"2026-04-10T13:53:02.403611Z","steps":["trace[503615781] 'agreement among raft nodes before linearized reading' (duration: 226.483621ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:53:02.404835Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:53:01.975849Z","time spent":"427.915272ms","remote":"127.0.0.1:33494","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-10T13:53:03.263436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.453746ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-10T13:53:03.263655Z","caller":"traceutil/trace.go:171","msg":"trace[1192177715] transaction","detail":"{read_only:false; response_revision:2094; number_of_response:1; }","duration":"587.248565ms","start":"2026-04-10T13:53:02.676389Z","end":"2026-04-10T13:53:03.263637Z","steps":["trace[1192177715] 'process raft request' (duration: 587.188815ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:53:03.263712Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:53:02.676364Z","time spent":"587.322397ms","remote":"127.0.0.1:33282","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":820,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-10T13:53:03.263864Z","caller":"traceutil/trace.go:171","msg":"trace[601233004] linearizableReadLoop","detail":"{readStateIndex:2165; appliedIndex:2164; }","duration":"831.562713ms","start":"2026-04-10T13:53:02.432246Z","end":"2026-04-10T13:53:03.263809Z","steps":["trace[601233004] 'read index received' (duration: 461.658422ms)","trace[601233004] 'applied index is now lower than readState.Index' (duration: 369.899021ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T13:53:03.263857Z","caller":"traceutil/trace.go:171","msg":"trace[1819251078] transaction","detail":"{read_only:false; response_revision:2093; number_of_response:1; }","duration":"855.396099ms","start":"2026-04-10T13:53:02.408414Z","end":"2026-04-10T13:53:03.26381Z","steps":["trace[1819251078] 'process raft request' (duration: 485.487088ms)","trace[1819251078] 'compare' (duration: 368.240141ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T13:53:03.264053Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:53:02.408397Z","time spent":"855.558281ms","remote":"127.0.0.1:33494","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-10T13:53:03.264079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"533.359069ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-10T13:53:03.264116Z","caller":"traceutil/trace.go:171","msg":"trace[168459503] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:2094; }","duration":"533.43416ms","start":"2026-04-10T13:53:02.730671Z","end":"2026-04-10T13:53:03.264105Z","steps":["trace[168459503] 'agreement among raft nodes before linearized reading' (duration: 533.368139ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:53:03.264147Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:53:02.730661Z","time spent":"533.47788ms","remote":"127.0.0.1:33376","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":30,"request content":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true "} {"level":"warn","ts":"2026-04-10T13:53:03.264186Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"798.042174ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-10T13:53:03.26422Z","caller":"traceutil/trace.go:171","msg":"trace[49787503] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2094; }","duration":"798.131155ms","start":"2026-04-10T13:53:02.46608Z","end":"2026-04-10T13:53:03.264211Z","steps":["trace[49787503] 'agreement among raft nodes before linearized reading' (duration: 797.947253ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:53:03.264257Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:53:02.466064Z","time spent":"798.184855ms","remote":"127.0.0.1:33494","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-10T13:53:03.264232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"831.956008ms","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":"warn","ts":"2026-04-10T13:53:03.264321Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.92203ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T13:53:03.264334Z","caller":"traceutil/trace.go:171","msg":"trace[857071693] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:2094; }","duration":"832.097389ms","start":"2026-04-10T13:53:02.432217Z","end":"2026-04-10T13:53:03.264314Z","steps":["trace[857071693] 'agreement among raft nodes before linearized reading' (duration: 831.764025ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T13:53:03.264355Z","caller":"traceutil/trace.go:171","msg":"trace[1948494850] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:2094; }","duration":"150.995481ms","start":"2026-04-10T13:53:03.113349Z","end":"2026-04-10T13:53:03.264344Z","steps":["trace[1948494850] 'agreement among raft nodes before linearized reading' (duration: 150.945301ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:53:03.264379Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:53:02.432205Z","time spent":"832.164009ms","remote":"127.0.0.1:33282","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":250,"response size":31,"request content":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true "} {"level":"warn","ts":"2026-04-10T13:53:03.264507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"553.25172ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:644"} {"level":"info","ts":"2026-04-10T13:53:03.264546Z","caller":"traceutil/trace.go:171","msg":"trace[589988747] range","detail":"{range_begin:/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2094; }","duration":"553.321231ms","start":"2026-04-10T13:53:02.711212Z","end":"2026-04-10T13:53:03.264534Z","steps":["trace[589988747] 'agreement among raft nodes before linearized reading' (duration: 553.17535ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:53:03.264576Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:53:02.7112Z","time spent":"553.369162ms","remote":"127.0.0.1:33322","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":667,"request content":"key:\"/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"warn","ts":"2026-04-10T13:53:03.264587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.400773ms","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-04-10T13:53:03.264619Z","caller":"traceutil/trace.go:171","msg":"trace[627803640] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:2094; }","duration":"275.469004ms","start":"2026-04-10T13:53:02.989138Z","end":"2026-04-10T13:53:03.264607Z","steps":["trace[627803640] 'agreement among raft nodes before linearized reading' (duration: 275.364933ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:53:03.264728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"705.087053ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-10T13:53:03.264775Z","caller":"traceutil/trace.go:171","msg":"trace[1635187168] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:2094; }","duration":"705.161334ms","start":"2026-04-10T13:53:02.5596Z","end":"2026-04-10T13:53:03.264762Z","steps":["trace[1635187168] 'agreement among raft nodes before linearized reading' (duration: 705.059543ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:53:03.264786Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"790.634787ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/08db1feb.percona.com\" ","response":"range_response_count:1 size:525"} {"level":"warn","ts":"2026-04-10T13:53:03.264807Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:53:02.559588Z","time spent":"705.211194ms","remote":"127.0.0.1:33634","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":13,"response size":30,"request content":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true "} {"level":"info","ts":"2026-04-10T13:53:03.264816Z","caller":"traceutil/trace.go:171","msg":"trace[1623900470] range","detail":"{range_begin:/registry/leases/openstack/08db1feb.percona.com; range_end:; response_count:1; response_revision:2094; }","duration":"790.699237ms","start":"2026-04-10T13:53:02.474108Z","end":"2026-04-10T13:53:03.264807Z","steps":["trace[1623900470] 'agreement among raft nodes before linearized reading' (duration: 790.612506ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:53:03.264843Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:53:02.474086Z","time spent":"790.751539ms","remote":"127.0.0.1:33494","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":548,"request content":"key:\"/registry/leases/openstack/08db1feb.percona.com\" "} {"level":"warn","ts":"2026-04-10T13:53:03.264925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"522.418012ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-10T13:53:03.265Z","caller":"traceutil/trace.go:171","msg":"trace[1688088799] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2094; }","duration":"522.536053ms","start":"2026-04-10T13:53:02.742445Z","end":"2026-04-10T13:53:03.264981Z","steps":["trace[1688088799] 'agreement among raft nodes before linearized reading' (duration: 522.23722ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:53:03.265012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"796.324954ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-10T13:53:03.265041Z","caller":"traceutil/trace.go:171","msg":"trace[1152338188] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2094; }","duration":"796.354614ms","start":"2026-04-10T13:53:02.468679Z","end":"2026-04-10T13:53:03.265033Z","steps":["trace[1152338188] 'agreement among raft nodes before linearized reading' (duration: 796.274833ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:53:03.265044Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:53:02.742414Z","time spent":"522.623564ms","remote":"127.0.0.1:33494","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-10T13:53:03.265062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"557.900414ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-04-10T13:53:03.265068Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:53:02.468639Z","time spent":"796.421274ms","remote":"127.0.0.1:33494","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-10T13:53:03.265062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"501.452409ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:4591"} {"level":"info","ts":"2026-04-10T13:53:03.265099Z","caller":"traceutil/trace.go:171","msg":"trace[920048350] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2094; }","duration":"557.979436ms","start":"2026-04-10T13:53:02.707107Z","end":"2026-04-10T13:53:03.265087Z","steps":["trace[920048350] 'agreement among raft nodes before linearized reading' (duration: 557.824744ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T13:53:03.265104Z","caller":"traceutil/trace.go:171","msg":"trace[690674758] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2094; }","duration":"501.49598ms","start":"2026-04-10T13:53:02.763599Z","end":"2026-04-10T13:53:03.265095Z","steps":["trace[690674758] 'agreement among raft nodes before linearized reading' (duration: 501.392008ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:53:03.265128Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:53:02.70707Z","time spent":"558.051566ms","remote":"127.0.0.1:33494","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-10T13:53:03.265138Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:53:02.763544Z","time spent":"501.587ms","remote":"127.0.0.1:60536","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":4614,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-04-10T13:53:03.2653Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"563.289588ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:659"} {"level":"info","ts":"2026-04-10T13:53:03.265329Z","caller":"traceutil/trace.go:171","msg":"trace[1088864128] range","detail":"{range_begin:/registry/configmaps/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:2094; }","duration":"563.352898ms","start":"2026-04-10T13:53:02.701967Z","end":"2026-04-10T13:53:03.26532Z","steps":["trace[1088864128] 'agreement among raft nodes before linearized reading' (duration: 563.273757ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:53:03.265355Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:53:02.701954Z","time spent":"563.394549ms","remote":"127.0.0.1:33322","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":1,"response size":682,"request content":"key:\"/registry/configmaps/openstack/messaging-topology-operator-leader-election\" "} {"level":"info","ts":"2026-04-10T13:53:03.435828Z","caller":"traceutil/trace.go:171","msg":"trace[1804860949] transaction","detail":"{read_only:false; response_revision:2095; number_of_response:1; }","duration":"148.727125ms","start":"2026-04-10T13:53:03.287078Z","end":"2026-04-10T13:53:03.435806Z","steps":["trace[1804860949] 'process raft request' (duration: 100.611277ms)","trace[1804860949] 'compare' (duration: 48.017526ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T13:53:03.944912Z","caller":"traceutil/trace.go:171","msg":"trace[438578048] transaction","detail":"{read_only:false; response_revision:2096; number_of_response:1; }","duration":"657.720966ms","start":"2026-04-10T13:53:03.287159Z","end":"2026-04-10T13:53:03.94488Z","steps":["trace[438578048] 'process raft request' (duration: 573.020134ms)","trace[438578048] 'compare' (duration: 84.47207ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T13:53:03.945388Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:53:03.28714Z","time spent":"657.868508ms","remote":"127.0.0.1:33494","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T13:53:03.945955Z","caller":"traceutil/trace.go:171","msg":"trace[1446129965] transaction","detail":"{read_only:false; response_revision:2097; number_of_response:1; }","duration":"658.690077ms","start":"2026-04-10T13:53:03.287219Z","end":"2026-04-10T13:53:03.945909Z","steps":["trace[1446129965] 'process raft request' (duration: 657.616115ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T13:53:03.946019Z","caller":"traceutil/trace.go:171","msg":"trace[1943099130] transaction","detail":"{read_only:false; response_revision:2098; number_of_response:1; }","duration":"658.736459ms","start":"2026-04-10T13:53:03.287249Z","end":"2026-04-10T13:53:03.945985Z","steps":["trace[1943099130] 'process raft request' (duration: 658.558886ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:53:03.946146Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:53:03.287216Z","time spent":"658.833709ms","remote":"127.0.0.1:33494","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":544,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T13:53:03.946166Z","caller":"traceutil/trace.go:171","msg":"trace[348014306] linearizableReadLoop","detail":"{readStateIndex:2170; appliedIndex:2166; }","duration":"658.865209ms","start":"2026-04-10T13:53:03.287273Z","end":"2026-04-10T13:53:03.946137Z","steps":["trace[348014306] 'read index received' (duration: 100.429184ms)","trace[348014306] 'applied index is now lower than readState.Index' (duration: 558.433685ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T13:53:03.946227Z","caller":"traceutil/trace.go:171","msg":"trace[1379565231] transaction","detail":"{read_only:false; response_revision:2099; number_of_response:1; }","duration":"658.944221ms","start":"2026-04-10T13:53:03.287257Z","end":"2026-04-10T13:53:03.946201Z","steps":["trace[1379565231] 'process raft request' (duration: 658.658967ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:53:03.946294Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:53:03.28724Z","time spent":"658.955251ms","remote":"127.0.0.1:33494","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-10T13:53:03.946335Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:53:03.287222Z","time spent":"659.061342ms","remote":"127.0.0.1:33494","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T13:53:03.946446Z","caller":"traceutil/trace.go:171","msg":"trace[1561509039] transaction","detail":"{read_only:false; response_revision:2101; number_of_response:1; }","duration":"657.635045ms","start":"2026-04-10T13:53:03.288765Z","end":"2026-04-10T13:53:03.9464Z","steps":["trace[1561509039] 'process raft request' (duration: 657.256241ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:53:03.946481Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"469.304562ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T13:53:03.946491Z","caller":"traceutil/trace.go:171","msg":"trace[1725742745] transaction","detail":"{read_only:false; response_revision:2100; number_of_response:1; }","duration":"657.551725ms","start":"2026-04-10T13:53:03.288502Z","end":"2026-04-10T13:53:03.946053Z","steps":["trace[1725742745] 'process raft request' (duration: 657.470284ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T13:53:03.946529Z","caller":"traceutil/trace.go:171","msg":"trace[1048892645] range","detail":"{range_begin:/registry/ingress/; range_end:/registry/ingress0; response_count:0; response_revision:2101; }","duration":"469.389123ms","start":"2026-04-10T13:53:03.477128Z","end":"2026-04-10T13:53:03.946517Z","steps":["trace[1048892645] 'agreement among raft nodes before linearized reading' (duration: 469.16188ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:53:03.946567Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:53:03.47711Z","time spent":"469.447443ms","remote":"127.0.0.1:33526","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":0,"response size":28,"request content":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true "} {"level":"warn","ts":"2026-04-10T13:53:03.946654Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"659.373095ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:567"} {"level":"warn","ts":"2026-04-10T13:53:03.946694Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:53:03.288485Z","time spent":"658.128521ms","remote":"127.0.0.1:33322","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":629,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-10T13:53:03.946721Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:53:03.288757Z","time spent":"657.721906ms","remote":"127.0.0.1:33494","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T13:53:03.946706Z","caller":"traceutil/trace.go:171","msg":"trace[1703578044] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:2101; }","duration":"659.441107ms","start":"2026-04-10T13:53:03.287251Z","end":"2026-04-10T13:53:03.946692Z","steps":["trace[1703578044] 'agreement among raft nodes before linearized reading' (duration: 659.297895ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:53:03.946882Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:53:03.287244Z","time spent":"659.624229ms","remote":"127.0.0.1:33494","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":590,"request content":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" "} {"level":"warn","ts":"2026-04-10T13:53:03.947119Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"422.805072ms","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-04-10T13:53:03.947187Z","caller":"traceutil/trace.go:171","msg":"trace[931218749] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:2101; }","duration":"422.899453ms","start":"2026-04-10T13:53:03.524274Z","end":"2026-04-10T13:53:03.947174Z","steps":["trace[931218749] 'agreement among raft nodes before linearized reading' (duration: 422.367387ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:53:03.947224Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:53:03.524263Z","time spent":"422.953124ms","remote":"127.0.0.1:33728","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":250,"response size":31,"request content":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true "} {"level":"warn","ts":"2026-04-10T13:53:46.542725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.52835ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-10T13:53:46.542905Z","caller":"traceutil/trace.go:171","msg":"trace[258218866] transaction","detail":"{read_only:false; response_revision:2445; number_of_response:1; }","duration":"143.781925ms","start":"2026-04-10T13:53:46.399102Z","end":"2026-04-10T13:53:46.542884Z","steps":["trace[258218866] 'process raft request' (duration: 33.974222ms)","trace[258218866] 'compare' (duration: 109.249237ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T13:53:54.877723Z","caller":"traceutil/trace.go:171","msg":"trace[984451874] transaction","detail":"{read_only:false; response_revision:2552; number_of_response:1; }","duration":"241.58379ms","start":"2026-04-10T13:53:54.636096Z","end":"2026-04-10T13:53:54.877679Z","steps":["trace[984451874] 'process raft request' (duration: 238.309504ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T13:53:54.897743Z","caller":"traceutil/trace.go:171","msg":"trace[27352754] linearizableReadLoop","detail":"{readStateIndex:2649; appliedIndex:2647; }","duration":"116.864442ms","start":"2026-04-10T13:53:54.780856Z","end":"2026-04-10T13:53:54.89772Z","steps":["trace[27352754] 'read index received' (duration: 93.582339ms)","trace[27352754] 'applied index is now lower than readState.Index' (duration: 23.281263ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T13:53:54.897828Z","caller":"traceutil/trace.go:171","msg":"trace[1420622458] transaction","detail":"{read_only:false; response_revision:2553; number_of_response:1; }","duration":"245.932447ms","start":"2026-04-10T13:53:54.651868Z","end":"2026-04-10T13:53:54.897801Z","steps":["trace[1420622458] 'process raft request' (duration: 245.711755ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:53:54.897886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.004743ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T13:53:54.897958Z","caller":"traceutil/trace.go:171","msg":"trace[5368016] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:2553; }","duration":"117.125054ms","start":"2026-04-10T13:53:54.780822Z","end":"2026-04-10T13:53:54.897947Z","steps":["trace[5368016] 'agreement among raft nodes before linearized reading' (duration: 117.016503ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T13:53:55.922006Z","caller":"traceutil/trace.go:171","msg":"trace[1783475942] linearizableReadLoop","detail":"{readStateIndex:2651; appliedIndex:2650; }","duration":"382.519498ms","start":"2026-04-10T13:53:55.539456Z","end":"2026-04-10T13:53:55.921976Z","steps":["trace[1783475942] 'read index received' (duration: 379.80282ms)","trace[1783475942] 'applied index is now lower than readState.Index' (duration: 2.714758ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T13:53:55.922194Z","caller":"traceutil/trace.go:171","msg":"trace[935039275] transaction","detail":"{read_only:false; response_revision:2554; number_of_response:1; }","duration":"448.208003ms","start":"2026-04-10T13:53:55.473943Z","end":"2026-04-10T13:53:55.922151Z","steps":["trace[935039275] 'process raft request' (duration: 445.435573ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:53:55.922453Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:53:55.473916Z","time spent":"448.383035ms","remote":"127.0.0.1:33246","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-10T13:53:55.922584Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"383.117175ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-10T13:53:55.922696Z","caller":"traceutil/trace.go:171","msg":"trace[2001182330] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2554; }","duration":"383.267437ms","start":"2026-04-10T13:53:55.539413Z","end":"2026-04-10T13:53:55.922681Z","steps":["trace[2001182330] 'agreement among raft nodes before linearized reading' (duration: 382.799943ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:53:55.922793Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:53:55.539394Z","time spent":"383.382789ms","remote":"127.0.0.1:33494","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-10T13:53:55.923141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.975942ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-10T13:53:55.92323Z","caller":"traceutil/trace.go:171","msg":"trace[1054372104] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2554; }","duration":"231.122643ms","start":"2026-04-10T13:53:55.692096Z","end":"2026-04-10T13:53:55.923218Z","steps":["trace[1054372104] 'agreement among raft nodes before linearized reading' (duration: 230.976562ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:53:55.923605Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.593189ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-10T13:53:55.923662Z","caller":"traceutil/trace.go:171","msg":"trace[1168365773] range","detail":"{range_begin:/registry/endpointslices/; range_end:/registry/endpointslices0; response_count:0; response_revision:2554; }","duration":"175.687511ms","start":"2026-04-10T13:53:55.747962Z","end":"2026-04-10T13:53:55.923649Z","steps":["trace[1168365773] 'agreement among raft nodes before linearized reading' (duration: 175.556519ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T13:54:23.004271Z","caller":"traceutil/trace.go:171","msg":"trace[134360162] transaction","detail":"{read_only:false; response_revision:2745; number_of_response:1; }","duration":"128.30341ms","start":"2026-04-10T13:54:22.87595Z","end":"2026-04-10T13:54:23.004253Z","steps":["trace[134360162] 'process raft request' (duration: 125.612571ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:54:23.447851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.158464ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:5"} {"level":"info","ts":"2026-04-10T13:54:23.448366Z","caller":"traceutil/trace.go:171","msg":"trace[996034418] linearizableReadLoop","detail":"{readStateIndex:2855; appliedIndex:2853; }","duration":"301.234784ms","start":"2026-04-10T13:54:23.147107Z","end":"2026-04-10T13:54:23.448342Z","steps":["trace[996034418] 'read index received' (duration: 126.685681ms)","trace[996034418] 'applied index is now lower than readState.Index' (duration: 174.548303ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T13:54:23.448461Z","caller":"traceutil/trace.go:171","msg":"trace[1672432993] transaction","detail":"{read_only:false; number_of_response:0; response_revision:2746; }","duration":"436.945532ms","start":"2026-04-10T13:54:23.011506Z","end":"2026-04-10T13:54:23.448452Z","steps":["trace[1672432993] 'process raft request' (duration: 133.13109ms)","trace[1672432993] 'compare' (duration: 303.122804ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T13:54:23.448542Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:54:23.011489Z","time spent":"437.000613ms","remote":"127.0.0.1:33680","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-10T13:54:23.448548Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.113241ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:659"} {"level":"info","ts":"2026-04-10T13:54:23.448611Z","caller":"traceutil/trace.go:171","msg":"trace[989611424] range","detail":"{range_begin:/registry/configmaps/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:2747; }","duration":"224.8382ms","start":"2026-04-10T13:54:23.22376Z","end":"2026-04-10T13:54:23.448598Z","steps":["trace[989611424] 'agreement among raft nodes before linearized reading' (duration: 224.681078ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:54:23.448748Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.643949ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/auth-system/keycloak-0.18a5034add64ba2c\" ","response":"range_response_count:1 size:779"} {"level":"info","ts":"2026-04-10T13:54:23.448817Z","caller":"traceutil/trace.go:171","msg":"trace[12467277] transaction","detail":"{read_only:false; response_revision:2747; number_of_response:1; }","duration":"433.210263ms","start":"2026-04-10T13:54:23.015598Z","end":"2026-04-10T13:54:23.448808Z","steps":["trace[12467277] 'process raft request' (duration: 432.344833ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T13:54:23.448829Z","caller":"traceutil/trace.go:171","msg":"trace[1503482371] range","detail":"{range_begin:/registry/events/auth-system/keycloak-0.18a5034add64ba2c; range_end:; response_count:1; response_revision:2747; }","duration":"301.79727ms","start":"2026-04-10T13:54:23.147013Z","end":"2026-04-10T13:54:23.448811Z","steps":["trace[1503482371] 'agreement among raft nodes before linearized reading' (duration: 301.596348ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:54:23.44888Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:54:23.146993Z","time spent":"301.875021ms","remote":"127.0.0.1:33282","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":1,"response size":802,"request content":"key:\"/registry/events/auth-system/keycloak-0.18a5034add64ba2c\" "} {"level":"warn","ts":"2026-04-10T13:54:23.448892Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:54:23.015577Z","time spent":"433.280253ms","remote":"127.0.0.1:33494","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-10T13:54:24.206702Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"510.525846ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-10T13:54:24.207262Z","caller":"traceutil/trace.go:171","msg":"trace[1947064960] transaction","detail":"{read_only:false; response_revision:2748; number_of_response:1; }","duration":"751.878833ms","start":"2026-04-10T13:54:23.455353Z","end":"2026-04-10T13:54:24.207232Z","steps":["trace[1947064960] 'process raft request' (duration: 240.721439ms)","trace[1947064960] 'compare' (duration: 510.156943ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T13:54:24.207387Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:54:23.457459Z","time spent":"749.919871ms","remote":"127.0.0.1:33282","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-04-10T13:54:24.207607Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:54:23.455345Z","time spent":"752.024364ms","remote":"127.0.0.1:33322","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":644,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T13:54:24.208486Z","caller":"traceutil/trace.go:171","msg":"trace[970190808] linearizableReadLoop","detail":"{readStateIndex:2858; appliedIndex:2855; }","duration":"140.999983ms","start":"2026-04-10T13:54:24.067434Z","end":"2026-04-10T13:54:24.208434Z","steps":["trace[970190808] 'read index received' (duration: 44.71µs)","trace[970190808] 'applied index is now lower than readState.Index' (duration: 140.952713ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T13:54:24.208556Z","caller":"traceutil/trace.go:171","msg":"trace[1851062328] transaction","detail":"{read_only:false; response_revision:2749; number_of_response:1; }","duration":"734.183213ms","start":"2026-04-10T13:54:23.474347Z","end":"2026-04-10T13:54:24.20853Z","steps":["trace[1851062328] 'process raft request' (duration: 732.848619ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:54:24.209262Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:54:23.47433Z","time spent":"734.8867ms","remote":"127.0.0.1:33680","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":16842,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-10T13:54:24.209612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.011314ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-10T13:54:24.209732Z","caller":"traceutil/trace.go:171","msg":"trace[1357182199] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2749; }","duration":"142.176505ms","start":"2026-04-10T13:54:24.067529Z","end":"2026-04-10T13:54:24.209705Z","steps":["trace[1357182199] 'agreement among raft nodes before linearized reading' (duration: 141.978823ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:54:24.208652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.210645ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-10T13:54:24.209927Z","caller":"traceutil/trace.go:171","msg":"trace[259127084] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2749; }","duration":"142.494809ms","start":"2026-04-10T13:54:24.067377Z","end":"2026-04-10T13:54:24.209872Z","steps":["trace[259127084] 'agreement among raft nodes before linearized reading' (duration: 141.145825ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:54:25.05394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"506.34333ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-10T13:54:25.054257Z","caller":"traceutil/trace.go:171","msg":"trace[1412377971] transaction","detail":"{read_only:false; response_revision:2752; number_of_response:1; }","duration":"837.085967ms","start":"2026-04-10T13:54:24.217152Z","end":"2026-04-10T13:54:25.054238Z","steps":["trace[1412377971] 'process raft request' (duration: 837.014036ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:54:25.054355Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:54:24.217137Z","time spent":"837.181748ms","remote":"127.0.0.1:33494","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T13:54:25.054534Z","caller":"traceutil/trace.go:171","msg":"trace[990904740] linearizableReadLoop","detail":"{readStateIndex:2859; appliedIndex:2858; }","duration":"841.232191ms","start":"2026-04-10T13:54:24.213269Z","end":"2026-04-10T13:54:25.054501Z","steps":["trace[990904740] 'read index received' (duration: 308.913µs)","trace[990904740] 'applied index is now lower than readState.Index' (duration: 840.917898ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T13:54:25.054648Z","caller":"traceutil/trace.go:171","msg":"trace[858654063] transaction","detail":"{read_only:false; response_revision:2750; number_of_response:1; }","duration":"841.402062ms","start":"2026-04-10T13:54:24.213236Z","end":"2026-04-10T13:54:25.054638Z","steps":["trace[858654063] 'process raft request' (duration: 334.240234ms)","trace[858654063] 'compare' (duration: 506.006086ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T13:54:25.054743Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:54:24.213216Z","time spent":"841.454553ms","remote":"127.0.0.1:33282","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":764,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T13:54:25.054778Z","caller":"traceutil/trace.go:171","msg":"trace[903672707] transaction","detail":"{read_only:false; response_revision:2751; number_of_response:1; }","duration":"837.631943ms","start":"2026-04-10T13:54:24.217132Z","end":"2026-04-10T13:54:25.054764Z","steps":["trace[903672707] 'process raft request' (duration: 836.942305ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:54:25.054857Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:54:24.217118Z","time spent":"837.690793ms","remote":"127.0.0.1:33494","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-10T13:54:25.055061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"841.786597ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/queues/\" range_end:\"/registry/rabbitmq.com/queues0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T13:54:25.055106Z","caller":"traceutil/trace.go:171","msg":"trace[2101715525] range","detail":"{range_begin:/registry/rabbitmq.com/queues/; range_end:/registry/rabbitmq.com/queues0; response_count:0; response_revision:2752; }","duration":"841.870887ms","start":"2026-04-10T13:54:24.213224Z","end":"2026-04-10T13:54:25.055095Z","steps":["trace[2101715525] 'agreement among raft nodes before linearized reading' (duration: 841.790296ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:54:25.055146Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:54:24.213202Z","time spent":"841.936328ms","remote":"127.0.0.1:60352","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":0,"response size":28,"request content":"key:\"/registry/rabbitmq.com/queues/\" range_end:\"/registry/rabbitmq.com/queues0\" count_only:true "} {"level":"warn","ts":"2026-04-10T13:54:25.05516Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"841.443043ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T13:54:25.055237Z","caller":"traceutil/trace.go:171","msg":"trace[1003079555] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2752; }","duration":"841.579944ms","start":"2026-04-10T13:54:24.213639Z","end":"2026-04-10T13:54:25.055219Z","steps":["trace[1003079555] 'agreement among raft nodes before linearized reading' (duration: 841.452773ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:54:25.055283Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:54:24.213591Z","time spent":"841.685346ms","remote":"127.0.0.1:33220","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-10T13:54:25.055378Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"627.514762ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-10T13:54:25.055423Z","caller":"traceutil/trace.go:171","msg":"trace[878093388] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2752; }","duration":"627.590803ms","start":"2026-04-10T13:54:24.427821Z","end":"2026-04-10T13:54:25.055412Z","steps":["trace[878093388] 'agreement among raft nodes before linearized reading' (duration: 627.460302ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:54:25.055441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"819.886212ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:11499"} {"level":"warn","ts":"2026-04-10T13:54:25.055454Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:54:24.42781Z","time spent":"627.637424ms","remote":"127.0.0.1:33494","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-10T13:54:25.05547Z","caller":"traceutil/trace.go:171","msg":"trace[146373021] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2752; }","duration":"819.956734ms","start":"2026-04-10T13:54:24.235505Z","end":"2026-04-10T13:54:25.055462Z","steps":["trace[146373021] 'agreement among raft nodes before linearized reading' (duration: 819.820132ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:54:25.055504Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:54:24.235487Z","time spent":"820.006784ms","remote":"127.0.0.1:33424","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":11522,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-04-10T13:54:25.055543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"838.404471ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:566"} {"level":"info","ts":"2026-04-10T13:54:25.055584Z","caller":"traceutil/trace.go:171","msg":"trace[2028145231] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:2752; }","duration":"838.469481ms","start":"2026-04-10T13:54:24.217102Z","end":"2026-04-10T13:54:25.055572Z","steps":["trace[2028145231] 'agreement among raft nodes before linearized reading' (duration: 838.321759ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:54:25.055612Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:54:24.217082Z","time spent":"838.523562ms","remote":"127.0.0.1:33494","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":589,"request content":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" "} {"level":"warn","ts":"2026-04-10T13:54:25.055607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"633.345774ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-10T13:54:25.055693Z","caller":"traceutil/trace.go:171","msg":"trace[1488735686] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2752; }","duration":"633.479345ms","start":"2026-04-10T13:54:24.422194Z","end":"2026-04-10T13:54:25.055674Z","steps":["trace[1488735686] 'agreement among raft nodes before linearized reading' (duration: 633.264863ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:54:25.055718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.912323ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:644"} {"level":"warn","ts":"2026-04-10T13:54:25.055736Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:54:24.422171Z","time spent":"633.556837ms","remote":"127.0.0.1:33494","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-04-10T13:54:25.055758Z","caller":"traceutil/trace.go:171","msg":"trace[488524139] range","detail":"{range_begin:/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2752; }","duration":"216.950394ms","start":"2026-04-10T13:54:24.838798Z","end":"2026-04-10T13:54:25.055748Z","steps":["trace[488524139] 'agreement among raft nodes before linearized reading' (duration: 216.862063ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:54:25.055842Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"624.371058ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/08db1feb.percona.com\" ","response":"range_response_count:1 size:525"} {"level":"warn","ts":"2026-04-10T13:54:25.055637Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.911601ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1296"} {"level":"info","ts":"2026-04-10T13:54:25.055925Z","caller":"traceutil/trace.go:171","msg":"trace[566103812] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2752; }","duration":"198.227153ms","start":"2026-04-10T13:54:24.857687Z","end":"2026-04-10T13:54:25.055914Z","steps":["trace[566103812] 'agreement among raft nodes before linearized reading' (duration: 197.88249ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:54:25.055938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"517.947703ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T13:54:25.055971Z","caller":"traceutil/trace.go:171","msg":"trace[465487387] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:2752; }","duration":"518.061225ms","start":"2026-04-10T13:54:24.537902Z","end":"2026-04-10T13:54:25.055963Z","steps":["trace[465487387] 'agreement among raft nodes before linearized reading' (duration: 518.005393ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T13:54:25.055884Z","caller":"traceutil/trace.go:171","msg":"trace[39253273] range","detail":"{range_begin:/registry/leases/openstack/08db1feb.percona.com; range_end:; response_count:1; response_revision:2752; }","duration":"624.452298ms","start":"2026-04-10T13:54:24.431423Z","end":"2026-04-10T13:54:25.055876Z","steps":["trace[39253273] 'agreement among raft nodes before linearized reading' (duration: 624.354187ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:54:25.056076Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:54:24.537867Z","time spent":"518.198466ms","remote":"127.0.0.1:34710","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true "} {"level":"warn","ts":"2026-04-10T13:54:25.056084Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:54:24.431399Z","time spent":"624.673292ms","remote":"127.0.0.1:33494","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":548,"request content":"key:\"/registry/leases/openstack/08db1feb.percona.com\" "} {"level":"warn","ts":"2026-04-10T13:54:25.05642Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"674.758216ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-10T13:54:25.056463Z","caller":"traceutil/trace.go:171","msg":"trace[1538051205] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2752; }","duration":"674.863797ms","start":"2026-04-10T13:54:24.381589Z","end":"2026-04-10T13:54:25.056453Z","steps":["trace[1538051205] 'agreement among raft nodes before linearized reading' (duration: 674.754736ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:54:25.056492Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:54:24.381562Z","time spent":"674.923157ms","remote":"127.0.0.1:33494","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-10T13:54:25.057976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"694.589247ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-10T13:54:25.058128Z","caller":"traceutil/trace.go:171","msg":"trace[314849240] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:2752; }","duration":"694.89836ms","start":"2026-04-10T13:54:24.363208Z","end":"2026-04-10T13:54:25.058107Z","steps":["trace[314849240] 'agreement among raft nodes before linearized reading' (duration: 692.09471ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:54:25.064549Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:54:24.363188Z","time spent":"701.32249ms","remote":"127.0.0.1:60504","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":30,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "} {"level":"info","ts":"2026-04-10T13:56:24.465016Z","caller":"traceutil/trace.go:171","msg":"trace[9002145] transaction","detail":"{read_only:false; response_revision:3723; number_of_response:1; }","duration":"104.305007ms","start":"2026-04-10T13:56:24.360691Z","end":"2026-04-10T13:56:24.464996Z","steps":["trace[9002145] 'process raft request' (duration: 90.229374ms)","trace[9002145] 'compare' (duration: 13.989911ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T13:56:33.467593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.286617ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-10T13:56:33.467693Z","caller":"traceutil/trace.go:171","msg":"trace[605559914] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:3801; }","duration":"104.443231ms","start":"2026-04-10T13:56:33.363225Z","end":"2026-04-10T13:56:33.467668Z","steps":["trace[605559914] 'count revisions from in-memory index tree' (duration: 104.182915ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:56:33.467961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.222574ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T13:56:33.468049Z","caller":"traceutil/trace.go:171","msg":"trace[2022854217] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:3801; }","duration":"102.376638ms","start":"2026-04-10T13:56:33.365651Z","end":"2026-04-10T13:56:33.468027Z","steps":["trace[2022854217] 'count revisions from in-memory index tree' (duration: 102.138412ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T13:56:38.9116Z","caller":"traceutil/trace.go:171","msg":"trace[723458882] transaction","detail":"{read_only:false; response_revision:4157; number_of_response:1; }","duration":"218.106712ms","start":"2026-04-10T13:56:38.693466Z","end":"2026-04-10T13:56:38.911573Z","steps":["trace[723458882] 'process raft request' (duration: 216.992504ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T13:56:38.922538Z","caller":"traceutil/trace.go:171","msg":"trace[1503117459] transaction","detail":"{read_only:false; response_revision:4158; number_of_response:1; }","duration":"210.178291ms","start":"2026-04-10T13:56:38.712343Z","end":"2026-04-10T13:56:38.922522Z","steps":["trace[1503117459] 'process raft request' (duration: 210.032147ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T13:56:38.922833Z","caller":"traceutil/trace.go:171","msg":"trace[458369331] linearizableReadLoop","detail":"{readStateIndex:4345; appliedIndex:4341; }","duration":"194.736211ms","start":"2026-04-10T13:56:38.728089Z","end":"2026-04-10T13:56:38.922825Z","steps":["trace[458369331] 'read index received' (duration: 182.36053ms)","trace[458369331] 'applied index is now lower than readState.Index' (duration: 12.374681ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T13:56:38.922887Z","caller":"traceutil/trace.go:171","msg":"trace[1416969828] transaction","detail":"{read_only:false; response_revision:4159; number_of_response:1; }","duration":"210.000337ms","start":"2026-04-10T13:56:38.712881Z","end":"2026-04-10T13:56:38.922881Z","steps":["trace[1416969828] 'process raft request' (duration: 209.607767ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T13:56:38.923185Z","caller":"traceutil/trace.go:171","msg":"trace[1210665924] transaction","detail":"{read_only:false; response_revision:4160; number_of_response:1; }","duration":"209.38191ms","start":"2026-04-10T13:56:38.713784Z","end":"2026-04-10T13:56:38.923166Z","steps":["trace[1210665924] 'process raft request' (duration: 208.912308ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T13:56:38.923447Z","caller":"traceutil/trace.go:171","msg":"trace[2009238675] transaction","detail":"{read_only:false; response_revision:4161; number_of_response:1; }","duration":"132.294476ms","start":"2026-04-10T13:56:38.791144Z","end":"2026-04-10T13:56:38.923439Z","steps":["trace[2009238675] 'process raft request' (duration: 131.593679ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:56:38.923293Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.194222ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/grafana-tls-2czqd\" ","response":"range_response_count:1 size:2444"} {"level":"info","ts":"2026-04-10T13:56:38.925416Z","caller":"traceutil/trace.go:171","msg":"trace[151725122] range","detail":"{range_begin:/registry/secrets/monitoring/grafana-tls-2czqd; range_end:; response_count:1; response_revision:4162; }","duration":"197.345036ms","start":"2026-04-10T13:56:38.72806Z","end":"2026-04-10T13:56:38.925405Z","steps":["trace[151725122] 'agreement among raft nodes before linearized reading' (duration: 195.149751ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T13:56:44.850798Z","caller":"traceutil/trace.go:171","msg":"trace[1883032194] linearizableReadLoop","detail":"{readStateIndex:4460; appliedIndex:4459; }","duration":"279.514825ms","start":"2026-04-10T13:56:44.571246Z","end":"2026-04-10T13:56:44.850761Z","steps":["trace[1883032194] 'read index received' (duration: 279.221068ms)","trace[1883032194] 'applied index is now lower than readState.Index' (duration: 292.227µs)"],"step_count":2} {"level":"info","ts":"2026-04-10T13:56:44.851204Z","caller":"traceutil/trace.go:171","msg":"trace[8577848] transaction","detail":"{read_only:false; response_revision:4272; number_of_response:1; }","duration":"319.529045ms","start":"2026-04-10T13:56:44.531661Z","end":"2026-04-10T13:56:44.85119Z","steps":["trace[8577848] 'process raft request' (duration: 318.913289ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:56:44.851306Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:56:44.531632Z","time spent":"319.613247ms","remote":"127.0.0.1:33322","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":238919,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-10T13:56:44.851567Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.323495ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:645"} {"level":"info","ts":"2026-04-10T13:56:44.851597Z","caller":"traceutil/trace.go:171","msg":"trace[905944488] range","detail":"{range_begin:/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4272; }","duration":"280.397707ms","start":"2026-04-10T13:56:44.571192Z","end":"2026-04-10T13:56:44.85159Z","steps":["trace[905944488] 'agreement among raft nodes before linearized reading' (duration: 280.262394ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T13:56:44.853194Z","caller":"traceutil/trace.go:171","msg":"trace[538119853] transaction","detail":"{read_only:false; response_revision:4273; number_of_response:1; }","duration":"217.950315ms","start":"2026-04-10T13:56:44.63523Z","end":"2026-04-10T13:56:44.85318Z","steps":["trace[538119853] 'process raft request' (duration: 217.728439ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:56:44.853386Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.270335ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:660"} {"level":"info","ts":"2026-04-10T13:56:44.853406Z","caller":"traceutil/trace.go:171","msg":"trace[1889250035] range","detail":"{range_begin:/registry/configmaps/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:4273; }","duration":"206.319507ms","start":"2026-04-10T13:56:44.647079Z","end":"2026-04-10T13:56:44.853399Z","steps":["trace[1889250035] 'agreement among raft nodes before linearized reading' (duration: 206.233065ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:56:44.853718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.325369ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:18 size:523232"} {"level":"info","ts":"2026-04-10T13:56:44.853733Z","caller":"traceutil/trace.go:171","msg":"trace[809074259] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:18; response_revision:4273; }","duration":"217.38049ms","start":"2026-04-10T13:56:44.636348Z","end":"2026-04-10T13:56:44.853729Z","steps":["trace[809074259] 'agreement among raft nodes before linearized reading' (duration: 217.126124ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T13:56:45.596883Z","caller":"traceutil/trace.go:171","msg":"trace[1951669707] linearizableReadLoop","detail":"{readStateIndex:4498; appliedIndex:4497; }","duration":"178.203987ms","start":"2026-04-10T13:56:45.418655Z","end":"2026-04-10T13:56:45.596859Z","steps":["trace[1951669707] 'read index received' (duration: 177.92023ms)","trace[1951669707] 'applied index is now lower than readState.Index' (duration: 282.637µs)"],"step_count":2} {"level":"warn","ts":"2026-04-10T13:56:45.597075Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.410183ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.227\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-10T13:56:45.597112Z","caller":"traceutil/trace.go:171","msg":"trace[1516909218] range","detail":"{range_begin:/registry/masterleases/199.204.45.227; range_end:; response_count:1; response_revision:4310; }","duration":"178.504715ms","start":"2026-04-10T13:56:45.418597Z","end":"2026-04-10T13:56:45.597101Z","steps":["trace[1516909218] 'agreement among raft nodes before linearized reading' (duration: 178.348981ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T13:56:45.596959Z","caller":"traceutil/trace.go:171","msg":"trace[2128003667] transaction","detail":"{read_only:false; response_revision:4310; number_of_response:1; }","duration":"206.339401ms","start":"2026-04-10T13:56:45.390577Z","end":"2026-04-10T13:56:45.596916Z","steps":["trace[2128003667] 'process raft request' (duration: 206.133526ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T13:56:49.134754Z","caller":"traceutil/trace.go:171","msg":"trace[2056715396] transaction","detail":"{read_only:false; response_revision:4388; number_of_response:1; }","duration":"235.15808ms","start":"2026-04-10T13:56:48.899572Z","end":"2026-04-10T13:56:49.13473Z","steps":["trace[2056715396] 'process raft request' (duration: 235.012997ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T13:56:49.180025Z","caller":"traceutil/trace.go:171","msg":"trace[293542592] linearizableReadLoop","detail":"{readStateIndex:4581; appliedIndex:4579; }","duration":"221.250228ms","start":"2026-04-10T13:56:48.958749Z","end":"2026-04-10T13:56:49.18Z","steps":["trace[293542592] 'read index received' (duration: 175.872686ms)","trace[293542592] 'applied index is now lower than readState.Index' (duration: 45.376572ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T13:56:49.180708Z","caller":"traceutil/trace.go:171","msg":"trace[71951205] transaction","detail":"{read_only:false; response_revision:4389; number_of_response:1; }","duration":"274.27114ms","start":"2026-04-10T13:56:48.906413Z","end":"2026-04-10T13:56:49.180684Z","steps":["trace[71951205] 'process raft request' (duration: 272.354494ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:56:49.180904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.113568ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:660"} {"level":"info","ts":"2026-04-10T13:56:49.181015Z","caller":"traceutil/trace.go:171","msg":"trace[1370529652] range","detail":"{range_begin:/registry/configmaps/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:4389; }","duration":"222.287583ms","start":"2026-04-10T13:56:48.958703Z","end":"2026-04-10T13:56:49.180991Z","steps":["trace[1370529652] 'agreement among raft nodes before linearized reading' (duration: 221.977805ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:56:49.184244Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.447739ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:645"} {"level":"info","ts":"2026-04-10T13:56:49.184325Z","caller":"traceutil/trace.go:171","msg":"trace[21524271] range","detail":"{range_begin:/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4389; }","duration":"225.568852ms","start":"2026-04-10T13:56:48.958735Z","end":"2026-04-10T13:56:49.184304Z","steps":["trace[21524271] 'agreement among raft nodes before linearized reading' (duration: 221.416492ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T13:56:54.493688Z","caller":"traceutil/trace.go:171","msg":"trace[603096228] transaction","detail":"{read_only:false; response_revision:4519; number_of_response:1; }","duration":"137.781673ms","start":"2026-04-10T13:56:54.355869Z","end":"2026-04-10T13:56:54.493651Z","steps":["trace[603096228] 'process raft request' (duration: 59.435371ms)","trace[603096228] 'compare' (duration: 78.145606ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T13:56:55.084152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.318341ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"} {"level":"info","ts":"2026-04-10T13:56:55.084247Z","caller":"traceutil/trace.go:171","msg":"trace[875728971] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4519; }","duration":"108.422994ms","start":"2026-04-10T13:56:54.975801Z","end":"2026-04-10T13:56:55.084224Z","steps":["trace[875728971] 'range keys from in-memory index tree' (duration: 108.158997ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:56:55.084245Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.01666ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-grafana-694dcfff4c-kmsv7.18a5037179208c88\" ","response":"range_response_count:1 size:896"} {"level":"warn","ts":"2026-04-10T13:56:55.084267Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.967807ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T13:56:55.084354Z","caller":"traceutil/trace.go:171","msg":"trace[2100257099] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-grafana-694dcfff4c-kmsv7.18a5037179208c88; range_end:; response_count:1; response_revision:4519; }","duration":"107.184614ms","start":"2026-04-10T13:56:54.977141Z","end":"2026-04-10T13:56:55.084326Z","steps":["trace[2100257099] 'range keys from in-memory index tree' (duration: 106.786575ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T13:56:55.084361Z","caller":"traceutil/trace.go:171","msg":"trace[20374626] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4519; }","duration":"145.105789ms","start":"2026-04-10T13:56:54.93923Z","end":"2026-04-10T13:56:55.084336Z","steps":["trace[20374626] 'range keys from in-memory index tree' (duration: 144.880155ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:56:55.084581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.79269ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:12975"} {"level":"info","ts":"2026-04-10T13:56:55.084686Z","caller":"traceutil/trace.go:171","msg":"trace[142670460] range","detail":"{range_begin:/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4519; }","duration":"110.935945ms","start":"2026-04-10T13:56:54.973721Z","end":"2026-04-10T13:56:55.084657Z","steps":["trace[142670460] 'range keys from in-memory index tree' (duration: 110.502884ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T13:56:55.282241Z","caller":"traceutil/trace.go:171","msg":"trace[2139458137] linearizableReadLoop","detail":"{readStateIndex:4715; appliedIndex:4714; }","duration":"188.367695ms","start":"2026-04-10T13:56:55.093835Z","end":"2026-04-10T13:56:55.282202Z","steps":["trace[2139458137] 'read index received' (duration: 188.196811ms)","trace[2139458137] 'applied index is now lower than readState.Index' (duration: 169.414µs)"],"step_count":2} {"level":"info","ts":"2026-04-10T13:56:55.282284Z","caller":"traceutil/trace.go:171","msg":"trace[2084847080] transaction","detail":"{read_only:false; response_revision:4520; number_of_response:1; }","duration":"189.412271ms","start":"2026-04-10T13:56:55.092825Z","end":"2026-04-10T13:56:55.282238Z","steps":["trace[2084847080] 'process raft request' (duration: 189.148725ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:56:55.282612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.679844ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-606ad3b5-4a90-4241-99d3-71248776c0b3\" ","response":"range_response_count:1 size:1450"} {"level":"info","ts":"2026-04-10T13:56:55.282669Z","caller":"traceutil/trace.go:171","msg":"trace[699341403] range","detail":"{range_begin:/registry/persistentvolumes/pvc-606ad3b5-4a90-4241-99d3-71248776c0b3; range_end:; response_count:1; response_revision:4520; }","duration":"188.859167ms","start":"2026-04-10T13:56:55.093793Z","end":"2026-04-10T13:56:55.282652Z","steps":["trace[699341403] 'agreement among raft nodes before linearized reading' (duration: 188.55309ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T13:56:55.373294Z","caller":"traceutil/trace.go:171","msg":"trace[826953101] transaction","detail":"{read_only:false; response_revision:4521; number_of_response:1; }","duration":"271.455136ms","start":"2026-04-10T13:56:55.101806Z","end":"2026-04-10T13:56:55.373261Z","steps":["trace[826953101] 'process raft request' (duration: 254.702457ms)","trace[826953101] 'compare' (duration: 16.470301ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T13:56:55.373327Z","caller":"traceutil/trace.go:171","msg":"trace[107438639] transaction","detail":"{read_only:false; response_revision:4522; number_of_response:1; }","duration":"153.282692ms","start":"2026-04-10T13:56:55.219975Z","end":"2026-04-10T13:56:55.373257Z","steps":["trace[107438639] 'process raft request' (duration: 153.142087ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:56:55.373693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.170697ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:645"} {"level":"info","ts":"2026-04-10T13:56:55.373783Z","caller":"traceutil/trace.go:171","msg":"trace[268233699] range","detail":"{range_begin:/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4522; }","duration":"108.338821ms","start":"2026-04-10T13:56:55.265425Z","end":"2026-04-10T13:56:55.373763Z","steps":["trace[268233699] 'agreement among raft nodes before linearized reading' (duration: 108.177547ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:56:55.373945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.740008ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T13:56:55.37408Z","caller":"traceutil/trace.go:171","msg":"trace[559825728] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4522; }","duration":"199.938652ms","start":"2026-04-10T13:56:55.174116Z","end":"2026-04-10T13:56:55.374054Z","steps":["trace[559825728] 'agreement among raft nodes before linearized reading' (duration: 199.735008ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:56:55.567687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.342399ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:3198"} {"level":"info","ts":"2026-04-10T13:56:55.56778Z","caller":"traceutil/trace.go:171","msg":"trace[600002040] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:4529; }","duration":"105.493053ms","start":"2026-04-10T13:56:55.462263Z","end":"2026-04-10T13:56:55.567756Z","steps":["trace[600002040] 'agreement among raft nodes before linearized reading' (duration: 105.265717ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T13:56:55.567761Z","caller":"traceutil/trace.go:171","msg":"trace[356759363] transaction","detail":"{read_only:false; response_revision:4529; number_of_response:1; }","duration":"127.132678ms","start":"2026-04-10T13:56:55.440584Z","end":"2026-04-10T13:56:55.567716Z","steps":["trace[356759363] 'process raft request' (duration: 109.235692ms)","trace[356759363] 'compare' (duration: 17.400804ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T13:56:55.56792Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.099975ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:552"} {"level":"info","ts":"2026-04-10T13:56:55.567993Z","caller":"traceutil/trace.go:171","msg":"trace[338213618] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4529; }","duration":"129.229348ms","start":"2026-04-10T13:56:55.438743Z","end":"2026-04-10T13:56:55.567973Z","steps":["trace[338213618] 'agreement among raft nodes before linearized reading' (duration: 129.034273ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T13:56:55.628004Z","caller":"traceutil/trace.go:171","msg":"trace[1670278746] transaction","detail":"{read_only:false; response_revision:4530; number_of_response:1; }","duration":"107.222193ms","start":"2026-04-10T13:56:55.520746Z","end":"2026-04-10T13:56:55.627968Z","steps":["trace[1670278746] 'process raft request' (duration: 107.010118ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:56:55.628264Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.661481ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-6663a060-6377-468c-b5a3-b2a692407017\" ","response":"range_response_count:1 size:3763"} {"level":"info","ts":"2026-04-10T13:56:55.628405Z","caller":"traceutil/trace.go:171","msg":"trace[631812169] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-6663a060-6377-468c-b5a3-b2a692407017; range_end:; response_count:1; response_revision:4530; }","duration":"122.805595ms","start":"2026-04-10T13:56:55.50553Z","end":"2026-04-10T13:56:55.628335Z","steps":["trace[631812169] 'agreement among raft nodes before linearized reading' (duration: 122.530357ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:56:56.288682Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.157868ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-10T13:56:56.289012Z","caller":"traceutil/trace.go:171","msg":"trace[1774279295] transaction","detail":"{read_only:false; response_revision:4532; number_of_response:1; }","duration":"656.990486ms","start":"2026-04-10T13:56:55.631944Z","end":"2026-04-10T13:56:56.288935Z","steps":["trace[1774279295] 'process raft request' (duration: 486.446408ms)","trace[1774279295] 'compare' (duration: 169.834371ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T13:56:56.289083Z","caller":"traceutil/trace.go:171","msg":"trace[1046538429] transaction","detail":"{read_only:false; response_revision:4534; number_of_response:1; }","duration":"174.089252ms","start":"2026-04-10T13:56:56.114969Z","end":"2026-04-10T13:56:56.289058Z","steps":["trace[1046538429] 'process raft request' (duration: 173.98101ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:56:56.289226Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:56:55.631911Z","time spent":"657.23143ms","remote":"127.0.0.1:33246","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T13:56:56.289017Z","caller":"traceutil/trace.go:171","msg":"trace[965699916] linearizableReadLoop","detail":"{readStateIndex:4728; appliedIndex:4727; }","duration":"646.228229ms","start":"2026-04-10T13:56:55.642754Z","end":"2026-04-10T13:56:56.288982Z","steps":["trace[965699916] 'read index received' (duration: 475.61476ms)","trace[965699916] 'applied index is now lower than readState.Index' (duration: 170.610009ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T13:56:56.289401Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"646.619399ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/rabbitmq-keystone.18a503715c4644c8\" ","response":"range_response_count:1 size:694"} {"level":"info","ts":"2026-04-10T13:56:56.289482Z","caller":"traceutil/trace.go:171","msg":"trace[709707762] range","detail":"{range_begin:/registry/events/openstack/rabbitmq-keystone.18a503715c4644c8; range_end:; response_count:1; response_revision:4534; }","duration":"646.725782ms","start":"2026-04-10T13:56:55.642735Z","end":"2026-04-10T13:56:56.289461Z","steps":["trace[709707762] 'agreement among raft nodes before linearized reading' (duration: 646.349422ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:56:56.289537Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:56:55.642721Z","time spent":"646.803343ms","remote":"127.0.0.1:33282","response type":"/etcdserverpb.KV/Range","request count":0,"request size":63,"response count":1,"response size":717,"request content":"key:\"/registry/events/openstack/rabbitmq-keystone.18a503715c4644c8\" "} {"level":"info","ts":"2026-04-10T13:56:56.289417Z","caller":"traceutil/trace.go:171","msg":"trace[1578233000] transaction","detail":"{read_only:false; response_revision:4533; number_of_response:1; }","duration":"646.371083ms","start":"2026-04-10T13:56:55.64303Z","end":"2026-04-10T13:56:56.289401Z","steps":["trace[1578233000] 'process raft request' (duration: 645.792369ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:56:56.289791Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"390.428258ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/08db1feb.percona.com\" ","response":"range_response_count:1 size:526"} {"level":"warn","ts":"2026-04-10T13:56:56.289827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"353.174799ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-04-10T13:56:56.289864Z","caller":"traceutil/trace.go:171","msg":"trace[1889691716] range","detail":"{range_begin:/registry/leases/openstack/08db1feb.percona.com; range_end:; response_count:1; response_revision:4534; }","duration":"390.560941ms","start":"2026-04-10T13:56:55.899285Z","end":"2026-04-10T13:56:56.289846Z","steps":["trace[1889691716] 'agreement among raft nodes before linearized reading' (duration: 390.357346ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T13:56:56.289877Z","caller":"traceutil/trace.go:171","msg":"trace[1515554104] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4534; }","duration":"353.246891ms","start":"2026-04-10T13:56:55.936615Z","end":"2026-04-10T13:56:56.289862Z","steps":["trace[1515554104] 'agreement among raft nodes before linearized reading' (duration: 353.113298ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:56:56.289912Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:56:55.899263Z","time spent":"390.639712ms","remote":"127.0.0.1:33494","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":549,"request content":"key:\"/registry/leases/openstack/08db1feb.percona.com\" "} {"level":"warn","ts":"2026-04-10T13:56:56.289919Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:56:55.936599Z","time spent":"353.310392ms","remote":"127.0.0.1:33494","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-10T13:56:56.289939Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"388.572283ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-04-10T13:56:56.290048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.61199ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-10T13:56:56.290077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"398.1394ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-04-10T13:56:56.290094Z","caller":"traceutil/trace.go:171","msg":"trace[1892897487] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4534; }","duration":"114.705003ms","start":"2026-04-10T13:56:56.175378Z","end":"2026-04-10T13:56:56.290083Z","steps":["trace[1892897487] 'agreement among raft nodes before linearized reading' (duration: 114.638852ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T13:56:56.290108Z","caller":"traceutil/trace.go:171","msg":"trace[1985176076] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4534; }","duration":"398.188552ms","start":"2026-04-10T13:56:55.89191Z","end":"2026-04-10T13:56:56.290098Z","steps":["trace[1985176076] 'agreement among raft nodes before linearized reading' (duration: 398.10142ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:56:56.290107Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.278344ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"} {"level":"warn","ts":"2026-04-10T13:56:56.290138Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:56:55.891898Z","time spent":"398.234333ms","remote":"127.0.0.1:33494","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-10T13:56:56.290162Z","caller":"traceutil/trace.go:171","msg":"trace[1379849428] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4534; }","duration":"293.403286ms","start":"2026-04-10T13:56:55.99674Z","end":"2026-04-10T13:56:56.290144Z","steps":["trace[1379849428] 'agreement among raft nodes before linearized reading' (duration: 293.258122ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:56:56.290095Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:56:55.643017Z","time spent":"646.762692ms","remote":"127.0.0.1:33494","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":552,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-10T13:56:56.290292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"415.188386ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-10T13:56:56.290325Z","caller":"traceutil/trace.go:171","msg":"trace[1588434425] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4534; }","duration":"415.245358ms","start":"2026-04-10T13:56:55.875071Z","end":"2026-04-10T13:56:56.290317Z","steps":["trace[1588434425] 'agreement among raft nodes before linearized reading' (duration: 415.162096ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:56:56.289821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.702853ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"warn","ts":"2026-04-10T13:56:56.29035Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:56:55.875057Z","time spent":"415.287479ms","remote":"127.0.0.1:33494","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":"info","ts":"2026-04-10T13:56:56.290053Z","caller":"traceutil/trace.go:171","msg":"trace[1876250406] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4534; }","duration":"388.743007ms","start":"2026-04-10T13:56:55.901297Z","end":"2026-04-10T13:56:56.29004Z","steps":["trace[1876250406] 'agreement among raft nodes before linearized reading' (duration: 388.472121ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T13:56:56.290387Z","caller":"traceutil/trace.go:171","msg":"trace[372280560] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4534; }","duration":"341.293837ms","start":"2026-04-10T13:56:55.949079Z","end":"2026-04-10T13:56:56.290372Z","steps":["trace[372280560] 'agreement among raft nodes before linearized reading' (duration: 340.5536ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:56:56.290461Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:56:55.901286Z","time spent":"389.167147ms","remote":"127.0.0.1:33494","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-10T13:56:56.290497Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:56:55.949069Z","time spent":"341.40865ms","remote":"127.0.0.1:33494","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-10T13:56:56.290207Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.649382ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-grafana-694dcfff4c-kmsv7.18a5037179208c88\" ","response":"range_response_count:1 size:896"} {"level":"info","ts":"2026-04-10T13:56:56.290551Z","caller":"traceutil/trace.go:171","msg":"trace[389462920] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-grafana-694dcfff4c-kmsv7.18a5037179208c88; range_end:; response_count:1; response_revision:4534; }","duration":"307.084322ms","start":"2026-04-10T13:56:55.983453Z","end":"2026-04-10T13:56:56.290538Z","steps":["trace[389462920] 'agreement among raft nodes before linearized reading' (duration: 306.632021ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:56:56.290584Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:56:55.983416Z","time spent":"307.160414ms","remote":"127.0.0.1:33282","response type":"/etcdserverpb.KV/Range","request count":0,"request size":93,"response count":1,"response size":919,"request content":"key:\"/registry/events/monitoring/kube-prometheus-stack-grafana-694dcfff4c-kmsv7.18a5037179208c88\" "} {"level":"warn","ts":"2026-04-10T13:56:56.290807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"647.97439ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/openstack/rabbitmq-keystone-server\" ","response":"range_response_count:1 size:9761"} {"level":"info","ts":"2026-04-10T13:56:56.290864Z","caller":"traceutil/trace.go:171","msg":"trace[1134854402] range","detail":"{range_begin:/registry/statefulsets/openstack/rabbitmq-keystone-server; range_end:; response_count:1; response_revision:4534; }","duration":"648.082693ms","start":"2026-04-10T13:56:55.642767Z","end":"2026-04-10T13:56:56.29085Z","steps":["trace[1134854402] 'agreement among raft nodes before linearized reading' (duration: 646.807954ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:56:56.290904Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:56:55.642747Z","time spent":"648.146594ms","remote":"127.0.0.1:33680","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":9784,"request content":"key:\"/registry/statefulsets/openstack/rabbitmq-keystone-server\" "} {"level":"warn","ts":"2026-04-10T13:56:56.594308Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.834358ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-10T13:56:56.59476Z","caller":"traceutil/trace.go:171","msg":"trace[94323323] transaction","detail":"{read_only:false; response_revision:4538; number_of_response:1; }","duration":"296.961009ms","start":"2026-04-10T13:56:56.297776Z","end":"2026-04-10T13:56:56.594737Z","steps":["trace[94323323] 'process raft request' (duration: 296.807416ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T13:56:56.595041Z","caller":"traceutil/trace.go:171","msg":"trace[393365715] transaction","detail":"{read_only:false; response_revision:4537; number_of_response:1; }","duration":"297.262167ms","start":"2026-04-10T13:56:56.297767Z","end":"2026-04-10T13:56:56.595029Z","steps":["trace[393365715] 'process raft request' (duration: 296.768315ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T13:56:56.595057Z","caller":"traceutil/trace.go:171","msg":"trace[783638000] transaction","detail":"{read_only:false; response_revision:4539; number_of_response:1; }","duration":"297.204765ms","start":"2026-04-10T13:56:56.297827Z","end":"2026-04-10T13:56:56.595032Z","steps":["trace[783638000] 'process raft request' (duration: 296.791505ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T13:56:56.595137Z","caller":"traceutil/trace.go:171","msg":"trace[1918497255] linearizableReadLoop","detail":"{readStateIndex:4731; appliedIndex:4730; }","duration":"301.1527ms","start":"2026-04-10T13:56:56.29377Z","end":"2026-04-10T13:56:56.594923Z","steps":["trace[1918497255] 'read index received' (duration: 131.590194ms)","trace[1918497255] 'applied index is now lower than readState.Index' (duration: 169.560846ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T13:56:56.595335Z","caller":"traceutil/trace.go:171","msg":"trace[1376236418] transaction","detail":"{read_only:false; response_revision:4536; number_of_response:1; }","duration":"300.657819ms","start":"2026-04-10T13:56:56.294661Z","end":"2026-04-10T13:56:56.595319Z","steps":["trace[1376236418] 'process raft request' (duration: 299.804898ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:56:56.595525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.748004ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:422"} {"level":"info","ts":"2026-04-10T13:56:56.595574Z","caller":"traceutil/trace.go:171","msg":"trace[1345416117] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:4540; }","duration":"301.827796ms","start":"2026-04-10T13:56:56.293735Z","end":"2026-04-10T13:56:56.595563Z","steps":["trace[1345416117] 'agreement among raft nodes before linearized reading' (duration: 301.740474ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:56:56.595605Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:56:56.293719Z","time spent":"301.878237ms","remote":"127.0.0.1:33400","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":445,"request content":"key:\"/registry/services/endpoints/default/kubernetes\" "} {"level":"warn","ts":"2026-04-10T13:56:56.595486Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:56:56.294644Z","time spent":"300.755431ms","remote":"127.0.0.1:33282","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":881,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T13:56:56.595838Z","caller":"traceutil/trace.go:171","msg":"trace[499019212] transaction","detail":"{read_only:false; response_revision:4540; number_of_response:1; }","duration":"297.972394ms","start":"2026-04-10T13:56:56.29785Z","end":"2026-04-10T13:56:56.595822Z","steps":["trace[499019212] 'process raft request' (duration: 296.796266ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:56:56.596093Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.706555ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-606ad3b5-4a90-4241-99d3-71248776c0b3\" ","response":"range_response_count:1 size:1450"} {"level":"info","ts":"2026-04-10T13:56:56.596142Z","caller":"traceutil/trace.go:171","msg":"trace[700920477] range","detail":"{range_begin:/registry/persistentvolumes/pvc-606ad3b5-4a90-4241-99d3-71248776c0b3; range_end:; response_count:1; response_revision:4542; }","duration":"299.794107ms","start":"2026-04-10T13:56:56.296334Z","end":"2026-04-10T13:56:56.596129Z","steps":["trace[700920477] 'agreement among raft nodes before linearized reading' (duration: 299.600642ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T13:56:56.596345Z","caller":"traceutil/trace.go:171","msg":"trace[1886984655] transaction","detail":"{read_only:false; response_revision:4542; number_of_response:1; }","duration":"294.819968ms","start":"2026-04-10T13:56:56.301507Z","end":"2026-04-10T13:56:56.596327Z","steps":["trace[1886984655] 'process raft request' (duration: 294.387118ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:56:56.596396Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.914607ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1451"} {"level":"info","ts":"2026-04-10T13:56:56.596438Z","caller":"traceutil/trace.go:171","msg":"trace[358437838] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4542; }","duration":"298.976608ms","start":"2026-04-10T13:56:56.29745Z","end":"2026-04-10T13:56:56.596427Z","steps":["trace[358437838] 'agreement among raft nodes before linearized reading' (duration: 298.888266ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T13:56:56.596587Z","caller":"traceutil/trace.go:171","msg":"trace[1298864164] transaction","detail":"{read_only:false; response_revision:4541; number_of_response:1; }","duration":"298.312021ms","start":"2026-04-10T13:56:56.298262Z","end":"2026-04-10T13:56:56.596574Z","steps":["trace[1298864164] 'process raft request' (duration: 296.411457ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T13:56:56.594543Z","caller":"traceutil/trace.go:171","msg":"trace[1608618965] transaction","detail":"{read_only:false; response_revision:4535; number_of_response:1; }","duration":"301.326243ms","start":"2026-04-10T13:56:56.293183Z","end":"2026-04-10T13:56:56.594509Z","steps":["trace[1608618965] 'process raft request' (duration: 132.193398ms)","trace[1608618965] 'compare' (duration: 168.704215ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T13:56:56.597443Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:56:56.293158Z","time spent":"304.232163ms","remote":"127.0.0.1:33282","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":679,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T13:56:56.930653Z","caller":"traceutil/trace.go:171","msg":"trace[489353800] linearizableReadLoop","detail":"{readStateIndex:4739; appliedIndex:4738; }","duration":"329.526492ms","start":"2026-04-10T13:56:56.601097Z","end":"2026-04-10T13:56:56.930624Z","steps":["trace[489353800] 'read index received' (duration: 329.339228ms)","trace[489353800] 'applied index is now lower than readState.Index' (duration: 185.564µs)"],"step_count":2} {"level":"info","ts":"2026-04-10T13:56:56.930696Z","caller":"traceutil/trace.go:171","msg":"trace[1238881100] transaction","detail":"{read_only:false; response_revision:4543; number_of_response:1; }","duration":"329.979693ms","start":"2026-04-10T13:56:56.600673Z","end":"2026-04-10T13:56:56.930652Z","steps":["trace[1238881100] 'process raft request' (duration: 329.764908ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:56:56.930914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.792139ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-04-10T13:56:56.931018Z","caller":"traceutil/trace.go:171","msg":"trace[1259110000] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:4543; }","duration":"329.894642ms","start":"2026-04-10T13:56:56.601058Z","end":"2026-04-10T13:56:56.930953Z","steps":["trace[1259110000] 'agreement among raft nodes before linearized reading' (duration: 329.726208ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:56:56.931103Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:56:56.601042Z","time spent":"330.017014ms","remote":"127.0.0.1:33510","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":504,"request content":"key:\"/registry/endpointslices/default/kubernetes\" "} {"level":"warn","ts":"2026-04-10T13:56:56.931114Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:56:56.600656Z","time spent":"330.107896ms","remote":"127.0.0.1:33282","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":924,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-10T13:56:57.099805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.304488ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T13:56:57.099898Z","caller":"traceutil/trace.go:171","msg":"trace[1934703806] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:4543; }","duration":"184.475633ms","start":"2026-04-10T13:56:56.915401Z","end":"2026-04-10T13:56:57.099876Z","steps":["trace[1934703806] 'count revisions from in-memory index tree' (duration: 168.713188ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:56:57.100052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"465.738289ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-6663a060-6377-468c-b5a3-b2a692407017\" ","response":"range_response_count:1 size:3763"} {"level":"info","ts":"2026-04-10T13:56:57.100151Z","caller":"traceutil/trace.go:171","msg":"trace[1533591746] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-6663a060-6377-468c-b5a3-b2a692407017; range_end:; response_count:1; response_revision:4543; }","duration":"465.902012ms","start":"2026-04-10T13:56:56.634226Z","end":"2026-04-10T13:56:57.100128Z","steps":["trace[1533591746] 'agreement among raft nodes before linearized reading' (duration: 296.798806ms)","trace[1533591746] 'range keys from in-memory index tree' (duration: 168.82463ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T13:56:57.100221Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:56:56.634214Z","time spent":"465.996214ms","remote":"127.0.0.1:33424","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3786,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-6663a060-6377-468c-b5a3-b2a692407017\" "} {"level":"warn","ts":"2026-04-10T13:56:57.100141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"492.118086ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/openstack/rabbitmq-keystone-server\" ","response":"range_response_count:1 size:9761"} {"level":"info","ts":"2026-04-10T13:56:57.100449Z","caller":"traceutil/trace.go:171","msg":"trace[2121758774] range","detail":"{range_begin:/registry/statefulsets/openstack/rabbitmq-keystone-server; range_end:; response_count:1; response_revision:4543; }","duration":"492.452003ms","start":"2026-04-10T13:56:56.607973Z","end":"2026-04-10T13:56:57.100425Z","steps":["trace[2121758774] 'agreement among raft nodes before linearized reading' (duration: 323.017019ms)","trace[2121758774] 'range keys from in-memory index tree' (duration: 168.976564ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T13:56:57.100599Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:56:56.607962Z","time spent":"492.618747ms","remote":"127.0.0.1:33680","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":9784,"request content":"key:\"/registry/statefulsets/openstack/rabbitmq-keystone-server\" "} {"level":"warn","ts":"2026-04-10T13:56:59.23762Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.029091ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-6663a060-6377-468c-b5a3-b2a692407017\" ","response":"range_response_count:1 size:3949"} {"level":"info","ts":"2026-04-10T13:56:59.237706Z","caller":"traceutil/trace.go:171","msg":"trace[1821294854] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-6663a060-6377-468c-b5a3-b2a692407017; range_end:; response_count:1; response_revision:4570; }","duration":"128.130313ms","start":"2026-04-10T13:56:59.109555Z","end":"2026-04-10T13:56:59.237686Z","steps":["trace[1821294854] 'range keys from in-memory index tree' (duration: 127.860657ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T13:57:00.57447Z","caller":"traceutil/trace.go:171","msg":"trace[86088984] linearizableReadLoop","detail":"{readStateIndex:4779; appliedIndex:4778; }","duration":"259.301397ms","start":"2026-04-10T13:57:00.315146Z","end":"2026-04-10T13:57:00.574448Z","steps":["trace[86088984] 'read index received' (duration: 259.182385ms)","trace[86088984] 'applied index is now lower than readState.Index' (duration: 117.912µs)"],"step_count":2} {"level":"info","ts":"2026-04-10T13:57:00.57459Z","caller":"traceutil/trace.go:171","msg":"trace[1057482826] transaction","detail":"{read_only:false; response_revision:4582; number_of_response:1; }","duration":"327.343782ms","start":"2026-04-10T13:57:00.247236Z","end":"2026-04-10T13:57:00.57458Z","steps":["trace[1057482826] 'process raft request' (duration: 327.002625ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:57:00.574698Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:57:00.247216Z","time spent":"327.399473ms","remote":"127.0.0.1:33424","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3948,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-10T13:57:00.574922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.759778ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:660"} {"level":"info","ts":"2026-04-10T13:57:00.575006Z","caller":"traceutil/trace.go:171","msg":"trace[394500831] range","detail":"{range_begin:/registry/configmaps/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:4582; }","duration":"259.8602ms","start":"2026-04-10T13:57:00.315123Z","end":"2026-04-10T13:57:00.574983Z","steps":["trace[394500831] 'agreement among raft nodes before linearized reading' (duration: 259.666595ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:57:00.575476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.863143ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-10T13:57:00.575517Z","caller":"traceutil/trace.go:171","msg":"trace[973743869] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:4583; }","duration":"239.951055ms","start":"2026-04-10T13:57:00.335557Z","end":"2026-04-10T13:57:00.575508Z","steps":["trace[973743869] 'agreement among raft nodes before linearized reading' (duration: 239.838202ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T13:57:00.575646Z","caller":"traceutil/trace.go:171","msg":"trace[902082565] transaction","detail":"{read_only:false; response_revision:4583; number_of_response:1; }","duration":"252.853597ms","start":"2026-04-10T13:57:00.322778Z","end":"2026-04-10T13:57:00.575632Z","steps":["trace[902082565] 'process raft request' (duration: 252.491747ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T13:57:05.843606Z","caller":"traceutil/trace.go:171","msg":"trace[1256204938] transaction","detail":"{read_only:false; response_revision:4676; number_of_response:1; }","duration":"120.117002ms","start":"2026-04-10T13:57:05.723466Z","end":"2026-04-10T13:57:05.843584Z","steps":["trace[1256204938] 'process raft request' (duration: 119.972168ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:57:09.587046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"492.812443ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:10516"} {"level":"info","ts":"2026-04-10T13:57:09.587122Z","caller":"traceutil/trace.go:171","msg":"trace[8701039] range","detail":"{range_begin:/registry/pods/openstack/rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4720; }","duration":"492.940816ms","start":"2026-04-10T13:57:09.094163Z","end":"2026-04-10T13:57:09.587104Z","steps":["trace[8701039] 'range keys from in-memory index tree' (duration: 492.627358ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:57:09.587161Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:57:09.094141Z","time spent":"493.011207ms","remote":"127.0.0.1:33424","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":1,"response size":10539,"request content":"key:\"/registry/pods/openstack/rabbitmq-keystone-server-0\" "} {"level":"warn","ts":"2026-04-10T13:57:09.587393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"467.074946ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-04-10T13:57:09.587422Z","caller":"traceutil/trace.go:171","msg":"trace[377062389] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4720; }","duration":"467.101987ms","start":"2026-04-10T13:57:09.12031Z","end":"2026-04-10T13:57:09.587412Z","steps":["trace[377062389] 'range keys from in-memory index tree' (duration: 466.985494ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:57:09.587452Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:57:09.120258Z","time spent":"467.182758ms","remote":"127.0.0.1:33384","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":1,"response size":1888,"request content":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" "} {"level":"warn","ts":"2026-04-10T13:57:09.587461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"591.416301ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-jwn6t.18a503700eaf17ff\" ","response":"range_response_count:1 size:906"} {"level":"info","ts":"2026-04-10T13:57:09.58755Z","caller":"traceutil/trace.go:171","msg":"trace[1437167945] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-jwn6t.18a503700eaf17ff; range_end:; response_count:1; response_revision:4720; }","duration":"591.551084ms","start":"2026-04-10T13:57:08.995978Z","end":"2026-04-10T13:57:09.587529Z","steps":["trace[1437167945] 'range keys from in-memory index tree' (duration: 591.226108ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:57:09.587603Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:57:08.99596Z","time spent":"591.632997ms","remote":"127.0.0.1:33282","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":1,"response size":929,"request content":"key:\"/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-jwn6t.18a503700eaf17ff\" "} {"level":"warn","ts":"2026-04-10T13:57:09.587634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"451.059751ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:11499"} {"level":"info","ts":"2026-04-10T13:57:09.587698Z","caller":"traceutil/trace.go:171","msg":"trace[540808882] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4720; }","duration":"451.148002ms","start":"2026-04-10T13:57:09.136541Z","end":"2026-04-10T13:57:09.587689Z","steps":["trace[540808882] 'range keys from in-memory index tree' (duration: 450.911018ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:57:09.587725Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T13:57:09.13653Z","time spent":"451.187504ms","remote":"127.0.0.1:33424","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":11522,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"info","ts":"2026-04-10T13:57:09.697872Z","caller":"traceutil/trace.go:171","msg":"trace[538103408] linearizableReadLoop","detail":"{readStateIndex:4925; appliedIndex:4924; }","duration":"106.420456ms","start":"2026-04-10T13:57:09.591427Z","end":"2026-04-10T13:57:09.697848Z","steps":["trace[538103408] 'read index received' (duration: 106.313883ms)","trace[538103408] 'applied index is now lower than readState.Index' (duration: 105.453µs)"],"step_count":2} {"level":"info","ts":"2026-04-10T13:57:09.697937Z","caller":"traceutil/trace.go:171","msg":"trace[1381418567] transaction","detail":"{read_only:false; response_revision:4721; number_of_response:1; }","duration":"107.859009ms","start":"2026-04-10T13:57:09.590044Z","end":"2026-04-10T13:57:09.697903Z","steps":["trace[1381418567] 'process raft request' (duration: 107.645594ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:57:09.698135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.682581ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-6663a060-6377-468c-b5a3-b2a692407017\" ","response":"range_response_count:1 size:1322"} {"level":"info","ts":"2026-04-10T13:57:09.698179Z","caller":"traceutil/trace.go:171","msg":"trace[534600475] range","detail":"{range_begin:/registry/persistentvolumes/pvc-6663a060-6377-468c-b5a3-b2a692407017; range_end:; response_count:1; response_revision:4721; }","duration":"106.773384ms","start":"2026-04-10T13:57:09.591396Z","end":"2026-04-10T13:57:09.698169Z","steps":["trace[534600475] 'agreement among raft nodes before linearized reading' (duration: 106.571559ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:57:09.751417Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.511136ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:11499"} {"level":"info","ts":"2026-04-10T13:57:09.75148Z","caller":"traceutil/trace.go:171","msg":"trace[1675774395] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4722; }","duration":"159.589578ms","start":"2026-04-10T13:57:09.591877Z","end":"2026-04-10T13:57:09.751466Z","steps":["trace[1675774395] 'agreement among raft nodes before linearized reading' (duration: 159.412024ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T13:57:09.751526Z","caller":"traceutil/trace.go:171","msg":"trace[1961472535] transaction","detail":"{read_only:false; response_revision:4722; number_of_response:1; }","duration":"153.904688ms","start":"2026-04-10T13:57:09.597593Z","end":"2026-04-10T13:57:09.751498Z","steps":["trace[1961472535] 'process raft request' (duration: 153.599392ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T13:57:10.044845Z","caller":"traceutil/trace.go:171","msg":"trace[1500536668] transaction","detail":"{read_only:false; response_revision:4730; number_of_response:1; }","duration":"102.939013ms","start":"2026-04-10T13:57:09.941888Z","end":"2026-04-10T13:57:10.044827Z","steps":["trace[1500536668] 'process raft request' (duration: 102.643797ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T13:57:10.044867Z","caller":"traceutil/trace.go:171","msg":"trace[354266108] transaction","detail":"{read_only:false; response_revision:4729; number_of_response:1; }","duration":"107.267622ms","start":"2026-04-10T13:57:09.937574Z","end":"2026-04-10T13:57:10.044842Z","steps":["trace[354266108] 'process raft request' (duration: 106.862702ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:57:10.336589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.769246ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T13:57:10.336691Z","caller":"traceutil/trace.go:171","msg":"trace[979090763] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4731; }","duration":"161.92029ms","start":"2026-04-10T13:57:10.174748Z","end":"2026-04-10T13:57:10.336668Z","steps":["trace[979090763] 'range keys from in-memory index tree' (duration: 161.687255ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:57:10.336803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.958432ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-04-10T13:57:10.336871Z","caller":"traceutil/trace.go:171","msg":"trace[425079599] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4731; }","duration":"130.065965ms","start":"2026-04-10T13:57:10.206785Z","end":"2026-04-10T13:57:10.336851Z","steps":["trace[425079599] 'range keys from in-memory index tree' (duration: 129.762858ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T13:57:44.740068Z","caller":"traceutil/trace.go:171","msg":"trace[1763064661] transaction","detail":"{read_only:false; response_revision:5084; number_of_response:1; }","duration":"118.47497ms","start":"2026-04-10T13:57:44.621548Z","end":"2026-04-10T13:57:44.740023Z","steps":["trace[1763064661] 'process raft request' (duration: 107.506053ms)","trace[1763064661] 'compare' (duration: 10.64763ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T13:57:53.32934Z","caller":"traceutil/trace.go:171","msg":"trace[1000116966] linearizableReadLoop","detail":"{readStateIndex:5374; appliedIndex:5373; }","duration":"137.999859ms","start":"2026-04-10T13:57:53.191316Z","end":"2026-04-10T13:57:53.329316Z","steps":["trace[1000116966] 'read index received' (duration: 137.859216ms)","trace[1000116966] 'applied index is now lower than readState.Index' (duration: 139.153µs)"],"step_count":2} {"level":"info","ts":"2026-04-10T13:57:53.329627Z","caller":"traceutil/trace.go:171","msg":"trace[1960747172] transaction","detail":"{read_only:false; response_revision:5151; number_of_response:1; }","duration":"158.3146ms","start":"2026-04-10T13:57:53.171277Z","end":"2026-04-10T13:57:53.329591Z","steps":["trace[1960747172] 'process raft request' (duration: 157.898141ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T13:57:53.329843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.505539ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:3465"} {"level":"info","ts":"2026-04-10T13:57:53.32999Z","caller":"traceutil/trace.go:171","msg":"trace[1376975232] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:5151; }","duration":"138.654742ms","start":"2026-04-10T13:57:53.191257Z","end":"2026-04-10T13:57:53.329912Z","steps":["trace[1376975232] 'agreement among raft nodes before linearized reading' (duration: 138.160272ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T13:58:06.528293Z","caller":"traceutil/trace.go:171","msg":"trace[2085754508] transaction","detail":"{read_only:false; number_of_response:0; response_revision:5261; }","duration":"128.344927ms","start":"2026-04-10T13:58:06.399922Z","end":"2026-04-10T13:58:06.528267Z","steps":["trace[2085754508] 'process raft request' (duration: 36.130689ms)","trace[2085754508] 'compare' (duration: 92.175788ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T14:00:12.454507Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3164} {"level":"info","ts":"2026-04-10T14:00:12.578815Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3164,"took":"122.651341ms","hash":855159333,"current-db-size-bytes":57700352,"current-db-size":"58 MB","current-db-size-in-use-bytes":30978048,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-04-10T14:00:12.578889Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":855159333,"revision":3164,"compact-revision":-1} {"level":"info","ts":"2026-04-10T14:00:53.649974Z","caller":"traceutil/trace.go:171","msg":"trace[1172463793] transaction","detail":"{read_only:false; response_revision:6642; number_of_response:1; }","duration":"145.986681ms","start":"2026-04-10T14:00:53.503934Z","end":"2026-04-10T14:00:53.649921Z","steps":["trace[1172463793] 'process raft request' (duration: 62.185873ms)","trace[1172463793] 'compare' (duration: 83.491434ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T14:00:53.649975Z","caller":"traceutil/trace.go:171","msg":"trace[541424366] transaction","detail":"{read_only:false; response_revision:6643; number_of_response:1; }","duration":"123.099467ms","start":"2026-04-10T14:00:53.526835Z","end":"2026-04-10T14:00:53.649934Z","steps":["trace[541424366] 'process raft request' (duration: 122.992966ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T14:00:53.868645Z","caller":"traceutil/trace.go:171","msg":"trace[681620708] linearizableReadLoop","detail":"{readStateIndex:6945; appliedIndex:6944; }","duration":"118.663588ms","start":"2026-04-10T14:00:53.749955Z","end":"2026-04-10T14:00:53.868619Z","steps":["trace[681620708] 'read index received' (duration: 118.402274ms)","trace[681620708] 'applied index is now lower than readState.Index' (duration: 260.284µs)"],"step_count":2} {"level":"info","ts":"2026-04-10T14:00:53.868695Z","caller":"traceutil/trace.go:171","msg":"trace[1559269971] transaction","detail":"{read_only:false; response_revision:6644; number_of_response:1; }","duration":"208.371447ms","start":"2026-04-10T14:00:53.660298Z","end":"2026-04-10T14:00:53.868669Z","steps":["trace[1559269971] 'process raft request' (duration: 208.146224ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T14:00:53.868787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.807801ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.carvel.dev/secretimports/\" range_end:\"/registry/secretgen.carvel.dev/secretimports0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T14:00:53.868831Z","caller":"traceutil/trace.go:171","msg":"trace[851563603] range","detail":"{range_begin:/registry/secretgen.carvel.dev/secretimports/; range_end:/registry/secretgen.carvel.dev/secretimports0; response_count:0; response_revision:6644; }","duration":"118.919542ms","start":"2026-04-10T14:00:53.749897Z","end":"2026-04-10T14:00:53.868816Z","steps":["trace[851563603] 'agreement among raft nodes before linearized reading' (duration: 118.82446ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T14:01:06.223443Z","caller":"traceutil/trace.go:171","msg":"trace[655150184] linearizableReadLoop","detail":"{readStateIndex:7037; appliedIndex:7035; }","duration":"143.260508ms","start":"2026-04-10T14:01:06.080154Z","end":"2026-04-10T14:01:06.223414Z","steps":["trace[655150184] 'read index received' (duration: 5.254161ms)","trace[655150184] 'applied index is now lower than readState.Index' (duration: 138.005057ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T14:01:06.223751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.583093ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-10T14:01:06.223797Z","caller":"traceutil/trace.go:171","msg":"trace[744690021] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:6729; }","duration":"143.666975ms","start":"2026-04-10T14:01:06.080119Z","end":"2026-04-10T14:01:06.223785Z","steps":["trace[744690021] 'agreement among raft nodes before linearized reading' (duration: 143.476281ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T14:01:06.224013Z","caller":"traceutil/trace.go:171","msg":"trace[1507117428] transaction","detail":"{read_only:false; response_revision:6729; number_of_response:1; }","duration":"147.228898ms","start":"2026-04-10T14:01:06.076313Z","end":"2026-04-10T14:01:06.223542Z","steps":["trace[1507117428] 'process raft request' (duration: 146.933104ms)"],"step_count":1}