{"level":"warn","ts":"2026-04-16T09:13:06.670361Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-16T09:13:06.670465Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.70:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.70:2380","--initial-cluster=instance=https://199.204.45.70:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.70:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.70:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-04-16T09:13:06.670539Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-16T09:13:06.670548Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.70:2380"]} {"level":"info","ts":"2026-04-16T09:13:06.670582Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-16T09:13:06.671214Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.70:2379"]} {"level":"info","ts":"2026-04-16T09:13:06.671302Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.70:2380"],"listen-peer-urls":["https://199.204.45.70:2380"],"advertise-client-urls":["https://199.204.45.70:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.70:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.70:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-04-16T09:13:06.678736Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"7.234248ms"} {"level":"info","ts":"2026-04-16T09:13:06.689446Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"f8844a9a4263041d","cluster-id":"4749b7c221ae0648"} {"level":"info","ts":"2026-04-16T09:13:06.689495Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d switched to configuration voters=()"} {"level":"info","ts":"2026-04-16T09:13:06.689516Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d became follower at term 0"} {"level":"info","ts":"2026-04-16T09:13:06.689529Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft f8844a9a4263041d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-16T09:13:06.689541Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d became follower at term 1"} {"level":"info","ts":"2026-04-16T09:13:06.689573Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d switched to configuration voters=(17907520044731139101)"} {"level":"warn","ts":"2026-04-16T09:13:06.698147Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-16T09:13:06.699382Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-16T09:13:06.700546Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-04-16T09:13:06.702248Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"f8844a9a4263041d","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-16T09:13:06.703058Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"f8844a9a4263041d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-16T09:13:06.703941Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-16T09:13:06.70401Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-16T09:13:06.70402Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-16T09:13:06.705583Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d switched to configuration voters=(17907520044731139101)"} {"level":"info","ts":"2026-04-16T09:13:06.705848Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"4749b7c221ae0648","local-member-id":"f8844a9a4263041d","added-peer-id":"f8844a9a4263041d","added-peer-peer-urls":["https://199.204.45.70:2380"]} {"level":"info","ts":"2026-04-16T09:13:06.707036Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-16T09:13:06.707107Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.70:2380"} {"level":"info","ts":"2026-04-16T09:13:06.707126Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.70:2380"} {"level":"info","ts":"2026-04-16T09:13:06.70724Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"f8844a9a4263041d","initial-advertise-peer-urls":["https://199.204.45.70:2380"],"listen-peer-urls":["https://199.204.45.70:2380"],"advertise-client-urls":["https://199.204.45.70:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.70:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-16T09:13:06.707279Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-16T09:13:07.489885Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d is starting a new election at term 1"} {"level":"info","ts":"2026-04-16T09:13:07.489942Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d became pre-candidate at term 1"} {"level":"info","ts":"2026-04-16T09:13:07.489979Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d received MsgPreVoteResp from f8844a9a4263041d at term 1"} {"level":"info","ts":"2026-04-16T09:13:07.489999Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d became candidate at term 2"} {"level":"info","ts":"2026-04-16T09:13:07.49001Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d received MsgVoteResp from f8844a9a4263041d at term 2"} {"level":"info","ts":"2026-04-16T09:13:07.490027Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d became leader at term 2"} {"level":"info","ts":"2026-04-16T09:13:07.490047Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: f8844a9a4263041d elected leader f8844a9a4263041d at term 2"} {"level":"info","ts":"2026-04-16T09:13:07.636584Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"f8844a9a4263041d","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.70:2379]}","request-path":"/0/members/f8844a9a4263041d/attributes","cluster-id":"4749b7c221ae0648","publish-timeout":"7s"} {"level":"info","ts":"2026-04-16T09:13:07.636612Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-16T09:13:07.636668Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-16T09:13:07.636844Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-16T09:13:07.637162Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-16T09:13:07.637357Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-16T09:13:07.638871Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-16T09:13:07.644756Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.70:2379"} {"level":"info","ts":"2026-04-16T09:13:07.800344Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"4749b7c221ae0648","local-member-id":"f8844a9a4263041d","cluster-version":"3.5"} {"level":"info","ts":"2026-04-16T09:13:07.802689Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-16T09:13:07.803652Z","caller":"traceutil/trace.go:171","msg":"trace[590285133] linearizableReadLoop","detail":"{readStateIndex:4; appliedIndex:3; }","duration":"122.424257ms","start":"2026-04-16T09:13:07.680542Z","end":"2026-04-16T09:13:07.802966Z","steps":["trace[590285133] 'read index received' (duration: 119.773001ms)","trace[590285133] 'applied index is now lower than readState.Index' (duration: 2.648276ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T09:13:07.803041Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"warn","ts":"2026-04-16T09:13:07.803779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.131027ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-16T09:13:07.803827Z","caller":"traceutil/trace.go:171","msg":"trace[72008224] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:1; }","duration":"123.189699ms","start":"2026-04-16T09:13:07.680624Z","end":"2026-04-16T09:13:07.803813Z","steps":["trace[72008224] 'agreement among raft nodes before linearized reading' (duration: 123.114216ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T09:13:07.803977Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.262662ms","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:4"} {"level":"info","ts":"2026-04-16T09:13:07.804131Z","caller":"traceutil/trace.go:171","msg":"trace[76436199] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:1; }","duration":"123.546414ms","start":"2026-04-16T09:13:07.680533Z","end":"2026-04-16T09:13:07.804079Z","steps":["trace[76436199] 'agreement among raft nodes before linearized reading' (duration: 122.565074ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T09:13:32.542665Z","caller":"traceutil/trace.go:171","msg":"trace[305624860] transaction","detail":"{read_only:false; response_revision:503; number_of_response:1; }","duration":"130.363198ms","start":"2026-04-16T09:13:32.412273Z","end":"2026-04-16T09:13:32.542636Z","steps":["trace[305624860] 'process raft request' (duration: 129.928499ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T09:13:32.543008Z","caller":"traceutil/trace.go:171","msg":"trace[1575616771] transaction","detail":"{read_only:false; response_revision:505; number_of_response:1; }","duration":"120.253507ms","start":"2026-04-16T09:13:32.422664Z","end":"2026-04-16T09:13:32.542917Z","steps":["trace[1575616771] 'process raft request' (duration: 119.962115ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T09:13:32.543045Z","caller":"traceutil/trace.go:171","msg":"trace[659042416] transaction","detail":"{read_only:false; response_revision:504; number_of_response:1; }","duration":"128.631977ms","start":"2026-04-16T09:13:32.414346Z","end":"2026-04-16T09:13:32.542978Z","steps":["trace[659042416] 'process raft request' (duration: 128.197778ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T09:13:32.543076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.261206ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-16T09:13:32.543408Z","caller":"traceutil/trace.go:171","msg":"trace[489199587] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:505; }","duration":"125.574678ms","start":"2026-04-16T09:13:32.41776Z","end":"2026-04-16T09:13:32.543335Z","steps":["trace[489199587] 'agreement among raft nodes before linearized reading' (duration: 125.239674ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T09:13:32.543456Z","caller":"traceutil/trace.go:171","msg":"trace[1162871116] linearizableReadLoop","detail":"{readStateIndex:524; appliedIndex:522; }","duration":"124.940653ms","start":"2026-04-16T09:13:32.417797Z","end":"2026-04-16T09:13:32.542737Z","steps":["trace[1162871116] 'read index received' (duration: 16.016009ms)","trace[1162871116] 'applied index is now lower than readState.Index' (duration: 108.923734ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T09:13:32.551336Z","caller":"traceutil/trace.go:171","msg":"trace[1250459234] transaction","detail":"{read_only:false; response_revision:506; number_of_response:1; }","duration":"118.424991ms","start":"2026-04-16T09:13:32.432892Z","end":"2026-04-16T09:13:32.551317Z","steps":["trace[1250459234] 'process raft request' (duration: 117.740842ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T09:13:32.551457Z","caller":"traceutil/trace.go:171","msg":"trace[1707391568] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"118.495784ms","start":"2026-04-16T09:13:32.432954Z","end":"2026-04-16T09:13:32.55145Z","steps":["trace[1707391568] 'process raft request' (duration: 117.761833ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T09:13:32.551535Z","caller":"traceutil/trace.go:171","msg":"trace[809614631] transaction","detail":"{read_only:false; number_of_response:1; response_revision:507; }","duration":"118.461962ms","start":"2026-04-16T09:13:32.433067Z","end":"2026-04-16T09:13:32.551529Z","steps":["trace[809614631] 'process raft request' (duration: 117.678929ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T09:13:32.552704Z","caller":"traceutil/trace.go:171","msg":"trace[1851628955] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"112.001702ms","start":"2026-04-16T09:13:32.440668Z","end":"2026-04-16T09:13:32.55267Z","steps":["trace[1851628955] 'process raft request' (duration: 110.121604ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T09:13:32.553033Z","caller":"traceutil/trace.go:171","msg":"trace[872009683] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"105.965281ms","start":"2026-04-16T09:13:32.447056Z","end":"2026-04-16T09:13:32.553021Z","steps":["trace[872009683] 'process raft request' (duration: 103.893324ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T09:13:32.553067Z","caller":"traceutil/trace.go:171","msg":"trace[999716400] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"106.145768ms","start":"2026-04-16T09:13:32.446915Z","end":"2026-04-16T09:13:32.553061Z","steps":["trace[999716400] 'process raft request' (duration: 103.962526ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T09:13:32.553089Z","caller":"traceutil/trace.go:171","msg":"trace[699135774] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"106.096897ms","start":"2026-04-16T09:13:32.446986Z","end":"2026-04-16T09:13:32.553083Z","steps":["trace[699135774] 'process raft request' (duration: 103.928596ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T09:13:38.820355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.735708ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-16T09:13:38.820461Z","caller":"traceutil/trace.go:171","msg":"trace[786460905] transaction","detail":"{read_only:false; response_revision:602; number_of_response:1; }","duration":"230.398404ms","start":"2026-04-16T09:13:38.590045Z","end":"2026-04-16T09:13:38.820444Z","steps":["trace[786460905] 'process raft request' (duration: 126.981978ms)","trace[786460905] 'compare' (duration: 102.626153ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T09:13:39.097495Z","caller":"traceutil/trace.go:171","msg":"trace[784092464] transaction","detail":"{read_only:false; response_revision:604; number_of_response:1; }","duration":"118.185743ms","start":"2026-04-16T09:13:38.979282Z","end":"2026-04-16T09:13:39.097468Z","steps":["trace[784092464] 'process raft request' (duration: 118.042777ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T09:13:39.610181Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.613365ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-16T09:13:39.610273Z","caller":"traceutil/trace.go:171","msg":"trace[6172608] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:604; }","duration":"292.74531ms","start":"2026-04-16T09:13:39.317508Z","end":"2026-04-16T09:13:39.610254Z","steps":["trace[6172608] 'range keys from in-memory index tree' (duration: 292.51259ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T09:13:39.610466Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.350164ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-dfg5g\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-04-16T09:13:39.610605Z","caller":"traceutil/trace.go:171","msg":"trace[523925777] range","detail":"{range_begin:/registry/pods/kube-system/cilium-dfg5g; range_end:; response_count:1; response_revision:604; }","duration":"249.524322ms","start":"2026-04-16T09:13:39.361049Z","end":"2026-04-16T09:13:39.610573Z","steps":["trace[523925777] 'range keys from in-memory index tree' (duration: 249.079583ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T09:13:39.610996Z","caller":"traceutil/trace.go:171","msg":"trace[1626165851] transaction","detail":"{read_only:false; response_revision:605; number_of_response:1; }","duration":"161.80023ms","start":"2026-04-16T09:13:39.449166Z","end":"2026-04-16T09:13:39.610966Z","steps":["trace[1626165851] 'process raft request' (duration: 140.66521ms)","trace[1626165851] 'compare' (duration: 20.251892ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T09:13:39.619912Z","caller":"traceutil/trace.go:171","msg":"trace[1181967733] transaction","detail":"{read_only:false; response_revision:606; number_of_response:1; }","duration":"124.49825ms","start":"2026-04-16T09:13:39.495395Z","end":"2026-04-16T09:13:39.619893Z","steps":["trace[1181967733] 'process raft request' (duration: 123.668966ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T09:14:02.594456Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.83681ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-xdskk\" ","response":"range_response_count:1 size:3964"} {"level":"info","ts":"2026-04-16T09:14:02.594584Z","caller":"traceutil/trace.go:171","msg":"trace[846770816] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-xdskk; range_end:; response_count:1; response_revision:790; }","duration":"100.997897ms","start":"2026-04-16T09:14:02.493544Z","end":"2026-04-16T09:14:02.594542Z","steps":["trace[846770816] 'range keys from in-memory index tree' (duration: 100.674913ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T09:14:31.357393Z","caller":"traceutil/trace.go:171","msg":"trace[1319127639] transaction","detail":"{read_only:false; response_revision:1119; number_of_response:1; }","duration":"133.545856ms","start":"2026-04-16T09:14:31.223826Z","end":"2026-04-16T09:14:31.357372Z","steps":["trace[1319127639] 'process raft request' (duration: 117.479571ms)","trace[1319127639] 'compare' (duration: 15.93617ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T09:14:31.358153Z","caller":"traceutil/trace.go:171","msg":"trace[252640697] transaction","detail":"{read_only:false; response_revision:1121; number_of_response:1; }","duration":"111.148074ms","start":"2026-04-16T09:14:31.246999Z","end":"2026-04-16T09:14:31.358147Z","steps":["trace[252640697] 'process raft request' (duration: 110.980277ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T09:14:31.358255Z","caller":"traceutil/trace.go:171","msg":"trace[988086092] transaction","detail":"{read_only:false; response_revision:1120; number_of_response:1; }","duration":"131.315598ms","start":"2026-04-16T09:14:31.226935Z","end":"2026-04-16T09:14:31.35825Z","steps":["trace[988086092] 'process raft request' (duration: 131.005445ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T09:14:31.358417Z","caller":"traceutil/trace.go:171","msg":"trace[3122011] linearizableReadLoop","detail":"{readStateIndex:1158; appliedIndex:1156; }","duration":"111.896337ms","start":"2026-04-16T09:14:31.24649Z","end":"2026-04-16T09:14:31.358387Z","steps":["trace[3122011] 'read index received' (duration: 94.671472ms)","trace[3122011] 'applied index is now lower than readState.Index' (duration: 17.223275ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T09:14:31.358575Z","caller":"traceutil/trace.go:171","msg":"trace[819658909] transaction","detail":"{read_only:false; response_revision:1122; number_of_response:1; }","duration":"107.971634ms","start":"2026-04-16T09:14:31.250591Z","end":"2026-04-16T09:14:31.358562Z","steps":["trace[819658909] 'process raft request' (duration: 107.462032ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T09:14:31.358811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.294595ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T09:14:31.358847Z","caller":"traceutil/trace.go:171","msg":"trace[1377220113] range","detail":"{range_begin:/registry/ingress/; range_end:/registry/ingress0; response_count:0; response_revision:1122; }","duration":"112.3998ms","start":"2026-04-16T09:14:31.246435Z","end":"2026-04-16T09:14:31.358835Z","steps":["trace[1377220113] 'agreement among raft nodes before linearized reading' (duration: 112.311576ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T09:14:32.483287Z","caller":"traceutil/trace.go:171","msg":"trace[1518048130] transaction","detail":"{read_only:false; response_revision:1211; number_of_response:1; }","duration":"108.262661ms","start":"2026-04-16T09:14:32.374994Z","end":"2026-04-16T09:14:32.483257Z","steps":["trace[1518048130] 'process raft request' (duration: 103.47136ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T09:14:34.120051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.074111ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T09:14:34.120135Z","caller":"traceutil/trace.go:171","msg":"trace[887577393] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:1229; }","duration":"127.181235ms","start":"2026-04-16T09:14:33.992935Z","end":"2026-04-16T09:14:34.120117Z","steps":["trace[887577393] 'count revisions from in-memory index tree' (duration: 126.899383ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T09:14:39.387534Z","caller":"traceutil/trace.go:171","msg":"trace[144501821] transaction","detail":"{read_only:false; response_revision:1375; number_of_response:1; }","duration":"139.300281ms","start":"2026-04-16T09:14:39.248177Z","end":"2026-04-16T09:14:39.387478Z","steps":["trace[144501821] 'process raft request' (duration: 61.079209ms)","trace[144501821] 'compare' (duration: 77.967201ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T09:14:47.032073Z","caller":"traceutil/trace.go:171","msg":"trace[1738402460] transaction","detail":"{read_only:false; response_revision:1455; number_of_response:1; }","duration":"238.460847ms","start":"2026-04-16T09:14:46.793582Z","end":"2026-04-16T09:14:47.032043Z","steps":["trace[1738402460] 'process raft request' (duration: 238.280119ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T09:14:47.233323Z","caller":"traceutil/trace.go:171","msg":"trace[1400512424] linearizableReadLoop","detail":"{readStateIndex:1502; appliedIndex:1498; }","duration":"227.954967ms","start":"2026-04-16T09:14:47.00534Z","end":"2026-04-16T09:14:47.233295Z","steps":["trace[1400512424] 'read index received' (duration: 26.612415ms)","trace[1400512424] 'applied index is now lower than readState.Index' (duration: 201.341582ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T09:14:47.233573Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.201828ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T09:14:47.233617Z","caller":"traceutil/trace.go:171","msg":"trace[112900978] range","detail":"{range_begin:/registry/leases/ingress-nginx/ingress-nginx-leader; range_end:; response_count:0; response_revision:1458; }","duration":"228.328003ms","start":"2026-04-16T09:14:47.005277Z","end":"2026-04-16T09:14:47.233605Z","steps":["trace[112900978] 'agreement among raft nodes before linearized reading' (duration: 228.146605ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T09:14:47.234053Z","caller":"traceutil/trace.go:171","msg":"trace[914954301] transaction","detail":"{read_only:false; response_revision:1456; number_of_response:1; }","duration":"406.878426ms","start":"2026-04-16T09:14:46.827163Z","end":"2026-04-16T09:14:47.234042Z","steps":["trace[914954301] 'process raft request' (duration: 405.786158ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T09:14:47.235392Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T09:14:46.827134Z","time spent":"408.163323ms","remote":"127.0.0.1:35436","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1164,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-16T09:14:47.234377Z","caller":"traceutil/trace.go:171","msg":"trace[794749701] transaction","detail":"{read_only:false; response_revision:1457; number_of_response:1; }","duration":"406.952479ms","start":"2026-04-16T09:14:46.82739Z","end":"2026-04-16T09:14:47.234343Z","steps":["trace[794749701] 'process raft request' (duration: 405.734406ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T09:14:47.235775Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T09:14:46.827381Z","time spent":"408.257797ms","remote":"127.0.0.1:35524","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1732,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-16T09:14:47.234575Z","caller":"traceutil/trace.go:171","msg":"trace[1740738991] transaction","detail":"{read_only:false; response_revision:1458; number_of_response:1; }","duration":"407.002312ms","start":"2026-04-16T09:14:46.827562Z","end":"2026-04-16T09:14:47.234564Z","steps":["trace[1740738991] 'process raft request' (duration: 405.668263ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T09:14:47.235978Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T09:14:46.827553Z","time spent":"408.393873ms","remote":"127.0.0.1:35726","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4247,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-16T09:14:47.352435Z","caller":"traceutil/trace.go:171","msg":"trace[914278795] transaction","detail":"{read_only:false; response_revision:1459; number_of_response:1; }","duration":"112.670707ms","start":"2026-04-16T09:14:47.239736Z","end":"2026-04-16T09:14:47.352407Z","steps":["trace[914278795] 'process raft request' (duration: 81.355323ms)","trace[914278795] 'compare' (duration: 31.177658ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T09:14:47.411749Z","caller":"traceutil/trace.go:171","msg":"trace[451921116] transaction","detail":"{read_only:false; response_revision:1460; number_of_response:1; }","duration":"171.930223ms","start":"2026-04-16T09:14:47.239787Z","end":"2026-04-16T09:14:47.411718Z","steps":["trace[451921116] 'process raft request' (duration: 171.63794ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T09:14:47.412271Z","caller":"traceutil/trace.go:171","msg":"trace[1143258239] transaction","detail":"{read_only:false; response_revision:1461; number_of_response:1; }","duration":"168.925309ms","start":"2026-04-16T09:14:47.24332Z","end":"2026-04-16T09:14:47.412245Z","steps":["trace[1143258239] 'process raft request' (duration: 168.288932ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T09:16:08.977036Z","caller":"traceutil/trace.go:171","msg":"trace[1429861209] transaction","detail":"{read_only:false; response_revision:2168; number_of_response:1; }","duration":"483.102113ms","start":"2026-04-16T09:16:08.493911Z","end":"2026-04-16T09:16:08.977013Z","steps":["trace[1429861209] 'process raft request' (duration: 482.963162ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T09:16:08.977186Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T09:16:08.493884Z","time spent":"483.228104ms","remote":"127.0.0.1:35518","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-16T09:16:08.977563Z","caller":"traceutil/trace.go:171","msg":"trace[1012935980] linearizableReadLoop","detail":"{readStateIndex:2260; appliedIndex:2260; }","duration":"479.901402ms","start":"2026-04-16T09:16:08.497632Z","end":"2026-04-16T09:16:08.977534Z","steps":["trace[1012935980] 'read index received' (duration: 479.889242ms)","trace[1012935980] 'applied index is now lower than readState.Index' (duration: 9.68µs)"],"step_count":2} {"level":"warn","ts":"2026-04-16T09:16:08.977768Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"480.076354ms","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-04-16T09:16:08.977844Z","caller":"traceutil/trace.go:171","msg":"trace[1472588524] range","detail":"{range_begin:/registry/rabbitmq.com/queues/; range_end:/registry/rabbitmq.com/queues0; response_count:0; response_revision:2168; }","duration":"480.221886ms","start":"2026-04-16T09:16:08.4976Z","end":"2026-04-16T09:16:08.977822Z","steps":["trace[1472588524] 'agreement among raft nodes before linearized reading' (duration: 480.047084ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T09:16:08.977901Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T09:16:08.497587Z","time spent":"480.299687ms","remote":"127.0.0.1:42996","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":"info","ts":"2026-04-16T09:16:09.027141Z","caller":"traceutil/trace.go:171","msg":"trace[613118164] transaction","detail":"{read_only:false; response_revision:2169; number_of_response:1; }","duration":"500.477386ms","start":"2026-04-16T09:16:08.526644Z","end":"2026-04-16T09:16:09.027122Z","steps":["trace[613118164] 'process raft request' (duration: 483.665021ms)","trace[613118164] 'compare' (duration: 16.533643ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T09:16:09.027238Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T09:16:08.526625Z","time spent":"500.558087ms","remote":"127.0.0.1:35356","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":646,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-16T09:16:09.027469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"501.677627ms","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-04-16T09:16:09.027548Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"517.679681ms","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":"warn","ts":"2026-04-16T09:16:09.02757Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"435.006866ms","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":"warn","ts":"2026-04-16T09:16:09.02763Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"518.224507ms","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-04-16T09:16:09.027635Z","caller":"traceutil/trace.go:171","msg":"trace[252434458] transaction","detail":"{read_only:false; response_revision:2170; number_of_response:1; }","duration":"492.872713ms","start":"2026-04-16T09:16:08.534706Z","end":"2026-04-16T09:16:09.027578Z","steps":["trace[252434458] 'process raft request' (duration: 492.306847ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T09:16:09.027646Z","caller":"traceutil/trace.go:171","msg":"trace[1622160857] range","detail":"{range_begin:/registry/rabbitmq.com/operatorpolicies/; range_end:/registry/rabbitmq.com/operatorpolicies0; response_count:0; response_revision:2171; }","duration":"435.091527ms","start":"2026-04-16T09:16:08.592515Z","end":"2026-04-16T09:16:09.027607Z","steps":["trace[1622160857] 'agreement among raft nodes before linearized reading' (duration: 435.002856ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T09:16:09.027703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"486.868506ms","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":"warn","ts":"2026-04-16T09:16:09.027709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"518.367138ms","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-04-16T09:16:09.027722Z","caller":"traceutil/trace.go:171","msg":"trace[16691512] range","detail":"{range_begin:/registry/rabbitmq.com/permissions/; range_end:/registry/rabbitmq.com/permissions0; response_count:0; response_revision:2171; }","duration":"486.909816ms","start":"2026-04-16T09:16:08.540806Z","end":"2026-04-16T09:16:09.027715Z","steps":["trace[16691512] 'agreement among raft nodes before linearized reading' (duration: 486.882676ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T09:16:09.027736Z","caller":"traceutil/trace.go:171","msg":"trace[766157469] range","detail":"{range_begin:/registry/rabbitmq.com/bindings/; range_end:/registry/rabbitmq.com/bindings0; response_count:0; response_revision:2171; }","duration":"518.435909ms","start":"2026-04-16T09:16:08.509292Z","end":"2026-04-16T09:16:09.027727Z","steps":["trace[766157469] 'agreement among raft nodes before linearized reading' (duration: 518.391759ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T09:16:09.027732Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T09:16:08.59251Z","time spent":"435.208278ms","remote":"127.0.0.1:43048","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-04-16T09:16:09.02775Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T09:16:08.540797Z","time spent":"486.946216ms","remote":"127.0.0.1:43022","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-04-16T09:16:09.027762Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T09:16:08.509273Z","time spent":"518.480439ms","remote":"127.0.0.1:43004","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-04-16T09:16:09.027758Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T09:16:08.534684Z","time spent":"492.984154ms","remote":"127.0.0.1:46050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1081,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T09:16:09.028016Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"436.196579ms","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-04-16T09:16:09.028058Z","caller":"traceutil/trace.go:171","msg":"trace[1816792810] range","detail":"{range_begin:/registry/rabbitmq.com/operatorpolicies/; range_end:/registry/rabbitmq.com/operatorpolicies0; response_count:0; response_revision:2171; }","duration":"436.240219ms","start":"2026-04-16T09:16:08.591807Z","end":"2026-04-16T09:16:09.028047Z","steps":["trace[1816792810] 'agreement among raft nodes before linearized reading' (duration: 436.176648ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T09:16:09.028106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"436.444841ms","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":"warn","ts":"2026-04-16T09:16:09.028123Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T09:16:08.591788Z","time spent":"436.296549ms","remote":"127.0.0.1:43048","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":"warn","ts":"2026-04-16T09:16:09.028139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"488.388649ms","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":"info","ts":"2026-04-16T09:16:09.028134Z","caller":"traceutil/trace.go:171","msg":"trace[1508114178] transaction","detail":"{read_only:false; response_revision:2171; number_of_response:1; }","duration":"240.926331ms","start":"2026-04-16T09:16:08.787195Z","end":"2026-04-16T09:16:09.028122Z","steps":["trace[1508114178] 'process raft request' (duration: 239.890411ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T09:16:09.028149Z","caller":"traceutil/trace.go:171","msg":"trace[1867788738] range","detail":"{range_begin:/registry/rabbitmq.com/operatorpolicies/; range_end:/registry/rabbitmq.com/operatorpolicies0; response_count:0; response_revision:2171; }","duration":"436.495241ms","start":"2026-04-16T09:16:08.591642Z","end":"2026-04-16T09:16:09.028137Z","steps":["trace[1867788738] 'agreement among raft nodes before linearized reading' (duration: 436.4376ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T09:16:09.028163Z","caller":"traceutil/trace.go:171","msg":"trace[1966337731] range","detail":"{range_begin:/registry/rabbitmq.com/permissions/; range_end:/registry/rabbitmq.com/permissions0; response_count:0; response_revision:2171; }","duration":"488.44481ms","start":"2026-04-16T09:16:08.539711Z","end":"2026-04-16T09:16:09.028156Z","steps":["trace[1966337731] 'agreement among raft nodes before linearized reading' (duration: 488.41247ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T09:16:09.028185Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T09:16:08.539698Z","time spent":"488.48125ms","remote":"127.0.0.1:43022","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-04-16T09:16:09.028225Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"453.006319ms","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-04-16T09:16:09.028253Z","caller":"traceutil/trace.go:171","msg":"trace[1285269642] range","detail":"{range_begin:/registry/rabbitmq.com/vhosts/; range_end:/registry/rabbitmq.com/vhosts0; response_count:0; response_revision:2171; }","duration":"453.05552ms","start":"2026-04-16T09:16:08.575188Z","end":"2026-04-16T09:16:09.028244Z","steps":["trace[1285269642] 'agreement among raft nodes before linearized reading' (duration: 453.01351ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T09:16:09.028285Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T09:16:08.57518Z","time spent":"453.09646ms","remote":"127.0.0.1:43040","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-04-16T09:16:09.028309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"502.272683ms","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":"info","ts":"2026-04-16T09:16:09.02833Z","caller":"traceutil/trace.go:171","msg":"trace[766152520] range","detail":"{range_begin:/registry/rabbitmq.com/users/; range_end:/registry/rabbitmq.com/users0; response_count:0; response_revision:2171; }","duration":"502.344774ms","start":"2026-04-16T09:16:08.525978Z","end":"2026-04-16T09:16:09.028323Z","steps":["trace[766152520] 'agreement among raft nodes before linearized reading' (duration: 502.311733ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T09:16:09.028354Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T09:16:08.525956Z","time spent":"502.393084ms","remote":"127.0.0.1:43010","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":"warn","ts":"2026-04-16T09:16:09.028444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"453.861128ms","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":"warn","ts":"2026-04-16T09:16:09.028476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"502.692937ms","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-04-16T09:16:09.028481Z","caller":"traceutil/trace.go:171","msg":"trace[1143954971] range","detail":"{range_begin:/registry/rabbitmq.com/vhosts/; range_end:/registry/rabbitmq.com/vhosts0; response_count:0; response_revision:2171; }","duration":"453.927859ms","start":"2026-04-16T09:16:08.574543Z","end":"2026-04-16T09:16:09.02847Z","steps":["trace[1143954971] 'agreement among raft nodes before linearized reading' (duration: 453.873869ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T09:16:09.028495Z","caller":"traceutil/trace.go:171","msg":"trace[1502729729] range","detail":"{range_begin:/registry/rabbitmq.com/users/; range_end:/registry/rabbitmq.com/users0; response_count:0; response_revision:2171; }","duration":"502.803168ms","start":"2026-04-16T09:16:08.525686Z","end":"2026-04-16T09:16:09.028489Z","steps":["trace[1502729729] 'agreement among raft nodes before linearized reading' (duration: 502.766718ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T09:16:09.028512Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T09:16:08.574522Z","time spent":"453.981169ms","remote":"127.0.0.1:43040","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":"warn","ts":"2026-04-16T09:16:09.028519Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T09:16:08.525672Z","time spent":"502.842098ms","remote":"127.0.0.1:43010","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-04-16T09:16:09.028096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"488.323598ms","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-04-16T09:16:09.028642Z","caller":"traceutil/trace.go:171","msg":"trace[1361432083] range","detail":"{range_begin:/registry/rabbitmq.com/permissions/; range_end:/registry/rabbitmq.com/permissions0; response_count:0; response_revision:2171; }","duration":"488.901545ms","start":"2026-04-16T09:16:08.539734Z","end":"2026-04-16T09:16:09.028636Z","steps":["trace[1361432083] 'agreement among raft nodes before linearized reading' (duration: 488.338599ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T09:16:09.028665Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T09:16:08.539706Z","time spent":"488.952105ms","remote":"127.0.0.1:43022","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-04-16T09:16:09.028185Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T09:16:08.591634Z","time spent":"436.540341ms","remote":"127.0.0.1:43048","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":"warn","ts":"2026-04-16T09:16:09.028891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.332158ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-cbe75657-0a8c-463e-9754-f1713a3cd6bd\" ","response":"range_response_count:1 size:3616"} {"level":"info","ts":"2026-04-16T09:16:09.02893Z","caller":"traceutil/trace.go:171","msg":"trace[1424946344] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-cbe75657-0a8c-463e-9754-f1713a3cd6bd; range_end:; response_count:1; response_revision:2171; }","duration":"204.47572ms","start":"2026-04-16T09:16:08.824445Z","end":"2026-04-16T09:16:09.028921Z","steps":["trace[1424946344] 'agreement among raft nodes before linearized reading' (duration: 204.371008ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T09:16:09.027664Z","caller":"traceutil/trace.go:171","msg":"trace[905374625] range","detail":"{range_begin:/registry/rabbitmq.com/bindings/; range_end:/registry/rabbitmq.com/bindings0; response_count:0; response_revision:2171; }","duration":"518.295697ms","start":"2026-04-16T09:16:08.50936Z","end":"2026-04-16T09:16:09.027656Z","steps":["trace[905374625] 'agreement among raft nodes before linearized reading' (duration: 518.244437ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T09:16:09.028968Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T09:16:08.50933Z","time spent":"519.629471ms","remote":"127.0.0.1:43004","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-04-16T09:16:09.029213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"471.631ms","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-04-16T09:16:09.029313Z","caller":"traceutil/trace.go:171","msg":"trace[1797942997] range","detail":"{range_begin:/registry/rabbitmq.com/topicpermissions/; range_end:/registry/rabbitmq.com/topicpermissions0; response_count:0; response_revision:2171; }","duration":"471.68864ms","start":"2026-04-16T09:16:08.557566Z","end":"2026-04-16T09:16:09.029254Z","steps":["trace[1797942997] 'agreement among raft nodes before linearized reading' (duration: 471.60834ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T09:16:09.0294Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T09:16:08.557559Z","time spent":"471.790211ms","remote":"127.0.0.1:43032","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":"warn","ts":"2026-04-16T09:16:09.029779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"532.005909ms","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":"warn","ts":"2026-04-16T09:16:09.027483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"470.572779ms","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":"warn","ts":"2026-04-16T09:16:09.027508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"529.587056ms","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-04-16T09:16:09.027483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.114397ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T09:16:09.027585Z","caller":"traceutil/trace.go:171","msg":"trace[1971543506] range","detail":"{range_begin:/registry/rabbitmq.com/bindings/; range_end:/registry/rabbitmq.com/bindings0; response_count:0; response_revision:2171; }","duration":"517.724962ms","start":"2026-04-16T09:16:08.509849Z","end":"2026-04-16T09:16:09.027574Z","steps":["trace[1971543506] 'agreement among raft nodes before linearized reading' (duration: 517.677771ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T09:16:09.027677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"473.937211ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T09:16:09.027575Z","caller":"traceutil/trace.go:171","msg":"trace[1562867549] range","detail":"{range_begin:/registry/rabbitmq.com/users/; range_end:/registry/rabbitmq.com/users0; response_count:0; response_revision:2171; }","duration":"501.817599ms","start":"2026-04-16T09:16:08.525742Z","end":"2026-04-16T09:16:09.02756Z","steps":["trace[1562867549] 'agreement among raft nodes before linearized reading' (duration: 501.644577ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T09:16:09.030424Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T09:16:08.525737Z","time spent":"504.672186ms","remote":"127.0.0.1:43010","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":"info","ts":"2026-04-16T09:16:09.030463Z","caller":"traceutil/trace.go:171","msg":"trace[1082366067] range","detail":"{range_begin:/registry/rabbitmq.com/topicpermissions/; range_end:/registry/rabbitmq.com/topicpermissions0; response_count:0; response_revision:2171; }","duration":"473.572218ms","start":"2026-04-16T09:16:08.556859Z","end":"2026-04-16T09:16:09.030431Z","steps":["trace[1082366067] 'agreement among raft nodes before linearized reading' (duration: 470.513958ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T09:16:09.027619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"470.799991ms","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-04-16T09:16:09.03043Z","caller":"traceutil/trace.go:171","msg":"trace[1031967898] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2171; }","duration":"476.670707ms","start":"2026-04-16T09:16:08.553714Z","end":"2026-04-16T09:16:09.030385Z","steps":["trace[1031967898] 'agreement among raft nodes before linearized reading' (duration: 473.93792ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T09:16:09.030569Z","caller":"traceutil/trace.go:171","msg":"trace[939115649] range","detail":"{range_begin:/registry/rabbitmq.com/topicpermissions/; range_end:/registry/rabbitmq.com/topicpermissions0; response_count:0; response_revision:2171; }","duration":"473.76576ms","start":"2026-04-16T09:16:08.55679Z","end":"2026-04-16T09:16:09.030556Z","steps":["trace[939115649] 'agreement among raft nodes before linearized reading' (duration: 470.808171ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T09:16:09.03059Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T09:16:08.55684Z","time spent":"473.709459ms","remote":"127.0.0.1:43032","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-04-16T09:16:09.030613Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T09:16:08.556773Z","time spent":"473.82767ms","remote":"127.0.0.1:43032","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":"info","ts":"2026-04-16T09:16:09.030784Z","caller":"traceutil/trace.go:171","msg":"trace[157713688] range","detail":"{range_begin:/registry/rabbitmq.com/queues/; range_end:/registry/rabbitmq.com/queues0; response_count:0; response_revision:2171; }","duration":"533.05581ms","start":"2026-04-16T09:16:08.497718Z","end":"2026-04-16T09:16:09.030774Z","steps":["trace[157713688] 'agreement among raft nodes before linearized reading' (duration: 532.00609ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T09:16:09.030819Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T09:16:08.497693Z","time spent":"533.1157ms","remote":"127.0.0.1:42996","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":0,"response size":28,"request content":"key:\"/registry/rabbitmq.com/queues/\" range_end:\"/registry/rabbitmq.com/queues0\" count_only:true "} {"level":"warn","ts":"2026-04-16T09:16:09.03091Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T09:16:08.553702Z","time spent":"477.162402ms","remote":"127.0.0.1:35260","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-16T09:16:09.031035Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T09:16:08.509842Z","time spent":"521.178405ms","remote":"127.0.0.1:43004","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-04-16T09:16:09.028059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"453.540005ms","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-04-16T09:16:09.030935Z","caller":"traceutil/trace.go:171","msg":"trace[1299704610] range","detail":"{range_begin:/registry/csistoragecapacities/; range_end:/registry/csistoragecapacities0; response_count:0; response_revision:2171; }","duration":"312.61189ms","start":"2026-04-16T09:16:08.718309Z","end":"2026-04-16T09:16:09.030921Z","steps":["trace[1299704610] 'agreement among raft nodes before linearized reading' (duration: 309.091516ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T09:16:09.031436Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T09:16:08.718285Z","time spent":"313.135655ms","remote":"127.0.0.1:35648","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":"info","ts":"2026-04-16T09:16:09.030966Z","caller":"traceutil/trace.go:171","msg":"trace[578714068] range","detail":"{range_begin:/registry/rabbitmq.com/queues/; range_end:/registry/rabbitmq.com/queues0; response_count:0; response_revision:2171; }","duration":"533.0545ms","start":"2026-04-16T09:16:08.497903Z","end":"2026-04-16T09:16:09.030957Z","steps":["trace[578714068] 'agreement among raft nodes before linearized reading' (duration: 529.570926ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T09:16:09.032005Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T09:16:08.497898Z","time spent":"534.09175ms","remote":"127.0.0.1:42996","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-04-16T09:16:09.031947Z","caller":"traceutil/trace.go:171","msg":"trace[965751403] range","detail":"{range_begin:/registry/rabbitmq.com/vhosts/; range_end:/registry/rabbitmq.com/vhosts0; response_count:0; response_revision:2171; }","duration":"457.437954ms","start":"2026-04-16T09:16:08.574494Z","end":"2026-04-16T09:16:09.031932Z","steps":["trace[965751403] 'agreement among raft nodes before linearized reading' (duration: 453.493965ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T09:16:09.032147Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T09:16:08.574485Z","time spent":"457.648416ms","remote":"127.0.0.1:43040","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-04-16T09:16:46.098364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.479906ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-04-16T09:16:46.203965Z","caller":"traceutil/trace.go:171","msg":"trace[1181282368] linearizableReadLoop","detail":"{readStateIndex:2579; appliedIndex:2578; }","duration":"106.918625ms","start":"2026-04-16T09:16:46.097022Z","end":"2026-04-16T09:16:46.20394Z","steps":["trace[1181282368] 'read index received' (duration: 106.768293ms)","trace[1181282368] 'applied index is now lower than readState.Index' (duration: 149.512µs)"],"step_count":2} {"level":"info","ts":"2026-04-16T09:16:46.204134Z","caller":"traceutil/trace.go:171","msg":"trace[1488608260] transaction","detail":"{read_only:false; response_revision:2476; number_of_response:1; }","duration":"120.071185ms","start":"2026-04-16T09:16:46.084009Z","end":"2026-04-16T09:16:46.20408Z","steps":["trace[1488608260] 'process raft request' (duration: 119.750759ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T09:16:46.204444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.410003ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T09:16:46.204494Z","caller":"traceutil/trace.go:171","msg":"trace[2082756217] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2476; }","duration":"107.518606ms","start":"2026-04-16T09:16:46.096966Z","end":"2026-04-16T09:16:46.204484Z","steps":["trace[2082756217] 'agreement among raft nodes before linearized reading' (duration: 107.095798ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T09:16:46.652371Z","caller":"traceutil/trace.go:171","msg":"trace[696400046] transaction","detail":"{read_only:false; response_revision:2480; number_of_response:1; }","duration":"119.825591ms","start":"2026-04-16T09:16:46.53252Z","end":"2026-04-16T09:16:46.652346Z","steps":["trace[696400046] 'process raft request' (duration: 119.627818ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T09:16:46.879875Z","caller":"traceutil/trace.go:171","msg":"trace[271854474] linearizableReadLoop","detail":"{readStateIndex:2584; appliedIndex:2583; }","duration":"227.529199ms","start":"2026-04-16T09:16:46.652314Z","end":"2026-04-16T09:16:46.879843Z","steps":["trace[271854474] 'read index received' (duration: 227.356436ms)","trace[271854474] 'applied index is now lower than readState.Index' (duration: 171.473µs)"],"step_count":2} {"level":"info","ts":"2026-04-16T09:16:46.879992Z","caller":"traceutil/trace.go:171","msg":"trace[1559029691] transaction","detail":"{read_only:false; response_revision:2481; number_of_response:1; }","duration":"317.846084ms","start":"2026-04-16T09:16:46.562104Z","end":"2026-04-16T09:16:46.87995Z","steps":["trace[1559029691] 'process raft request' (duration: 317.452168ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T09:16:46.880276Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T09:16:46.562069Z","time spent":"318.017998ms","remote":"127.0.0.1:35518","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T09:16:46.880353Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.413917ms","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-04-16T09:16:46.880539Z","caller":"traceutil/trace.go:171","msg":"trace[1915200937] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2481; }","duration":"235.664431ms","start":"2026-04-16T09:16:46.64485Z","end":"2026-04-16T09:16:46.880514Z","steps":["trace[1915200937] 'agreement among raft nodes before linearized reading' (duration: 235.128772ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T09:16:47.11068Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.553376ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-16T09:16:47.110873Z","caller":"traceutil/trace.go:171","msg":"trace[1612389720] transaction","detail":"{read_only:false; response_revision:2482; number_of_response:1; }","duration":"328.111633ms","start":"2026-04-16T09:16:46.782734Z","end":"2026-04-16T09:16:47.110845Z","steps":["trace[1612389720] 'process raft request' (duration: 185.326243ms)","trace[1612389720] 'compare' (duration: 142.456375ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T09:16:47.110761Z","caller":"traceutil/trace.go:171","msg":"trace[411797244] linearizableReadLoop","detail":"{readStateIndex:2585; appliedIndex:2584; }","duration":"230.795406ms","start":"2026-04-16T09:16:46.879947Z","end":"2026-04-16T09:16:47.110743Z","steps":["trace[411797244] 'read index received' (duration: 88.078728ms)","trace[411797244] 'applied index is now lower than readState.Index' (duration: 142.715928ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T09:16:47.111002Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T09:16:46.782701Z","time spent":"328.240225ms","remote":"127.0.0.1:35518","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-04-16T09:16:47.111027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"334.917292ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-16T09:16:47.111048Z","caller":"traceutil/trace.go:171","msg":"trace[1885924667] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2482; }","duration":"334.966264ms","start":"2026-04-16T09:16:46.776074Z","end":"2026-04-16T09:16:47.11104Z","steps":["trace[1885924667] 'agreement among raft nodes before linearized reading' (duration: 334.867512ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T09:16:47.111074Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T09:16:46.776056Z","time spent":"335.012224ms","remote":"127.0.0.1:35518","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-16T09:18:35.758477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.821129ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-04-16T09:18:35.758786Z","caller":"traceutil/trace.go:171","msg":"trace[1758793412] linearizableReadLoop","detail":"{readStateIndex:3256; appliedIndex:3255; }","duration":"150.052523ms","start":"2026-04-16T09:18:35.608715Z","end":"2026-04-16T09:18:35.758767Z","steps":["trace[1758793412] 'read index received' (duration: 52.612µs)","trace[1758793412] 'applied index is now lower than readState.Index' (duration: 149.998611ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T09:18:35.759144Z","caller":"traceutil/trace.go:171","msg":"trace[168771379] transaction","detail":"{read_only:false; response_revision:3130; number_of_response:1; }","duration":"114.730918ms","start":"2026-04-16T09:18:35.644388Z","end":"2026-04-16T09:18:35.759119Z","steps":["trace[168771379] 'process raft request' (duration: 114.242123ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T09:18:35.759575Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.848738ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"} {"level":"info","ts":"2026-04-16T09:18:35.759624Z","caller":"traceutil/trace.go:171","msg":"trace[168063462] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:3129; }","duration":"150.946991ms","start":"2026-04-16T09:18:35.608665Z","end":"2026-04-16T09:18:35.759612Z","steps":["trace[168063462] 'agreement among raft nodes before linearized reading' (duration: 150.376983ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T09:18:36.058906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.801723ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-16T09:18:36.059003Z","caller":"traceutil/trace.go:171","msg":"trace[308302906] linearizableReadLoop","detail":"{readStateIndex:3259; appliedIndex:3258; }","duration":"246.449449ms","start":"2026-04-16T09:18:35.812538Z","end":"2026-04-16T09:18:36.058988Z","steps":["trace[308302906] 'read index received' (duration: 110.391877ms)","trace[308302906] 'applied index is now lower than readState.Index' (duration: 136.055922ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T09:18:36.059167Z","caller":"traceutil/trace.go:171","msg":"trace[1968547583] transaction","detail":"{read_only:false; response_revision:3132; number_of_response:1; }","duration":"247.267304ms","start":"2026-04-16T09:18:35.811872Z","end":"2026-04-16T09:18:36.059139Z","steps":["trace[1968547583] 'process raft request' (duration: 111.155661ms)","trace[1968547583] 'compare' (duration: 135.69993ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T09:18:36.059302Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.752018ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-04-16T09:18:36.059341Z","caller":"traceutil/trace.go:171","msg":"trace[214279505] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:3132; }","duration":"246.83267ms","start":"2026-04-16T09:18:35.812498Z","end":"2026-04-16T09:18:36.05933Z","steps":["trace[214279505] 'agreement among raft nodes before linearized reading' (duration: 246.675385ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T09:18:36.059361Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.961041ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T09:18:36.059403Z","caller":"traceutil/trace.go:171","msg":"trace[1815470724] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:3132; }","duration":"213.033342ms","start":"2026-04-16T09:18:35.846359Z","end":"2026-04-16T09:18:36.059392Z","steps":["trace[1815470724] 'agreement among raft nodes before linearized reading' (duration: 212.95994ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T09:20:36.314101Z","caller":"traceutil/trace.go:171","msg":"trace[422187515] transaction","detail":"{read_only:false; response_revision:3920; number_of_response:1; }","duration":"111.736795ms","start":"2026-04-16T09:20:36.201976Z","end":"2026-04-16T09:20:36.313713Z","steps":["trace[422187515] 'process raft request' (duration: 97.887763ms)","trace[422187515] 'compare' (duration: 13.5055ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T09:22:33.835644Z","caller":"traceutil/trace.go:171","msg":"trace[1167545183] transaction","detail":"{read_only:false; response_revision:5384; number_of_response:1; }","duration":"103.490907ms","start":"2026-04-16T09:22:33.732112Z","end":"2026-04-16T09:22:33.835603Z","steps":["trace[1167545183] 'process raft request' (duration: 102.649955ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T09:22:44.995546Z","caller":"traceutil/trace.go:171","msg":"trace[762785139] transaction","detail":"{read_only:false; response_revision:5550; number_of_response:1; }","duration":"135.879341ms","start":"2026-04-16T09:22:44.859629Z","end":"2026-04-16T09:22:44.995508Z","steps":["trace[762785139] 'process raft request' (duration: 131.387597ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T09:22:45.188378Z","caller":"traceutil/trace.go:171","msg":"trace[138335381] linearizableReadLoop","detail":"{readStateIndex:5762; appliedIndex:5761; }","duration":"115.743995ms","start":"2026-04-16T09:22:45.072608Z","end":"2026-04-16T09:22:45.188352Z","steps":["trace[138335381] 'read index received' (duration: 91.779178ms)","trace[138335381] 'applied index is now lower than readState.Index' (duration: 23.963717ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T09:22:45.188646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.012755ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-16T09:22:45.188693Z","caller":"traceutil/trace.go:171","msg":"trace[783038561] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5551; }","duration":"116.110439ms","start":"2026-04-16T09:22:45.072574Z","end":"2026-04-16T09:22:45.188684Z","steps":["trace[783038561] 'agreement among raft nodes before linearized reading' (duration: 115.916401ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T09:22:45.188802Z","caller":"traceutil/trace.go:171","msg":"trace[1639557189] transaction","detail":"{read_only:false; response_revision:5551; number_of_response:1; }","duration":"122.730744ms","start":"2026-04-16T09:22:45.066021Z","end":"2026-04-16T09:22:45.188751Z","steps":["trace[1639557189] 'process raft request' (duration: 98.430635ms)","trace[1639557189] 'compare' (duration: 23.80067ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T09:23:07.662298Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2983} {"level":"info","ts":"2026-04-16T09:23:07.797537Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2983,"took":"132.013772ms","hash":1467172306,"current-db-size-bytes":55222272,"current-db-size":"55 MB","current-db-size-in-use-bytes":31047680,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-04-16T09:23:07.797628Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1467172306,"revision":2983,"compact-revision":-1}