{"level":"warn","ts":"2026-08-14T08:58:06.328368Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-14T08:58:06.328462Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.170:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.170:2380","--initial-cluster=instance=https://199.19.213.170:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.170:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.170: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-08-14T08:58:06.328575Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-14T08:58:06.328593Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.170:2380"]} {"level":"info","ts":"2026-08-14T08:58:06.328642Z","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-08-14T08:58:06.329543Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.170:2379"]} {"level":"info","ts":"2026-08-14T08:58:06.329663Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.170:2380"],"listen-peer-urls":["https://199.19.213.170:2380"],"advertise-client-urls":["https://199.19.213.170:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.170:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.170: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-08-14T08:58:06.333843Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.91704ms"} {"level":"info","ts":"2026-08-14T08:58:06.342474Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"80be33c6b0d5a492","cluster-id":"abad33c2eec87dc"} {"level":"info","ts":"2026-08-14T08:58:06.342643Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"80be33c6b0d5a492 switched to configuration voters=()"} {"level":"info","ts":"2026-08-14T08:58:06.342673Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"80be33c6b0d5a492 became follower at term 0"} {"level":"info","ts":"2026-08-14T08:58:06.342684Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 80be33c6b0d5a492 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-14T08:58:06.342693Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"80be33c6b0d5a492 became follower at term 1"} {"level":"info","ts":"2026-08-14T08:58:06.342758Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"80be33c6b0d5a492 switched to configuration voters=(9276909210893132946)"} {"level":"warn","ts":"2026-08-14T08:58:06.348634Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-14T08:58:06.351017Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-14T08:58:06.35224Z","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-08-14T08:58:06.354185Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"80be33c6b0d5a492","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-14T08:58:06.355756Z","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-08-14T08:58:06.355845Z","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-08-14T08:58:06.355858Z","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-08-14T08:58:06.355903Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"80be33c6b0d5a492","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-14T08:58:06.357893Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"80be33c6b0d5a492 switched to configuration voters=(9276909210893132946)"} {"level":"info","ts":"2026-08-14T08:58:06.358109Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"abad33c2eec87dc","local-member-id":"80be33c6b0d5a492","added-peer-id":"80be33c6b0d5a492","added-peer-peer-urls":["https://199.19.213.170:2380"]} {"level":"info","ts":"2026-08-14T08:58:06.359461Z","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-08-14T08:58:06.359548Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.170:2380"} {"level":"info","ts":"2026-08-14T08:58:06.359587Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.170:2380"} {"level":"info","ts":"2026-08-14T08:58:06.35979Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"80be33c6b0d5a492","initial-advertise-peer-urls":["https://199.19.213.170:2380"],"listen-peer-urls":["https://199.19.213.170:2380"],"advertise-client-urls":["https://199.19.213.170:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.170:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-14T08:58:06.359842Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-14T08:58:06.743438Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"80be33c6b0d5a492 is starting a new election at term 1"} {"level":"info","ts":"2026-08-14T08:58:06.743552Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"80be33c6b0d5a492 became pre-candidate at term 1"} {"level":"info","ts":"2026-08-14T08:58:06.743593Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"80be33c6b0d5a492 received MsgPreVoteResp from 80be33c6b0d5a492 at term 1"} {"level":"info","ts":"2026-08-14T08:58:06.74362Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"80be33c6b0d5a492 became candidate at term 2"} {"level":"info","ts":"2026-08-14T08:58:06.743633Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"80be33c6b0d5a492 received MsgVoteResp from 80be33c6b0d5a492 at term 2"} {"level":"info","ts":"2026-08-14T08:58:06.743658Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"80be33c6b0d5a492 became leader at term 2"} {"level":"info","ts":"2026-08-14T08:58:06.743675Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 80be33c6b0d5a492 elected leader 80be33c6b0d5a492 at term 2"} {"level":"info","ts":"2026-08-14T08:58:06.758594Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-14T08:58:06.891306Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"80be33c6b0d5a492","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.170:2379]}","request-path":"/0/members/80be33c6b0d5a492/attributes","cluster-id":"abad33c2eec87dc","publish-timeout":"7s"} {"level":"info","ts":"2026-08-14T08:58:06.891319Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-14T08:58:06.89137Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-14T08:58:06.891839Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-14T08:58:06.89192Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-14T08:58:06.895119Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-08-14T08:58:06.91215Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.170:2379"} {"level":"info","ts":"2026-08-14T08:58:06.961275Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"abad33c2eec87dc","local-member-id":"80be33c6b0d5a492","cluster-version":"3.5"} {"level":"info","ts":"2026-08-14T08:58:06.961458Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-14T08:58:06.961554Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-08-14T08:58:42.764329Z","caller":"traceutil/trace.go:171","msg":"trace[1962993083] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"187.083498ms","start":"2026-08-14T08:58:42.577204Z","end":"2026-08-14T08:58:42.764287Z","steps":["trace[1962993083] 'process raft request' (duration: 186.777377ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T08:58:42.772812Z","caller":"traceutil/trace.go:171","msg":"trace[803131393] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"174.164818ms","start":"2026-08-14T08:58:42.598619Z","end":"2026-08-14T08:58:42.772784Z","steps":["trace[803131393] 'process raft request' (duration: 173.898957ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T08:58:42.77298Z","caller":"traceutil/trace.go:171","msg":"trace[157236150] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"174.203838ms","start":"2026-08-14T08:58:42.598708Z","end":"2026-08-14T08:58:42.772912Z","steps":["trace[157236150] 'process raft request' (duration: 173.984637ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T08:58:42.773027Z","caller":"traceutil/trace.go:171","msg":"trace[799810684] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"164.364386ms","start":"2026-08-14T08:58:42.60862Z","end":"2026-08-14T08:58:42.772984Z","steps":["trace[799810684] 'process raft request' (duration: 164.132875ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T08:58:42.773449Z","caller":"traceutil/trace.go:171","msg":"trace[2118262576] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"159.51699ms","start":"2026-08-14T08:58:42.613892Z","end":"2026-08-14T08:58:42.773409Z","steps":["trace[2118262576] 'process raft request' (duration: 159.014127ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T08:58:42.773628Z","caller":"traceutil/trace.go:171","msg":"trace[71464823] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"158.074693ms","start":"2026-08-14T08:58:42.615534Z","end":"2026-08-14T08:58:42.773608Z","steps":["trace[71464823] 'process raft request' (duration: 157.827812ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T08:58:42.773647Z","caller":"traceutil/trace.go:171","msg":"trace[379939985] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"157.104427ms","start":"2026-08-14T08:58:42.616524Z","end":"2026-08-14T08:58:42.773629Z","steps":["trace[379939985] 'process raft request' (duration: 156.939016ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T08:58:42.773843Z","caller":"traceutil/trace.go:171","msg":"trace[713339106] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"153.414828ms","start":"2026-08-14T08:58:42.620417Z","end":"2026-08-14T08:58:42.773832Z","steps":["trace[713339106] 'process raft request' (duration: 153.117387ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T08:58:42.782007Z","caller":"traceutil/trace.go:171","msg":"trace[1077639400] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"148.823133ms","start":"2026-08-14T08:58:42.625162Z","end":"2026-08-14T08:58:42.773985Z","steps":["trace[1077639400] 'process raft request' (duration: 148.422271ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T08:58:42.782558Z","caller":"traceutil/trace.go:171","msg":"trace[784399770] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"147.580007ms","start":"2026-08-14T08:58:42.626565Z","end":"2026-08-14T08:58:42.774145Z","steps":["trace[784399770] 'process raft request' (duration: 147.239425ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T08:58:42.784915Z","caller":"traceutil/trace.go:171","msg":"trace[659297588] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"153.698419ms","start":"2026-08-14T08:58:42.631202Z","end":"2026-08-14T08:58:42.784901Z","steps":["trace[659297588] 'process raft request' (duration: 148.008979ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T08:58:42.791425Z","caller":"traceutil/trace.go:171","msg":"trace[1143579132] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"131.249269ms","start":"2026-08-14T08:58:42.660166Z","end":"2026-08-14T08:58:42.791415Z","steps":["trace[1143579132] 'process raft request' (duration: 123.81402ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T08:58:42.791822Z","caller":"traceutil/trace.go:171","msg":"trace[1334764559] linearizableReadLoop","detail":"{readStateIndex:548; appliedIndex:537; }","duration":"150.904495ms","start":"2026-08-14T08:58:42.640855Z","end":"2026-08-14T08:58:42.791759Z","steps":["trace[1334764559] 'read index received' (duration: 123.113967ms)","trace[1334764559] 'applied index is now lower than readState.Index' (duration: 27.789368ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T08:58:42.792001Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.124736ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T08:58:42.79205Z","caller":"traceutil/trace.go:171","msg":"trace[1310095702] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:532; }","duration":"151.193006ms","start":"2026-08-14T08:58:42.640847Z","end":"2026-08-14T08:58:42.79204Z","steps":["trace[1310095702] 'agreement among raft nodes before linearized reading' (duration: 151.032756ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T08:58:49.075724Z","caller":"traceutil/trace.go:171","msg":"trace[2092164620] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"109.024302ms","start":"2026-08-14T08:58:48.966637Z","end":"2026-08-14T08:58:49.075662Z","steps":["trace[2092164620] 'process raft request' (duration: 108.187717ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T08:58:49.266036Z","caller":"traceutil/trace.go:171","msg":"trace[926500321] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"160.334096ms","start":"2026-08-14T08:58:49.105668Z","end":"2026-08-14T08:58:49.266002Z","steps":["trace[926500321] 'process raft request' (duration: 160.082455ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T08:58:49.272744Z","caller":"traceutil/trace.go:171","msg":"trace[689501197] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"134.032904ms","start":"2026-08-14T08:58:49.138674Z","end":"2026-08-14T08:58:49.272707Z","steps":["trace[689501197] 'process raft request' (duration: 133.875553ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T08:58:49.773769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.958543ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T08:58:49.773838Z","caller":"traceutil/trace.go:171","msg":"trace[1267734094] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:626; }","duration":"132.087115ms","start":"2026-08-14T08:58:49.641734Z","end":"2026-08-14T08:58:49.773821Z","steps":["trace[1267734094] 'range keys from in-memory index tree' (duration: 131.786563ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:00:09.163291Z","caller":"traceutil/trace.go:171","msg":"trace[578855112] transaction","detail":"{read_only:false; response_revision:1571; number_of_response:1; }","duration":"214.825508ms","start":"2026-08-14T09:00:08.948423Z","end":"2026-08-14T09:00:09.163248Z","steps":["trace[578855112] 'process raft request' (duration: 214.542025ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:00:09.164088Z","caller":"traceutil/trace.go:171","msg":"trace[81806626] transaction","detail":"{read_only:false; response_revision:1573; number_of_response:1; }","duration":"211.366871ms","start":"2026-08-14T09:00:08.952685Z","end":"2026-08-14T09:00:09.164052Z","steps":["trace[81806626] 'process raft request' (duration: 211.312728ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:00:09.164405Z","caller":"traceutil/trace.go:171","msg":"trace[2104292999] transaction","detail":"{read_only:false; response_revision:1572; number_of_response:1; }","duration":"213.686454ms","start":"2026-08-14T09:00:08.950688Z","end":"2026-08-14T09:00:09.164375Z","steps":["trace[2104292999] 'process raft request' (duration: 213.138388ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:00:15.118199Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11858716688502133609,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-14T09:00:15.618523Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11858716688502133609,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-14T09:00:16.119282Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11858716688502133609,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-14T09:00:16.619902Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11858716688502133609,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-14T09:00:16.643442Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.99977452s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-08-14T09:00:16.643531Z","caller":"traceutil/trace.go:171","msg":"trace[1492825510] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"1.999914826s","start":"2026-08-14T09:00:14.643596Z","end":"2026-08-14T09:00:16.643511Z","steps":["trace[1492825510] 'agreement among raft nodes before linearized reading' (duration: 1.99979687s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:00:16.643634Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:00:14.643583Z","time spent":"2.000036271s","remote":"127.0.0.1:58256","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/08/14 09:00:16 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-08-14T09:00:17.120601Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11858716688502133609,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-14T09:00:17.620841Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11858716688502133609,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-14T09:00:18.121461Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11858716688502133609,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-14T09:00:18.622522Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11858716688502133609,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-14T09:00:18.643842Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000012062s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-08-14T09:00:18.643931Z","caller":"traceutil/trace.go:171","msg":"trace[355027755] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000152928s","start":"2026-08-14T09:00:16.643759Z","end":"2026-08-14T09:00:18.643912Z","steps":["trace[355027755] 'agreement among raft nodes before linearized reading' (duration: 2.000044684s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:00:18.643992Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:00:16.643701Z","time spent":"2.000281104s","remote":"127.0.0.1:58246","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/08/14 09:00:18 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-08-14T09:00:19.12274Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11858716688502133609,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-14T09:00:19.428662Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000020058s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-08-14T09:00:19.428748Z","caller":"traceutil/trace.go:171","msg":"trace[1145265820] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000188786s","start":"2026-08-14T09:00:17.42854Z","end":"2026-08-14T09:00:19.428729Z","steps":["trace[1145265820] 'agreement among raft nodes before linearized reading' (duration: 2.000070841s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:00:19.428799Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:00:17.428521Z","time spent":"2.0002675s","remote":"127.0.0.1:58256","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/08/14 09:00:19 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-08-14T09:00:19.499344Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:00:14.501262Z","time spent":"4.998052066s","remote":"127.0.0.1:58512","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""} {"level":"warn","ts":"2026-08-14T09:00:19.62358Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11858716688502133609,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-14T09:00:20.124133Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11858716688502133609,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-14T09:00:20.178596Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"5.946203338s","expected-duration":"1s"} {"level":"warn","ts":"2026-08-14T09:00:20.183054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.822853253s","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-08-14T09:00:20.183173Z","caller":"traceutil/trace.go:171","msg":"trace[891287112] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1698; }","duration":"2.822982249s","start":"2026-08-14T09:00:17.36017Z","end":"2026-08-14T09:00:20.183152Z","steps":["trace[891287112] 'range keys from in-memory index tree' (duration: 2.822837791s)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:00:20.183182Z","caller":"traceutil/trace.go:171","msg":"trace[506214180] transaction","detail":"{read_only:false; response_revision:1699; number_of_response:1; }","duration":"5.958992499s","start":"2026-08-14T09:00:14.224162Z","end":"2026-08-14T09:00:20.183154Z","steps":["trace[506214180] 'process raft request' (duration: 5.95480504s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:00:20.184554Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:00:14.224129Z","time spent":"5.959093774s","remote":"127.0.0.1:58426","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7063,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-14T09:00:20.193776Z","caller":"traceutil/trace.go:171","msg":"trace[1905181591] transaction","detail":"{read_only:false; response_revision:1700; number_of_response:1; }","duration":"5.920997414s","start":"2026-08-14T09:00:14.272756Z","end":"2026-08-14T09:00:20.193753Z","steps":["trace[1905181591] 'process raft request' (duration: 5.920742002s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:00:20.19391Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:00:14.272704Z","time spent":"5.921135911s","remote":"127.0.0.1:58512","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-14T09:00:20.196615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.999038594s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-08-14T09:00:20.19673Z","caller":"traceutil/trace.go:171","msg":"trace[1350375506] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; }","duration":"4.999193341s","start":"2026-08-14T09:00:15.197509Z","end":"2026-08-14T09:00:20.196702Z","steps":["trace[1350375506] 'agreement among raft nodes before linearized reading' (duration: 4.999048485s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:00:20.196791Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:00:15.197502Z","time spent":"4.999275434s","remote":"127.0.0.1:58512","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} 2026/08/14 09:00:20 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"info","ts":"2026-08-14T09:00:20.197683Z","caller":"traceutil/trace.go:171","msg":"trace[302857525] linearizableReadLoop","detail":"{readStateIndex:1773; appliedIndex:1768; }","duration":"5.580246883s","start":"2026-08-14T09:00:14.617412Z","end":"2026-08-14T09:00:20.197658Z","steps":["trace[302857525] 'read index received' (duration: 5.561497528s)","trace[302857525] 'applied index is now lower than readState.Index' (duration: 18.748175ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T09:00:20.197757Z","caller":"traceutil/trace.go:171","msg":"trace[2009395935] transaction","detail":"{read_only:false; response_revision:1702; number_of_response:1; }","duration":"1.549406824s","start":"2026-08-14T09:00:18.64832Z","end":"2026-08-14T09:00:20.197727Z","steps":["trace[2009395935] 'process raft request' (duration: 1.549215386s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:00:20.197879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"5.580461203s","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-08-14T09:00:20.19789Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:00:18.648295Z","time spent":"1.549530441s","remote":"127.0.0.1:58328","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":759,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-14T09:00:20.197922Z","caller":"traceutil/trace.go:171","msg":"trace[383988790] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:1702; }","duration":"5.580509225s","start":"2026-08-14T09:00:14.617403Z","end":"2026-08-14T09:00:20.197912Z","steps":["trace[383988790] 'agreement among raft nodes before linearized reading' (duration: 5.58039214s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:00:20.197951Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:00:14.617327Z","time spent":"5.58061519s","remote":"127.0.0.1:53144","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-08-14T09:00:20.198055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"5.314722959s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-14T09:00:20.198206Z","caller":"traceutil/trace.go:171","msg":"trace[1742496631] range","detail":"{range_begin:/registry/controllerrevisions/; range_end:/registry/controllerrevisions0; response_count:0; response_revision:1702; }","duration":"5.314920778s","start":"2026-08-14T09:00:14.883258Z","end":"2026-08-14T09:00:20.198179Z","steps":["trace[1742496631] 'agreement among raft nodes before linearized reading' (duration: 5.314697908s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:00:20.198281Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.533240602s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/permissions/\" range_end:\"/registry/rabbitmq.com/permissions0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T09:00:20.198332Z","caller":"traceutil/trace.go:171","msg":"trace[1751837309] range","detail":"{range_begin:/registry/rabbitmq.com/permissions/; range_end:/registry/rabbitmq.com/permissions0; response_count:0; response_revision:1702; }","duration":"2.533291075s","start":"2026-08-14T09:00:17.665028Z","end":"2026-08-14T09:00:20.198319Z","steps":["trace[1751837309] 'agreement among raft nodes before linearized reading' (duration: 2.533208651s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:00:20.198364Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:00:17.664934Z","time spent":"2.53342127s","remote":"127.0.0.1:53672","response type":"/etcdserverpb.KV/Range","request count":0,"request size":77,"response count":0,"response size":28,"request content":"key:\"/registry/rabbitmq.com/permissions/\" range_end:\"/registry/rabbitmq.com/permissions0\" limit:500 "} {"level":"warn","ts":"2026-08-14T09:00:20.198416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.734079ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.170\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-08-14T09:00:20.198453Z","caller":"traceutil/trace.go:171","msg":"trace[438305267] range","detail":"{range_begin:/registry/masterleases/199.19.213.170; range_end:; response_count:1; response_revision:1702; }","duration":"165.809752ms","start":"2026-08-14T09:00:20.032634Z","end":"2026-08-14T09:00:20.198444Z","steps":["trace[438305267] 'agreement among raft nodes before linearized reading' (duration: 165.693066ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:00:20.198426Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:00:14.88323Z","time spent":"5.315071444s","remote":"127.0.0.1:58736","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":3,"response size":30,"request content":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true "} {"level":"warn","ts":"2026-08-14T09:00:20.198565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.426942908s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/operatorpolicies/\" range_end:\"/registry/rabbitmq.com/operatorpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T09:00:20.198607Z","caller":"traceutil/trace.go:171","msg":"trace[335432196] range","detail":"{range_begin:/registry/rabbitmq.com/operatorpolicies/; range_end:/registry/rabbitmq.com/operatorpolicies0; response_count:0; response_revision:1702; }","duration":"2.427004301s","start":"2026-08-14T09:00:17.771593Z","end":"2026-08-14T09:00:20.198597Z","steps":["trace[335432196] 'agreement among raft nodes before linearized reading' (duration: 2.426940028s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:00:20.198634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.397067ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/ingress-nginx/ingress-nginx-controller-nx2pb\" ","response":"range_response_count:1 size:7308"} {"level":"warn","ts":"2026-08-14T09:00:20.19864Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:00:17.771579Z","time spent":"2.427047664s","remote":"127.0.0.1:53718","response type":"/etcdserverpb.KV/Range","request count":0,"request size":87,"response count":0,"response size":28,"request content":"key:\"/registry/rabbitmq.com/operatorpolicies/\" range_end:\"/registry/rabbitmq.com/operatorpolicies0\" limit:10000 "} {"level":"info","ts":"2026-08-14T09:00:20.198663Z","caller":"traceutil/trace.go:171","msg":"trace[417809870] range","detail":"{range_begin:/registry/pods/ingress-nginx/ingress-nginx-controller-nx2pb; range_end:; response_count:1; response_revision:1702; }","duration":"267.426568ms","start":"2026-08-14T09:00:19.93123Z","end":"2026-08-14T09:00:20.198657Z","steps":["trace[417809870] 'agreement among raft nodes before linearized reading' (duration: 267.335044ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:00:20.19885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"696.931066ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" ","response":"range_response_count:1 size:549"} {"level":"info","ts":"2026-08-14T09:00:20.198888Z","caller":"traceutil/trace.go:171","msg":"trace[294378319] range","detail":"{range_begin:/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io; range_end:; response_count:1; response_revision:1702; }","duration":"696.9981ms","start":"2026-08-14T09:00:19.501881Z","end":"2026-08-14T09:00:20.198879Z","steps":["trace[294378319] 'agreement among raft nodes before linearized reading' (duration: 696.896425ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:00:20.198908Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:00:19.501848Z","time spent":"697.054432ms","remote":"127.0.0.1:58512","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":572,"request content":"key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" "} {"level":"warn","ts":"2026-08-14T09:00:20.198862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.534095421s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/permissions/\" range_end:\"/registry/rabbitmq.com/permissions0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-14T09:00:20.198966Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.427367388s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/operatorpolicies/\" range_end:\"/registry/rabbitmq.com/operatorpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T09:00:20.199016Z","caller":"traceutil/trace.go:171","msg":"trace[379780329] range","detail":"{range_begin:/registry/rabbitmq.com/operatorpolicies/; range_end:/registry/rabbitmq.com/operatorpolicies0; response_count:0; response_revision:1702; }","duration":"2.42744007s","start":"2026-08-14T09:00:17.771566Z","end":"2026-08-14T09:00:20.199006Z","steps":["trace[379780329] 'agreement among raft nodes before linearized reading' (duration: 2.427218641s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:00:20.19903Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.547830612s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-14T09:00:20.199049Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:00:17.771556Z","time spent":"2.427483623s","remote":"127.0.0.1:53718","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":0,"response size":28,"request content":"key:\"/registry/rabbitmq.com/operatorpolicies/\" range_end:\"/registry/rabbitmq.com/operatorpolicies0\" count_only:true "} {"level":"info","ts":"2026-08-14T09:00:20.199062Z","caller":"traceutil/trace.go:171","msg":"trace[294408268] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1702; }","duration":"1.547899736s","start":"2026-08-14T09:00:18.651155Z","end":"2026-08-14T09:00:20.199055Z","steps":["trace[294408268] 'agreement among raft nodes before linearized reading' (duration: 1.547853673s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:00:20.199092Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:00:18.651127Z","time spent":"1.547960168s","remote":"127.0.0.1:58256","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-08-14T09:00:20.198984Z","caller":"traceutil/trace.go:171","msg":"trace[737420190] range","detail":"{range_begin:/registry/rabbitmq.com/permissions/; range_end:/registry/rabbitmq.com/permissions0; response_count:0; response_revision:1702; }","duration":"2.534253669s","start":"2026-08-14T09:00:17.664716Z","end":"2026-08-14T09:00:20.198969Z","steps":["trace[737420190] 'agreement among raft nodes before linearized reading' (duration: 2.534102622s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:00:20.199243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.443609663s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/shovels/\" range_end:\"/registry/rabbitmq.com/shovels0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T09:00:20.199283Z","caller":"traceutil/trace.go:171","msg":"trace[2008143343] range","detail":"{range_begin:/registry/rabbitmq.com/shovels/; range_end:/registry/rabbitmq.com/shovels0; response_count:0; response_revision:1702; }","duration":"2.443705037s","start":"2026-08-14T09:00:17.755568Z","end":"2026-08-14T09:00:20.199273Z","steps":["trace[2008143343] 'agreement among raft nodes before linearized reading' (duration: 2.443597742s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:00:20.199315Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:00:17.755557Z","time spent":"2.443748139s","remote":"127.0.0.1:53716","response type":"/etcdserverpb.KV/Range","request count":0,"request size":69,"response count":0,"response size":28,"request content":"key:\"/registry/rabbitmq.com/shovels/\" range_end:\"/registry/rabbitmq.com/shovels0\" limit:500 "} {"level":"warn","ts":"2026-08-14T09:00:20.199366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.780418634s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T09:00:20.199393Z","caller":"traceutil/trace.go:171","msg":"trace[1299788096] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:1702; }","duration":"1.780472216s","start":"2026-08-14T09:00:18.418914Z","end":"2026-08-14T09:00:20.199386Z","steps":["trace[1299788096] 'agreement among raft nodes before linearized reading' (duration: 1.780439355s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:00:20.199414Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:00:18.418892Z","time spent":"1.780517198s","remote":"127.0.0.1:58388","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":28,"request content":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true "} {"level":"warn","ts":"2026-08-14T09:00:20.199261Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:00:17.664692Z","time spent":"2.5345079s","remote":"127.0.0.1:53672","response type":"/etcdserverpb.KV/Range","request count":0,"request size":77,"response count":0,"response size":28,"request content":"key:\"/registry/rabbitmq.com/permissions/\" range_end:\"/registry/rabbitmq.com/permissions0\" limit:10000 "} {"level":"warn","ts":"2026-08-14T09:00:20.199503Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.615925981s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/policies/\" range_end:\"/registry/rabbitmq.com/policies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-14T09:00:20.199559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.398028918s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/queues/\" range_end:\"/registry/rabbitmq.com/queues0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-14T09:00:20.199585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.444281003s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/shovels/\" range_end:\"/registry/rabbitmq.com/shovels0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-14T09:00:20.199533Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.444195509s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/shovels/\" range_end:\"/registry/rabbitmq.com/shovels0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-14T09:00:20.199627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.398318962s","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-08-14T09:00:20.199635Z","caller":"traceutil/trace.go:171","msg":"trace[2081288892] range","detail":"{range_begin:/registry/rabbitmq.com/shovels/; range_end:/registry/rabbitmq.com/shovels0; response_count:0; response_revision:1702; }","duration":"2.444318625s","start":"2026-08-14T09:00:17.755308Z","end":"2026-08-14T09:00:20.199626Z","steps":["trace[2081288892] 'agreement among raft nodes before linearized reading' (duration: 2.444188129s)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:00:20.19965Z","caller":"traceutil/trace.go:171","msg":"trace[245272369] range","detail":"{range_begin:/registry/rabbitmq.com/queues/; range_end:/registry/rabbitmq.com/queues0; response_count:0; response_revision:1702; }","duration":"2.398393996s","start":"2026-08-14T09:00:17.80125Z","end":"2026-08-14T09:00:20.199644Z","steps":["trace[245272369] 'agreement among raft nodes before linearized reading' (duration: 2.398358434s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:00:20.199681Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:00:17.801238Z","time spent":"2.398437497s","remote":"127.0.0.1:53746","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-08-14T09:00:20.199676Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:00:17.755208Z","time spent":"2.444456741s","remote":"127.0.0.1:53716","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":0,"response size":28,"request content":"key:\"/registry/rabbitmq.com/shovels/\" range_end:\"/registry/rabbitmq.com/shovels0\" count_only:true "} {"level":"warn","ts":"2026-08-14T09:00:20.199699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.459582736s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/vhosts/\" range_end:\"/registry/rabbitmq.com/vhosts0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T09:00:20.199734Z","caller":"traceutil/trace.go:171","msg":"trace[475600375] range","detail":"{range_begin:/registry/rabbitmq.com/vhosts/; range_end:/registry/rabbitmq.com/vhosts0; response_count:0; response_revision:1702; }","duration":"2.459628238s","start":"2026-08-14T09:00:17.740097Z","end":"2026-08-14T09:00:20.199725Z","steps":["trace[475600375] 'agreement among raft nodes before linearized reading' (duration: 2.459573426s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:00:20.199763Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:00:17.74009Z","time spent":"2.45966533s","remote":"127.0.0.1:53702","response type":"/etcdserverpb.KV/Range","request count":0,"request size":67,"response count":0,"response size":28,"request content":"key:\"/registry/rabbitmq.com/vhosts/\" range_end:\"/registry/rabbitmq.com/vhosts0\" limit:500 "} {"level":"warn","ts":"2026-08-14T09:00:20.199824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.398799603s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/queues/\" range_end:\"/registry/rabbitmq.com/queues0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T09:00:20.199855Z","caller":"traceutil/trace.go:171","msg":"trace[2002867611] range","detail":"{range_begin:/registry/rabbitmq.com/queues/; range_end:/registry/rabbitmq.com/queues0; response_count:0; response_revision:1702; }","duration":"2.398846707s","start":"2026-08-14T09:00:17.801001Z","end":"2026-08-14T09:00:20.199848Z","steps":["trace[2002867611] 'agreement among raft nodes before linearized reading' (duration: 2.398794964s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:00:20.199879Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:00:17.800991Z","time spent":"2.398881708s","remote":"127.0.0.1:53746","response type":"/etcdserverpb.KV/Range","request count":0,"request size":67,"response count":0,"response size":28,"request content":"key:\"/registry/rabbitmq.com/queues/\" range_end:\"/registry/rabbitmq.com/queues0\" limit:10000 "} {"level":"warn","ts":"2026-08-14T09:00:20.199908Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.548735343s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/superstreams/\" range_end:\"/registry/rabbitmq.com/superstreams0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-14T09:00:20.199949Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.460897547s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/vhosts/\" range_end:\"/registry/rabbitmq.com/vhosts0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T09:00:20.199992Z","caller":"traceutil/trace.go:171","msg":"trace[1664522414] range","detail":"{range_begin:/registry/rabbitmq.com/vhosts/; range_end:/registry/rabbitmq.com/vhosts0; response_count:0; response_revision:1702; }","duration":"2.46096324s","start":"2026-08-14T09:00:17.739019Z","end":"2026-08-14T09:00:20.199982Z","steps":["trace[1664522414] 'agreement among raft nodes before linearized reading' (duration: 2.460889376s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:00:20.200018Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.412162078s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/exchanges/\" range_end:\"/registry/rabbitmq.com/exchanges0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-14T09:00:20.200031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.548946043s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/superstreams/\" range_end:\"/registry/rabbitmq.com/superstreams0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-14T09:00:20.200032Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:00:17.739006Z","time spent":"2.461016703s","remote":"127.0.0.1:53702","response type":"/etcdserverpb.KV/Range","request count":0,"request size":67,"response count":0,"response size":28,"request content":"key:\"/registry/rabbitmq.com/vhosts/\" range_end:\"/registry/rabbitmq.com/vhosts0\" limit:10000 "} {"level":"info","ts":"2026-08-14T09:00:20.200048Z","caller":"traceutil/trace.go:171","msg":"trace[537926478] range","detail":"{range_begin:/registry/rabbitmq.com/exchanges/; range_end:/registry/rabbitmq.com/exchanges0; response_count:0; response_revision:1702; }","duration":"2.412209029s","start":"2026-08-14T09:00:17.787833Z","end":"2026-08-14T09:00:20.200042Z","steps":["trace[537926478] 'agreement among raft nodes before linearized reading' (duration: 2.412156727s)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:00:20.200057Z","caller":"traceutil/trace.go:171","msg":"trace[1153259512] range","detail":"{range_begin:/registry/rabbitmq.com/superstreams/; range_end:/registry/rabbitmq.com/superstreams0; response_count:0; response_revision:1702; }","duration":"2.548979855s","start":"2026-08-14T09:00:17.651069Z","end":"2026-08-14T09:00:20.200049Z","steps":["trace[1153259512] 'agreement among raft nodes before linearized reading' (duration: 2.548943473s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:00:20.200074Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:00:17.787828Z","time spent":"2.412237391s","remote":"127.0.0.1:53732","response type":"/etcdserverpb.KV/Range","request count":0,"request size":73,"response count":0,"response size":28,"request content":"key:\"/registry/rabbitmq.com/exchanges/\" range_end:\"/registry/rabbitmq.com/exchanges0\" limit:500 "} {"level":"warn","ts":"2026-08-14T09:00:20.200111Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.56673871s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/bindings/\" range_end:\"/registry/rabbitmq.com/bindings0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T09:00:20.200129Z","caller":"traceutil/trace.go:171","msg":"trace[1433477578] range","detail":"{range_begin:/registry/rabbitmq.com/bindings/; range_end:/registry/rabbitmq.com/bindings0; response_count:0; response_revision:1702; }","duration":"2.566773922s","start":"2026-08-14T09:00:17.63335Z","end":"2026-08-14T09:00:20.200124Z","steps":["trace[1433477578] 'agreement among raft nodes before linearized reading' (duration: 2.566746301s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:00:20.200156Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:00:17.633338Z","time spent":"2.566812823s","remote":"127.0.0.1:53654","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":0,"response size":28,"request content":"key:\"/registry/rabbitmq.com/bindings/\" range_end:\"/registry/rabbitmq.com/bindings0\" limit:500 "} {"level":"warn","ts":"2026-08-14T09:00:20.200235Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.461249043s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/vhosts/\" range_end:\"/registry/rabbitmq.com/vhosts0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T09:00:20.200277Z","caller":"traceutil/trace.go:171","msg":"trace[1835168473] range","detail":"{range_begin:/registry/rabbitmq.com/vhosts/; range_end:/registry/rabbitmq.com/vhosts0; response_count:0; response_revision:1702; }","duration":"2.461314105s","start":"2026-08-14T09:00:17.738954Z","end":"2026-08-14T09:00:20.200268Z","steps":["trace[1835168473] 'agreement among raft nodes before linearized reading' (duration: 2.461250723s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:00:20.200276Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.413240328s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/exchanges/\" range_end:\"/registry/rabbitmq.com/exchanges0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-14T09:00:20.200295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.567648712s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/bindings/\" range_end:\"/registry/rabbitmq.com/bindings0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T09:00:20.20031Z","caller":"traceutil/trace.go:171","msg":"trace[174961190] range","detail":"{range_begin:/registry/rabbitmq.com/exchanges/; range_end:/registry/rabbitmq.com/exchanges0; response_count:0; response_revision:1702; }","duration":"2.413280289s","start":"2026-08-14T09:00:17.787021Z","end":"2026-08-14T09:00:20.200301Z","steps":["trace[174961190] 'agreement among raft nodes before linearized reading' (duration: 2.413243437s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:00:20.200249Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.413187165s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/exchanges/\" range_end:\"/registry/rabbitmq.com/exchanges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-14T09:00:20.200339Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:00:17.787014Z","time spent":"2.41331946s","remote":"127.0.0.1:53732","response type":"/etcdserverpb.KV/Range","request count":0,"request size":73,"response count":0,"response size":28,"request content":"key:\"/registry/rabbitmq.com/exchanges/\" range_end:\"/registry/rabbitmq.com/exchanges0\" limit:10000 "} {"level":"info","ts":"2026-08-14T09:00:20.200349Z","caller":"traceutil/trace.go:171","msg":"trace[2068309394] range","detail":"{range_begin:/registry/rabbitmq.com/exchanges/; range_end:/registry/rabbitmq.com/exchanges0; response_count:0; response_revision:1702; }","duration":"2.41329428s","start":"2026-08-14T09:00:17.787045Z","end":"2026-08-14T09:00:20.200339Z","steps":["trace[2068309394] 'agreement among raft nodes before linearized reading' (duration: 2.413176494s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:00:20.200388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.584652673s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/users/\" range_end:\"/registry/rabbitmq.com/users0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-14T09:00:20.200394Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:00:17.787041Z","time spent":"2.413341642s","remote":"127.0.0.1:53732","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":28,"request content":"key:\"/registry/rabbitmq.com/exchanges/\" range_end:\"/registry/rabbitmq.com/exchanges0\" count_only:true "} {"level":"info","ts":"2026-08-14T09:00:20.20041Z","caller":"traceutil/trace.go:171","msg":"trace[1158348972] range","detail":"{range_begin:/registry/rabbitmq.com/users/; range_end:/registry/rabbitmq.com/users0; response_count:0; response_revision:1702; }","duration":"2.584685415s","start":"2026-08-14T09:00:17.615718Z","end":"2026-08-14T09:00:20.200403Z","steps":["trace[1158348972] 'agreement among raft nodes before linearized reading' (duration: 2.584650623s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:00:20.200434Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:00:17.615712Z","time spent":"2.584716146s","remote":"127.0.0.1:53648","response type":"/etcdserverpb.KV/Range","request count":0,"request size":65,"response count":0,"response size":28,"request content":"key:\"/registry/rabbitmq.com/users/\" range_end:\"/registry/rabbitmq.com/users0\" limit:500 "} {"level":"info","ts":"2026-08-14T09:00:20.19959Z","caller":"traceutil/trace.go:171","msg":"trace[472715513] range","detail":"{range_begin:/registry/rabbitmq.com/queues/; range_end:/registry/rabbitmq.com/queues0; response_count:0; response_revision:1702; }","duration":"2.39808254s","start":"2026-08-14T09:00:17.801497Z","end":"2026-08-14T09:00:20.19958Z","steps":["trace[472715513] 'agreement among raft nodes before linearized reading' (duration: 2.398019677s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:00:20.200564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.585288291s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/users/\" range_end:\"/registry/rabbitmq.com/users0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-14T09:00:20.200566Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:00:17.80149Z","time spent":"2.399067245s","remote":"127.0.0.1:53746","response type":"/etcdserverpb.KV/Range","request count":0,"request size":67,"response count":0,"response size":28,"request content":"key:\"/registry/rabbitmq.com/queues/\" range_end:\"/registry/rabbitmq.com/queues0\" limit:500 "} {"level":"info","ts":"2026-08-14T09:00:20.200585Z","caller":"traceutil/trace.go:171","msg":"trace[1833113951] range","detail":"{range_begin:/registry/rabbitmq.com/users/; range_end:/registry/rabbitmq.com/users0; response_count:0; response_revision:1702; }","duration":"2.585320893s","start":"2026-08-14T09:00:17.615259Z","end":"2026-08-14T09:00:20.20058Z","steps":["trace[1833113951] 'agreement among raft nodes before linearized reading' (duration: 2.585281672s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:00:20.200601Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:00:17.615256Z","time spent":"2.585341534s","remote":"127.0.0.1:53648","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":0,"response size":28,"request content":"key:\"/registry/rabbitmq.com/users/\" range_end:\"/registry/rabbitmq.com/users0\" count_only:true "} {"level":"warn","ts":"2026-08-14T09:00:20.199875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.535200212s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/permissions/\" range_end:\"/registry/rabbitmq.com/permissions0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T09:00:20.200671Z","caller":"traceutil/trace.go:171","msg":"trace[908336045] range","detail":"{range_begin:/registry/rabbitmq.com/permissions/; range_end:/registry/rabbitmq.com/permissions0; response_count:0; response_revision:1702; }","duration":"2.536014188s","start":"2026-08-14T09:00:17.664649Z","end":"2026-08-14T09:00:20.200663Z","steps":["trace[908336045] 'agreement among raft nodes before linearized reading' (duration: 2.535203632s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:00:20.200539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.61702043s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/policies/\" range_end:\"/registry/rabbitmq.com/policies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-14T09:00:20.20073Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.602057082s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/schemareplications/\" range_end:\"/registry/rabbitmq.com/schemareplications0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-14T09:00:20.200082Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:00:17.651062Z","time spent":"2.549014476s","remote":"127.0.0.1:53662","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":28,"request content":"key:\"/registry/rabbitmq.com/superstreams/\" range_end:\"/registry/rabbitmq.com/superstreams0\" count_only:true "} {"level":"info","ts":"2026-08-14T09:00:20.200773Z","caller":"traceutil/trace.go:171","msg":"trace[495369252] range","detail":"{range_begin:/registry/rabbitmq.com/schemareplications/; range_end:/registry/rabbitmq.com/schemareplications0; response_count:0; response_revision:1702; }","duration":"2.602090024s","start":"2026-08-14T09:00:17.598656Z","end":"2026-08-14T09:00:20.200746Z","steps":["trace[495369252] 'agreement among raft nodes before linearized reading' (duration: 2.602060422s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:00:20.200791Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:00:17.59865Z","time spent":"2.602135766s","remote":"127.0.0.1:53644","response type":"/etcdserverpb.KV/Range","request count":0,"request size":91,"response count":0,"response size":28,"request content":"key:\"/registry/rabbitmq.com/schemareplications/\" range_end:\"/registry/rabbitmq.com/schemareplications0\" limit:500 "} {"level":"warn","ts":"2026-08-14T09:00:20.20031Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:00:17.73894Z","time spent":"2.461360828s","remote":"127.0.0.1:53702","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":0,"response size":28,"request content":"key:\"/registry/rabbitmq.com/vhosts/\" range_end:\"/registry/rabbitmq.com/vhosts0\" count_only:true "} {"level":"warn","ts":"2026-08-14T09:00:20.200886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.602694232s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/schemareplications/\" range_end:\"/registry/rabbitmq.com/schemareplications0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T09:00:20.200901Z","caller":"traceutil/trace.go:171","msg":"trace[1233918738] range","detail":"{range_begin:/registry/rabbitmq.com/schemareplications/; range_end:/registry/rabbitmq.com/schemareplications0; response_count:0; response_revision:1702; }","duration":"2.602710012s","start":"2026-08-14T09:00:17.598186Z","end":"2026-08-14T09:00:20.200896Z","steps":["trace[1233918738] 'agreement among raft nodes before linearized reading' (duration: 2.602686261s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:00:20.20092Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:00:17.598168Z","time spent":"2.602748024s","remote":"127.0.0.1:53644","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":28,"request content":"key:\"/registry/rabbitmq.com/schemareplications/\" range_end:\"/registry/rabbitmq.com/schemareplications0\" count_only:true "} {"level":"info","ts":"2026-08-14T09:00:20.200801Z","caller":"traceutil/trace.go:171","msg":"trace[284320397] range","detail":"{range_begin:/registry/rabbitmq.com/policies/; range_end:/registry/rabbitmq.com/policies0; response_count:0; response_revision:1702; }","duration":"2.61725705s","start":"2026-08-14T09:00:17.583477Z","end":"2026-08-14T09:00:20.200734Z","steps":["trace[284320397] 'agreement among raft nodes before linearized reading' (duration: 2.617010829s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:00:20.201016Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.602861169s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/schemareplications/\" range_end:\"/registry/rabbitmq.com/schemareplications0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T09:00:20.201035Z","caller":"traceutil/trace.go:171","msg":"trace[625203615] range","detail":"{range_begin:/registry/rabbitmq.com/schemareplications/; range_end:/registry/rabbitmq.com/schemareplications0; response_count:0; response_revision:1702; }","duration":"2.602901481s","start":"2026-08-14T09:00:17.598129Z","end":"2026-08-14T09:00:20.20103Z","steps":["trace[625203615] 'agreement among raft nodes before linearized reading' (duration: 2.60287383s)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:00:20.200316Z","caller":"traceutil/trace.go:171","msg":"trace[579202040] range","detail":"{range_begin:/registry/rabbitmq.com/bindings/; range_end:/registry/rabbitmq.com/bindings0; response_count:0; response_revision:1702; }","duration":"2.567708554s","start":"2026-08-14T09:00:17.632601Z","end":"2026-08-14T09:00:20.20031Z","steps":["trace[579202040] 'agreement among raft nodes before linearized reading' (duration: 2.567673933s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:00:20.201084Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:00:17.632577Z","time spent":"2.56849642s","remote":"127.0.0.1:53654","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":0,"response size":28,"request content":"key:\"/registry/rabbitmq.com/bindings/\" range_end:\"/registry/rabbitmq.com/bindings0\" limit:10000 "} {"level":"warn","ts":"2026-08-14T09:00:20.201147Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:00:17.583463Z","time spent":"2.617563094s","remote":"127.0.0.1:53642","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":0,"response size":28,"request content":"key:\"/registry/rabbitmq.com/policies/\" range_end:\"/registry/rabbitmq.com/policies0\" limit:10000 "} {"level":"warn","ts":"2026-08-14T09:00:20.201057Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:00:17.598113Z","time spent":"2.602939922s","remote":"127.0.0.1:53644","response type":"/etcdserverpb.KV/Range","request count":0,"request size":91,"response count":0,"response size":28,"request content":"key:\"/registry/rabbitmq.com/schemareplications/\" range_end:\"/registry/rabbitmq.com/schemareplications0\" limit:10000 "} {"level":"warn","ts":"2026-08-14T09:00:20.201095Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.617526662s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/policies/\" range_end:\"/registry/rabbitmq.com/policies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T09:00:20.201448Z","caller":"traceutil/trace.go:171","msg":"trace[1985603781] range","detail":"{range_begin:/registry/rabbitmq.com/policies/; range_end:/registry/rabbitmq.com/policies0; response_count:0; response_revision:1702; }","duration":"2.617886729s","start":"2026-08-14T09:00:17.583552Z","end":"2026-08-14T09:00:20.201439Z","steps":["trace[1985603781] 'agreement among raft nodes before linearized reading' (duration: 2.617514012s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:00:20.201526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.632132194s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/\" range_end:\"/registry/rabbitmq.com/rabbitmqclusters0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T09:00:20.201609Z","caller":"traceutil/trace.go:171","msg":"trace[1328411667] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/; range_end:/registry/rabbitmq.com/rabbitmqclusters0; response_count:0; response_revision:1702; }","duration":"2.632230588s","start":"2026-08-14T09:00:17.569357Z","end":"2026-08-14T09:00:20.201588Z","steps":["trace[1328411667] 'agreement among raft nodes before linearized reading' (duration: 2.632103232s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:00:20.201679Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:00:17.569347Z","time spent":"2.632313741s","remote":"127.0.0.1:53628","response type":"/etcdserverpb.KV/Range","request count":0,"request size":87,"response count":0,"response size":28,"request content":"key:\"/registry/rabbitmq.com/rabbitmqclusters/\" range_end:\"/registry/rabbitmq.com/rabbitmqclusters0\" limit:500 "} {"level":"warn","ts":"2026-08-14T09:00:20.201739Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.478347428s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/topicpermissions/\" range_end:\"/registry/rabbitmq.com/topicpermissions0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T09:00:20.201761Z","caller":"traceutil/trace.go:171","msg":"trace[591495568] range","detail":"{range_begin:/registry/rabbitmq.com/topicpermissions/; range_end:/registry/rabbitmq.com/topicpermissions0; response_count:0; response_revision:1702; }","duration":"2.47840908s","start":"2026-08-14T09:00:17.723346Z","end":"2026-08-14T09:00:20.201755Z","steps":["trace[591495568] 'agreement among raft nodes before linearized reading' (duration: 2.478380698s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:00:20.201787Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:00:17.723323Z","time spent":"2.478451212s","remote":"127.0.0.1:53694","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":0,"response size":28,"request content":"key:\"/registry/rabbitmq.com/topicpermissions/\" range_end:\"/registry/rabbitmq.com/topicpermissions0\" count_only:true "} {"level":"warn","ts":"2026-08-14T09:00:20.201881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.51843968s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/federations/\" range_end:\"/registry/rabbitmq.com/federations0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T09:00:20.201901Z","caller":"traceutil/trace.go:171","msg":"trace[1484659834] range","detail":"{range_begin:/registry/rabbitmq.com/federations/; range_end:/registry/rabbitmq.com/federations0; response_count:0; response_revision:1702; }","duration":"2.518459371s","start":"2026-08-14T09:00:17.683436Z","end":"2026-08-14T09:00:20.201895Z","steps":["trace[1484659834] 'agreement among raft nodes before linearized reading' (duration: 2.518431719s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:00:20.201915Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:00:17.68341Z","time spent":"2.518500962s","remote":"127.0.0.1:53678","response type":"/etcdserverpb.KV/Range","request count":0,"request size":77,"response count":0,"response size":28,"request content":"key:\"/registry/rabbitmq.com/federations/\" range_end:\"/registry/rabbitmq.com/federations0\" limit:500 "} {"level":"warn","ts":"2026-08-14T09:00:20.202004Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.519542789s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/federations/\" range_end:\"/registry/rabbitmq.com/federations0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T09:00:20.202022Z","caller":"traceutil/trace.go:171","msg":"trace[1247763455] range","detail":"{range_begin:/registry/rabbitmq.com/federations/; range_end:/registry/rabbitmq.com/federations0; response_count:0; response_revision:1702; }","duration":"2.519604422s","start":"2026-08-14T09:00:17.682412Z","end":"2026-08-14T09:00:20.202017Z","steps":["trace[1247763455] 'agreement among raft nodes before linearized reading' (duration: 2.519573061s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:00:20.202035Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:00:17.682386Z","time spent":"2.519645134s","remote":"127.0.0.1:53678","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":28,"request content":"key:\"/registry/rabbitmq.com/federations/\" range_end:\"/registry/rabbitmq.com/federations0\" count_only:true "} {"level":"warn","ts":"2026-08-14T09:00:20.202104Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.519844934s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/federations/\" range_end:\"/registry/rabbitmq.com/federations0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T09:00:20.202123Z","caller":"traceutil/trace.go:171","msg":"trace[1605300302] range","detail":"{range_begin:/registry/rabbitmq.com/federations/; range_end:/registry/rabbitmq.com/federations0; response_count:0; response_revision:1702; }","duration":"2.519871855s","start":"2026-08-14T09:00:17.682247Z","end":"2026-08-14T09:00:20.202118Z","steps":["trace[1605300302] 'agreement among raft nodes before linearized reading' (duration: 2.519839643s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:00:20.202137Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:00:17.682241Z","time spent":"2.519891396s","remote":"127.0.0.1:53678","response type":"/etcdserverpb.KV/Range","request count":0,"request size":77,"response count":0,"response size":28,"request content":"key:\"/registry/rabbitmq.com/federations/\" range_end:\"/registry/rabbitmq.com/federations0\" limit:10000 "} {"level":"warn","ts":"2026-08-14T09:00:20.198282Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.426055417s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/operatorpolicies/\" range_end:\"/registry/rabbitmq.com/operatorpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T09:00:20.202206Z","caller":"traceutil/trace.go:171","msg":"trace[1001080450] range","detail":"{range_begin:/registry/rabbitmq.com/operatorpolicies/; range_end:/registry/rabbitmq.com/operatorpolicies0; response_count:0; response_revision:1702; }","duration":"2.430005965s","start":"2026-08-14T09:00:17.77219Z","end":"2026-08-14T09:00:20.202196Z","steps":["trace[1001080450] 'agreement among raft nodes before linearized reading' (duration: 2.426049036s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:00:20.202228Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:00:17.772175Z","time spent":"2.430044827s","remote":"127.0.0.1:53718","response type":"/etcdserverpb.KV/Range","request count":0,"request size":87,"response count":0,"response size":28,"request content":"key:\"/registry/rabbitmq.com/operatorpolicies/\" range_end:\"/registry/rabbitmq.com/operatorpolicies0\" limit:500 "} {"level":"warn","ts":"2026-08-14T09:00:20.202184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.6335883s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/\" range_end:\"/registry/rabbitmq.com/rabbitmqclusters0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T09:00:20.202331Z","caller":"traceutil/trace.go:171","msg":"trace[1551320191] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/; range_end:/registry/rabbitmq.com/rabbitmqclusters0; response_count:0; response_revision:1702; }","duration":"2.633741057s","start":"2026-08-14T09:00:17.568563Z","end":"2026-08-14T09:00:20.202304Z","steps":["trace[1551320191] 'agreement among raft nodes before linearized reading' (duration: 2.63359317s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:00:20.202091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.633411412s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/\" range_end:\"/registry/rabbitmq.com/rabbitmqclusters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T09:00:20.202421Z","caller":"traceutil/trace.go:171","msg":"trace[1319754568] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/; range_end:/registry/rabbitmq.com/rabbitmqclusters0; response_count:0; response_revision:1702; }","duration":"2.633761187s","start":"2026-08-14T09:00:17.568644Z","end":"2026-08-14T09:00:20.202405Z","steps":["trace[1319754568] 'agreement among raft nodes before linearized reading' (duration: 2.63336244s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:00:20.202447Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:00:17.568633Z","time spent":"2.63380672s","remote":"127.0.0.1:53628","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":0,"response size":28,"request content":"key:\"/registry/rabbitmq.com/rabbitmqclusters/\" range_end:\"/registry/rabbitmq.com/rabbitmqclusters0\" count_only:true "} {"level":"warn","ts":"2026-08-14T09:00:20.202477Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:00:17.568548Z","time spent":"2.633846332s","remote":"127.0.0.1:53628","response type":"/etcdserverpb.KV/Range","request count":0,"request size":87,"response count":0,"response size":28,"request content":"key:\"/registry/rabbitmq.com/rabbitmqclusters/\" range_end:\"/registry/rabbitmq.com/rabbitmqclusters0\" limit:10000 "} {"level":"warn","ts":"2026-08-14T09:00:20.202684Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.529238056s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T09:00:20.202761Z","caller":"traceutil/trace.go:171","msg":"trace[981747411] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:1702; }","duration":"3.52931545s","start":"2026-08-14T09:00:16.673433Z","end":"2026-08-14T09:00:20.202749Z","steps":["trace[981747411] 'agreement among raft nodes before linearized reading' (duration: 3.529209835s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:00:20.202826Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:00:16.673395Z","time spent":"3.529418264s","remote":"127.0.0.1:53128","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-08-14T09:00:20.203091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.966234586s","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-08-14T09:00:20.203162Z","caller":"traceutil/trace.go:171","msg":"trace[484740381] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1702; }","duration":"3.966347591s","start":"2026-08-14T09:00:16.236803Z","end":"2026-08-14T09:00:20.203151Z","steps":["trace[484740381] 'agreement among raft nodes before linearized reading' (duration: 3.966178334s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:00:20.203235Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:00:16.236773Z","time spent":"3.966446646s","remote":"127.0.0.1:58512","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-08-14T09:00:20.203499Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.260446124s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-14T09:00:20.20357Z","caller":"traceutil/trace.go:171","msg":"trace[1181774416] range","detail":"{range_begin:/registry/storageclasses/; range_end:/registry/storageclasses0; response_count:0; response_revision:1702; }","duration":"4.2605608s","start":"2026-08-14T09:00:15.942999Z","end":"2026-08-14T09:00:20.203559Z","steps":["trace[1181774416] 'agreement among raft nodes before linearized reading' (duration: 4.260467525s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:00:20.203639Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:00:15.942977Z","time spent":"4.260650154s","remote":"127.0.0.1:58628","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":30,"request content":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true "} {"level":"warn","ts":"2026-08-14T09:00:20.203849Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.383103177s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-14T09:00:20.203921Z","caller":"traceutil/trace.go:171","msg":"trace[795655079] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:1702; }","duration":"4.383212352s","start":"2026-08-14T09:00:15.820698Z","end":"2026-08-14T09:00:20.20391Z","steps":["trace[795655079] 'agreement among raft nodes before linearized reading' (duration: 4.383110088s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:00:20.203984Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:00:15.820678Z","time spent":"4.383294946s","remote":"127.0.0.1:58338","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":17,"response size":30,"request content":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true "} {"level":"warn","ts":"2026-08-14T09:00:20.204242Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.699066722s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-08-14T09:00:20.204323Z","caller":"traceutil/trace.go:171","msg":"trace[1920542350] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1702; }","duration":"4.699184067s","start":"2026-08-14T09:00:15.505125Z","end":"2026-08-14T09:00:20.204309Z","steps":["trace[1920542350] 'agreement among raft nodes before linearized reading' (duration: 4.69903735s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:00:20.204391Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:00:15.505109Z","time spent":"4.699271451s","remote":"127.0.0.1:58512","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-08-14T09:00:20.204545Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.941004974s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-14T09:00:20.204591Z","caller":"traceutil/trace.go:171","msg":"trace[468896559] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:1702; }","duration":"4.941093538s","start":"2026-08-14T09:00:15.26349Z","end":"2026-08-14T09:00:20.204583Z","steps":["trace[468896559] 'agreement among raft nodes before linearized reading' (duration: 4.941025155s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:00:20.20463Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:00:15.263466Z","time spent":"4.941156891s","remote":"127.0.0.1:58672","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":8,"response size":30,"request content":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true "} {"level":"warn","ts":"2026-08-14T09:00:20.20148Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:00:17.583545Z","time spent":"2.617925871s","remote":"127.0.0.1:53642","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":0,"response size":28,"request content":"key:\"/registry/rabbitmq.com/policies/\" range_end:\"/registry/rabbitmq.com/policies0\" count_only:true "} {"level":"warn","ts":"2026-08-14T09:00:20.204813Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"5.00737874s","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-08-14T09:00:20.204862Z","caller":"traceutil/trace.go:171","msg":"trace[557348887] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1702; }","duration":"5.007467234s","start":"2026-08-14T09:00:15.197388Z","end":"2026-08-14T09:00:20.204855Z","steps":["trace[557348887] 'agreement among raft nodes before linearized reading' (duration: 5.00737244s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:00:20.2049Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:00:15.197364Z","time spent":"5.007529377s","remote":"127.0.0.1:58512","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-08-14T09:00:20.199592Z","caller":"traceutil/trace.go:171","msg":"trace[266250540] range","detail":"{range_begin:/registry/rabbitmq.com/policies/; range_end:/registry/rabbitmq.com/policies0; response_count:0; response_revision:1702; }","duration":"2.616042775s","start":"2026-08-14T09:00:17.583523Z","end":"2026-08-14T09:00:20.199566Z","steps":["trace[266250540] 'agreement among raft nodes before linearized reading' (duration: 2.615884528s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:00:20.199997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.548863239s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/superstreams/\" range_end:\"/registry/rabbitmq.com/superstreams0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-14T09:00:20.205025Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:00:17.583518Z","time spent":"2.621486271s","remote":"127.0.0.1:53642","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":0,"response size":28,"request content":"key:\"/registry/rabbitmq.com/policies/\" range_end:\"/registry/rabbitmq.com/policies0\" limit:500 "} {"level":"info","ts":"2026-08-14T09:00:20.205028Z","caller":"traceutil/trace.go:171","msg":"trace[211850458] range","detail":"{range_begin:/registry/rabbitmq.com/superstreams/; range_end:/registry/rabbitmq.com/superstreams0; response_count:0; response_revision:1702; }","duration":"2.553907566s","start":"2026-08-14T09:00:17.651106Z","end":"2026-08-14T09:00:20.205013Z","steps":["trace[211850458] 'agreement among raft nodes before linearized reading' (duration: 2.548869559s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:00:20.205072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"5.306754113s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/perconaxtradbclusterbackups.pxc.percona.com\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-14T09:00:20.205084Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:00:17.651096Z","time spent":"2.553964689s","remote":"127.0.0.1:53662","response type":"/etcdserverpb.KV/Range","request count":0,"request size":79,"response count":0,"response size":28,"request content":"key:\"/registry/rabbitmq.com/superstreams/\" range_end:\"/registry/rabbitmq.com/superstreams0\" limit:500 "} {"level":"info","ts":"2026-08-14T09:00:20.2051Z","caller":"traceutil/trace.go:171","msg":"trace[1507366934] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/perconaxtradbclusterbackups.pxc.percona.com; range_end:; response_count:0; response_revision:1702; }","duration":"5.306801465s","start":"2026-08-14T09:00:14.898289Z","end":"2026-08-14T09:00:20.205091Z","steps":["trace[1507366934] 'agreement among raft nodes before linearized reading' (duration: 5.306761954s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:00:20.201717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.478113057s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/topicpermissions/\" range_end:\"/registry/rabbitmq.com/topicpermissions0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T09:00:20.205152Z","caller":"traceutil/trace.go:171","msg":"trace[1845944923] range","detail":"{range_begin:/registry/rabbitmq.com/topicpermissions/; range_end:/registry/rabbitmq.com/topicpermissions0; response_count:0; response_revision:1702; }","duration":"2.481558342s","start":"2026-08-14T09:00:17.723584Z","end":"2026-08-14T09:00:20.205143Z","steps":["trace[1845944923] 'agreement among raft nodes before linearized reading' (duration: 2.478121337s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:00:20.205201Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:00:17.723573Z","time spent":"2.481616014s","remote":"127.0.0.1:53694","response type":"/etcdserverpb.KV/Range","request count":0,"request size":87,"response count":0,"response size":28,"request content":"key:\"/registry/rabbitmq.com/topicpermissions/\" range_end:\"/registry/rabbitmq.com/topicpermissions0\" limit:10000 "} {"level":"warn","ts":"2026-08-14T09:00:20.200696Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:00:17.664637Z","time spent":"2.536051289s","remote":"127.0.0.1:53672","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":28,"request content":"key:\"/registry/rabbitmq.com/permissions/\" range_end:\"/registry/rabbitmq.com/permissions0\" count_only:true "} {"level":"warn","ts":"2026-08-14T09:00:20.200701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.585451869s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/users/\" range_end:\"/registry/rabbitmq.com/users0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T09:00:20.205345Z","caller":"traceutil/trace.go:171","msg":"trace[1939705086] range","detail":"{range_begin:/registry/rabbitmq.com/users/; range_end:/registry/rabbitmq.com/users0; response_count:0; response_revision:1702; }","duration":"2.590093627s","start":"2026-08-14T09:00:17.615244Z","end":"2026-08-14T09:00:20.205338Z","steps":["trace[1939705086] 'agreement among raft nodes before linearized reading' (duration: 2.585440808s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:00:20.205426Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:00:17.61522Z","time spent":"2.590193682s","remote":"127.0.0.1:53648","response type":"/etcdserverpb.KV/Range","request count":0,"request size":65,"response count":0,"response size":28,"request content":"key:\"/registry/rabbitmq.com/users/\" range_end:\"/registry/rabbitmq.com/users0\" limit:10000 "} {"level":"warn","ts":"2026-08-14T09:00:20.205117Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:00:14.898277Z","time spent":"5.306835827s","remote":"127.0.0.1:58306","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":0,"response size":28,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/perconaxtradbclusterbackups.pxc.percona.com\" "} {"level":"warn","ts":"2026-08-14T09:00:20.201691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.47753254s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/topicpermissions/\" range_end:\"/registry/rabbitmq.com/topicpermissions0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T09:00:20.205839Z","caller":"traceutil/trace.go:171","msg":"trace[1002862883] range","detail":"{range_begin:/registry/rabbitmq.com/topicpermissions/; range_end:/registry/rabbitmq.com/topicpermissions0; response_count:0; response_revision:1702; }","duration":"2.481707168s","start":"2026-08-14T09:00:17.724124Z","end":"2026-08-14T09:00:20.205831Z","steps":["trace[1002862883] 'agreement among raft nodes before linearized reading' (duration: 2.477545971s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:00:20.205033Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"5.007609041s","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-08-14T09:00:20.205863Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:00:17.724112Z","time spent":"2.48174193s","remote":"127.0.0.1:53694","response type":"/etcdserverpb.KV/Range","request count":0,"request size":87,"response count":0,"response size":28,"request content":"key:\"/registry/rabbitmq.com/topicpermissions/\" range_end:\"/registry/rabbitmq.com/topicpermissions0\" limit:500 "} {"level":"info","ts":"2026-08-14T09:00:20.205915Z","caller":"traceutil/trace.go:171","msg":"trace[2038184969] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1702; }","duration":"5.008526223s","start":"2026-08-14T09:00:15.197377Z","end":"2026-08-14T09:00:20.205903Z","steps":["trace[2038184969] 'agreement among raft nodes before linearized reading' (duration: 5.00759617s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:00:20.206006Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:00:15.197352Z","time spent":"5.008642398s","remote":"127.0.0.1:58512","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-08-14T09:00:20.199648Z","caller":"traceutil/trace.go:171","msg":"trace[562319722] range","detail":"{range_begin:/registry/rabbitmq.com/shovels/; range_end:/registry/rabbitmq.com/shovels0; response_count:0; response_revision:1702; }","duration":"2.444322845s","start":"2026-08-14T09:00:17.755296Z","end":"2026-08-14T09:00:20.199619Z","steps":["trace[562319722] 'agreement among raft nodes before linearized reading' (duration: 2.444259742s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:00:20.208708Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:00:17.755258Z","time spent":"2.453396995s","remote":"127.0.0.1:53716","response type":"/etcdserverpb.KV/Range","request count":0,"request size":69,"response count":0,"response size":28,"request content":"key:\"/registry/rabbitmq.com/shovels/\" range_end:\"/registry/rabbitmq.com/shovels0\" limit:10000 "} {"level":"warn","ts":"2026-08-14T09:00:20.200353Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.567844981s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/bindings/\" range_end:\"/registry/rabbitmq.com/bindings0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T09:00:20.208959Z","caller":"traceutil/trace.go:171","msg":"trace[419893383] range","detail":"{range_begin:/registry/rabbitmq.com/bindings/; range_end:/registry/rabbitmq.com/bindings0; response_count:0; response_revision:1702; }","duration":"2.576449669s","start":"2026-08-14T09:00:17.632488Z","end":"2026-08-14T09:00:20.208938Z","steps":["trace[419893383] 'agreement among raft nodes before linearized reading' (duration: 2.567845631s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:00:20.209001Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:00:17.632479Z","time spent":"2.576509122s","remote":"127.0.0.1:53654","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":0,"response size":28,"request content":"key:\"/registry/rabbitmq.com/bindings/\" range_end:\"/registry/rabbitmq.com/bindings0\" count_only:true "} {"level":"warn","ts":"2026-08-14T09:00:20.199339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.550790167s","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:7"} {"level":"info","ts":"2026-08-14T09:00:20.20914Z","caller":"traceutil/trace.go:171","msg":"trace[632222875] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:1702; }","duration":"1.56061524s","start":"2026-08-14T09:00:18.648513Z","end":"2026-08-14T09:00:20.209128Z","steps":["trace[632222875] 'agreement among raft nodes before linearized reading' (duration: 1.550688882s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:00:20.20919Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:00:18.6485Z","time spent":"1.560672962s","remote":"127.0.0.1:53272","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":1,"response size":30,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"info","ts":"2026-08-14T09:00:20.199958Z","caller":"traceutil/trace.go:171","msg":"trace[1414434085] range","detail":"{range_begin:/registry/rabbitmq.com/superstreams/; range_end:/registry/rabbitmq.com/superstreams0; response_count:0; response_revision:1702; }","duration":"2.548781396s","start":"2026-08-14T09:00:17.651159Z","end":"2026-08-14T09:00:20.19994Z","steps":["trace[1414434085] 'agreement among raft nodes before linearized reading' (duration: 2.548733324s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:00:20.20978Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:00:17.651155Z","time spent":"2.558608769s","remote":"127.0.0.1:53662","response type":"/etcdserverpb.KV/Range","request count":0,"request size":79,"response count":0,"response size":28,"request content":"key:\"/registry/rabbitmq.com/superstreams/\" range_end:\"/registry/rabbitmq.com/superstreams0\" limit:10000 "} {"level":"info","ts":"2026-08-14T09:00:34.421852Z","caller":"traceutil/trace.go:171","msg":"trace[1297554110] transaction","detail":"{read_only:false; response_revision:1903; number_of_response:1; }","duration":"103.576261ms","start":"2026-08-14T09:00:34.318252Z","end":"2026-08-14T09:00:34.421828Z","steps":["trace[1297554110] 'process raft request' (duration: 102.10438ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:00:34.422225Z","caller":"traceutil/trace.go:171","msg":"trace[1661380396] transaction","detail":"{read_only:false; response_revision:1905; number_of_response:1; }","duration":"102.788838ms","start":"2026-08-14T09:00:34.31941Z","end":"2026-08-14T09:00:34.422199Z","steps":["trace[1661380396] 'process raft request' (duration: 102.750857ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:00:34.422345Z","caller":"traceutil/trace.go:171","msg":"trace[2049631160] transaction","detail":"{read_only:false; response_revision:1904; number_of_response:1; }","duration":"103.094181ms","start":"2026-08-14T09:00:34.319228Z","end":"2026-08-14T09:00:34.422323Z","steps":["trace[2049631160] 'process raft request' (duration: 102.831721ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:00:34.75492Z","caller":"traceutil/trace.go:171","msg":"trace[182515048] linearizableReadLoop","detail":"{readStateIndex:1985; appliedIndex:1984; }","duration":"112.130096ms","start":"2026-08-14T09:00:34.642766Z","end":"2026-08-14T09:00:34.754896Z","steps":["trace[182515048] 'read index received' (duration: 111.997571ms)","trace[182515048] 'applied index is now lower than readState.Index' (duration: 131.535µs)"],"step_count":2} {"level":"warn","ts":"2026-08-14T09:00:34.755038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.253631ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T09:00:34.755071Z","caller":"traceutil/trace.go:171","msg":"trace[2111083040] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1907; }","duration":"112.330495ms","start":"2026-08-14T09:00:34.642729Z","end":"2026-08-14T09:00:34.75506Z","steps":["trace[2111083040] 'agreement among raft nodes before linearized reading' (duration: 112.264532ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:00:34.756098Z","caller":"traceutil/trace.go:171","msg":"trace[1972804164] transaction","detail":"{read_only:false; response_revision:1907; number_of_response:1; }","duration":"135.526219ms","start":"2026-08-14T09:00:34.619777Z","end":"2026-08-14T09:00:34.755303Z","steps":["trace[1972804164] 'process raft request' (duration: 134.996047ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:00:46.596076Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11858716688502134205,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-14T09:00:47.09678Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11858716688502134205,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-14T09:00:47.598003Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11858716688502134205,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-14T09:00:48.09828Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11858716688502134205,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-14T09:00:48.599425Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11858716688502134205,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-14T09:00:49.100358Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11858716688502134205,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-14T09:00:49.428333Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.999692529s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-08-14T09:00:49.428414Z","caller":"traceutil/trace.go:171","msg":"trace[61720363] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"1.999844205s","start":"2026-08-14T09:00:47.428549Z","end":"2026-08-14T09:00:49.428393Z","steps":["trace[61720363] 'agreement among raft nodes before linearized reading' (duration: 1.999726031s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:00:49.428468Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:00:47.428526Z","time spent":"1.999932598s","remote":"127.0.0.1:58256","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-14T09:00:49.601524Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11858716688502134205,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-14T09:00:49.643497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.999914563s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-08-14T09:00:49.643582Z","caller":"traceutil/trace.go:171","msg":"trace[2020768253] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000072438s","start":"2026-08-14T09:00:47.643485Z","end":"2026-08-14T09:00:49.643558Z","steps":["trace[2020768253] 'agreement among raft nodes before linearized reading' (duration: 1.999968084s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:00:49.643633Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:00:47.643455Z","time spent":"2.000166102s","remote":"127.0.0.1:58246","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-14T09:00:50.101712Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11858716688502134205,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-14T09:00:50.602864Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11858716688502134205,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-14T09:00:51.072555Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:00:46.07437Z","time spent":"4.998176214s","remote":"127.0.0.1:58512","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""} 2026/08/14 09:00:51 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-08-14T09:00:51.103884Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11858716688502134205,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-14T09:00:51.282299Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:00:46.283967Z","time spent":"4.998322453s","remote":"127.0.0.1:58512","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""} 2026/08/14 09:00:51 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-08-14T09:00:51.298974Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:00:46.299567Z","time spent":"4.999402016s","remote":"127.0.0.1:58512","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""} 2026/08/14 09:00:51 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-08-14T09:00:51.353795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.999068343s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-08-14T09:00:51.353861Z","caller":"traceutil/trace.go:171","msg":"trace[1391365377] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; }","duration":"4.999189398s","start":"2026-08-14T09:00:46.354657Z","end":"2026-08-14T09:00:51.353846Z","steps":["trace[1391365377] 'agreement among raft nodes before linearized reading' (duration: 4.999107275s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:00:51.353896Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:00:46.354635Z","time spent":"4.999254641s","remote":"127.0.0.1:58512","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} 2026/08/14 09:00:51 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-08-14T09:00:51.47624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.999509108s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-08-14T09:00:51.476328Z","caller":"traceutil/trace.go:171","msg":"trace[157911545] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; }","duration":"4.999648863s","start":"2026-08-14T09:00:46.476656Z","end":"2026-08-14T09:00:51.476305Z","steps":["trace[157911545] 'agreement among raft nodes before linearized reading' (duration: 4.999538929s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:00:51.47638Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:00:46.47664Z","time spent":"4.999729847s","remote":"127.0.0.1:58512","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} 2026/08/14 09:00:51 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-08-14T09:00:51.481213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.999079066s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-08-14T09:00:51.481293Z","caller":"traceutil/trace.go:171","msg":"trace[647204588] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; }","duration":"4.999197821s","start":"2026-08-14T09:00:46.482075Z","end":"2026-08-14T09:00:51.481273Z","steps":["trace[647204588] 'agreement among raft nodes before linearized reading' (duration: 4.999095347s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:00:51.481342Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:00:46.482059Z","time spent":"4.999274023s","remote":"127.0.0.1:58512","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} 2026/08/14 09:00:51 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-08-14T09:00:51.604356Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11858716688502134205,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-14T09:00:51.651616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.99976055s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-08-14T09:00:51.651687Z","caller":"traceutil/trace.go:171","msg":"trace[522135385] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"1.999906145s","start":"2026-08-14T09:00:49.651757Z","end":"2026-08-14T09:00:51.651663Z","steps":["trace[522135385] 'agreement among raft nodes before linearized reading' (duration: 1.999824732s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:00:51.651749Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:00:49.651728Z","time spent":"2.00000845s","remote":"127.0.0.1:58256","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/08/14 09:00:51 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-08-14T09:00:51.796411Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"6.039773073s","expected-duration":"1s"} {"level":"warn","ts":"2026-08-14T09:00:51.803294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.442997718s","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-08-14T09:00:51.803473Z","caller":"traceutil/trace.go:171","msg":"trace[1376753496] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:2001; }","duration":"4.443189115s","start":"2026-08-14T09:00:47.360248Z","end":"2026-08-14T09:00:51.803438Z","steps":["trace[1376753496] 'range keys from in-memory index tree' (duration: 4.442961517s)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:00:51.80439Z","caller":"traceutil/trace.go:171","msg":"trace[529261047] transaction","detail":"{read_only:false; response_revision:2002; number_of_response:1; }","duration":"6.047896129s","start":"2026-08-14T09:00:45.756474Z","end":"2026-08-14T09:00:51.80437Z","steps":["trace[529261047] 'process raft request' (duration: 6.040137147s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:00:51.804538Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:00:45.756448Z","time spent":"6.047990693s","remote":"127.0.0.1:58432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":11964,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-14T09:00:52.18129Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.931478ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-08-14T09:00:52.181604Z","caller":"traceutil/trace.go:171","msg":"trace[1826777384] transaction","detail":"{read_only:false; response_revision:2006; number_of_response:1; }","duration":"4.431786122s","start":"2026-08-14T09:00:47.749801Z","end":"2026-08-14T09:00:52.181587Z","steps":["trace[1826777384] 'process raft request' (duration: 4.431706669s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:00:52.181677Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:00:47.749772Z","time spent":"4.431865705s","remote":"127.0.0.1:58512","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-08-14T09:00:52.181862Z","caller":"traceutil/trace.go:171","msg":"trace[1478869297] transaction","detail":"{read_only:false; response_revision:2007; number_of_response:1; }","duration":"1.50434545s","start":"2026-08-14T09:00:50.677496Z","end":"2026-08-14T09:00:52.181842Z","steps":["trace[1478869297] 'process raft request' (duration: 1.504045339s)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:00:52.181884Z","caller":"traceutil/trace.go:171","msg":"trace[2049073212] linearizableReadLoop","detail":"{readStateIndex:2092; appliedIndex:2083; }","duration":"6.086235763s","start":"2026-08-14T09:00:46.095624Z","end":"2026-08-14T09:00:52.18186Z","steps":["trace[2049073212] 'read index received' (duration: 5.700999911s)","trace[2049073212] 'applied index is now lower than readState.Index' (duration: 385.234782ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T09:00:52.181933Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:00:50.677471Z","time spent":"1.504429803s","remote":"127.0.0.1:58426","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7948,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-14T09:00:52.181984Z","caller":"traceutil/trace.go:171","msg":"trace[1768042978] transaction","detail":"{read_only:false; response_revision:2010; number_of_response:1; }","duration":"862.996015ms","start":"2026-08-14T09:00:51.318975Z","end":"2026-08-14T09:00:52.181971Z","steps":["trace[1768042978] 'process raft request' (duration: 862.85252ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:00:52.181991Z","caller":"traceutil/trace.go:171","msg":"trace[125568660] transaction","detail":"{read_only:false; response_revision:2008; number_of_response:1; }","duration":"1.174192136s","start":"2026-08-14T09:00:51.007792Z","end":"2026-08-14T09:00:52.181984Z","steps":["trace[125568660] 'process raft request' (duration: 1.173923326s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:00:52.18205Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:00:51.007763Z","time spent":"1.174252648s","remote":"127.0.0.1:58512","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-14T09:00:52.182088Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:00:51.318954Z","time spent":"863.058358ms","remote":"127.0.0.1:58512","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-14T09:00:52.181956Z","caller":"traceutil/trace.go:171","msg":"trace[433887852] transaction","detail":"{read_only:false; response_revision:2009; number_of_response:1; }","duration":"1.133208722s","start":"2026-08-14T09:00:51.048734Z","end":"2026-08-14T09:00:52.181943Z","steps":["trace[433887852] 'process raft request' (duration: 1.133054857s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:00:52.18218Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:00:51.04872Z","time spent":"1.1334216s","remote":"127.0.0.1:58512","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-14T09:00:52.182393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"6.086722061s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-08-14T09:00:52.182469Z","caller":"traceutil/trace.go:171","msg":"trace[779011882] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2010; }","duration":"6.086862837s","start":"2026-08-14T09:00:46.095586Z","end":"2026-08-14T09:00:52.182449Z","steps":["trace[779011882] 'agreement among raft nodes before linearized reading' (duration: 6.086500813s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:00:52.182517Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:00:46.095568Z","time spent":"6.08693829s","remote":"127.0.0.1:51824","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"info","ts":"2026-08-14T09:00:52.229639Z","caller":"traceutil/trace.go:171","msg":"trace[740491584] transaction","detail":"{read_only:false; response_revision:2011; number_of_response:1; }","duration":"417.57883ms","start":"2026-08-14T09:00:51.812039Z","end":"2026-08-14T09:00:52.229618Z","steps":["trace[740491584] 'process raft request' (duration: 417.414424ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:00:52.229687Z","caller":"traceutil/trace.go:171","msg":"trace[114719111] transaction","detail":"{read_only:false; response_revision:2012; number_of_response:1; }","duration":"417.608711ms","start":"2026-08-14T09:00:51.812049Z","end":"2026-08-14T09:00:52.229658Z","steps":["trace[114719111] 'process raft request' (duration: 417.501577ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:00:52.229785Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:00:51.812008Z","time spent":"417.703344ms","remote":"127.0.0.1:58412","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1138,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-14T09:00:52.229814Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:00:51.812018Z","time spent":"417.727205ms","remote":"127.0.0.1:58412","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1142,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-14T09:00:52.230113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.277269839s","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":"warn","ts":"2026-08-14T09:00:52.230124Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"5.867993504s","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-08-14T09:00:52.230152Z","caller":"traceutil/trace.go:171","msg":"trace[348466615] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:2014; }","duration":"1.277350973s","start":"2026-08-14T09:00:50.952791Z","end":"2026-08-14T09:00:52.230142Z","steps":["trace[348466615] 'agreement among raft nodes before linearized reading' (duration: 1.277291021s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:00:52.23016Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.158280448s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-08-14T09:00:52.230181Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:00:50.952765Z","time spent":"1.277410655s","remote":"127.0.0.1:53216","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true "} {"level":"warn","ts":"2026-08-14T09:00:52.230222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.241643236s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:11979"} {"level":"info","ts":"2026-08-14T09:00:52.23026Z","caller":"traceutil/trace.go:171","msg":"trace[225632563] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2014; }","duration":"4.241700887s","start":"2026-08-14T09:00:47.98855Z","end":"2026-08-14T09:00:52.230251Z","steps":["trace[225632563] 'agreement among raft nodes before linearized reading' (duration: 4.241618574s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:00:52.230273Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.195688415s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.170\" ","response":"range_response_count:1 size:135"} {"level":"warn","ts":"2026-08-14T09:00:52.23029Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:00:47.988537Z","time spent":"4.241747269s","remote":"127.0.0.1:58432","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12002,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-08-14T09:00:52.230325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.444748605s","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:7"} {"level":"info","ts":"2026-08-14T09:00:52.230343Z","caller":"traceutil/trace.go:171","msg":"trace[2086080353] transaction","detail":"{read_only:false; response_revision:2013; number_of_response:1; }","duration":"417.497507ms","start":"2026-08-14T09:00:51.812838Z","end":"2026-08-14T09:00:52.230335Z","steps":["trace[2086080353] 'process raft request' (duration: 416.743868ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:00:52.23035Z","caller":"traceutil/trace.go:171","msg":"trace[1502522809] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:2014; }","duration":"2.444773116s","start":"2026-08-14T09:00:49.785571Z","end":"2026-08-14T09:00:52.230344Z","steps":["trace[1502522809] 'agreement among raft nodes before linearized reading' (duration: 2.444733495s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:00:52.230374Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:00:49.785525Z","time spent":"2.444843638s","remote":"127.0.0.1:53278","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":1,"response size":30,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"warn","ts":"2026-08-14T09:00:52.230387Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:00:51.812824Z","time spent":"417.540758ms","remote":"127.0.0.1:58528","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1683,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-14T09:00:52.230463Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.330486837s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-14T09:00:52.230489Z","caller":"traceutil/trace.go:171","msg":"trace[1322203556] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:2014; }","duration":"4.33054998s","start":"2026-08-14T09:00:47.899931Z","end":"2026-08-14T09:00:52.230481Z","steps":["trace[1322203556] 'agreement among raft nodes before linearized reading' (duration: 4.330494838s)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:00:52.230511Z","caller":"traceutil/trace.go:171","msg":"trace[449394948] transaction","detail":"{read_only:false; response_revision:2014; number_of_response:1; }","duration":"417.098372ms","start":"2026-08-14T09:00:51.813404Z","end":"2026-08-14T09:00:52.230502Z","steps":["trace[449394948] 'process raft request' (duration: 416.484479ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:00:52.230513Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:00:47.899905Z","time spent":"4.330602512s","remote":"127.0.0.1:58446","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":15,"response size":30,"request content":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true "} {"level":"warn","ts":"2026-08-14T09:00:52.230517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.798311183s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/kube-apiserver-instance.18cba061e0fda7db\" ","response":"range_response_count:1 size:773"} {"level":"info","ts":"2026-08-14T09:00:52.230542Z","caller":"traceutil/trace.go:171","msg":"trace[1070384853] range","detail":"{range_begin:/registry/events/kube-system/kube-apiserver-instance.18cba061e0fda7db; range_end:; response_count:1; response_revision:2014; }","duration":"2.798360835s","start":"2026-08-14T09:00:49.432175Z","end":"2026-08-14T09:00:52.230536Z","steps":["trace[1070384853] 'agreement among raft nodes before linearized reading' (duration: 2.798299773s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:00:52.230549Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:00:51.813396Z","time spent":"417.131173ms","remote":"127.0.0.1:58528","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1701,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-14T09:00:52.230564Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:00:49.432156Z","time spent":"2.798399426s","remote":"127.0.0.1:58328","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":796,"request content":"key:\"/registry/events/kube-system/kube-apiserver-instance.18cba061e0fda7db\" "} {"level":"warn","ts":"2026-08-14T09:00:52.230118Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.793925061s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-14T09:00:52.230636Z","caller":"traceutil/trace.go:171","msg":"trace[377068041] range","detail":"{range_begin:/registry/validatingwebhookconfigurations/; range_end:/registry/validatingwebhookconfigurations0; response_count:0; response_revision:2014; }","duration":"3.794486021s","start":"2026-08-14T09:00:48.43614Z","end":"2026-08-14T09:00:52.230627Z","steps":["trace[377068041] 'agreement among raft nodes before linearized reading' (duration: 3.793944171s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:00:52.230661Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:00:48.436115Z","time spent":"3.794538303s","remote":"127.0.0.1:58752","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":3,"response size":30,"request content":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true "} {"level":"warn","ts":"2026-08-14T09:00:52.23067Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"5.470077145s","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-08-14T09:00:52.230694Z","caller":"traceutil/trace.go:171","msg":"trace[379238537] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2014; }","duration":"5.470135758s","start":"2026-08-14T09:00:46.76055Z","end":"2026-08-14T09:00:52.230686Z","steps":["trace[379238537] 'agreement among raft nodes before linearized reading' (duration: 5.470064675s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:00:52.230717Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:00:46.760532Z","time spent":"5.470179149s","remote":"127.0.0.1:58406","response type":"/etcdserverpb.KV/Range","request count":0,"request size":73,"response count":1,"response size":1876,"request content":"key:\"/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0\" "} {"level":"info","ts":"2026-08-14T09:00:52.230155Z","caller":"traceutil/trace.go:171","msg":"trace[215419733] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2014; }","duration":"5.868057666s","start":"2026-08-14T09:00:46.362089Z","end":"2026-08-14T09:00:52.230147Z","steps":["trace[215419733] 'agreement among raft nodes before linearized reading' (duration: 5.867934811s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:00:52.230711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.20350229s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-14T09:00:52.230746Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:00:46.362072Z","time spent":"5.868668849s","remote":"127.0.0.1:58512","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-08-14T09:00:52.230774Z","caller":"traceutil/trace.go:171","msg":"trace[1357051237] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2014; }","duration":"1.203602253s","start":"2026-08-14T09:00:51.027155Z","end":"2026-08-14T09:00:52.230757Z","steps":["trace[1357051237] 'agreement among raft nodes before linearized reading' (duration: 1.203459448s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:00:52.230806Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:00:51.027139Z","time spent":"1.203661146s","remote":"127.0.0.1:58256","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-08-14T09:00:52.230832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"5.609267858s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/issuers/\" range_end:\"/registry/cert-manager.io/issuers0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-14T09:00:52.230853Z","caller":"traceutil/trace.go:171","msg":"trace[653606960] range","detail":"{range_begin:/registry/cert-manager.io/issuers/; range_end:/registry/cert-manager.io/issuers0; response_count:0; response_revision:2014; }","duration":"5.60931592s","start":"2026-08-14T09:00:46.621531Z","end":"2026-08-14T09:00:52.230846Z","steps":["trace[653606960] 'agreement among raft nodes before linearized reading' (duration: 5.609281248s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:00:52.230869Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:00:46.621516Z","time spent":"5.60934868s","remote":"127.0.0.1:48454","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":30,"request content":"key:\"/registry/cert-manager.io/issuers/\" range_end:\"/registry/cert-manager.io/issuers0\" count_only:true "} {"level":"warn","ts":"2026-08-14T09:00:52.230876Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"461.459671ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-14T09:00:52.230899Z","caller":"traceutil/trace.go:171","msg":"trace[1141065460] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:2014; }","duration":"461.527554ms","start":"2026-08-14T09:00:51.769365Z","end":"2026-08-14T09:00:52.230892Z","steps":["trace[1141065460] 'agreement among raft nodes before linearized reading' (duration: 461.460352ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:00:52.230917Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:00:51.769342Z","time spent":"461.569955ms","remote":"127.0.0.1:58458","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":56,"response size":30,"request content":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true "} {"level":"warn","ts":"2026-08-14T09:00:52.230987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"5.74893388s","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-08-14T09:00:52.231007Z","caller":"traceutil/trace.go:171","msg":"trace[410177999] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2014; }","duration":"5.74895581s","start":"2026-08-14T09:00:46.482045Z","end":"2026-08-14T09:00:52.231001Z","steps":["trace[410177999] 'agreement among raft nodes before linearized reading' (duration: 5.748902768s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:00:52.231016Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"930.972096ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" ","response":"range_response_count:1 size:549"} {"level":"warn","ts":"2026-08-14T09:00:52.231024Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:00:46.481959Z","time spent":"5.749061064s","remote":"127.0.0.1:58512","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":"info","ts":"2026-08-14T09:00:52.231046Z","caller":"traceutil/trace.go:171","msg":"trace[10097960] range","detail":"{range_begin:/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io; range_end:; response_count:1; response_revision:2014; }","duration":"931.047488ms","start":"2026-08-14T09:00:51.299986Z","end":"2026-08-14T09:00:52.231033Z","steps":["trace[10097960] 'agreement among raft nodes before linearized reading' (duration: 930.992476ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:00:52.231066Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:00:51.299963Z","time spent":"931.09887ms","remote":"127.0.0.1:58512","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":572,"request content":"key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" "} {"level":"info","ts":"2026-08-14T09:00:52.230293Z","caller":"traceutil/trace.go:171","msg":"trace[1099057180] range","detail":"{range_begin:/registry/masterleases/199.19.213.170; range_end:; response_count:1; response_revision:2014; }","duration":"2.195739336s","start":"2026-08-14T09:00:50.034549Z","end":"2026-08-14T09:00:52.230288Z","steps":["trace[1099057180] 'agreement among raft nodes before linearized reading' (duration: 2.195648943s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:00:52.231108Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:00:50.034524Z","time spent":"2.196578268s","remote":"127.0.0.1:58290","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.19.213.170\" "} {"level":"warn","ts":"2026-08-14T09:00:52.231159Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"947.142184ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"warn","ts":"2026-08-14T09:00:52.230811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"927.618188ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T09:00:52.231178Z","caller":"traceutil/trace.go:171","msg":"trace[848358725] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2014; }","duration":"947.162935ms","start":"2026-08-14T09:00:51.28401Z","end":"2026-08-14T09:00:52.231173Z","steps":["trace[848358725] 'agreement among raft nodes before linearized reading' (duration: 947.109263ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:00:52.231196Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:00:51.283948Z","time spent":"947.244047ms","remote":"127.0.0.1:58512","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":578,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"info","ts":"2026-08-14T09:00:52.231196Z","caller":"traceutil/trace.go:171","msg":"trace[1929484134] range","detail":"{range_begin:/registry/csistoragecapacities/; range_end:/registry/csistoragecapacities0; response_count:0; response_revision:2014; }","duration":"928.030593ms","start":"2026-08-14T09:00:51.303158Z","end":"2026-08-14T09:00:52.231189Z","steps":["trace[1929484134] 'agreement among raft nodes before linearized reading' (duration: 927.629449ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:00:52.231219Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:00:51.303147Z","time spent":"928.065825ms","remote":"127.0.0.1:58668","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":0,"response size":28,"request content":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true "} {"level":"warn","ts":"2026-08-14T09:00:52.23135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.156603293s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:570"} {"level":"info","ts":"2026-08-14T09:00:52.231369Z","caller":"traceutil/trace.go:171","msg":"trace[916788989] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:2014; }","duration":"1.156663296s","start":"2026-08-14T09:00:51.0747Z","end":"2026-08-14T09:00:52.231364Z","steps":["trace[916788989] 'agreement among raft nodes before linearized reading' (duration: 1.156629904s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:00:52.231386Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:00:51.074681Z","time spent":"1.156701246s","remote":"127.0.0.1:58512","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":593,"request content":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" "} {"level":"warn","ts":"2026-08-14T09:00:52.23102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"579.03999ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T09:00:52.231413Z","caller":"traceutil/trace.go:171","msg":"trace[2005020832] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2014; }","duration":"579.475997ms","start":"2026-08-14T09:00:51.65193Z","end":"2026-08-14T09:00:52.231406Z","steps":["trace[2005020832] 'agreement among raft nodes before linearized reading' (duration: 579.074642ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:00:52.231439Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:00:51.651903Z","time spent":"579.529069ms","remote":"127.0.0.1:58246","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-08-14T09:00:52.230185Z","caller":"traceutil/trace.go:171","msg":"trace[1862503708] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:2014; }","duration":"2.15832313s","start":"2026-08-14T09:00:50.071854Z","end":"2026-08-14T09:00:52.230177Z","steps":["trace[1862503708] 'agreement among raft nodes before linearized reading' (duration: 2.158283019s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:00:52.231477Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:00:50.071843Z","time spent":"2.159625049s","remote":"127.0.0.1:58694","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":8,"response size":30,"request content":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true "} {"level":"info","ts":"2026-08-14T09:00:52.37625Z","caller":"traceutil/trace.go:171","msg":"trace[1298039091] transaction","detail":"{read_only:false; response_revision:2015; number_of_response:1; }","duration":"140.945719ms","start":"2026-08-14T09:00:52.235265Z","end":"2026-08-14T09:00:52.37621Z","steps":["trace[1298039091] 'process raft request' (duration: 94.838822ms)","trace[1298039091] 'compare' (duration: 45.825096ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T09:00:52.376743Z","caller":"traceutil/trace.go:171","msg":"trace[1192624244] transaction","detail":"{read_only:false; response_revision:2016; number_of_response:1; }","duration":"138.620481ms","start":"2026-08-14T09:00:52.2381Z","end":"2026-08-14T09:00:52.37672Z","steps":["trace[1192624244] 'process raft request' (duration: 138.021339ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:00:52.376817Z","caller":"traceutil/trace.go:171","msg":"trace[1788600133] linearizableReadLoop","detail":"{readStateIndex:2100; appliedIndex:2097; }","duration":"112.731511ms","start":"2026-08-14T09:00:52.264059Z","end":"2026-08-14T09:00:52.37679Z","steps":["trace[1788600133] 'read index received' (duration: 65.998091ms)","trace[1788600133] 'applied index is now lower than readState.Index' (duration: 46.73153ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T09:00:52.376865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.697214ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T09:00:52.376943Z","caller":"traceutil/trace.go:171","msg":"trace[1605456309] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:2017; }","duration":"138.794708ms","start":"2026-08-14T09:00:52.238134Z","end":"2026-08-14T09:00:52.376929Z","steps":["trace[1605456309] 'agreement among raft nodes before linearized reading' (duration: 138.665043ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:00:52.377063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.069981ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-14T09:00:52.37707Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.75242ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"info","ts":"2026-08-14T09:00:52.377114Z","caller":"traceutil/trace.go:171","msg":"trace[886770861] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2017; }","duration":"138.159634ms","start":"2026-08-14T09:00:52.238941Z","end":"2026-08-14T09:00:52.377101Z","steps":["trace[886770861] 'agreement among raft nodes before linearized reading' (duration: 138.05626ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:00:52.377125Z","caller":"traceutil/trace.go:171","msg":"trace[1814634314] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2017; }","duration":"141.816912ms","start":"2026-08-14T09:00:52.235293Z","end":"2026-08-14T09:00:52.37711Z","steps":["trace[1814634314] 'agreement among raft nodes before linearized reading' (duration: 141.669845ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:00:52.377189Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.669786ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" ","response":"range_response_count:1 size:549"} {"level":"info","ts":"2026-08-14T09:00:52.377288Z","caller":"traceutil/trace.go:171","msg":"trace[1925487101] range","detail":"{range_begin:/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io; range_end:; response_count:1; response_revision:2017; }","duration":"141.78917ms","start":"2026-08-14T09:00:52.235472Z","end":"2026-08-14T09:00:52.377262Z","steps":["trace[1925487101] 'agreement among raft nodes before linearized reading' (duration: 141.510529ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:00:52.377354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.266306ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-46a3e29c-9a00-4f02-a4e8-94b02b70e7d0\" ","response":"range_response_count:1 size:1303"} {"level":"info","ts":"2026-08-14T09:00:52.377402Z","caller":"traceutil/trace.go:171","msg":"trace[2090588821] range","detail":"{range_begin:/registry/persistentvolumes/pvc-46a3e29c-9a00-4f02-a4e8-94b02b70e7d0; range_end:; response_count:1; response_revision:2017; }","duration":"139.324548ms","start":"2026-08-14T09:00:52.238065Z","end":"2026-08-14T09:00:52.37739Z","steps":["trace[2090588821] 'agreement among raft nodes before linearized reading' (duration: 139.171342ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:00:52.377686Z","caller":"traceutil/trace.go:171","msg":"trace[1111400544] transaction","detail":"{read_only:false; response_revision:2018; number_of_response:1; }","duration":"112.378928ms","start":"2026-08-14T09:00:52.265285Z","end":"2026-08-14T09:00:52.377664Z","steps":["trace[1111400544] 'process raft request' (duration: 110.980496ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:00:52.376724Z","caller":"traceutil/trace.go:171","msg":"trace[694326112] transaction","detail":"{read_only:false; response_revision:2017; number_of_response:1; }","duration":"138.543359ms","start":"2026-08-14T09:00:52.238138Z","end":"2026-08-14T09:00:52.376681Z","steps":["trace[694326112] 'process raft request' (duration: 138.053271ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:01:08.951188Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11858716688502134458,"retry-timeout":"500ms"} {"level":"info","ts":"2026-08-14T09:01:09.108957Z","caller":"traceutil/trace.go:171","msg":"trace[1795884606] transaction","detail":"{read_only:false; response_revision:2113; number_of_response:1; }","duration":"670.873729ms","start":"2026-08-14T09:01:08.438061Z","end":"2026-08-14T09:01:09.108935Z","steps":["trace[1795884606] 'process raft request' (duration: 668.617802ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:01:09.10908Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:01:08.438041Z","time spent":"670.971042ms","remote":"127.0.0.1:58512","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-14T09:01:09.109129Z","caller":"traceutil/trace.go:171","msg":"trace[50572058] linearizableReadLoop","detail":"{readStateIndex:2200; appliedIndex:2198; }","duration":"658.307119ms","start":"2026-08-14T09:01:08.450811Z","end":"2026-08-14T09:01:09.109118Z","steps":["trace[50572058] 'read index received' (duration: 655.778913ms)","trace[50572058] 'applied index is now lower than readState.Index' (duration: 2.527726ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T09:01:09.109196Z","caller":"traceutil/trace.go:171","msg":"trace[392155316] transaction","detail":"{read_only:false; response_revision:2114; number_of_response:1; }","duration":"669.986938ms","start":"2026-08-14T09:01:08.439204Z","end":"2026-08-14T09:01:09.109191Z","steps":["trace[392155316] 'process raft request' (duration: 669.639756ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:01:09.109238Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:01:08.43918Z","time spent":"670.0275ms","remote":"127.0.0.1:58512","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-08-14T09:01:09.109328Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"658.517086ms","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-08-14T09:01:09.109387Z","caller":"traceutil/trace.go:171","msg":"trace[1312158535] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2114; }","duration":"658.602069ms","start":"2026-08-14T09:01:08.450779Z","end":"2026-08-14T09:01:09.109382Z","steps":["trace[1312158535] 'agreement among raft nodes before linearized reading' (duration: 658.496575ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:01:09.109401Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:01:08.450771Z","time spent":"658.627109ms","remote":"127.0.0.1:58512","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-08-14T09:01:09.109466Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"658.339208ms","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-08-14T09:01:09.109481Z","caller":"traceutil/trace.go:171","msg":"trace[381038787] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2114; }","duration":"658.354229ms","start":"2026-08-14T09:01:08.451122Z","end":"2026-08-14T09:01:09.109476Z","steps":["trace[381038787] 'agreement among raft nodes before linearized reading' (duration: 658.315948ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:01:09.109494Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:01:08.451102Z","time spent":"658.38854ms","remote":"127.0.0.1:58512","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-08-14T09:01:09.109557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.453696ms","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-08-14T09:01:09.109572Z","caller":"traceutil/trace.go:171","msg":"trace[523783629] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2114; }","duration":"276.506959ms","start":"2026-08-14T09:01:08.833058Z","end":"2026-08-14T09:01:09.109565Z","steps":["trace[523783629] 'agreement among raft nodes before linearized reading' (duration: 276.467448ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:01:09.109671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"466.566764ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T09:01:09.109689Z","caller":"traceutil/trace.go:171","msg":"trace[1457260138] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2114; }","duration":"466.635517ms","start":"2026-08-14T09:01:08.643049Z","end":"2026-08-14T09:01:09.109685Z","steps":["trace[1457260138] 'agreement among raft nodes before linearized reading' (duration: 466.609566ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:01:09.109704Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:01:08.64302Z","time spent":"466.679278ms","remote":"127.0.0.1:58256","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-08-14T09:01:09.109784Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"633.243948ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/\" range_end:\"/registry/cert-manager.io/certificates0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-14T09:01:09.109802Z","caller":"traceutil/trace.go:171","msg":"trace[1014413465] range","detail":"{range_begin:/registry/cert-manager.io/certificates/; range_end:/registry/cert-manager.io/certificates0; response_count:0; response_revision:2114; }","duration":"633.30287ms","start":"2026-08-14T09:01:08.476494Z","end":"2026-08-14T09:01:09.109797Z","steps":["trace[1014413465] 'agreement among raft nodes before linearized reading' (duration: 633.271889ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:01:09.10982Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:01:08.476474Z","time spent":"633.341981ms","remote":"127.0.0.1:46168","response type":"/etcdserverpb.KV/Range","request count":0,"request size":84,"response count":2,"response size":30,"request content":"key:\"/registry/cert-manager.io/certificates/\" range_end:\"/registry/cert-manager.io/certificates0\" count_only:true "} {"level":"warn","ts":"2026-08-14T09:01:10.863424Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11858716688502134483,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-14T09:01:11.477051Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11858716688502134483,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-14T09:01:12.013851Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11858716688502134483,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-14T09:01:12.455133Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.131657175s","expected-duration":"1s"} {"level":"info","ts":"2026-08-14T09:01:12.45551Z","caller":"traceutil/trace.go:171","msg":"trace[1960764721] transaction","detail":"{read_only:false; response_revision:2122; number_of_response:1; }","duration":"2.132141311s","start":"2026-08-14T09:01:10.323345Z","end":"2026-08-14T09:01:12.455486Z","steps":["trace[1960764721] 'process raft request' (duration: 2.131969896s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:01:12.455636Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:01:10.323315Z","time spent":"2.132251265s","remote":"127.0.0.1:58512","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":543,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-14T09:01:12.465916Z","caller":"traceutil/trace.go:171","msg":"trace[757443001] linearizableReadLoop","detail":"{readStateIndex:2212; appliedIndex:2208; }","duration":"2.102689859s","start":"2026-08-14T09:01:10.363208Z","end":"2026-08-14T09:01:12.465898Z","steps":["trace[757443001] 'read index received' (duration: 2.092111715s)","trace[757443001] 'applied index is now lower than readState.Index' (duration: 10.577294ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T09:01:12.466126Z","caller":"traceutil/trace.go:171","msg":"trace[2116291020] transaction","detail":"{read_only:false; response_revision:2123; number_of_response:1; }","duration":"2.141764973s","start":"2026-08-14T09:01:10.324353Z","end":"2026-08-14T09:01:12.466118Z","steps":["trace[2116291020] 'process raft request' (duration: 2.141331949s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:01:12.466217Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:01:10.324327Z","time spent":"2.141818365s","remote":"127.0.0.1:58512","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-14T09:01:12.466353Z","caller":"traceutil/trace.go:171","msg":"trace[718328796] transaction","detail":"{read_only:false; response_revision:2124; number_of_response:1; }","duration":"1.351940632s","start":"2026-08-14T09:01:11.114405Z","end":"2026-08-14T09:01:12.466346Z","steps":["trace[718328796] 'process raft request' (duration: 1.351365853s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:01:12.466388Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:01:11.114378Z","time spent":"1.351989944s","remote":"127.0.0.1:58512","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-14T09:01:12.466468Z","caller":"traceutil/trace.go:171","msg":"trace[1793457289] transaction","detail":"{read_only:false; response_revision:2125; number_of_response:1; }","duration":"987.894606ms","start":"2026-08-14T09:01:11.478566Z","end":"2026-08-14T09:01:12.46646Z","steps":["trace[1793457289] 'process raft request' (duration: 987.232663ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:01:12.466659Z","caller":"traceutil/trace.go:171","msg":"trace[574275392] transaction","detail":"{read_only:false; response_revision:2127; number_of_response:1; }","duration":"221.792741ms","start":"2026-08-14T09:01:12.244853Z","end":"2026-08-14T09:01:12.466646Z","steps":["trace[574275392] 'process raft request' (duration: 220.993314ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:01:12.466791Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"894.543436ms","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-08-14T09:01:12.466804Z","caller":"traceutil/trace.go:171","msg":"trace[750640048] transaction","detail":"{read_only:false; response_revision:2126; number_of_response:1; }","duration":"233.856655ms","start":"2026-08-14T09:01:12.23294Z","end":"2026-08-14T09:01:12.466797Z","steps":["trace[750640048] 'process raft request' (duration: 232.877252ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:01:12.46682Z","caller":"traceutil/trace.go:171","msg":"trace[1586784920] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2127; }","duration":"894.606978ms","start":"2026-08-14T09:01:11.572203Z","end":"2026-08-14T09:01:12.46681Z","steps":["trace[1586784920] 'agreement among raft nodes before linearized reading' (duration: 894.537496ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:01:12.466805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.10358938s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"warn","ts":"2026-08-14T09:01:12.466813Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"837.471411ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"warn","ts":"2026-08-14T09:01:12.46684Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:01:11.572183Z","time spent":"894.65254ms","remote":"127.0.0.1:58512","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-08-14T09:01:12.466861Z","caller":"traceutil/trace.go:171","msg":"trace[695261668] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2127; }","duration":"2.103695363s","start":"2026-08-14T09:01:10.363151Z","end":"2026-08-14T09:01:12.466847Z","steps":["trace[695261668] 'agreement among raft nodes before linearized reading' (duration: 2.103495707s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:01:12.466891Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:01:10.363125Z","time spent":"2.103760696s","remote":"127.0.0.1:51824","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"info","ts":"2026-08-14T09:01:12.466882Z","caller":"traceutil/trace.go:171","msg":"trace[1003268447] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2127; }","duration":"837.576525ms","start":"2026-08-14T09:01:11.629288Z","end":"2026-08-14T09:01:12.466864Z","steps":["trace[1003268447] 'agreement among raft nodes before linearized reading' (duration: 837.349137ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:01:12.466905Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"988.03384ms","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-08-14T09:01:12.466937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.349165059s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-08-14T09:01:12.46693Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:01:11.629206Z","time spent":"837.711159ms","remote":"127.0.0.1:58512","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-08-14T09:01:12.466947Z","caller":"traceutil/trace.go:171","msg":"trace[755751795] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2127; }","duration":"988.092872ms","start":"2026-08-14T09:01:11.478839Z","end":"2026-08-14T09:01:12.466932Z","steps":["trace[755751795] 'agreement among raft nodes before linearized reading' (duration: 988.004959ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:01:12.466963Z","caller":"traceutil/trace.go:171","msg":"trace[1423466687] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2127; }","duration":"1.349210441s","start":"2026-08-14T09:01:11.11774Z","end":"2026-08-14T09:01:12.46695Z","steps":["trace[1423466687] 'agreement among raft nodes before linearized reading' (duration: 1.349154789s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:01:12.466986Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:01:11.117729Z","time spent":"1.349251122s","remote":"127.0.0.1:58512","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-08-14T09:01:12.466984Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:01:11.478831Z","time spent":"988.146164ms","remote":"127.0.0.1:58512","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-08-14T09:01:12.466805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.347232563s","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-08-14T09:01:12.467052Z","caller":"traceutil/trace.go:171","msg":"trace[49373718] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2127; }","duration":"1.347526723s","start":"2026-08-14T09:01:11.119517Z","end":"2026-08-14T09:01:12.467044Z","steps":["trace[49373718] 'agreement among raft nodes before linearized reading' (duration: 1.347121139s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:01:12.467075Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:01:11.119507Z","time spent":"1.347560724s","remote":"127.0.0.1:58512","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-08-14T09:01:12.467108Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"352.689791ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-08-14T09:01:12.467117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.633664695s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/clusterissuers/\" range_end:\"/registry/cert-manager.io/clusterissuers0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-14T09:01:12.467151Z","caller":"traceutil/trace.go:171","msg":"trace[1406372409] range","detail":"{range_begin:/registry/cert-manager.io/clusterissuers/; range_end:/registry/cert-manager.io/clusterissuers0; response_count:0; response_revision:2127; }","duration":"1.633736487s","start":"2026-08-14T09:01:10.833406Z","end":"2026-08-14T09:01:12.467143Z","steps":["trace[1406372409] 'agreement among raft nodes before linearized reading' (duration: 1.633684035s)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:01:12.467155Z","caller":"traceutil/trace.go:171","msg":"trace[834923773] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:2127; }","duration":"352.775624ms","start":"2026-08-14T09:01:12.114363Z","end":"2026-08-14T09:01:12.467138Z","steps":["trace[834923773] 'agreement among raft nodes before linearized reading' (duration: 352.66519ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:01:12.467172Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:01:10.833383Z","time spent":"1.633783199s","remote":"127.0.0.1:48442","response type":"/etcdserverpb.KV/Range","request count":0,"request size":88,"response count":2,"response size":30,"request content":"key:\"/registry/cert-manager.io/clusterissuers/\" range_end:\"/registry/cert-manager.io/clusterissuers0\" count_only:true "} {"level":"warn","ts":"2026-08-14T09:01:12.467199Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:01:12.11434Z","time spent":"352.846276ms","remote":"127.0.0.1:58306","response type":"/etcdserverpb.KV/Range","request count":0,"request size":120,"response count":54,"response size":30,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true "} {"level":"warn","ts":"2026-08-14T09:01:12.467207Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:01:11.478545Z","time spent":"987.937596ms","remote":"127.0.0.1:58512","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-14T09:01:12.467421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.825904233s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T09:01:12.467476Z","caller":"traceutil/trace.go:171","msg":"trace[1626203339] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2127; }","duration":"1.825988416s","start":"2026-08-14T09:01:10.641478Z","end":"2026-08-14T09:01:12.467466Z","steps":["trace[1626203339] 'agreement among raft nodes before linearized reading' (duration: 1.825050995s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:01:12.467548Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:01:10.64146Z","time spent":"1.826082409s","remote":"127.0.0.1:58256","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-08-14T09:01:20.784661Z","caller":"traceutil/trace.go:171","msg":"trace[160533858] transaction","detail":"{read_only:false; response_revision:2167; number_of_response:1; }","duration":"274.275846ms","start":"2026-08-14T09:01:20.510358Z","end":"2026-08-14T09:01:20.784634Z","steps":["trace[160533858] 'process raft request' (duration: 274.126832ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:01:20.87852Z","caller":"traceutil/trace.go:171","msg":"trace[1824432577] transaction","detail":"{read_only:false; response_revision:2169; number_of_response:1; }","duration":"360.832039ms","start":"2026-08-14T09:01:20.517649Z","end":"2026-08-14T09:01:20.878481Z","steps":["trace[1824432577] 'process raft request' (duration: 360.683765ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:01:20.878636Z","caller":"traceutil/trace.go:171","msg":"trace[2011698515] linearizableReadLoop","detail":"{readStateIndex:2259; appliedIndex:2256; }","duration":"352.033516ms","start":"2026-08-14T09:01:20.5265Z","end":"2026-08-14T09:01:20.878533Z","steps":["trace[2011698515] 'read index received' (duration: 257.968362ms)","trace[2011698515] 'applied index is now lower than readState.Index' (duration: 94.063744ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T09:01:20.878715Z","caller":"traceutil/trace.go:171","msg":"trace[1512559940] transaction","detail":"{read_only:false; response_revision:2168; number_of_response:1; }","duration":"362.299307ms","start":"2026-08-14T09:01:20.516406Z","end":"2026-08-14T09:01:20.878706Z","steps":["trace[1512559940] 'process raft request' (duration: 361.550203ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:01:20.878762Z","caller":"traceutil/trace.go:171","msg":"trace[960206379] transaction","detail":"{read_only:false; response_revision:2170; number_of_response:1; }","duration":"301.827344ms","start":"2026-08-14T09:01:20.576923Z","end":"2026-08-14T09:01:20.87875Z","steps":["trace[960206379] 'process raft request' (duration: 301.515743ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:01:20.878766Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:01:20.516388Z","time spent":"362.353368ms","remote":"127.0.0.1:58512","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-08-14T09:01:20.878665Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:01:20.517635Z","time spent":"360.951894ms","remote":"127.0.0.1:58512","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-14T09:01:20.878875Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:01:20.576903Z","time spent":"301.890865ms","remote":"127.0.0.1:58512","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-14T09:01:20.878973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"352.467241ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-08-14T09:01:20.879013Z","caller":"traceutil/trace.go:171","msg":"trace[171445421] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2170; }","duration":"352.532933ms","start":"2026-08-14T09:01:20.526467Z","end":"2026-08-14T09:01:20.879Z","steps":["trace[171445421] 'agreement among raft nodes before linearized reading' (duration: 352.368687ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:01:20.879047Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:01:20.526449Z","time spent":"352.591245ms","remote":"127.0.0.1:51824","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-08-14T09:01:20.879127Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"349.841436ms","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-08-14T09:01:20.879162Z","caller":"traceutil/trace.go:171","msg":"trace[671020147] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2170; }","duration":"349.899938ms","start":"2026-08-14T09:01:20.529251Z","end":"2026-08-14T09:01:20.879151Z","steps":["trace[671020147] 'agreement among raft nodes before linearized reading' (duration: 349.773054ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:01:20.87915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"352.220924ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-08-14T09:01:20.879193Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:01:20.529238Z","time spent":"349.948379ms","remote":"127.0.0.1:58512","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":"info","ts":"2026-08-14T09:01:20.879218Z","caller":"traceutil/trace.go:171","msg":"trace[962342827] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2170; }","duration":"352.303546ms","start":"2026-08-14T09:01:20.526893Z","end":"2026-08-14T09:01:20.879197Z","steps":["trace[962342827] 'agreement among raft nodes before linearized reading' (duration: 352.101589ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:01:20.879285Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:01:20.526875Z","time spent":"352.401789ms","remote":"127.0.0.1:58512","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-08-14T09:01:20.879405Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.143036ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-08-14T09:01:20.879602Z","caller":"traceutil/trace.go:171","msg":"trace[706749783] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2170; }","duration":"350.362383ms","start":"2026-08-14T09:01:20.52922Z","end":"2026-08-14T09:01:20.879583Z","steps":["trace[706749783] 'agreement among raft nodes before linearized reading' (duration: 350.068574ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:01:20.879647Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:01:20.529205Z","time spent":"350.434315ms","remote":"127.0.0.1:58512","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-08-14T09:01:20.879795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"351.007173ms","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-08-14T09:01:20.879838Z","caller":"traceutil/trace.go:171","msg":"trace[1475445268] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2170; }","duration":"351.083106ms","start":"2026-08-14T09:01:20.528742Z","end":"2026-08-14T09:01:20.879825Z","steps":["trace[1475445268] 'agreement among raft nodes before linearized reading' (duration: 350.982742ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:01:20.879869Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:01:20.528729Z","time spent":"351.132697ms","remote":"127.0.0.1:58512","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-08-14T09:01:20.879869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.999061ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T09:01:20.879915Z","caller":"traceutil/trace.go:171","msg":"trace[83352802] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2170; }","duration":"238.082614ms","start":"2026-08-14T09:01:20.641818Z","end":"2026-08-14T09:01:20.879901Z","steps":["trace[83352802] 'agreement among raft nodes before linearized reading' (duration: 238.016182ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:01:20.880049Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.189918ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-08-14T09:01:20.880109Z","caller":"traceutil/trace.go:171","msg":"trace[239993858] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2170; }","duration":"350.273331ms","start":"2026-08-14T09:01:20.529822Z","end":"2026-08-14T09:01:20.880095Z","steps":["trace[239993858] 'agreement among raft nodes before linearized reading' (duration: 350.120805ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:01:20.88015Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:01:20.529814Z","time spent":"350.326352ms","remote":"127.0.0.1:58512","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-08-14T09:01:21.108255Z","caller":"traceutil/trace.go:171","msg":"trace[409367679] transaction","detail":"{read_only:false; response_revision:2172; number_of_response:1; }","duration":"223.170438ms","start":"2026-08-14T09:01:20.88505Z","end":"2026-08-14T09:01:21.108221Z","steps":["trace[409367679] 'process raft request' (duration: 163.148199ms)","trace[409367679] 'compare' (duration: 59.617276ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T09:01:21.108258Z","caller":"traceutil/trace.go:171","msg":"trace[1077485607] transaction","detail":"{read_only:false; response_revision:2174; number_of_response:1; }","duration":"222.684383ms","start":"2026-08-14T09:01:20.885547Z","end":"2026-08-14T09:01:21.108231Z","steps":["trace[1077485607] 'process raft request' (duration: 222.614639ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:01:21.108327Z","caller":"traceutil/trace.go:171","msg":"trace[1734866073] transaction","detail":"{read_only:false; response_revision:2175; number_of_response:1; }","duration":"222.522587ms","start":"2026-08-14T09:01:20.885775Z","end":"2026-08-14T09:01:21.108298Z","steps":["trace[1734866073] 'process raft request' (duration: 222.421293ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:01:21.108455Z","caller":"traceutil/trace.go:171","msg":"trace[328409066] transaction","detail":"{read_only:false; response_revision:2173; number_of_response:1; }","duration":"222.998322ms","start":"2026-08-14T09:01:20.885437Z","end":"2026-08-14T09:01:21.108435Z","steps":["trace[328409066] 'process raft request' (duration: 222.63764ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:03:15.468663Z","caller":"traceutil/trace.go:171","msg":"trace[1254912874] transaction","detail":"{read_only:false; response_revision:2891; number_of_response:1; }","duration":"167.404362ms","start":"2026-08-14T09:03:15.301239Z","end":"2026-08-14T09:03:15.468643Z","steps":["trace[1254912874] 'process raft request' (duration: 167.315621ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:03:15.468676Z","caller":"traceutil/trace.go:171","msg":"trace[873146682] transaction","detail":"{read_only:false; response_revision:2890; number_of_response:1; }","duration":"169.86755ms","start":"2026-08-14T09:03:15.298766Z","end":"2026-08-14T09:03:15.468633Z","steps":["trace[873146682] 'process raft request' (duration: 112.38707ms)","trace[873146682] 'compare' (duration: 57.264456ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T09:03:15.46915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.026685ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-08-14T09:03:15.469236Z","caller":"traceutil/trace.go:171","msg":"trace[1958139735] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2891; }","duration":"111.188488ms","start":"2026-08-14T09:03:15.358029Z","end":"2026-08-14T09:03:15.469217Z","steps":["trace[1958139735] 'agreement among raft nodes before linearized reading' (duration: 110.900662ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:03:15.469405Z","caller":"traceutil/trace.go:171","msg":"trace[933582497] linearizableReadLoop","detail":"{readStateIndex:3006; appliedIndex:3004; }","duration":"110.531785ms","start":"2026-08-14T09:03:15.35807Z","end":"2026-08-14T09:03:15.468602Z","steps":["trace[933582497] 'read index received' (duration: 53.068495ms)","trace[933582497] 'applied index is now lower than readState.Index' (duration: 57.46239ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T09:06:52.876589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.740428ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-14T09:06:52.876694Z","caller":"traceutil/trace.go:171","msg":"trace[1132939990] linearizableReadLoop","detail":"{readStateIndex:4846; appliedIndex:4845; }","duration":"236.821607ms","start":"2026-08-14T09:06:52.639855Z","end":"2026-08-14T09:06:52.876677Z","steps":["trace[1132939990] 'read index received' (duration: 3.839297ms)","trace[1132939990] 'applied index is now lower than readState.Index' (duration: 232.98096ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T09:06:52.87681Z","caller":"traceutil/trace.go:171","msg":"trace[421174482] transaction","detail":"{read_only:false; response_revision:4664; number_of_response:1; }","duration":"310.35195ms","start":"2026-08-14T09:06:52.566421Z","end":"2026-08-14T09:06:52.876773Z","steps":["trace[421174482] 'process raft request' (duration: 188.347188ms)","trace[421174482] 'compare' (duration: 121.636787ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T09:06:52.876827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.955308ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T09:06:52.87696Z","caller":"traceutil/trace.go:171","msg":"trace[2082953876] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4664; }","duration":"237.126681ms","start":"2026-08-14T09:06:52.639814Z","end":"2026-08-14T09:06:52.876941Z","steps":["trace[2082953876] 'agreement among raft nodes before linearized reading' (duration: 236.959799ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:06:52.877008Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:06:52.566388Z","time spent":"310.550702ms","remote":"127.0.0.1:58512","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-14T09:07:00.529008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.099683ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-14T09:07:00.52913Z","caller":"traceutil/trace.go:171","msg":"trace[1209832787] transaction","detail":"{read_only:false; response_revision:4843; number_of_response:1; }","duration":"243.913048ms","start":"2026-08-14T09:07:00.285195Z","end":"2026-08-14T09:07:00.529108Z","steps":["trace[1209832787] 'process raft request' (duration: 42.622293ms)","trace[1209832787] 'compare' (duration: 200.747669ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T09:07:00.544246Z","caller":"traceutil/trace.go:171","msg":"trace[995664791] transaction","detail":"{read_only:false; response_revision:4844; number_of_response:1; }","duration":"243.585785ms","start":"2026-08-14T09:07:00.300638Z","end":"2026-08-14T09:07:00.544223Z","steps":["trace[995664791] 'process raft request' (duration: 243.446824ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:07:00.548945Z","caller":"traceutil/trace.go:171","msg":"trace[438703925] linearizableReadLoop","detail":"{readStateIndex:5034; appliedIndex:5032; }","duration":"132.266703ms","start":"2026-08-14T09:07:00.416666Z","end":"2026-08-14T09:07:00.548933Z","steps":["trace[438703925] 'read index received' (duration: 127.214763ms)","trace[438703925] 'applied index is now lower than readState.Index' (duration: 5.05117ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T09:07:00.549081Z","caller":"traceutil/trace.go:171","msg":"trace[56101676] transaction","detail":"{read_only:false; response_revision:4846; number_of_response:1; }","duration":"130.684485ms","start":"2026-08-14T09:07:00.418367Z","end":"2026-08-14T09:07:00.549052Z","steps":["trace[56101676] 'process raft request' (duration: 130.508453ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:07:00.549124Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.440795ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-39c6207e-47bd-41f8-8564-d73780169bd6\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-08-14T09:07:00.548995Z","caller":"traceutil/trace.go:171","msg":"trace[1836348332] transaction","detail":"{read_only:false; response_revision:4845; number_of_response:1; }","duration":"166.090651ms","start":"2026-08-14T09:07:00.382868Z","end":"2026-08-14T09:07:00.548959Z","steps":["trace[1836348332] 'process raft request' (duration: 165.916329ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:07:00.549352Z","caller":"traceutil/trace.go:171","msg":"trace[284077650] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-39c6207e-47bd-41f8-8564-d73780169bd6; range_end:; response_count:1; response_revision:4846; }","duration":"132.702819ms","start":"2026-08-14T09:07:00.416639Z","end":"2026-08-14T09:07:00.549342Z","steps":["trace[284077650] 'agreement among raft nodes before linearized reading' (duration: 132.338044ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:07:12.932796Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.671128ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-14T09:07:12.933036Z","caller":"traceutil/trace.go:171","msg":"trace[661096336] linearizableReadLoop","detail":"{readStateIndex:5207; appliedIndex:5205; }","duration":"195.179154ms","start":"2026-08-14T09:07:12.73784Z","end":"2026-08-14T09:07:12.93302Z","steps":["trace[661096336] 'read index received' (duration: 79.195783ms)","trace[661096336] 'applied index is now lower than readState.Index' (duration: 115.982321ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T09:07:12.933149Z","caller":"traceutil/trace.go:171","msg":"trace[48817117] transaction","detail":"{read_only:false; response_revision:5013; number_of_response:1; }","duration":"279.861414ms","start":"2026-08-14T09:07:12.653234Z","end":"2026-08-14T09:07:12.933096Z","steps":["trace[48817117] 'process raft request' (duration: 279.697392ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:07:12.933207Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.360956ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-08-14T09:07:12.933202Z","caller":"traceutil/trace.go:171","msg":"trace[1214927359] transaction","detail":"{read_only:false; response_revision:5012; number_of_response:1; }","duration":"286.156559ms","start":"2026-08-14T09:07:12.646994Z","end":"2026-08-14T09:07:12.933151Z","steps":["trace[1214927359] 'process raft request' (duration: 169.921434ms)","trace[1214927359] 'compare' (duration: 115.279014ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T09:07:12.933246Z","caller":"traceutil/trace.go:171","msg":"trace[1463901391] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5013; }","duration":"195.435348ms","start":"2026-08-14T09:07:12.737797Z","end":"2026-08-14T09:07:12.933233Z","steps":["trace[1463901391] 'agreement among raft nodes before linearized reading' (duration: 195.277736ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:07:54.503281Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.826963ms","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-08-14T09:07:54.503379Z","caller":"traceutil/trace.go:171","msg":"trace[1042504743] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:5399; }","duration":"244.982914ms","start":"2026-08-14T09:07:54.258372Z","end":"2026-08-14T09:07:54.503355Z","steps":["trace[1042504743] 'count revisions from in-memory index tree' (duration: 244.734372ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:07:54.503943Z","caller":"traceutil/trace.go:171","msg":"trace[1647229896] linearizableReadLoop","detail":"{readStateIndex:5603; appliedIndex:5602; }","duration":"122.534612ms","start":"2026-08-14T09:07:54.381384Z","end":"2026-08-14T09:07:54.503919Z","steps":["trace[1647229896] 'read index received' (duration: 122.30334ms)","trace[1647229896] 'applied index is now lower than readState.Index' (duration: 229.972µs)"],"step_count":2} {"level":"info","ts":"2026-08-14T09:07:54.504165Z","caller":"traceutil/trace.go:171","msg":"trace[1362103222] transaction","detail":"{read_only:false; response_revision:5400; number_of_response:1; }","duration":"188.004738ms","start":"2026-08-14T09:07:54.316124Z","end":"2026-08-14T09:07:54.504128Z","steps":["trace[1362103222] 'process raft request' (duration: 187.631834ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:07:54.504203Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.807555ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/keystone-fernet-setup\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T09:07:54.504334Z","caller":"traceutil/trace.go:171","msg":"trace[1458198553] range","detail":"{range_begin:/registry/jobs/openstack/keystone-fernet-setup; range_end:; response_count:0; response_revision:5400; }","duration":"122.948847ms","start":"2026-08-14T09:07:54.381369Z","end":"2026-08-14T09:07:54.504317Z","steps":["trace[1458198553] 'agreement among raft nodes before linearized reading' (duration: 122.752635ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:07:54.504571Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.485592ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/keystone-db-sync\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T09:07:54.504615Z","caller":"traceutil/trace.go:171","msg":"trace[343743540] range","detail":"{range_begin:/registry/jobs/openstack/keystone-db-sync; range_end:; response_count:0; response_revision:5400; }","duration":"122.563444ms","start":"2026-08-14T09:07:54.382043Z","end":"2026-08-14T09:07:54.504606Z","steps":["trace[343743540] 'agreement among raft nodes before linearized reading' (duration: 122.480103ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:07:54.504727Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.922345ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-14T09:07:54.5048Z","caller":"traceutil/trace.go:171","msg":"trace[933645184] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:5400; }","duration":"121.016676ms","start":"2026-08-14T09:07:54.383764Z","end":"2026-08-14T09:07:54.504781Z","steps":["trace[933645184] 'agreement among raft nodes before linearized reading' (duration: 120.816364ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:07:54.504973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.665745ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/keystone-credential-setup\" ","response":"range_response_count:1 size:6181"} {"level":"info","ts":"2026-08-14T09:07:54.505104Z","caller":"traceutil/trace.go:171","msg":"trace[327652169] range","detail":"{range_begin:/registry/jobs/openstack/keystone-credential-setup; range_end:; response_count:1; response_revision:5400; }","duration":"116.788777ms","start":"2026-08-14T09:07:54.388255Z","end":"2026-08-14T09:07:54.505044Z","steps":["trace[327652169] 'agreement among raft nodes before linearized reading' (duration: 116.307811ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:08:01.062952Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11858716688502142458,"retry-timeout":"500ms"} {"level":"info","ts":"2026-08-14T09:08:01.150532Z","caller":"traceutil/trace.go:171","msg":"trace[1365497528] transaction","detail":"{read_only:false; response_revision:5436; number_of_response:1; }","duration":"590.673833ms","start":"2026-08-14T09:08:00.559836Z","end":"2026-08-14T09:08:01.15051Z","steps":["trace[1365497528] 'process raft request' (duration: 590.542882ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:08:01.150677Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:08:00.559812Z","time spent":"590.789414ms","remote":"127.0.0.1:58432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7199,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-14T09:08:01.165726Z","caller":"traceutil/trace.go:171","msg":"trace[1236941769] linearizableReadLoop","detail":"{readStateIndex:5646; appliedIndex:5641; }","duration":"603.47037ms","start":"2026-08-14T09:08:00.562229Z","end":"2026-08-14T09:08:01.165699Z","steps":["trace[1236941769] 'read index received' (duration: 588.258515ms)","trace[1236941769] 'applied index is now lower than readState.Index' (duration: 15.210835ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T09:08:01.165866Z","caller":"traceutil/trace.go:171","msg":"trace[690301633] transaction","detail":"{read_only:false; response_revision:5437; number_of_response:1; }","duration":"605.616724ms","start":"2026-08-14T09:08:00.560239Z","end":"2026-08-14T09:08:01.165856Z","steps":["trace[690301633] 'process raft request' (duration: 605.160209ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:08:01.165978Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:08:00.560225Z","time spent":"605.676245ms","remote":"127.0.0.1:58290","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-08-14T09:08:01.166443Z","caller":"traceutil/trace.go:171","msg":"trace[120058757] transaction","detail":"{read_only:false; response_revision:5438; number_of_response:1; }","duration":"472.657527ms","start":"2026-08-14T09:08:00.693775Z","end":"2026-08-14T09:08:01.166432Z","steps":["trace[120058757] 'process raft request' (duration: 471.764897ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:08:01.166507Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:08:00.693743Z","time spent":"472.734298ms","remote":"127.0.0.1:58512","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-14T09:08:01.166598Z","caller":"traceutil/trace.go:171","msg":"trace[1829455851] transaction","detail":"{read_only:false; response_revision:5439; number_of_response:1; }","duration":"397.558825ms","start":"2026-08-14T09:08:00.769031Z","end":"2026-08-14T09:08:01.16659Z","steps":["trace[1829455851] 'process raft request' (duration: 396.576234ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:08:01.166653Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:08:00.769006Z","time spent":"397.619076ms","remote":"127.0.0.1:58512","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-14T09:08:01.166729Z","caller":"traceutil/trace.go:171","msg":"trace[1213451289] transaction","detail":"{read_only:false; response_revision:5440; number_of_response:1; }","duration":"163.355646ms","start":"2026-08-14T09:08:01.003363Z","end":"2026-08-14T09:08:01.166718Z","steps":["trace[1213451289] 'process raft request' (duration: 162.276653ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:08:01.166863Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"604.632633ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T09:08:01.1669Z","caller":"traceutil/trace.go:171","msg":"trace[1716875206] range","detail":"{range_begin:/registry/services/specs/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:5441; }","duration":"604.708734ms","start":"2026-08-14T09:08:00.562182Z","end":"2026-08-14T09:08:01.166891Z","steps":["trace[1716875206] 'agreement among raft nodes before linearized reading' (duration: 604.648544ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:08:01.166933Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:08:00.562156Z","time spent":"604.770145ms","remote":"127.0.0.1:58446","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":28,"request content":"key:\"/registry/services/specs/openstack/percona-xtradb-pitr\" "} {"level":"warn","ts":"2026-08-14T09:08:01.167106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"465.697177ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/prometheuses/\" range_end:\"/registry/monitoring.coreos.com/prometheuses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-14T09:08:01.167145Z","caller":"traceutil/trace.go:171","msg":"trace[393215879] range","detail":"{range_begin:/registry/monitoring.coreos.com/prometheuses/; range_end:/registry/monitoring.coreos.com/prometheuses0; response_count:0; response_revision:5441; }","duration":"465.765488ms","start":"2026-08-14T09:08:00.701369Z","end":"2026-08-14T09:08:01.167134Z","steps":["trace[393215879] 'agreement among raft nodes before linearized reading' (duration: 465.709757ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:08:01.167179Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:08:00.701356Z","time spent":"465.814398ms","remote":"127.0.0.1:33778","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":1,"response size":30,"request content":"key:\"/registry/monitoring.coreos.com/prometheuses/\" range_end:\"/registry/monitoring.coreos.com/prometheuses0\" count_only:true "} {"level":"warn","ts":"2026-08-14T09:08:01.167371Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.094565ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-14T09:08:01.167406Z","caller":"traceutil/trace.go:171","msg":"trace[997225078] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; response_count:0; response_revision:5441; }","duration":"199.174106ms","start":"2026-08-14T09:08:00.968224Z","end":"2026-08-14T09:08:01.167398Z","steps":["trace[997225078] 'agreement among raft nodes before linearized reading' (duration: 199.116015ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:08:06.928364Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2842} {"level":"info","ts":"2026-08-14T09:08:07.000602Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2842,"took":"70.7223ms","hash":629659121,"current-db-size-bytes":53309440,"current-db-size":"53 MB","current-db-size-in-use-bytes":29011968,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-08-14T09:08:07.000658Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":629659121,"revision":2842,"compact-revision":-1} {"level":"info","ts":"2026-08-14T09:11:11.667808Z","caller":"traceutil/trace.go:171","msg":"trace[1546193987] transaction","detail":"{read_only:false; response_revision:6766; number_of_response:1; }","duration":"387.189788ms","start":"2026-08-14T09:11:11.280593Z","end":"2026-08-14T09:11:11.667782Z","steps":["trace[1546193987] 'process raft request' (duration: 386.996074ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:11:11.668004Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:11:11.280551Z","time spent":"387.347742ms","remote":"127.0.0.1:58512","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-14T09:11:12.008974Z","caller":"traceutil/trace.go:171","msg":"trace[1939997025] linearizableReadLoop","detail":"{readStateIndex:7022; appliedIndex:7020; }","duration":"647.389297ms","start":"2026-08-14T09:11:11.361564Z","end":"2026-08-14T09:11:12.008953Z","steps":["trace[1939997025] 'read index received' (duration: 306.583028ms)","trace[1939997025] 'applied index is now lower than readState.Index' (duration: 340.805379ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T09:11:12.009009Z","caller":"traceutil/trace.go:171","msg":"trace[738172041] transaction","detail":"{read_only:false; response_revision:6768; number_of_response:1; }","duration":"683.592428ms","start":"2026-08-14T09:11:11.325395Z","end":"2026-08-14T09:11:12.008988Z","steps":["trace[738172041] 'process raft request' (duration: 683.509116ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:11:12.009007Z","caller":"traceutil/trace.go:171","msg":"trace[1345944112] transaction","detail":"{read_only:false; response_revision:6767; number_of_response:1; }","duration":"706.309986ms","start":"2026-08-14T09:11:11.302659Z","end":"2026-08-14T09:11:12.008969Z","steps":["trace[1345944112] 'process raft request' (duration: 683.396863ms)","trace[1345944112] 'compare' (duration: 22.670296ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T09:11:12.009124Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:11:11.325367Z","time spent":"683.703181ms","remote":"127.0.0.1:58512","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-14T09:11:12.009162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"647.581512ms","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-08-14T09:11:12.009196Z","caller":"traceutil/trace.go:171","msg":"trace[1884126168] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:6768; }","duration":"647.666654ms","start":"2026-08-14T09:11:11.361519Z","end":"2026-08-14T09:11:12.009186Z","steps":["trace[1884126168] 'agreement among raft nodes before linearized reading' (duration: 647.527481ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:11:12.009227Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:11:11.361497Z","time spent":"647.721695ms","remote":"127.0.0.1:58512","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-08-14T09:11:12.009314Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:11:11.302618Z","time spent":"706.47693ms","remote":"127.0.0.1:58512","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-08-14T09:11:12.041214Z","caller":"traceutil/trace.go:171","msg":"trace[1487253100] transaction","detail":"{read_only:false; response_revision:6769; number_of_response:1; }","duration":"185.375144ms","start":"2026-08-14T09:11:11.855821Z","end":"2026-08-14T09:11:12.041196Z","steps":["trace[1487253100] 'process raft request' (duration: 181.775942ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:11:12.04157Z","caller":"traceutil/trace.go:171","msg":"trace[811484923] transaction","detail":"{read_only:false; response_revision:6770; number_of_response:1; }","duration":"180.873779ms","start":"2026-08-14T09:11:11.860675Z","end":"2026-08-14T09:11:12.041548Z","steps":["trace[811484923] 'process raft request' (duration: 177.02059ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:11:12.041747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"401.398138ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T09:11:12.041767Z","caller":"traceutil/trace.go:171","msg":"trace[1041919707] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:6770; }","duration":"401.47684ms","start":"2026-08-14T09:11:11.640285Z","end":"2026-08-14T09:11:12.041762Z","steps":["trace[1041919707] 'agreement among raft nodes before linearized reading' (duration: 401.397038ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:11:12.041782Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:11:11.640261Z","time spent":"401.516801ms","remote":"127.0.0.1:58256","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-08-14T09:11:12.047081Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"681.243937ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-08-14T09:11:12.04712Z","caller":"traceutil/trace.go:171","msg":"trace[1923031299] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:6771; }","duration":"681.318098ms","start":"2026-08-14T09:11:11.365793Z","end":"2026-08-14T09:11:12.047112Z","steps":["trace[1923031299] 'agreement among raft nodes before linearized reading' (duration: 675.311136ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:11:12.047159Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:11:11.365778Z","time spent":"681.36043ms","remote":"127.0.0.1:58512","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-08-14T09:13:06.938628Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5486} {"level":"info","ts":"2026-08-14T09:13:07.043666Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5486,"took":"103.436309ms","hash":2515767474,"current-db-size-bytes":53309440,"current-db-size":"53 MB","current-db-size-in-use-bytes":18817024,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-08-14T09:13:07.043751Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2515767474,"revision":5486,"compact-revision":2842}