{"level":"warn","ts":"2026-08-22T10:33:06.38794Z","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-22T10:33:06.388025Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.177: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.177:2380","--initial-cluster=instance=https://199.204.45.177:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.177:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.177: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-22T10:33:06.388088Z","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-22T10:33:06.388101Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.177:2380"]} {"level":"info","ts":"2026-08-22T10:33:06.388122Z","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-22T10:33:06.38875Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.177:2379"]} {"level":"info","ts":"2026-08-22T10:33:06.388834Z","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":16,"max-cpu-available":16,"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.177:2380"],"listen-peer-urls":["https://199.204.45.177:2380"],"advertise-client-urls":["https://199.204.45.177:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.177:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.177: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-22T10:33:06.39266Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.265705ms"} {"level":"info","ts":"2026-08-22T10:33:06.399077Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"7c53a18098324dc9","cluster-id":"4717e8aa221973c8"} {"level":"info","ts":"2026-08-22T10:33:06.399163Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7c53a18098324dc9 switched to configuration voters=()"} {"level":"info","ts":"2026-08-22T10:33:06.399185Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7c53a18098324dc9 became follower at term 0"} {"level":"info","ts":"2026-08-22T10:33:06.399195Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 7c53a18098324dc9 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-22T10:33:06.399203Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7c53a18098324dc9 became follower at term 1"} {"level":"info","ts":"2026-08-22T10:33:06.399238Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7c53a18098324dc9 switched to configuration voters=(8958681657451367881)"} {"level":"warn","ts":"2026-08-22T10:33:06.405206Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-22T10:33:06.406671Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-22T10:33:06.407674Z","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-22T10:33:06.409788Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"7c53a18098324dc9","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-22T10:33:06.409995Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"7c53a18098324dc9","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-22T10:33:06.41006Z","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-22T10:33:06.41015Z","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-22T10:33:06.410186Z","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-22T10:33:06.411966Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7c53a18098324dc9 switched to configuration voters=(8958681657451367881)"} {"level":"info","ts":"2026-08-22T10:33:06.412256Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"4717e8aa221973c8","local-member-id":"7c53a18098324dc9","added-peer-id":"7c53a18098324dc9","added-peer-peer-urls":["https://199.204.45.177:2380"]} {"level":"info","ts":"2026-08-22T10:33:06.413737Z","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-22T10:33:06.413854Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.177:2380"} {"level":"info","ts":"2026-08-22T10:33:06.413919Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.177:2380"} {"level":"info","ts":"2026-08-22T10:33:06.413969Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"7c53a18098324dc9","initial-advertise-peer-urls":["https://199.204.45.177:2380"],"listen-peer-urls":["https://199.204.45.177:2380"],"advertise-client-urls":["https://199.204.45.177:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.177:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-22T10:33:06.414006Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-22T10:33:07.200187Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7c53a18098324dc9 is starting a new election at term 1"} {"level":"info","ts":"2026-08-22T10:33:07.200259Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7c53a18098324dc9 became pre-candidate at term 1"} {"level":"info","ts":"2026-08-22T10:33:07.200297Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7c53a18098324dc9 received MsgPreVoteResp from 7c53a18098324dc9 at term 1"} {"level":"info","ts":"2026-08-22T10:33:07.200333Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7c53a18098324dc9 became candidate at term 2"} {"level":"info","ts":"2026-08-22T10:33:07.200349Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7c53a18098324dc9 received MsgVoteResp from 7c53a18098324dc9 at term 2"} {"level":"info","ts":"2026-08-22T10:33:07.200371Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7c53a18098324dc9 became leader at term 2"} {"level":"info","ts":"2026-08-22T10:33:07.20039Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 7c53a18098324dc9 elected leader 7c53a18098324dc9 at term 2"} {"level":"info","ts":"2026-08-22T10:33:07.201719Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"7c53a18098324dc9","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.177:2379]}","request-path":"/0/members/7c53a18098324dc9/attributes","cluster-id":"4717e8aa221973c8","publish-timeout":"7s"} {"level":"info","ts":"2026-08-22T10:33:07.201723Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-22T10:33:07.201738Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-22T10:33:07.201792Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-22T10:33:07.202243Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-22T10:33:07.20227Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-22T10:33:07.203056Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"4717e8aa221973c8","local-member-id":"7c53a18098324dc9","cluster-version":"3.5"} {"level":"info","ts":"2026-08-22T10:33:07.203213Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-22T10:33:07.203249Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-08-22T10:33:07.205157Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.177:2379"} {"level":"info","ts":"2026-08-22T10:33:07.205295Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-08-22T10:33:24.548077Z","caller":"traceutil/trace.go:171","msg":"trace[1308899575] transaction","detail":"{read_only:false; response_revision:371; number_of_response:1; }","duration":"108.263516ms","start":"2026-08-22T10:33:24.439774Z","end":"2026-08-22T10:33:24.548037Z","steps":["trace[1308899575] 'process raft request' (duration: 107.997981ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:33:50.212279Z","caller":"traceutil/trace.go:171","msg":"trace[178897240] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"128.11138ms","start":"2026-08-22T10:33:50.084127Z","end":"2026-08-22T10:33:50.212238Z","steps":["trace[178897240] 'process raft request' (duration: 127.479087ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:33:50.433667Z","caller":"traceutil/trace.go:171","msg":"trace[1249941475] linearizableReadLoop","detail":"{readStateIndex:612; appliedIndex:610; }","duration":"133.082311ms","start":"2026-08-22T10:33:50.300534Z","end":"2026-08-22T10:33:50.433616Z","steps":["trace[1249941475] 'read index received' (duration: 99.357184ms)","trace[1249941475] 'applied index is now lower than readState.Index' (duration: 33.723747ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T10:33:50.43381Z","caller":"traceutil/trace.go:171","msg":"trace[1356294249] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"201.579298ms","start":"2026-08-22T10:33:50.232183Z","end":"2026-08-22T10:33:50.433762Z","steps":["trace[1356294249] 'process raft request' (duration: 167.599436ms)","trace[1356294249] 'compare' (duration: 33.644435ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T10:33:50.433931Z","caller":"traceutil/trace.go:171","msg":"trace[88259022] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"159.738115ms","start":"2026-08-22T10:33:50.274168Z","end":"2026-08-22T10:33:50.433906Z","steps":["trace[88259022] 'process raft request' (duration: 159.392288ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:33:50.433916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.363176ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.177\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-08-22T10:33:50.434034Z","caller":"traceutil/trace.go:171","msg":"trace[1902596540] range","detail":"{range_begin:/registry/masterleases/199.204.45.177; range_end:; response_count:1; response_revision:592; }","duration":"133.498989ms","start":"2026-08-22T10:33:50.300517Z","end":"2026-08-22T10:33:50.434016Z","steps":["trace[1902596540] 'agreement among raft nodes before linearized reading' (duration: 133.268255ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:33:50.606605Z","caller":"traceutil/trace.go:171","msg":"trace[404017553] linearizableReadLoop","detail":"{readStateIndex:613; appliedIndex:612; }","duration":"161.532102ms","start":"2026-08-22T10:33:50.445044Z","end":"2026-08-22T10:33:50.606576Z","steps":["trace[404017553] 'read index received' (duration: 136.094114ms)","trace[404017553] 'applied index is now lower than readState.Index' (duration: 25.436338ms)"],"step_count":2} {"level":"warn","ts":"2026-08-22T10:33:50.606823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.755806ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-22T10:33:50.606919Z","caller":"traceutil/trace.go:171","msg":"trace[982214343] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:592; }","duration":"161.902119ms","start":"2026-08-22T10:33:50.444991Z","end":"2026-08-22T10:33:50.606893Z","steps":["trace[982214343] 'agreement among raft nodes before linearized reading' (duration: 161.742186ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:33:50.606986Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.389767ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-22T10:33:50.607062Z","caller":"traceutil/trace.go:171","msg":"trace[1381224538] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:592; }","duration":"128.547199ms","start":"2026-08-22T10:33:50.478503Z","end":"2026-08-22T10:33:50.60705Z","steps":["trace[1381224538] 'agreement among raft nodes before linearized reading' (duration: 128.351486ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:33:51.099639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.036547ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-22T10:33:51.100431Z","caller":"traceutil/trace.go:171","msg":"trace[1066577956] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"411.353792ms","start":"2026-08-22T10:33:50.689012Z","end":"2026-08-22T10:33:51.100365Z","steps":["trace[1066577956] 'process raft request' (duration: 234.208263ms)","trace[1066577956] 'compare' (duration: 175.943265ms)"],"step_count":2} {"level":"warn","ts":"2026-08-22T10:33:51.100648Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T10:33:50.688988Z","time spent":"411.560326ms","remote":"127.0.0.1:41972","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-22T10:34:05.278794Z","caller":"traceutil/trace.go:171","msg":"trace[1041948237] linearizableReadLoop","detail":"{readStateIndex:776; appliedIndex:775; }","duration":"113.509544ms","start":"2026-08-22T10:34:05.165247Z","end":"2026-08-22T10:34:05.278757Z","steps":["trace[1041948237] 'read index received' (duration: 112.971272ms)","trace[1041948237] 'applied index is now lower than readState.Index' (duration: 536.622µs)"],"step_count":2} {"level":"info","ts":"2026-08-22T10:34:05.27884Z","caller":"traceutil/trace.go:171","msg":"trace[1785269533] transaction","detail":"{read_only:false; response_revision:752; number_of_response:1; }","duration":"116.186159ms","start":"2026-08-22T10:34:05.162614Z","end":"2026-08-22T10:34:05.2788Z","steps":["trace[1785269533] 'process raft request' (duration: 115.620346ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:34:05.279068Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.802529ms","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-22T10:34:05.279123Z","caller":"traceutil/trace.go:171","msg":"trace[690732883] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:752; }","duration":"113.919342ms","start":"2026-08-22T10:34:05.165192Z","end":"2026-08-22T10:34:05.279112Z","steps":["trace[690732883] 'agreement among raft nodes before linearized reading' (duration: 113.731178ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:34:05.279196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.044745ms","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-08-22T10:34:05.279271Z","caller":"traceutil/trace.go:171","msg":"trace[1241413832] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:752; }","duration":"113.168267ms","start":"2026-08-22T10:34:05.166084Z","end":"2026-08-22T10:34:05.279252Z","steps":["trace[1241413832] 'agreement among raft nodes before linearized reading' (duration: 112.916962ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:34:05.469735Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.976975ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-22T10:34:05.469861Z","caller":"traceutil/trace.go:171","msg":"trace[1506258398] transaction","detail":"{read_only:false; response_revision:753; number_of_response:1; }","duration":"185.909959ms","start":"2026-08-22T10:34:05.283927Z","end":"2026-08-22T10:34:05.469837Z","steps":["trace[1506258398] 'process raft request' (duration: 63.716429ms)","trace[1506258398] 'compare' (duration: 121.837703ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T10:34:05.471432Z","caller":"traceutil/trace.go:171","msg":"trace[1624965626] linearizableReadLoop","detail":"{readStateIndex:778; appliedIndex:776; }","duration":"185.580402ms","start":"2026-08-22T10:34:05.285836Z","end":"2026-08-22T10:34:05.471416Z","steps":["trace[1624965626] 'read index received' (duration: 61.82817ms)","trace[1624965626] 'applied index is now lower than readState.Index' (duration: 123.751092ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T10:34:05.471455Z","caller":"traceutil/trace.go:171","msg":"trace[1275779908] transaction","detail":"{read_only:false; response_revision:754; number_of_response:1; }","duration":"186.757395ms","start":"2026-08-22T10:34:05.284684Z","end":"2026-08-22T10:34:05.471441Z","steps":["trace[1275779908] 'process raft request' (duration: 186.651923ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:34:05.47161Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.775235ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-f6gq8\" ","response":"range_response_count:1 size:3965"} {"level":"info","ts":"2026-08-22T10:34:05.471648Z","caller":"traceutil/trace.go:171","msg":"trace[754402177] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-f6gq8; range_end:; response_count:1; response_revision:754; }","duration":"185.846747ms","start":"2026-08-22T10:34:05.285789Z","end":"2026-08-22T10:34:05.471636Z","steps":["trace[754402177] 'agreement among raft nodes before linearized reading' (duration: 185.685824ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:35:16.771236Z","caller":"traceutil/trace.go:171","msg":"trace[1245932073] linearizableReadLoop","detail":"{readStateIndex:1870; appliedIndex:1869; }","duration":"105.992964ms","start":"2026-08-22T10:35:16.665215Z","end":"2026-08-22T10:35:16.771208Z","steps":["trace[1245932073] 'read index received' (duration: 105.821551ms)","trace[1245932073] 'applied index is now lower than readState.Index' (duration: 169.883µs)"],"step_count":2} {"level":"info","ts":"2026-08-22T10:35:16.771329Z","caller":"traceutil/trace.go:171","msg":"trace[524334026] transaction","detail":"{read_only:false; response_revision:1799; number_of_response:1; }","duration":"134.192276ms","start":"2026-08-22T10:35:16.637111Z","end":"2026-08-22T10:35:16.771303Z","steps":["trace[524334026] 'process raft request' (duration: 133.911691ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:35:16.771584Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.347892ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-3bff87c9-94a1-412e-8091-e4b406d8301b\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-08-22T10:35:16.771672Z","caller":"traceutil/trace.go:171","msg":"trace[1917513409] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-3bff87c9-94a1-412e-8091-e4b406d8301b; range_end:; response_count:1; response_revision:1799; }","duration":"106.452794ms","start":"2026-08-22T10:35:16.665198Z","end":"2026-08-22T10:35:16.771651Z","steps":["trace[1917513409] 'agreement among raft nodes before linearized reading' (duration: 106.159508ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:35:16.908529Z","caller":"traceutil/trace.go:171","msg":"trace[825962643] transaction","detail":"{read_only:false; response_revision:1802; number_of_response:1; }","duration":"130.622286ms","start":"2026-08-22T10:35:16.77788Z","end":"2026-08-22T10:35:16.908503Z","steps":["trace[825962643] 'process raft request' (duration: 130.563345ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:35:16.908563Z","caller":"traceutil/trace.go:171","msg":"trace[438694428] transaction","detail":"{read_only:false; response_revision:1801; number_of_response:1; }","duration":"132.616945ms","start":"2026-08-22T10:35:16.77591Z","end":"2026-08-22T10:35:16.908527Z","steps":["trace[438694428] 'process raft request' (duration: 132.394931ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:36:00.4947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.479101ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"info","ts":"2026-08-22T10:36:00.494833Z","caller":"traceutil/trace.go:171","msg":"trace[189066290] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2094; }","duration":"103.783316ms","start":"2026-08-22T10:36:00.391016Z","end":"2026-08-22T10:36:00.494799Z","steps":["trace[189066290] 'range keys from in-memory index tree' (duration: 103.216185ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:36:06.293027Z","caller":"traceutil/trace.go:171","msg":"trace[1892525384] linearizableReadLoop","detail":"{readStateIndex:2204; appliedIndex:2203; }","duration":"182.875354ms","start":"2026-08-22T10:36:06.110123Z","end":"2026-08-22T10:36:06.292998Z","steps":["trace[1892525384] 'read index received' (duration: 182.733142ms)","trace[1892525384] 'applied index is now lower than readState.Index' (duration: 140.472µs)"],"step_count":2} {"level":"info","ts":"2026-08-22T10:36:06.293153Z","caller":"traceutil/trace.go:171","msg":"trace[1263527646] transaction","detail":"{read_only:false; response_revision:2123; number_of_response:1; }","duration":"183.57472ms","start":"2026-08-22T10:36:06.109532Z","end":"2026-08-22T10:36:06.293107Z","steps":["trace[1263527646] 'process raft request' (duration: 183.291374ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:36:06.293298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.949867ms","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-22T10:36:06.293348Z","caller":"traceutil/trace.go:171","msg":"trace[317747452] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2123; }","duration":"134.041408ms","start":"2026-08-22T10:36:06.159293Z","end":"2026-08-22T10:36:06.293335Z","steps":["trace[317747452] 'agreement among raft nodes before linearized reading' (duration: 133.858664ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:36:06.293387Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.241241ms","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-22T10:36:06.293582Z","caller":"traceutil/trace.go:171","msg":"trace[487537815] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2123; }","duration":"183.509636ms","start":"2026-08-22T10:36:06.110043Z","end":"2026-08-22T10:36:06.293553Z","steps":["trace[487537815] 'agreement among raft nodes before linearized reading' (duration: 183.092578ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:36:06.611789Z","caller":"traceutil/trace.go:171","msg":"trace[969852744] linearizableReadLoop","detail":"{readStateIndex:2207; appliedIndex:2206; }","duration":"132.877265ms","start":"2026-08-22T10:36:06.478886Z","end":"2026-08-22T10:36:06.611763Z","steps":["trace[969852744] 'read index received' (duration: 57.951371ms)","trace[969852744] 'applied index is now lower than readState.Index' (duration: 74.923834ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T10:36:06.611798Z","caller":"traceutil/trace.go:171","msg":"trace[1713312456] transaction","detail":"{read_only:false; response_revision:2126; number_of_response:1; }","duration":"213.632137ms","start":"2026-08-22T10:36:06.398118Z","end":"2026-08-22T10:36:06.61175Z","steps":["trace[1713312456] 'process raft request' (duration: 138.770594ms)","trace[1713312456] 'compare' (duration: 74.690609ms)"],"step_count":2} {"level":"warn","ts":"2026-08-22T10:36:06.611972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.024078ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-22T10:36:06.612163Z","caller":"traceutil/trace.go:171","msg":"trace[1733147098] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2127; }","duration":"133.300894ms","start":"2026-08-22T10:36:06.478812Z","end":"2026-08-22T10:36:06.612113Z","steps":["trace[1733147098] 'agreement among raft nodes before linearized reading' (duration: 133.051349ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:37:29.779802Z","caller":"traceutil/trace.go:171","msg":"trace[1583523222] transaction","detail":"{read_only:false; response_revision:2770; number_of_response:1; }","duration":"198.496075ms","start":"2026-08-22T10:37:29.581272Z","end":"2026-08-22T10:37:29.779768Z","steps":["trace[1583523222] 'process raft request' (duration: 198.2673ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:40:00.01691Z","caller":"traceutil/trace.go:171","msg":"trace[1250453052] transaction","detail":"{read_only:false; response_revision:3764; number_of_response:1; }","duration":"185.900126ms","start":"2026-08-22T10:39:59.830974Z","end":"2026-08-22T10:40:00.016875Z","steps":["trace[1250453052] 'process raft request' (duration: 144.150088ms)","trace[1250453052] 'compare' (duration: 41.590015ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T10:40:00.016891Z","caller":"traceutil/trace.go:171","msg":"trace[65052137] linearizableReadLoop","detail":"{readStateIndex:3907; appliedIndex:3906; }","duration":"100.211405ms","start":"2026-08-22T10:39:59.916647Z","end":"2026-08-22T10:40:00.016858Z","steps":["trace[65052137] 'read index received' (duration: 58.419957ms)","trace[65052137] 'applied index is now lower than readState.Index' (duration: 41.789758ms)"],"step_count":2} {"level":"warn","ts":"2026-08-22T10:40:00.017501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.830709ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-22T10:40:00.017621Z","caller":"traceutil/trace.go:171","msg":"trace[541490254] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:3764; }","duration":"100.996571ms","start":"2026-08-22T10:39:59.9166Z","end":"2026-08-22T10:40:00.017596Z","steps":["trace[541490254] 'agreement among raft nodes before linearized reading' (duration: 100.325858ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:41:19.866644Z","caller":"traceutil/trace.go:171","msg":"trace[131370026] linearizableReadLoop","detail":"{readStateIndex:4980; appliedIndex:4978; }","duration":"135.177832ms","start":"2026-08-22T10:41:19.731425Z","end":"2026-08-22T10:41:19.866603Z","steps":["trace[131370026] 'read index received' (duration: 13.713267ms)","trace[131370026] 'applied index is now lower than readState.Index' (duration: 121.463535ms)"],"step_count":2} {"level":"warn","ts":"2026-08-22T10:41:19.866907Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.443977ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-22T10:41:19.867044Z","caller":"traceutil/trace.go:171","msg":"trace[1078360251] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:4797; }","duration":"135.634862ms","start":"2026-08-22T10:41:19.731384Z","end":"2026-08-22T10:41:19.867019Z","steps":["trace[1078360251] 'agreement among raft nodes before linearized reading' (duration: 135.397897ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:41:19.866713Z","caller":"traceutil/trace.go:171","msg":"trace[436879411] transaction","detail":"{read_only:false; response_revision:4797; number_of_response:1; }","duration":"137.050591ms","start":"2026-08-22T10:41:19.729614Z","end":"2026-08-22T10:41:19.866664Z","steps":["trace[436879411] 'process raft request' (duration: 114.487813ms)","trace[436879411] 'compare' (duration: 22.359574ms)"],"step_count":2} {"level":"warn","ts":"2026-08-22T10:41:24.145557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.216043ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/monitoring/kube-prometheus-stack-prometheus-node-exporter-ddtt9-tls\" ","response":"range_response_count:1 size:1967"} {"level":"warn","ts":"2026-08-22T10:41:24.145606Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.695377ms","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-22T10:41:24.145706Z","caller":"traceutil/trace.go:171","msg":"trace[1392837066] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4932; }","duration":"116.84203ms","start":"2026-08-22T10:41:24.02885Z","end":"2026-08-22T10:41:24.145692Z","steps":["trace[1392837066] 'range keys from in-memory index tree' (duration: 116.568565ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:41:24.145743Z","caller":"traceutil/trace.go:171","msg":"trace[1474702806] range","detail":"{range_begin:/registry/cert-manager.io/certificates/monitoring/kube-prometheus-stack-prometheus-node-exporter-ddtt9-tls; range_end:; response_count:1; response_revision:4932; }","duration":"102.432537ms","start":"2026-08-22T10:41:24.043284Z","end":"2026-08-22T10:41:24.145717Z","steps":["trace[1474702806] 'range keys from in-memory index tree' (duration: 102.022299ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:41:24.145825Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.88665ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-08-22T10:41:24.145895Z","caller":"traceutil/trace.go:171","msg":"trace[2012513980] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4932; }","duration":"113.998052ms","start":"2026-08-22T10:41:24.031879Z","end":"2026-08-22T10:41:24.145877Z","steps":["trace[2012513980] 'range keys from in-memory index tree' (duration: 113.710306ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:41:24.264939Z","caller":"traceutil/trace.go:171","msg":"trace[535826970] transaction","detail":"{read_only:false; response_revision:4933; number_of_response:1; }","duration":"115.111326ms","start":"2026-08-22T10:41:24.149792Z","end":"2026-08-22T10:41:24.264903Z","steps":["trace[535826970] 'process raft request' (duration: 114.882621ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:41:24.324942Z","caller":"traceutil/trace.go:171","msg":"trace[17031987] linearizableReadLoop","detail":"{readStateIndex:5120; appliedIndex:5118; }","duration":"173.393558ms","start":"2026-08-22T10:41:24.151524Z","end":"2026-08-22T10:41:24.324918Z","steps":["trace[17031987] 'read index received' (duration: 113.185997ms)","trace[17031987] 'applied index is now lower than readState.Index' (duration: 60.206071ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T10:41:24.32522Z","caller":"traceutil/trace.go:171","msg":"trace[743258886] transaction","detail":"{read_only:false; response_revision:4934; number_of_response:1; }","duration":"173.825456ms","start":"2026-08-22T10:41:24.151375Z","end":"2026-08-22T10:41:24.325201Z","steps":["trace[743258886] 'process raft request' (duration: 173.414378ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:41:24.325488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.96648ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/vector\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-22T10:41:24.325559Z","caller":"traceutil/trace.go:171","msg":"trace[818851639] range","detail":"{range_begin:/registry/clusterroles/vector; range_end:; response_count:0; response_revision:4934; }","duration":"174.102683ms","start":"2026-08-22T10:41:24.151438Z","end":"2026-08-22T10:41:24.32554Z","steps":["trace[818851639] 'agreement among raft nodes before linearized reading' (duration: 173.99857ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:41:24.40763Z","caller":"traceutil/trace.go:171","msg":"trace[416201238] transaction","detail":"{read_only:false; response_revision:4935; number_of_response:1; }","duration":"110.107893ms","start":"2026-08-22T10:41:24.297477Z","end":"2026-08-22T10:41:24.407585Z","steps":["trace[416201238] 'process raft request' (duration: 92.123908ms)","trace[416201238] 'compare' (duration: 17.784681ms)"],"step_count":2} {"level":"warn","ts":"2026-08-22T10:41:24.407753Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.2219ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-08-22T10:41:24.407753Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.494243ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-aff344f4-874c-427b-a83c-57d0ba527339\" ","response":"range_response_count:1 size:3601"} {"level":"info","ts":"2026-08-22T10:41:24.4078Z","caller":"traceutil/trace.go:171","msg":"trace[1259740499] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4935; }","duration":"194.329812ms","start":"2026-08-22T10:41:24.213456Z","end":"2026-08-22T10:41:24.407786Z","steps":["trace[1259740499] 'agreement among raft nodes before linearized reading' (duration: 194.114958ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:41:24.407827Z","caller":"traceutil/trace.go:171","msg":"trace[362619536] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-aff344f4-874c-427b-a83c-57d0ba527339; range_end:; response_count:1; response_revision:4935; }","duration":"217.598775ms","start":"2026-08-22T10:41:24.190212Z","end":"2026-08-22T10:41:24.40781Z","steps":["trace[362619536] 'agreement among raft nodes before linearized reading' (duration: 217.35644ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:41:24.408873Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.369911ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-prometheus-node-exporter-ddtt9-tls\" ","response":"range_response_count:1 size:4428"} {"level":"info","ts":"2026-08-22T10:41:24.409008Z","caller":"traceutil/trace.go:171","msg":"trace[1520230539] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-prometheus-node-exporter-ddtt9-tls; range_end:; response_count:1; response_revision:4935; }","duration":"256.616106ms","start":"2026-08-22T10:41:24.15236Z","end":"2026-08-22T10:41:24.408976Z","steps":["trace[1520230539] 'agreement among raft nodes before linearized reading' (duration: 255.236389ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:41:24.726318Z","caller":"traceutil/trace.go:171","msg":"trace[284573791] linearizableReadLoop","detail":"{readStateIndex:5128; appliedIndex:5127; }","duration":"147.487473ms","start":"2026-08-22T10:41:24.578798Z","end":"2026-08-22T10:41:24.726286Z","steps":["trace[284573791] 'read index received' (duration: 116.732578ms)","trace[284573791] 'applied index is now lower than readState.Index' (duration: 30.753705ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T10:41:24.726444Z","caller":"traceutil/trace.go:171","msg":"trace[1785576061] transaction","detail":"{read_only:false; response_revision:4941; number_of_response:1; }","duration":"165.457556ms","start":"2026-08-22T10:41:24.560959Z","end":"2026-08-22T10:41:24.726417Z","steps":["trace[1785576061] 'process raft request' (duration: 134.688902ms)","trace[1785576061] 'compare' (duration: 30.339545ms)"],"step_count":2} {"level":"warn","ts":"2026-08-22T10:41:24.726622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.792679ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-aff344f4-874c-427b-a83c-57d0ba527339\" ","response":"range_response_count:1 size:3601"} {"level":"info","ts":"2026-08-22T10:41:24.726673Z","caller":"traceutil/trace.go:171","msg":"trace[315705864] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-aff344f4-874c-427b-a83c-57d0ba527339; range_end:; response_count:1; response_revision:4941; }","duration":"147.898391ms","start":"2026-08-22T10:41:24.578758Z","end":"2026-08-22T10:41:24.726656Z","steps":["trace[315705864] 'agreement among raft nodes before linearized reading' (duration: 147.640006ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:41:24.850228Z","caller":"traceutil/trace.go:171","msg":"trace[1446953861] transaction","detail":"{read_only:false; response_revision:4943; number_of_response:1; }","duration":"115.040704ms","start":"2026-08-22T10:41:24.735164Z","end":"2026-08-22T10:41:24.850204Z","steps":["trace[1446953861] 'process raft request' (duration: 114.892131ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:41:38.34426Z","caller":"traceutil/trace.go:171","msg":"trace[1160247786] transaction","detail":"{read_only:false; response_revision:5203; number_of_response:1; }","duration":"529.606055ms","start":"2026-08-22T10:41:37.814636Z","end":"2026-08-22T10:41:38.344242Z","steps":["trace[1160247786] 'process raft request' (duration: 529.468122ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:41:38.344381Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T10:41:37.814618Z","time spent":"529.704917ms","remote":"127.0.0.1:41978","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1068,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-22T10:41:38.344469Z","caller":"traceutil/trace.go:171","msg":"trace[636443614] transaction","detail":"{read_only:false; response_revision:5204; number_of_response:1; }","duration":"529.36237ms","start":"2026-08-22T10:41:37.815101Z","end":"2026-08-22T10:41:38.344464Z","steps":["trace[636443614] 'process raft request' (duration: 529.106065ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:41:38.344493Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T10:41:37.815079Z","time spent":"529.40075ms","remote":"127.0.0.1:41848","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":530,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-22T10:41:38.344672Z","caller":"traceutil/trace.go:171","msg":"trace[2095131558] transaction","detail":"{read_only:false; response_revision:5205; number_of_response:1; }","duration":"528.490923ms","start":"2026-08-22T10:41:37.816168Z","end":"2026-08-22T10:41:38.344659Z","steps":["trace[2095131558] 'process raft request' (duration: 528.205837ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:41:38.344728Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T10:41:37.816141Z","time spent":"528.561364ms","remote":"127.0.0.1:41978","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1194,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-22T10:41:38.34482Z","caller":"traceutil/trace.go:171","msg":"trace[1312294281] transaction","detail":"{read_only:false; response_revision:5206; number_of_response:1; }","duration":"528.185706ms","start":"2026-08-22T10:41:37.81659Z","end":"2026-08-22T10:41:38.344776Z","steps":["trace[1312294281] 'process raft request' (duration: 527.993813ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:41:38.345071Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T10:41:37.816574Z","time spent":"528.360049ms","remote":"127.0.0.1:41848","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":682,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-22T10:41:38.469851Z","caller":"traceutil/trace.go:171","msg":"trace[521942322] linearizableReadLoop","detail":"{readStateIndex:5404; appliedIndex:5399; }","duration":"501.183418ms","start":"2026-08-22T10:41:37.968634Z","end":"2026-08-22T10:41:38.469817Z","steps":["trace[521942322] 'read index received' (duration: 375.525529ms)","trace[521942322] 'applied index is now lower than readState.Index' (duration: 125.656859ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T10:41:38.469901Z","caller":"traceutil/trace.go:171","msg":"trace[1703575338] transaction","detail":"{read_only:false; response_revision:5207; number_of_response:1; }","duration":"640.419563ms","start":"2026-08-22T10:41:37.829447Z","end":"2026-08-22T10:41:38.469866Z","steps":["trace[1703575338] 'process raft request' (duration: 640.182769ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:41:38.470069Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T10:41:37.829414Z","time spent":"640.560187ms","remote":"127.0.0.1:41868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9564,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-22T10:41:38.470097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"501.458734ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-08-22T10:41:38.470136Z","caller":"traceutil/trace.go:171","msg":"trace[812103226] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5207; }","duration":"501.571676ms","start":"2026-08-22T10:41:37.968551Z","end":"2026-08-22T10:41:38.470123Z","steps":["trace[812103226] 'agreement among raft nodes before linearized reading' (duration: 501.410392ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:41:38.470176Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T10:41:37.968529Z","time spent":"501.639057ms","remote":"127.0.0.1:41972","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-22T10:41:38.47253Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"384.229917ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-08-22T10:41:38.472668Z","caller":"traceutil/trace.go:171","msg":"trace[2073863862] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5208; }","duration":"384.439701ms","start":"2026-08-22T10:41:38.088199Z","end":"2026-08-22T10:41:38.472639Z","steps":["trace[2073863862] 'agreement among raft nodes before linearized reading' (duration: 384.073352ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:41:38.472731Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T10:41:38.088173Z","time spent":"384.547982ms","remote":"127.0.0.1:41868","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12238,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-08-22T10:41:38.47344Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.747185ms","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-22T10:41:38.473483Z","caller":"traceutil/trace.go:171","msg":"trace[1117736108] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5208; }","duration":"138.832397ms","start":"2026-08-22T10:41:38.334641Z","end":"2026-08-22T10:41:38.473473Z","steps":["trace[1117736108] 'agreement among raft nodes before linearized reading' (duration: 138.735785ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:41:38.47371Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.214057ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-22T10:41:38.473751Z","caller":"traceutil/trace.go:171","msg":"trace[1321023950] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:5208; }","duration":"253.307449ms","start":"2026-08-22T10:41:38.220433Z","end":"2026-08-22T10:41:38.47374Z","steps":["trace[1321023950] 'agreement among raft nodes before linearized reading' (duration: 253.161346ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:41:56.23381Z","caller":"traceutil/trace.go:171","msg":"trace[1847206194] transaction","detail":"{read_only:false; response_revision:5513; number_of_response:1; }","duration":"117.893797ms","start":"2026-08-22T10:41:56.11587Z","end":"2026-08-22T10:41:56.233764Z","steps":["trace[1847206194] 'process raft request' (duration: 47.802942ms)","trace[1847206194] 'compare' (duration: 69.689037ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T10:41:56.234006Z","caller":"traceutil/trace.go:171","msg":"trace[1774959577] transaction","detail":"{read_only:false; response_revision:5514; number_of_response:1; }","duration":"117.659984ms","start":"2026-08-22T10:41:56.116313Z","end":"2026-08-22T10:41:56.233973Z","steps":["trace[1774959577] 'process raft request' (duration: 117.372698ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:41:56.234219Z","caller":"traceutil/trace.go:171","msg":"trace[818732561] transaction","detail":"{read_only:false; response_revision:5515; number_of_response:1; }","duration":"117.720684ms","start":"2026-08-22T10:41:56.116487Z","end":"2026-08-22T10:41:56.234207Z","steps":["trace[818732561] 'process raft request' (duration: 117.370997ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:43:07.233863Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2975} {"level":"info","ts":"2026-08-22T10:43:07.310592Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2975,"took":"74.898964ms","hash":3065544600,"current-db-size-bytes":58015744,"current-db-size":"58 MB","current-db-size-in-use-bytes":34283520,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-08-22T10:43:07.310692Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3065544600,"revision":2975,"compact-revision":-1} {"level":"warn","ts":"2026-08-22T10:47:48.1627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.902981ms","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-22T10:47:48.162818Z","caller":"traceutil/trace.go:171","msg":"trace[1659642922] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:8172; }","duration":"199.114225ms","start":"2026-08-22T10:47:47.963682Z","end":"2026-08-22T10:47:48.162796Z","steps":["trace[1659642922] 'count revisions from in-memory index tree' (duration: 198.769298ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:47:48.163193Z","caller":"traceutil/trace.go:171","msg":"trace[1997046474] linearizableReadLoop","detail":"{readStateIndex:8461; appliedIndex:8460; }","duration":"112.354779ms","start":"2026-08-22T10:47:48.050789Z","end":"2026-08-22T10:47:48.163144Z","steps":["trace[1997046474] 'read index received' (duration: 80.095981ms)","trace[1997046474] 'applied index is now lower than readState.Index' (duration: 32.256738ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T10:47:48.163229Z","caller":"traceutil/trace.go:171","msg":"trace[1336326012] transaction","detail":"{read_only:false; response_revision:8173; number_of_response:1; }","duration":"169.945521ms","start":"2026-08-22T10:47:47.993199Z","end":"2026-08-22T10:47:48.163145Z","steps":["trace[1336326012] 'process raft request' (duration: 137.779275ms)","trace[1336326012] 'compare' (duration: 31.960211ms)"],"step_count":2} {"level":"warn","ts":"2026-08-22T10:47:48.1634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.602083ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-lf4bk\" ","response":"range_response_count:1 size:6531"} {"level":"info","ts":"2026-08-22T10:47:48.163481Z","caller":"traceutil/trace.go:171","msg":"trace[1756570523] range","detail":"{range_begin:/registry/pods/openstack/keepalived-lf4bk; range_end:; response_count:1; response_revision:8173; }","duration":"112.747366ms","start":"2026-08-22T10:47:48.050717Z","end":"2026-08-22T10:47:48.163464Z","steps":["trace[1756570523] 'agreement among raft nodes before linearized reading' (duration: 112.516792ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:48:00.257131Z","caller":"traceutil/trace.go:171","msg":"trace[527697345] transaction","detail":"{read_only:false; response_revision:8239; number_of_response:1; }","duration":"103.563769ms","start":"2026-08-22T10:48:00.153539Z","end":"2026-08-22T10:48:00.257103Z","steps":["trace[527697345] 'process raft request' (duration: 103.299313ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:48:00.314488Z","caller":"traceutil/trace.go:171","msg":"trace[1215277507] transaction","detail":"{read_only:false; response_revision:8240; number_of_response:1; }","duration":"109.093891ms","start":"2026-08-22T10:48:00.205338Z","end":"2026-08-22T10:48:00.314432Z","steps":["trace[1215277507] 'process raft request' (duration: 81.252685ms)","trace[1215277507] 'compare' (duration: 27.619262ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T10:48:01.008886Z","caller":"traceutil/trace.go:171","msg":"trace[621267731] linearizableReadLoop","detail":"{readStateIndex:8534; appliedIndex:8533; }","duration":"258.907873ms","start":"2026-08-22T10:48:00.749943Z","end":"2026-08-22T10:48:01.008851Z","steps":["trace[621267731] 'read index received' (duration: 258.7618ms)","trace[621267731] 'applied index is now lower than readState.Index' (duration: 144.513µs)"],"step_count":2} {"level":"info","ts":"2026-08-22T10:48:01.009003Z","caller":"traceutil/trace.go:171","msg":"trace[273874822] transaction","detail":"{read_only:false; response_revision:8242; number_of_response:1; }","duration":"259.448064ms","start":"2026-08-22T10:48:00.74949Z","end":"2026-08-22T10:48:01.008938Z","steps":["trace[273874822] 'process raft request' (duration: 259.133738ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:48:01.009588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.596776ms","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-22T10:48:01.009732Z","caller":"traceutil/trace.go:171","msg":"trace[710351608] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8242; }","duration":"259.808401ms","start":"2026-08-22T10:48:00.749897Z","end":"2026-08-22T10:48:01.009705Z","steps":["trace[710351608] 'agreement among raft nodes before linearized reading' (duration: 259.149137ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:48:01.069453Z","caller":"traceutil/trace.go:171","msg":"trace[94721967] transaction","detail":"{read_only:false; response_revision:8243; number_of_response:1; }","duration":"318.605698ms","start":"2026-08-22T10:48:00.750809Z","end":"2026-08-22T10:48:01.069414Z","steps":["trace[94721967] 'process raft request' (duration: 313.957043ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:48:01.069722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.920163ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"warn","ts":"2026-08-22T10:48:01.069736Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T10:48:00.750794Z","time spent":"318.768792ms","remote":"127.0.0.1:41972","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-22T10:48:01.069951Z","caller":"traceutil/trace.go:171","msg":"trace[486061490] transaction","detail":"{read_only:false; response_revision:8244; number_of_response:1; }","duration":"288.812742ms","start":"2026-08-22T10:48:00.781127Z","end":"2026-08-22T10:48:01.06994Z","steps":["trace[486061490] 'process raft request' (duration: 288.313022ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:48:01.069802Z","caller":"traceutil/trace.go:171","msg":"trace[196372625] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8244; }","duration":"316.029395ms","start":"2026-08-22T10:48:00.753753Z","end":"2026-08-22T10:48:01.069783Z","steps":["trace[196372625] 'agreement among raft nodes before linearized reading' (duration: 315.78469ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:48:01.070269Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T10:48:00.753746Z","time spent":"316.450805ms","remote":"127.0.0.1:41972","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-22T10:48:07.240878Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6111} {"level":"info","ts":"2026-08-22T10:48:07.337154Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6111,"took":"93.83808ms","hash":1286923447,"current-db-size-bytes":58015744,"current-db-size":"58 MB","current-db-size-in-use-bytes":23060480,"current-db-size-in-use":"23 MB"} {"level":"info","ts":"2026-08-22T10:48:07.33726Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1286923447,"revision":6111,"compact-revision":2975} {"level":"warn","ts":"2026-08-22T10:48:27.755707Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.422019ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-22T10:48:27.755831Z","caller":"traceutil/trace.go:171","msg":"trace[1577187448] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8439; }","duration":"275.601143ms","start":"2026-08-22T10:48:27.480206Z","end":"2026-08-22T10:48:27.755807Z","steps":["trace[1577187448] 'range keys from in-memory index tree' (duration: 275.304486ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:48:27.756098Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.151989ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5683"} {"level":"info","ts":"2026-08-22T10:48:27.756211Z","caller":"traceutil/trace.go:171","msg":"trace[31295014] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:8439; }","duration":"315.303082ms","start":"2026-08-22T10:48:27.440887Z","end":"2026-08-22T10:48:27.75619Z","steps":["trace[31295014] 'range keys from in-memory index tree' (duration: 314.931845ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:48:27.756271Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T10:48:27.440867Z","time spent":"315.387803ms","remote":"127.0.0.1:50046","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5705,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"info","ts":"2026-08-22T10:48:27.756586Z","caller":"traceutil/trace.go:171","msg":"trace[776058195] transaction","detail":"{read_only:false; response_revision:8440; number_of_response:1; }","duration":"108.381598ms","start":"2026-08-22T10:48:27.648145Z","end":"2026-08-22T10:48:27.756527Z","steps":["trace[776058195] 'process raft request' (duration: 40.539526ms)","trace[776058195] 'compare' (duration: 67.652308ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T10:48:29.506374Z","caller":"traceutil/trace.go:171","msg":"trace[1250574564] transaction","detail":"{read_only:false; response_revision:8450; number_of_response:1; }","duration":"112.526221ms","start":"2026-08-22T10:48:29.393821Z","end":"2026-08-22T10:48:29.506347Z","steps":["trace[1250574564] 'process raft request' (duration: 112.126053ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:48:36.106905Z","caller":"traceutil/trace.go:171","msg":"trace[1608164515] transaction","detail":"{read_only:false; response_revision:8485; number_of_response:1; }","duration":"135.332426ms","start":"2026-08-22T10:48:35.971542Z","end":"2026-08-22T10:48:36.106875Z","steps":["trace[1608164515] 'process raft request' (duration: 135.160613ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:48:40.725775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.678114ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-lf4bk\" ","response":"range_response_count:1 size:6531"} {"level":"info","ts":"2026-08-22T10:48:40.725896Z","caller":"traceutil/trace.go:171","msg":"trace[1835448202] range","detail":"{range_begin:/registry/pods/openstack/keepalived-lf4bk; range_end:; response_count:1; response_revision:8519; }","duration":"137.873337ms","start":"2026-08-22T10:48:40.587995Z","end":"2026-08-22T10:48:40.725868Z","steps":["trace[1835448202] 'range keys from in-memory index tree' (duration: 137.448039ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:48:40.966065Z","caller":"traceutil/trace.go:171","msg":"trace[564530848] linearizableReadLoop","detail":"{readStateIndex:8824; appliedIndex:8822; }","duration":"229.505542ms","start":"2026-08-22T10:48:40.736531Z","end":"2026-08-22T10:48:40.966036Z","steps":["trace[564530848] 'read index received' (duration: 16.336742ms)","trace[564530848] 'applied index is now lower than readState.Index' (duration: 213.16763ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T10:48:40.966241Z","caller":"traceutil/trace.go:171","msg":"trace[1633658629] transaction","detail":"{read_only:false; response_revision:8521; number_of_response:1; }","duration":"231.208289ms","start":"2026-08-22T10:48:40.735014Z","end":"2026-08-22T10:48:40.966222Z","steps":["trace[1633658629] 'process raft request' (duration: 133.303605ms)","trace[1633658629] 'compare' (duration: 97.599057ms)"],"step_count":2} {"level":"warn","ts":"2026-08-22T10:48:40.966507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.87493ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-22T10:48:40.966616Z","caller":"traceutil/trace.go:171","msg":"trace[890724903] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:8521; }","duration":"199.038063ms","start":"2026-08-22T10:48:40.767553Z","end":"2026-08-22T10:48:40.966591Z","steps":["trace[890724903] 'agreement among raft nodes before linearized reading' (duration: 198.86618ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:48:40.967255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.700957ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:26 size:228501"} {"level":"info","ts":"2026-08-22T10:48:40.967324Z","caller":"traceutil/trace.go:171","msg":"trace[1668323387] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:26; response_revision:8521; }","duration":"230.82145ms","start":"2026-08-22T10:48:40.736489Z","end":"2026-08-22T10:48:40.96731Z","steps":["trace[1668323387] 'agreement among raft nodes before linearized reading' (duration: 230.208338ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:49:32.156056Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-000000000000245b.wal"} {"level":"warn","ts":"2026-08-22T10:49:57.854202Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.370563ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-08-22T10:49:57.854488Z","caller":"traceutil/trace.go:171","msg":"trace[406688342] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:9233; }","duration":"154.7276ms","start":"2026-08-22T10:49:57.699725Z","end":"2026-08-22T10:49:57.854452Z","steps":["trace[406688342] 'range keys from in-memory index tree' (duration: 153.951214ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:49:57.992514Z","caller":"traceutil/trace.go:171","msg":"trace[1750250436] transaction","detail":"{read_only:false; response_revision:9234; number_of_response:1; }","duration":"133.301215ms","start":"2026-08-22T10:49:57.859175Z","end":"2026-08-22T10:49:57.992477Z","steps":["trace[1750250436] 'process raft request' (duration: 133.050319ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:49:58.000395Z","caller":"traceutil/trace.go:171","msg":"trace[2011083132] transaction","detail":"{read_only:false; response_revision:9236; number_of_response:1; }","duration":"140.647534ms","start":"2026-08-22T10:49:57.859713Z","end":"2026-08-22T10:49:58.000361Z","steps":["trace[2011083132] 'process raft request' (duration: 140.563842ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:49:58.00043Z","caller":"traceutil/trace.go:171","msg":"trace[670382022] transaction","detail":"{read_only:false; response_revision:9235; number_of_response:1; }","duration":"141.164565ms","start":"2026-08-22T10:49:57.859223Z","end":"2026-08-22T10:49:58.000388Z","steps":["trace[670382022] 'process raft request' (duration: 140.851458ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:49:58.001079Z","caller":"traceutil/trace.go:171","msg":"trace[1060675166] transaction","detail":"{read_only:false; response_revision:9237; number_of_response:1; }","duration":"140.903761ms","start":"2026-08-22T10:49:57.860135Z","end":"2026-08-22T10:49:58.001039Z","steps":["trace[1060675166] 'process raft request' (duration: 140.184965ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:50:45.029011Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"7c53a18098324dc9","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-08-22T10:50:45.035003Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-08-22T10:50:45.035127Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-08-22T10:53:07.250422Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8283} {"level":"info","ts":"2026-08-22T10:53:07.329401Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8283,"took":"75.391118ms","hash":3034438487,"current-db-size-bytes":58015744,"current-db-size":"58 MB","current-db-size-in-use-bytes":25579520,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-08-22T10:53:07.329488Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3034438487,"revision":8283,"compact-revision":6111} {"level":"info","ts":"2026-08-22T10:53:25.284607Z","caller":"traceutil/trace.go:171","msg":"trace[89990739] linearizableReadLoop","detail":"{readStateIndex:11463; appliedIndex:11462; }","duration":"103.833644ms","start":"2026-08-22T10:53:25.180743Z","end":"2026-08-22T10:53:25.284576Z","steps":["trace[89990739] 'read index received' (duration: 88.346111ms)","trace[89990739] 'applied index is now lower than readState.Index' (duration: 15.486153ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T10:53:25.284721Z","caller":"traceutil/trace.go:171","msg":"trace[891383765] transaction","detail":"{read_only:false; response_revision:11087; number_of_response:1; }","duration":"111.841057ms","start":"2026-08-22T10:53:25.172823Z","end":"2026-08-22T10:53:25.284665Z","steps":["trace[891383765] 'process raft request' (duration: 96.324903ms)","trace[891383765] 'compare' (duration: 15.268199ms)"],"step_count":2} {"level":"warn","ts":"2026-08-22T10:53:25.284885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.436069ms","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-22T10:53:25.284997Z","caller":"traceutil/trace.go:171","msg":"trace[1312339788] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:11087; }","duration":"112.575832ms","start":"2026-08-22T10:53:25.172394Z","end":"2026-08-22T10:53:25.28497Z","steps":["trace[1312339788] 'agreement among raft nodes before linearized reading' (duration: 112.356498ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:53:38.745449Z","caller":"traceutil/trace.go:171","msg":"trace[1007799782] linearizableReadLoop","detail":"{readStateIndex:11542; appliedIndex:11541; }","duration":"195.42374ms","start":"2026-08-22T10:53:38.549997Z","end":"2026-08-22T10:53:38.74542Z","steps":["trace[1007799782] 'read index received' (duration: 195.238116ms)","trace[1007799782] 'applied index is now lower than readState.Index' (duration: 180.364µs)"],"step_count":2} {"level":"warn","ts":"2026-08-22T10:53:38.745618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.595564ms","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-08-22T10:53:38.745582Z","caller":"traceutil/trace.go:171","msg":"trace[304122801] transaction","detail":"{read_only:false; response_revision:11163; number_of_response:1; }","duration":"213.481357ms","start":"2026-08-22T10:53:38.532053Z","end":"2026-08-22T10:53:38.745534Z","steps":["trace[304122801] 'process raft request' (duration: 213.191682ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:53:38.745683Z","caller":"traceutil/trace.go:171","msg":"trace[1375350976] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:11163; }","duration":"195.747848ms","start":"2026-08-22T10:53:38.549923Z","end":"2026-08-22T10:53:38.745671Z","steps":["trace[1375350976] 'agreement among raft nodes before linearized reading' (duration: 195.620985ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:58:07.257056Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10808} {"level":"info","ts":"2026-08-22T10:58:07.334369Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10808,"took":"74.978235ms","hash":3573870112,"current-db-size-bytes":58015744,"current-db-size":"58 MB","current-db-size-in-use-bytes":27705344,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-08-22T10:58:07.334445Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3573870112,"revision":10808,"compact-revision":8283} {"level":"warn","ts":"2026-08-22T10:59:51.568881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.665649ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-22T10:59:51.569018Z","caller":"traceutil/trace.go:171","msg":"trace[739426708] linearizableReadLoop","detail":"{readStateIndex:14143; appliedIndex:14142; }","duration":"208.893488ms","start":"2026-08-22T10:59:51.360105Z","end":"2026-08-22T10:59:51.568998Z","steps":["trace[739426708] 'read index received' (duration: 103.919433ms)","trace[739426708] 'applied index is now lower than readState.Index' (duration: 104.972185ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T10:59:51.569047Z","caller":"traceutil/trace.go:171","msg":"trace[1012913744] transaction","detail":"{read_only:false; response_revision:13677; number_of_response:1; }","duration":"241.856218ms","start":"2026-08-22T10:59:51.327154Z","end":"2026-08-22T10:59:51.56901Z","steps":["trace[1012913744] 'process raft request' (duration: 136.931675ms)","trace[1012913744] 'compare' (duration: 104.438804ms)"],"step_count":2} {"level":"warn","ts":"2026-08-22T10:59:51.569267Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.019649ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-08-22T10:59:51.569313Z","caller":"traceutil/trace.go:171","msg":"trace[1067680326] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:13677; }","duration":"177.103351ms","start":"2026-08-22T10:59:51.392197Z","end":"2026-08-22T10:59:51.5693Z","steps":["trace[1067680326] 'agreement among raft nodes before linearized reading' (duration: 176.915457ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:59:51.569524Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.508031ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:557"} {"level":"warn","ts":"2026-08-22T10:59:51.569585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.454719ms","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-22T10:59:51.569612Z","caller":"traceutil/trace.go:171","msg":"trace[2040317000] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:13677; }","duration":"153.623564ms","start":"2026-08-22T10:59:51.415967Z","end":"2026-08-22T10:59:51.569591Z","steps":["trace[2040317000] 'agreement among raft nodes before linearized reading' (duration: 153.355319ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:59:51.569623Z","caller":"traceutil/trace.go:171","msg":"trace[1261605544] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:13677; }","duration":"209.553931ms","start":"2026-08-22T10:59:51.360057Z","end":"2026-08-22T10:59:51.569611Z","steps":["trace[1261605544] 'agreement among raft nodes before linearized reading' (duration: 209.032901ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T11:00:06.14001Z","caller":"traceutil/trace.go:171","msg":"trace[788769668] transaction","detail":"{read_only:false; response_revision:13769; number_of_response:1; }","duration":"172.367364ms","start":"2026-08-22T11:00:05.967613Z","end":"2026-08-22T11:00:06.13998Z","steps":["trace[788769668] 'process raft request' (duration: 172.097868ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T11:00:06.941588Z","caller":"traceutil/trace.go:171","msg":"trace[2096535813] transaction","detail":"{read_only:false; response_revision:13772; number_of_response:1; }","duration":"150.080041ms","start":"2026-08-22T11:00:06.791469Z","end":"2026-08-22T11:00:06.941549Z","steps":["trace[2096535813] 'process raft request' (duration: 149.809875ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T11:00:32.55721Z","caller":"traceutil/trace.go:171","msg":"trace[2037709262] transaction","detail":"{read_only:false; response_revision:14102; number_of_response:1; }","duration":"215.151825ms","start":"2026-08-22T11:00:32.342027Z","end":"2026-08-22T11:00:32.557179Z","steps":["trace[2037709262] 'process raft request' (duration: 214.979142ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T11:00:32.628554Z","caller":"traceutil/trace.go:171","msg":"trace[1753102550] linearizableReadLoop","detail":"{readStateIndex:14586; appliedIndex:14584; }","duration":"148.859846ms","start":"2026-08-22T11:00:32.47966Z","end":"2026-08-22T11:00:32.62852Z","steps":["trace[1753102550] 'read index received' (duration: 77.335941ms)","trace[1753102550] 'applied index is now lower than readState.Index' (duration: 71.522325ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T11:00:32.628807Z","caller":"traceutil/trace.go:171","msg":"trace[707856213] transaction","detail":"{read_only:false; response_revision:14103; number_of_response:1; }","duration":"193.130467ms","start":"2026-08-22T11:00:32.435536Z","end":"2026-08-22T11:00:32.628667Z","steps":["trace[707856213] 'process raft request' (duration: 192.818431ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T11:00:32.629144Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.111382ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-22T11:00:32.629269Z","caller":"traceutil/trace.go:171","msg":"trace[1368679787] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:14103; }","duration":"149.608402ms","start":"2026-08-22T11:00:32.479584Z","end":"2026-08-22T11:00:32.629192Z","steps":["trace[1368679787] 'agreement among raft nodes before linearized reading' (duration: 149.068231ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T11:01:31.88231Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"402.256464ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-22T11:01:31.882582Z","caller":"traceutil/trace.go:171","msg":"trace[2106761831] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:14770; }","duration":"402.602553ms","start":"2026-08-22T11:01:31.479953Z","end":"2026-08-22T11:01:31.882556Z","steps":["trace[2106761831] 'range keys from in-memory index tree' (duration: 402.137191ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T11:01:31.8827Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T11:01:31.479914Z","time spent":"402.770135ms","remote":"127.0.0.1:41672","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-08-22T11:01:31.914545Z","caller":"traceutil/trace.go:171","msg":"trace[1403304384] linearizableReadLoop","detail":"{readStateIndex:15272; appliedIndex:15271; }","duration":"244.562935ms","start":"2026-08-22T11:01:31.669957Z","end":"2026-08-22T11:01:31.914519Z","steps":["trace[1403304384] 'read index received' (duration: 244.347361ms)","trace[1403304384] 'applied index is now lower than readState.Index' (duration: 214.034µs)"],"step_count":2} {"level":"warn","ts":"2026-08-22T11:01:31.914772Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.801691ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-22T11:01:31.914867Z","caller":"traceutil/trace.go:171","msg":"trace[2132364009] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:14771; }","duration":"244.951094ms","start":"2026-08-22T11:01:31.669894Z","end":"2026-08-22T11:01:31.914845Z","steps":["trace[2132364009] 'agreement among raft nodes before linearized reading' (duration: 244.76358ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T11:01:31.914873Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.845272ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5523"} {"level":"info","ts":"2026-08-22T11:01:31.91495Z","caller":"traceutil/trace.go:171","msg":"trace[1590041098] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:14771; }","duration":"242.978285ms","start":"2026-08-22T11:01:31.67195Z","end":"2026-08-22T11:01:31.914928Z","steps":["trace[1590041098] 'agreement among raft nodes before linearized reading' (duration: 242.74903ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T11:01:31.914802Z","caller":"traceutil/trace.go:171","msg":"trace[55424590] transaction","detail":"{read_only:false; response_revision:14771; number_of_response:1; }","duration":"379.613354ms","start":"2026-08-22T11:01:31.535024Z","end":"2026-08-22T11:01:31.914637Z","steps":["trace[55424590] 'process raft request' (duration: 379.319098ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T11:01:31.915292Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T11:01:31.53499Z","time spent":"380.144355ms","remote":"127.0.0.1:41972","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-22T11:01:31.91548Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.410103ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:667"} {"level":"info","ts":"2026-08-22T11:01:31.91551Z","caller":"traceutil/trace.go:171","msg":"trace[1652218460] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:14771; }","duration":"243.497455ms","start":"2026-08-22T11:01:31.672005Z","end":"2026-08-22T11:01:31.915503Z","steps":["trace[1652218460] 'agreement among raft nodes before linearized reading' (duration: 243.384603ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T11:01:31.915615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.70811ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-22T11:01:31.915716Z","caller":"traceutil/trace.go:171","msg":"trace[1011635291] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:14771; }","duration":"187.847512ms","start":"2026-08-22T11:01:31.727844Z","end":"2026-08-22T11:01:31.915692Z","steps":["trace[1011635291] 'agreement among raft nodes before linearized reading' (duration: 187.702799ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T11:03:07.263142Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":13000} {"level":"info","ts":"2026-08-22T11:03:07.345491Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":13000,"took":"79.128299ms","hash":2352795133,"current-db-size-bytes":58015744,"current-db-size":"58 MB","current-db-size-in-use-bytes":30580736,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-08-22T11:03:07.345562Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2352795133,"revision":13000,"compact-revision":10808} {"level":"info","ts":"2026-08-22T11:07:20.985871Z","caller":"traceutil/trace.go:171","msg":"trace[1394362973] transaction","detail":"{read_only:false; response_revision:17390; number_of_response:1; }","duration":"175.736545ms","start":"2026-08-22T11:07:20.810063Z","end":"2026-08-22T11:07:20.9858Z","steps":["trace[1394362973] 'process raft request' (duration: 175.309476ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T11:08:07.271825Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":15362} {"level":"info","ts":"2026-08-22T11:08:07.373459Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":15362,"took":"96.752618ms","hash":794044893,"current-db-size-bytes":58015744,"current-db-size":"58 MB","current-db-size-in-use-bytes":33566720,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-08-22T11:08:07.373576Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":794044893,"revision":15362,"compact-revision":13000} {"level":"info","ts":"2026-08-22T11:11:13.244441Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"7c53a18098324dc9","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-08-22T11:11:13.249566Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-08-22T11:11:13.249679Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-08-22T11:12:51.782102Z","caller":"traceutil/trace.go:171","msg":"trace[1240856503] transaction","detail":"{read_only:false; response_revision:19981; number_of_response:1; }","duration":"130.840019ms","start":"2026-08-22T11:12:51.651214Z","end":"2026-08-22T11:12:51.782054Z","steps":["trace[1240856503] 'process raft request' (duration: 122.445109ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T11:12:52.043598Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.944117ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-08-22T11:12:52.044256Z","caller":"traceutil/trace.go:171","msg":"trace[1992962821] transaction","detail":"{read_only:false; response_revision:19982; number_of_response:1; }","duration":"256.601428ms","start":"2026-08-22T11:12:51.78763Z","end":"2026-08-22T11:12:52.044231Z","steps":["trace[1992962821] 'process raft request' (duration: 141.854365ms)","trace[1992962821] 'compare' (duration: 113.796124ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T11:12:52.347012Z","caller":"traceutil/trace.go:171","msg":"trace[1844355317] transaction","detail":"{read_only:false; response_revision:19984; number_of_response:1; }","duration":"285.088737ms","start":"2026-08-22T11:12:52.061883Z","end":"2026-08-22T11:12:52.346971Z","steps":["trace[1844355317] 'process raft request' (duration: 284.877323ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T11:12:52.567266Z","caller":"traceutil/trace.go:171","msg":"trace[741929879] transaction","detail":"{read_only:false; response_revision:19986; number_of_response:1; }","duration":"141.282654ms","start":"2026-08-22T11:12:52.425942Z","end":"2026-08-22T11:12:52.567225Z","steps":["trace[741929879] 'process raft request' (duration: 141.217202ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T11:12:52.567594Z","caller":"traceutil/trace.go:171","msg":"trace[1820502820] linearizableReadLoop","detail":"{readStateIndex:20657; appliedIndex:20655; }","duration":"482.044222ms","start":"2026-08-22T11:12:52.085499Z","end":"2026-08-22T11:12:52.567543Z","steps":["trace[1820502820] 'read index received' (duration: 261.285792ms)","trace[1820502820] 'applied index is now lower than readState.Index' (duration: 220.75347ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T11:12:52.567636Z","caller":"traceutil/trace.go:171","msg":"trace[351379101] transaction","detail":"{read_only:false; response_revision:19985; number_of_response:1; }","duration":"504.994219ms","start":"2026-08-22T11:12:52.062533Z","end":"2026-08-22T11:12:52.567527Z","steps":["trace[351379101] 'process raft request' (duration: 407.469235ms)","trace[351379101] 'compare' (duration: 96.946102ms)"],"step_count":2} {"level":"warn","ts":"2026-08-22T11:12:52.567973Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T11:12:52.062498Z","time spent":"505.341637ms","remote":"127.0.0.1:41972","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-22T11:12:52.568Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"470.466737ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/storage-loki-0\" ","response":"range_response_count:1 size:1782"} {"level":"warn","ts":"2026-08-22T11:12:52.567993Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"482.474291ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-08-22T11:12:52.56847Z","caller":"traceutil/trace.go:171","msg":"trace[1896459191] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/storage-loki-0; range_end:; response_count:1; response_revision:19986; }","duration":"470.948086ms","start":"2026-08-22T11:12:52.09746Z","end":"2026-08-22T11:12:52.568408Z","steps":["trace[1896459191] 'agreement among raft nodes before linearized reading' (duration: 470.312843ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T11:12:52.568523Z","caller":"traceutil/trace.go:171","msg":"trace[2023781628] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:19986; }","duration":"483.072583ms","start":"2026-08-22T11:12:52.085429Z","end":"2026-08-22T11:12:52.568501Z","steps":["trace[2023781628] 'agreement among raft nodes before linearized reading' (duration: 482.316828ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T11:12:52.568038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.613816ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:558"} {"level":"warn","ts":"2026-08-22T11:12:52.568564Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T11:12:52.097449Z","time spent":"471.062169ms","remote":"127.0.0.1:41836","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":1804,"request content":"key:\"/registry/persistentvolumeclaims/monitoring/storage-loki-0\" "} {"level":"warn","ts":"2026-08-22T11:12:52.568594Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T11:12:52.085407Z","time spent":"483.164494ms","remote":"127.0.0.1:41972","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-08-22T11:12:52.568642Z","caller":"traceutil/trace.go:171","msg":"trace[1438738161] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:19986; }","duration":"341.240179ms","start":"2026-08-22T11:12:52.227347Z","end":"2026-08-22T11:12:52.568587Z","steps":["trace[1438738161] 'agreement among raft nodes before linearized reading' (duration: 340.509224ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T11:12:52.568729Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T11:12:52.22732Z","time spent":"341.367472ms","remote":"127.0.0.1:41972","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":580,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"info","ts":"2026-08-22T11:13:07.28063Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17963} {"level":"info","ts":"2026-08-22T11:13:07.398271Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17963,"took":"113.990679ms","hash":1596672428,"current-db-size-bytes":58015744,"current-db-size":"58 MB","current-db-size-in-use-bytes":29638656,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-08-22T11:13:07.39839Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1596672428,"revision":17963,"compact-revision":15362} {"level":"info","ts":"2026-08-22T11:16:36.900403Z","caller":"traceutil/trace.go:171","msg":"trace[196125202] transaction","detail":"{read_only:false; response_revision:22378; number_of_response:1; }","duration":"167.699061ms","start":"2026-08-22T11:16:36.732677Z","end":"2026-08-22T11:16:36.900376Z","steps":["trace[196125202] 'process raft request' (duration: 167.519377ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T11:16:36.932927Z","caller":"traceutil/trace.go:171","msg":"trace[614667382] transaction","detail":"{read_only:false; response_revision:22379; number_of_response:1; }","duration":"120.331877ms","start":"2026-08-22T11:16:36.812548Z","end":"2026-08-22T11:16:36.93288Z","steps":["trace[614667382] 'process raft request' (duration: 120.041671ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T11:18:07.293387Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":20060} {"level":"info","ts":"2026-08-22T11:18:07.409567Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":20060,"took":"110.446267ms","hash":674361340,"current-db-size-bytes":58015744,"current-db-size":"58 MB","current-db-size-in-use-bytes":42631168,"current-db-size-in-use":"43 MB"} {"level":"info","ts":"2026-08-22T11:18:07.409762Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":674361340,"revision":20060,"compact-revision":17963} {"level":"info","ts":"2026-08-22T11:23:04.575032Z","caller":"traceutil/trace.go:171","msg":"trace[488271650] linearizableReadLoop","detail":"{readStateIndex:26391; appliedIndex:26390; }","duration":"135.870073ms","start":"2026-08-22T11:23:04.439131Z","end":"2026-08-22T11:23:04.575001Z","steps":["trace[488271650] 'read index received' (duration: 135.609528ms)","trace[488271650] 'applied index is now lower than readState.Index' (duration: 259.455µs)"],"step_count":2} {"level":"info","ts":"2026-08-22T11:23:04.575461Z","caller":"traceutil/trace.go:171","msg":"trace[2143500393] transaction","detail":"{read_only:false; response_revision:25563; number_of_response:1; }","duration":"170.430925ms","start":"2026-08-22T11:23:04.405009Z","end":"2026-08-22T11:23:04.57544Z","steps":["trace[2143500393] 'process raft request' (duration: 169.802422ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T11:23:04.575964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.812973ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/auth-system/\" range_end:\"/registry/secrets/auth-system0\" ","response":"range_response_count:4 size:80990"} {"level":"info","ts":"2026-08-22T11:23:04.576016Z","caller":"traceutil/trace.go:171","msg":"trace[1747505067] range","detail":"{range_begin:/registry/secrets/auth-system/; range_end:/registry/secrets/auth-system0; response_count:4; response_revision:25563; }","duration":"136.926535ms","start":"2026-08-22T11:23:04.439077Z","end":"2026-08-22T11:23:04.576004Z","steps":["trace[1747505067] 'agreement among raft nodes before linearized reading' (duration: 136.67845ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T11:23:07.299803Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":23321} {"level":"info","ts":"2026-08-22T11:23:07.441352Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":23321,"took":"136.648309ms","hash":826439396,"current-db-size-bytes":58015744,"current-db-size":"58 MB","current-db-size-in-use-bytes":30961664,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-08-22T11:23:07.44142Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":826439396,"revision":23321,"compact-revision":20060} {"level":"warn","ts":"2026-08-22T11:25:08.045971Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5605187309327979994,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-22T11:25:08.546417Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5605187309327979994,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-22T11:25:08.855914Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.310973409s","expected-duration":"1s"} {"level":"info","ts":"2026-08-22T11:25:08.856396Z","caller":"traceutil/trace.go:171","msg":"trace[2048381199] transaction","detail":"{read_only:false; response_revision:26484; number_of_response:1; }","duration":"1.311564662s","start":"2026-08-22T11:25:07.544801Z","end":"2026-08-22T11:25:08.856366Z","steps":["trace[2048381199] 'process raft request' (duration: 1.311333627s)"],"step_count":1} {"level":"warn","ts":"2026-08-22T11:25:08.856628Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T11:25:07.54478Z","time spent":"1.311716854s","remote":"127.0.0.1:41972","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-22T11:25:08.862713Z","caller":"traceutil/trace.go:171","msg":"trace[5641761] transaction","detail":"{read_only:false; response_revision:26485; number_of_response:1; }","duration":"1.215105228s","start":"2026-08-22T11:25:07.64757Z","end":"2026-08-22T11:25:08.862676Z","steps":["trace[5641761] 'process raft request' (duration: 1.21471672s)"],"step_count":1} {"level":"info","ts":"2026-08-22T11:25:08.862763Z","caller":"traceutil/trace.go:171","msg":"trace[522349961] transaction","detail":"{read_only:false; response_revision:26487; number_of_response:1; }","duration":"1.152281064s","start":"2026-08-22T11:25:07.710448Z","end":"2026-08-22T11:25:08.862729Z","steps":["trace[522349961] 'process raft request' (duration: 1.152146391s)"],"step_count":1} {"level":"info","ts":"2026-08-22T11:25:08.862821Z","caller":"traceutil/trace.go:171","msg":"trace[2144352972] transaction","detail":"{read_only:false; response_revision:26486; number_of_response:1; }","duration":"1.159709174s","start":"2026-08-22T11:25:07.703058Z","end":"2026-08-22T11:25:08.862767Z","steps":["trace[2144352972] 'process raft request' (duration: 1.159457129s)"],"step_count":1} {"level":"warn","ts":"2026-08-22T11:25:08.862882Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T11:25:07.647535Z","time spent":"1.21525861s","remote":"127.0.0.1:41936","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5599,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-22T11:25:08.862956Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T11:25:07.710419Z","time spent":"1.152412047s","remote":"127.0.0.1:41972","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-22T11:25:08.863087Z","caller":"traceutil/trace.go:171","msg":"trace[1513777759] transaction","detail":"{read_only:false; response_revision:26488; number_of_response:1; }","duration":"1.146291863s","start":"2026-08-22T11:25:07.716785Z","end":"2026-08-22T11:25:08.863077Z","steps":["trace[1513777759] 'process raft request' (duration: 1.145882964s)"],"step_count":1} {"level":"warn","ts":"2026-08-22T11:25:08.863111Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T11:25:07.703014Z","time spent":"1.159915489s","remote":"127.0.0.1:41972","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":498,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-22T11:25:08.863144Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T11:25:07.716775Z","time spent":"1.146340583s","remote":"127.0.0.1:41972","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-22T11:25:08.863355Z","caller":"traceutil/trace.go:171","msg":"trace[1435834846] transaction","detail":"{read_only:false; response_revision:26489; number_of_response:1; }","duration":"846.973766ms","start":"2026-08-22T11:25:08.01636Z","end":"2026-08-22T11:25:08.863334Z","steps":["trace[1435834846] 'process raft request' (duration: 846.649509ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T11:25:08.863463Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T11:25:08.016325Z","time spent":"847.086367ms","remote":"127.0.0.1:41972","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":605,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-22T11:25:08.863436Z","caller":"traceutil/trace.go:171","msg":"trace[1259334047] transaction","detail":"{read_only:false; response_revision:26490; number_of_response:1; }","duration":"430.934783ms","start":"2026-08-22T11:25:08.432474Z","end":"2026-08-22T11:25:08.863409Z","steps":["trace[1259334047] 'process raft request' (duration: 430.78865ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T11:25:08.863479Z","caller":"traceutil/trace.go:171","msg":"trace[674919850] linearizableReadLoop","detail":"{readStateIndex:27348; appliedIndex:27339; }","duration":"1.318464191s","start":"2026-08-22T11:25:07.544984Z","end":"2026-08-22T11:25:08.863448Z","steps":["trace[674919850] 'read index received' (duration: 1.311126983s)","trace[674919850] 'applied index is now lower than readState.Index' (duration: 7.335248ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T11:25:08.863597Z","caller":"traceutil/trace.go:171","msg":"trace[1406866370] transaction","detail":"{read_only:false; response_revision:26491; number_of_response:1; }","duration":"388.93692ms","start":"2026-08-22T11:25:08.474648Z","end":"2026-08-22T11:25:08.863585Z","steps":["trace[1406866370] 'process raft request' (duration: 388.682115ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T11:25:08.863658Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T11:25:08.432453Z","time spent":"431.110567ms","remote":"127.0.0.1:41972","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-22T11:25:08.863729Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T11:25:08.474614Z","time spent":"389.068022ms","remote":"127.0.0.1:41972","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-22T11:25:08.863742Z","caller":"traceutil/trace.go:171","msg":"trace[1298974259] transaction","detail":"{read_only:false; response_revision:26492; number_of_response:1; }","duration":"378.798183ms","start":"2026-08-22T11:25:08.484923Z","end":"2026-08-22T11:25:08.863721Z","steps":["trace[1298974259] 'process raft request' (duration: 378.456947ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T11:25:08.864008Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T11:25:08.484894Z","time spent":"378.990779ms","remote":"127.0.0.1:41972","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-22T11:25:08.864091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.318176606s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/magnum-ks-endpoints\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-08-22T11:25:08.864151Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.231249885s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/heat-domain-ks-user-pl8mb\" ","response":"range_response_count:1 size:9170"} {"level":"info","ts":"2026-08-22T11:25:08.864165Z","caller":"traceutil/trace.go:171","msg":"trace[987347273] range","detail":"{range_begin:/registry/jobs/openstack/magnum-ks-endpoints; range_end:; response_count:0; response_revision:26492; }","duration":"1.318290299s","start":"2026-08-22T11:25:07.545854Z","end":"2026-08-22T11:25:08.864144Z","steps":["trace[987347273] 'agreement among raft nodes before linearized reading' (duration: 1.318136316s)"],"step_count":1} {"level":"info","ts":"2026-08-22T11:25:08.864186Z","caller":"traceutil/trace.go:171","msg":"trace[1012339596] range","detail":"{range_begin:/registry/pods/openstack/heat-domain-ks-user-pl8mb; range_end:; response_count:1; response_revision:26492; }","duration":"1.231347077s","start":"2026-08-22T11:25:07.63283Z","end":"2026-08-22T11:25:08.864177Z","steps":["trace[1012339596] 'agreement among raft nodes before linearized reading' (duration: 1.231169373s)"],"step_count":1} {"level":"warn","ts":"2026-08-22T11:25:08.864212Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T11:25:07.632808Z","time spent":"1.231399598s","remote":"127.0.0.1:41868","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":9192,"request content":"key:\"/registry/pods/openstack/heat-domain-ks-user-pl8mb\" "} {"level":"warn","ts":"2026-08-22T11:25:08.864215Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T11:25:07.545834Z","time spent":"1.31836932s","remote":"127.0.0.1:41936","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/openstack/magnum-ks-endpoints\" "} {"level":"warn","ts":"2026-08-22T11:25:08.864261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"357.842028ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-08-22T11:25:08.864327Z","caller":"traceutil/trace.go:171","msg":"trace[473729475] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26492; }","duration":"357.94989ms","start":"2026-08-22T11:25:08.50636Z","end":"2026-08-22T11:25:08.864309Z","steps":["trace[473729475] 'agreement among raft nodes before linearized reading' (duration: 357.715796ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T11:25:08.864362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.299085419s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/magnum-ks-endpoints\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-08-22T11:25:08.864375Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T11:25:08.506334Z","time spent":"358.028252ms","remote":"127.0.0.1:41972","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-08-22T11:25:08.864404Z","caller":"traceutil/trace.go:171","msg":"trace[2010920677] range","detail":"{range_begin:/registry/jobs/openstack/magnum-ks-endpoints; range_end:; response_count:0; response_revision:26492; }","duration":"1.299151171s","start":"2026-08-22T11:25:07.56524Z","end":"2026-08-22T11:25:08.864392Z","steps":["trace[2010920677] 'agreement among raft nodes before linearized reading' (duration: 1.299077479s)"],"step_count":1} {"level":"warn","ts":"2026-08-22T11:25:08.864417Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"621.889128ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"} {"level":"warn","ts":"2026-08-22T11:25:08.864418Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.30799674s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/magnum-rabbit-init\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-08-22T11:25:08.864444Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T11:25:07.565225Z","time spent":"1.299208932s","remote":"127.0.0.1:41936","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/openstack/magnum-ks-endpoints\" "} {"level":"info","ts":"2026-08-22T11:25:08.864459Z","caller":"traceutil/trace.go:171","msg":"trace[1165301131] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:26492; }","duration":"621.951439ms","start":"2026-08-22T11:25:08.2425Z","end":"2026-08-22T11:25:08.864452Z","steps":["trace[1165301131] 'agreement among raft nodes before linearized reading' (duration: 621.857597ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T11:25:08.864486Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T11:25:08.242488Z","time spent":"621.99414ms","remote":"127.0.0.1:41972","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-22T11:25:08.864478Z","caller":"traceutil/trace.go:171","msg":"trace[50518972] range","detail":"{range_begin:/registry/jobs/openstack/magnum-rabbit-init; range_end:; response_count:0; response_revision:26492; }","duration":"1.308067101s","start":"2026-08-22T11:25:07.556395Z","end":"2026-08-22T11:25:08.864462Z","steps":["trace[50518972] 'agreement among raft nodes before linearized reading' (duration: 1.3079764s)"],"step_count":1} {"level":"warn","ts":"2026-08-22T11:25:08.864522Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T11:25:07.556386Z","time spent":"1.308125532s","remote":"127.0.0.1:41936","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/openstack/magnum-rabbit-init\" "} {"level":"warn","ts":"2026-08-22T11:25:08.864577Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"669.276691ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-08-22T11:25:08.864596Z","caller":"traceutil/trace.go:171","msg":"trace[821110750] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:26492; }","duration":"669.299072ms","start":"2026-08-22T11:25:08.195291Z","end":"2026-08-22T11:25:08.86459Z","steps":["trace[821110750] 'agreement among raft nodes before linearized reading' (duration: 669.244421ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T11:25:08.864618Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T11:25:08.19522Z","time spent":"669.392964ms","remote":"127.0.0.1:46130","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":13,"response size":30,"request content":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true "} {"level":"warn","ts":"2026-08-22T11:25:08.86467Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.310571732s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/magnum-db-sync\" ","response":"range_response_count:1 size:5082"} {"level":"info","ts":"2026-08-22T11:25:08.86472Z","caller":"traceutil/trace.go:171","msg":"trace[1535693282] range","detail":"{range_begin:/registry/jobs/openstack/magnum-db-sync; range_end:; response_count:1; response_revision:26492; }","duration":"1.310624633s","start":"2026-08-22T11:25:07.554077Z","end":"2026-08-22T11:25:08.864701Z","steps":["trace[1535693282] 'agreement among raft nodes before linearized reading' (duration: 1.31046159s)"],"step_count":1} {"level":"warn","ts":"2026-08-22T11:25:08.864757Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T11:25:07.554071Z","time spent":"1.310675584s","remote":"127.0.0.1:41936","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":5104,"request content":"key:\"/registry/jobs/openstack/magnum-db-sync\" "} {"level":"warn","ts":"2026-08-22T11:25:08.864779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"708.721244ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-neutron-server-0\" ","response":"range_response_count:1 size:1862"} {"level":"info","ts":"2026-08-22T11:25:08.864803Z","caller":"traceutil/trace.go:171","msg":"trace[1470867901] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-neutron-server-0; range_end:; response_count:1; response_revision:26492; }","duration":"708.784535ms","start":"2026-08-22T11:25:08.156011Z","end":"2026-08-22T11:25:08.864795Z","steps":["trace[1470867901] 'agreement among raft nodes before linearized reading' (duration: 708.710254ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T11:25:08.864822Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T11:25:08.155992Z","time spent":"708.825736ms","remote":"127.0.0.1:41836","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":1,"response size":1884,"request content":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-neutron-server-0\" "} {"level":"warn","ts":"2026-08-22T11:25:08.864817Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.300180501s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/magnum-ks-user\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-22T11:25:08.864868Z","caller":"traceutil/trace.go:171","msg":"trace[465855703] range","detail":"{range_begin:/registry/jobs/openstack/magnum-ks-user; range_end:; response_count:0; response_revision:26492; }","duration":"1.300286193s","start":"2026-08-22T11:25:07.564568Z","end":"2026-08-22T11:25:08.864855Z","steps":["trace[465855703] 'agreement among raft nodes before linearized reading' (duration: 1.300201591s)"],"step_count":1} {"level":"warn","ts":"2026-08-22T11:25:08.864914Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T11:25:07.564532Z","time spent":"1.300370805s","remote":"127.0.0.1:41936","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/openstack/magnum-ks-user\" "} {"level":"warn","ts":"2026-08-22T11:25:08.864924Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.153531ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"} {"level":"info","ts":"2026-08-22T11:25:08.864982Z","caller":"traceutil/trace.go:171","msg":"trace[1861733809] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26492; }","duration":"201.263713ms","start":"2026-08-22T11:25:08.6637Z","end":"2026-08-22T11:25:08.864964Z","steps":["trace[1861733809] 'agreement among raft nodes before linearized reading' (duration: 201.11155ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T11:25:08.865087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"904.801192ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"warn","ts":"2026-08-22T11:25:08.865107Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.311322787s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/magnum-ks-user\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-08-22T11:25:08.865074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.300495168s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/magnum-rabbit-init\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-22T11:25:08.86518Z","caller":"traceutil/trace.go:171","msg":"trace[824128987] range","detail":"{range_begin:/registry/jobs/openstack/magnum-ks-user; range_end:; response_count:0; response_revision:26492; }","duration":"1.311402068s","start":"2026-08-22T11:25:07.553755Z","end":"2026-08-22T11:25:08.865157Z","steps":["trace[824128987] 'agreement among raft nodes before linearized reading' (duration: 1.311264765s)"],"step_count":1} {"level":"info","ts":"2026-08-22T11:25:08.865187Z","caller":"traceutil/trace.go:171","msg":"trace[1494910855] range","detail":"{range_begin:/registry/jobs/openstack/magnum-rabbit-init; range_end:; response_count:0; response_revision:26492; }","duration":"1.30064508s","start":"2026-08-22T11:25:07.564522Z","end":"2026-08-22T11:25:08.865167Z","steps":["trace[1494910855] 'agreement among raft nodes before linearized reading' (duration: 1.300435976s)"],"step_count":1} {"level":"warn","ts":"2026-08-22T11:25:08.865217Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T11:25:07.553749Z","time spent":"1.31146175s","remote":"127.0.0.1:41936","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/openstack/magnum-ks-user\" "} {"level":"warn","ts":"2026-08-22T11:25:08.865228Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T11:25:07.564518Z","time spent":"1.300702021s","remote":"127.0.0.1:41936","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/openstack/magnum-rabbit-init\" "} {"level":"warn","ts":"2026-08-22T11:25:08.865221Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.48599ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-08-22T11:25:08.865128Z","caller":"traceutil/trace.go:171","msg":"trace[1444071337] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:26492; }","duration":"904.881023ms","start":"2026-08-22T11:25:07.96023Z","end":"2026-08-22T11:25:08.865112Z","steps":["trace[1444071337] 'agreement among raft nodes before linearized reading' (duration: 904.752481ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T11:25:08.865288Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T11:25:07.960206Z","time spent":"905.076147ms","remote":"127.0.0.1:41972","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":504,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-08-22T11:25:08.86528Z","caller":"traceutil/trace.go:171","msg":"trace[639050338] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26492; }","duration":"206.583871ms","start":"2026-08-22T11:25:08.658679Z","end":"2026-08-22T11:25:08.865263Z","steps":["trace[639050338] 'agreement among raft nodes before linearized reading' (duration: 206.443629ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T11:25:08.865274Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.31691434s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12217"} {"level":"info","ts":"2026-08-22T11:25:08.865349Z","caller":"traceutil/trace.go:171","msg":"trace[925488682] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:26492; }","duration":"1.317005162s","start":"2026-08-22T11:25:07.548327Z","end":"2026-08-22T11:25:08.865332Z","steps":["trace[925488682] 'agreement among raft nodes before linearized reading' (duration: 1.316739236s)"],"step_count":1} {"level":"warn","ts":"2026-08-22T11:25:08.865399Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T11:25:07.548319Z","time spent":"1.317067194s","remote":"127.0.0.1:41868","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12239,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-08-22T11:25:08.865406Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.311557602s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/magnum-domain-ks-user\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-22T11:25:08.865564Z","caller":"traceutil/trace.go:171","msg":"trace[1917715979] range","detail":"{range_begin:/registry/jobs/openstack/magnum-domain-ks-user; range_end:; response_count:0; response_revision:26492; }","duration":"1.311739076s","start":"2026-08-22T11:25:07.5538Z","end":"2026-08-22T11:25:08.865539Z","steps":["trace[1917715979] 'agreement among raft nodes before linearized reading' (duration: 1.311528122s)"],"step_count":1} {"level":"warn","ts":"2026-08-22T11:25:08.865607Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T11:25:07.553774Z","time spent":"1.311823287s","remote":"127.0.0.1:41936","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/openstack/magnum-domain-ks-user\" "} {"level":"warn","ts":"2026-08-22T11:25:08.865901Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.301385485s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/magnum-db-sync\" ","response":"range_response_count:1 size:5082"} {"level":"info","ts":"2026-08-22T11:25:08.866026Z","caller":"traceutil/trace.go:171","msg":"trace[14326457] range","detail":"{range_begin:/registry/jobs/openstack/magnum-db-sync; range_end:; response_count:1; response_revision:26492; }","duration":"1.301588509s","start":"2026-08-22T11:25:07.564424Z","end":"2026-08-22T11:25:08.866012Z","steps":["trace[14326457] 'agreement among raft nodes before linearized reading' (duration: 1.300400096s)"],"step_count":1} {"level":"warn","ts":"2026-08-22T11:25:08.866065Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T11:25:07.564386Z","time spent":"1.301669591s","remote":"127.0.0.1:41936","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":5104,"request content":"key:\"/registry/jobs/openstack/magnum-db-sync\" "} {"level":"warn","ts":"2026-08-22T11:25:08.866895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.321865581s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/placement-ks-endpoints-79g9t.18ce1b817f36c336\\000\" range_end:\"/registry/events/openstack0\" limit:2000 revision:26483 ","response":"range_response_count:407 size:311787"} {"level":"info","ts":"2026-08-22T11:25:08.869084Z","caller":"traceutil/trace.go:171","msg":"trace[762429149] range","detail":"{range_begin:/registry/events/openstack/placement-ks-endpoints-79g9t.18ce1b817f36c336\u0000; range_end:/registry/events/openstack0; response_count:407; response_revision:26492; }","duration":"1.323459283s","start":"2026-08-22T11:25:07.544936Z","end":"2026-08-22T11:25:08.868395Z","steps":["trace[762429149] 'agreement among raft nodes before linearized reading' (duration: 1.319541014s)"],"step_count":1} {"level":"warn","ts":"2026-08-22T11:25:08.86919Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T11:25:07.544917Z","time spent":"1.324231948s","remote":"127.0.0.1:41746","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":407,"response size":311809,"request content":"key:\"/registry/events/openstack/placement-ks-endpoints-79g9t.18ce1b817f36c336\\000\" range_end:\"/registry/events/openstack0\" limit:2000 revision:26483 "}