{"level":"warn","ts":"2026-08-05T21:32:07.219784Z","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-05T21:32:07.219882Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.150:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.150:2380","--initial-cluster=instance=https://199.19.213.150:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.150:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.150: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-05T21:32:07.219955Z","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-05T21:32:07.219963Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.150:2380"]} {"level":"info","ts":"2026-08-05T21:32:07.219983Z","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-05T21:32:07.220552Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.150:2379"]} {"level":"info","ts":"2026-08-05T21:32:07.220632Z","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.19.213.150:2380"],"listen-peer-urls":["https://199.19.213.150:2380"],"advertise-client-urls":["https://199.19.213.150:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.150:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.150: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-05T21:32:07.223076Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.235578ms"} {"level":"info","ts":"2026-08-05T21:32:07.228699Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"dbd0ffa4f8c99812","cluster-id":"98aad832cd49bc30"} {"level":"info","ts":"2026-08-05T21:32:07.228789Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dbd0ffa4f8c99812 switched to configuration voters=()"} {"level":"info","ts":"2026-08-05T21:32:07.228817Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dbd0ffa4f8c99812 became follower at term 0"} {"level":"info","ts":"2026-08-05T21:32:07.228829Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft dbd0ffa4f8c99812 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-05T21:32:07.228844Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dbd0ffa4f8c99812 became follower at term 1"} {"level":"info","ts":"2026-08-05T21:32:07.228886Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dbd0ffa4f8c99812 switched to configuration voters=(15839440973475715090)"} {"level":"warn","ts":"2026-08-05T21:32:07.233801Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-05T21:32:07.235677Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-05T21:32:07.23685Z","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-05T21:32:07.239109Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"dbd0ffa4f8c99812","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-05T21:32:07.23962Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"dbd0ffa4f8c99812","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-05T21:32:07.23983Z","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-05T21:32:07.239883Z","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-05T21:32:07.239891Z","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-05T21:32:07.240718Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dbd0ffa4f8c99812 switched to configuration voters=(15839440973475715090)"} {"level":"info","ts":"2026-08-05T21:32:07.240939Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"98aad832cd49bc30","local-member-id":"dbd0ffa4f8c99812","added-peer-id":"dbd0ffa4f8c99812","added-peer-peer-urls":["https://199.19.213.150:2380"]} {"level":"info","ts":"2026-08-05T21:32:07.244794Z","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-05T21:32:07.245165Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"dbd0ffa4f8c99812","initial-advertise-peer-urls":["https://199.19.213.150:2380"],"listen-peer-urls":["https://199.19.213.150:2380"],"advertise-client-urls":["https://199.19.213.150:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.150:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-05T21:32:07.245248Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-05T21:32:07.245624Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.150:2380"} {"level":"info","ts":"2026-08-05T21:32:07.245707Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.150:2380"} {"level":"info","ts":"2026-08-05T21:32:07.529679Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dbd0ffa4f8c99812 is starting a new election at term 1"} {"level":"info","ts":"2026-08-05T21:32:07.529758Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dbd0ffa4f8c99812 became pre-candidate at term 1"} {"level":"info","ts":"2026-08-05T21:32:07.529795Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dbd0ffa4f8c99812 received MsgPreVoteResp from dbd0ffa4f8c99812 at term 1"} {"level":"info","ts":"2026-08-05T21:32:07.529815Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dbd0ffa4f8c99812 became candidate at term 2"} {"level":"info","ts":"2026-08-05T21:32:07.529826Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dbd0ffa4f8c99812 received MsgVoteResp from dbd0ffa4f8c99812 at term 2"} {"level":"info","ts":"2026-08-05T21:32:07.52985Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dbd0ffa4f8c99812 became leader at term 2"} {"level":"info","ts":"2026-08-05T21:32:07.529869Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: dbd0ffa4f8c99812 elected leader dbd0ffa4f8c99812 at term 2"} {"level":"info","ts":"2026-08-05T21:32:07.530938Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"dbd0ffa4f8c99812","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.150:2379]}","request-path":"/0/members/dbd0ffa4f8c99812/attributes","cluster-id":"98aad832cd49bc30","publish-timeout":"7s"} {"level":"info","ts":"2026-08-05T21:32:07.531063Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-05T21:32:07.531121Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-05T21:32:07.53121Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-05T21:32:07.532122Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"98aad832cd49bc30","local-member-id":"dbd0ffa4f8c99812","cluster-version":"3.5"} {"level":"info","ts":"2026-08-05T21:32:07.53233Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-05T21:32:07.532391Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-08-05T21:32:07.533556Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-08-05T21:32:07.541241Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.150:2379"} {"level":"info","ts":"2026-08-05T21:32:07.541878Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-05T21:32:07.541953Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-05T21:32:49.906691Z","caller":"traceutil/trace.go:171","msg":"trace[1027010393] linearizableReadLoop","detail":"{readStateIndex:655; appliedIndex:654; }","duration":"137.834565ms","start":"2026-08-05T21:32:49.768836Z","end":"2026-08-05T21:32:49.906671Z","steps":["trace[1027010393] 'read index received' (duration: 50.700272ms)","trace[1027010393] 'applied index is now lower than readState.Index' (duration: 87.133493ms)"],"step_count":2} {"level":"info","ts":"2026-08-05T21:32:49.906719Z","caller":"traceutil/trace.go:171","msg":"trace[1779442141] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"177.370177ms","start":"2026-08-05T21:32:49.729313Z","end":"2026-08-05T21:32:49.906683Z","steps":["trace[1779442141] 'process raft request' (duration: 90.277965ms)","trace[1779442141] 'compare' (duration: 86.942659ms)"],"step_count":2} {"level":"warn","ts":"2026-08-05T21:32:49.906906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.047768ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-05T21:32:49.907058Z","caller":"traceutil/trace.go:171","msg":"trace[492843922] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:634; }","duration":"138.254662ms","start":"2026-08-05T21:32:49.76877Z","end":"2026-08-05T21:32:49.907025Z","steps":["trace[492843922] 'agreement among raft nodes before linearized reading' (duration: 137.981628ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:32:50.468537Z","caller":"traceutil/trace.go:171","msg":"trace[2010694746] transaction","detail":"{read_only:false; response_revision:636; number_of_response:1; }","duration":"392.06517ms","start":"2026-08-05T21:32:50.076447Z","end":"2026-08-05T21:32:50.468512Z","steps":["trace[2010694746] 'process raft request' (duration: 391.920798ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:32:50.468791Z","caller":"traceutil/trace.go:171","msg":"trace[1189495017] linearizableReadLoop","detail":"{readStateIndex:657; appliedIndex:657; }","duration":"206.508862ms","start":"2026-08-05T21:32:50.262267Z","end":"2026-08-05T21:32:50.468776Z","steps":["trace[1189495017] 'read index received' (duration: 206.501972ms)","trace[1189495017] 'applied index is now lower than readState.Index' (duration: 5.65µs)"],"step_count":2} {"level":"warn","ts":"2026-08-05T21:32:50.468904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.601774ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-z8rnh\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-08-05T21:32:50.468937Z","caller":"traceutil/trace.go:171","msg":"trace[2024092388] range","detail":"{range_begin:/registry/pods/kube-system/cilium-z8rnh; range_end:; response_count:1; response_revision:636; }","duration":"206.705086ms","start":"2026-08-05T21:32:50.262224Z","end":"2026-08-05T21:32:50.468929Z","steps":["trace[2024092388] 'agreement among raft nodes before linearized reading' (duration: 206.602624ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T21:32:50.469111Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T21:32:50.076404Z","time spent":"392.211393ms","remote":"127.0.0.1:43212","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-05T21:33:54.746981Z","caller":"traceutil/trace.go:171","msg":"trace[1414183773] transaction","detail":"{read_only:false; response_revision:1447; number_of_response:1; }","duration":"109.338992ms","start":"2026-08-05T21:33:54.637614Z","end":"2026-08-05T21:33:54.746953Z","steps":["trace[1414183773] 'process raft request' (duration: 109.154219ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:34:33.832795Z","caller":"traceutil/trace.go:171","msg":"trace[552197544] transaction","detail":"{read_only:false; response_revision:1937; number_of_response:1; }","duration":"131.435043ms","start":"2026-08-05T21:34:33.701327Z","end":"2026-08-05T21:34:33.832762Z","steps":["trace[552197544] 'process raft request' (duration: 131.068666ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:35:23.236871Z","caller":"traceutil/trace.go:171","msg":"trace[364519744] transaction","detail":"{read_only:false; response_revision:2260; number_of_response:1; }","duration":"128.403916ms","start":"2026-08-05T21:35:23.108428Z","end":"2026-08-05T21:35:23.236832Z","steps":["trace[364519744] 'process raft request' (duration: 128.261333ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:35:29.401067Z","caller":"traceutil/trace.go:171","msg":"trace[92332340] transaction","detail":"{read_only:false; response_revision:2292; number_of_response:1; }","duration":"147.318474ms","start":"2026-08-05T21:35:29.253725Z","end":"2026-08-05T21:35:29.401044Z","steps":["trace[92332340] 'process raft request' (duration: 146.881866ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:36:37.731325Z","caller":"traceutil/trace.go:171","msg":"trace[1913839461] transaction","detail":"{read_only:false; response_revision:2858; number_of_response:1; }","duration":"103.581298ms","start":"2026-08-05T21:36:37.627708Z","end":"2026-08-05T21:36:37.731289Z","steps":["trace[1913839461] 'process raft request' (duration: 103.394425ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:40:29.248045Z","caller":"traceutil/trace.go:171","msg":"trace[78262788] transaction","detail":"{read_only:false; response_revision:4892; number_of_response:1; }","duration":"224.657531ms","start":"2026-08-05T21:40:29.023351Z","end":"2026-08-05T21:40:29.248009Z","steps":["trace[78262788] 'process raft request' (duration: 198.319702ms)","trace[78262788] 'compare' (duration: 26.070654ms)"],"step_count":2} {"level":"info","ts":"2026-08-05T21:40:33.80137Z","caller":"traceutil/trace.go:171","msg":"trace[199381753] transaction","detail":"{read_only:false; response_revision:5041; number_of_response:1; }","duration":"122.808529ms","start":"2026-08-05T21:40:33.678531Z","end":"2026-08-05T21:40:33.801339Z","steps":["trace[199381753] 'process raft request' (duration: 122.678946ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:40:46.02741Z","caller":"traceutil/trace.go:171","msg":"trace[1626222075] transaction","detail":"{read_only:false; response_revision:5292; number_of_response:1; }","duration":"192.011023ms","start":"2026-08-05T21:40:45.835368Z","end":"2026-08-05T21:40:46.027379Z","steps":["trace[1626222075] 'process raft request' (duration: 105.860344ms)","trace[1626222075] 'compare' (duration: 86.020696ms)"],"step_count":2} {"level":"info","ts":"2026-08-05T21:40:46.029041Z","caller":"traceutil/trace.go:171","msg":"trace[313480652] transaction","detail":"{read_only:false; response_revision:5293; number_of_response:1; }","duration":"192.728616ms","start":"2026-08-05T21:40:45.836289Z","end":"2026-08-05T21:40:46.029018Z","steps":["trace[313480652] 'process raft request' (duration: 192.545623ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:40:46.029087Z","caller":"traceutil/trace.go:171","msg":"trace[363850390] transaction","detail":"{read_only:false; response_revision:5295; number_of_response:1; }","duration":"192.061623ms","start":"2026-08-05T21:40:45.83701Z","end":"2026-08-05T21:40:46.029071Z","steps":["trace[363850390] 'process raft request' (duration: 191.970041ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:40:46.029103Z","caller":"traceutil/trace.go:171","msg":"trace[1344487722] transaction","detail":"{read_only:false; response_revision:5294; number_of_response:1; }","duration":"192.760896ms","start":"2026-08-05T21:40:45.83631Z","end":"2026-08-05T21:40:46.029071Z","steps":["trace[1344487722] 'process raft request' (duration: 192.625744ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:40:46.029259Z","caller":"traceutil/trace.go:171","msg":"trace[2097106989] linearizableReadLoop","detail":"{readStateIndex:5486; appliedIndex:5481; }","duration":"126.828622ms","start":"2026-08-05T21:40:45.902416Z","end":"2026-08-05T21:40:46.029244Z","steps":["trace[2097106989] 'read index received' (duration: 38.825328ms)","trace[2097106989] 'applied index is now lower than readState.Index' (duration: 88.001804ms)"],"step_count":2} {"level":"info","ts":"2026-08-05T21:40:46.029373Z","caller":"traceutil/trace.go:171","msg":"trace[1749897514] transaction","detail":"{read_only:false; response_revision:5296; number_of_response:1; }","duration":"139.196156ms","start":"2026-08-05T21:40:45.890168Z","end":"2026-08-05T21:40:46.029364Z","steps":["trace[1749897514] 'process raft request' (duration: 138.8512ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T21:40:46.029611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.179088ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-bzstm\" ","response":"range_response_count:1 size:6530"} {"level":"info","ts":"2026-08-05T21:40:46.029691Z","caller":"traceutil/trace.go:171","msg":"trace[1764910562] range","detail":"{range_begin:/registry/pods/openstack/keepalived-bzstm; range_end:; response_count:1; response_revision:5296; }","duration":"127.299331ms","start":"2026-08-05T21:40:45.902374Z","end":"2026-08-05T21:40:46.029673Z","steps":["trace[1764910562] 'agreement among raft nodes before linearized reading' (duration: 127.104668ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T21:40:53.366427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.395295ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/probes/\" range_end:\"/registry/monitoring.coreos.com/probes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-05T21:40:53.366532Z","caller":"traceutil/trace.go:171","msg":"trace[2069934708] range","detail":"{range_begin:/registry/monitoring.coreos.com/probes/; range_end:/registry/monitoring.coreos.com/probes0; response_count:0; response_revision:5491; }","duration":"114.554168ms","start":"2026-08-05T21:40:53.251956Z","end":"2026-08-05T21:40:53.36651Z","steps":["trace[2069934708] 'count revisions from in-memory index tree' (duration: 114.309344ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:40:53.497731Z","caller":"traceutil/trace.go:171","msg":"trace[1139868655] transaction","detail":"{read_only:false; response_revision:5493; number_of_response:1; }","duration":"109.689696ms","start":"2026-08-05T21:40:53.38801Z","end":"2026-08-05T21:40:53.4977Z","steps":["trace[1139868655] 'process raft request' (duration: 88.692536ms)","trace[1139868655] 'compare' (duration: 20.850537ms)"],"step_count":2} {"level":"info","ts":"2026-08-05T21:42:08.003745Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3024} {"level":"info","ts":"2026-08-05T21:42:08.0934Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3024,"took":"88.103589ms","hash":1714446730,"current-db-size-bytes":58777600,"current-db-size":"59 MB","current-db-size-in-use-bytes":32043008,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-08-05T21:42:08.093484Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1714446730,"revision":3024,"compact-revision":-1} {"level":"warn","ts":"2026-08-05T21:44:38.074405Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.488794ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-05T21:44:38.074498Z","caller":"traceutil/trace.go:171","msg":"trace[2084146410] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:7123; }","duration":"156.650178ms","start":"2026-08-05T21:44:37.917827Z","end":"2026-08-05T21:44:38.074477Z","steps":["trace[2084146410] 'count revisions from in-memory index tree' (duration: 156.354482ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:47:07.11301Z","caller":"traceutil/trace.go:171","msg":"trace[365459768] transaction","detail":"{read_only:false; response_revision:8317; number_of_response:1; }","duration":"225.314633ms","start":"2026-08-05T21:47:06.887669Z","end":"2026-08-05T21:47:07.112984Z","steps":["trace[365459768] 'process raft request' (duration: 225.14859ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:47:08.010506Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6125} {"level":"info","ts":"2026-08-05T21:47:08.099013Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6125,"took":"87.14743ms","hash":2252981513,"current-db-size-bytes":58777600,"current-db-size":"59 MB","current-db-size-in-use-bytes":23969792,"current-db-size-in-use":"24 MB"} {"level":"info","ts":"2026-08-05T21:47:08.099063Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2252981513,"revision":6125,"compact-revision":3024} {"level":"info","ts":"2026-08-05T21:47:13.992579Z","caller":"traceutil/trace.go:171","msg":"trace[534086742] transaction","detail":"{read_only:false; response_revision:8351; number_of_response:1; }","duration":"312.200429ms","start":"2026-08-05T21:47:13.680349Z","end":"2026-08-05T21:47:13.992549Z","steps":["trace[534086742] 'process raft request' (duration: 312.023535ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T21:47:13.992951Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T21:47:13.680325Z","time spent":"312.346431ms","remote":"127.0.0.1:43212","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-05T21:47:13.993981Z","caller":"traceutil/trace.go:171","msg":"trace[1268345932] transaction","detail":"{read_only:false; response_revision:8352; number_of_response:1; }","duration":"312.145797ms","start":"2026-08-05T21:47:13.681798Z","end":"2026-08-05T21:47:13.993944Z","steps":["trace[1268345932] 'process raft request' (duration: 311.975744ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T21:47:13.994177Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T21:47:13.681778Z","time spent":"312.287411ms","remote":"127.0.0.1:43212","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-05T21:47:20.133731Z","caller":"traceutil/trace.go:171","msg":"trace[972498330] transaction","detail":"{read_only:false; response_revision:8381; number_of_response:1; }","duration":"121.163518ms","start":"2026-08-05T21:47:20.012548Z","end":"2026-08-05T21:47:20.133712Z","steps":["trace[972498330] 'process raft request' (duration: 121.013865ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:47:20.162152Z","caller":"traceutil/trace.go:171","msg":"trace[1312167482] linearizableReadLoop","detail":"{readStateIndex:8671; appliedIndex:8669; }","duration":"130.366565ms","start":"2026-08-05T21:47:20.031765Z","end":"2026-08-05T21:47:20.162131Z","steps":["trace[1312167482] 'read index received' (duration: 101.895482ms)","trace[1312167482] 'applied index is now lower than readState.Index' (duration: 28.468043ms)"],"step_count":2} {"level":"warn","ts":"2026-08-05T21:47:20.162407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.62457ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-08-05T21:47:20.162377Z","caller":"traceutil/trace.go:171","msg":"trace[1877972227] transaction","detail":"{read_only:false; response_revision:8382; number_of_response:1; }","duration":"148.164423ms","start":"2026-08-05T21:47:20.014025Z","end":"2026-08-05T21:47:20.16219Z","steps":["trace[1877972227] 'process raft request' (duration: 147.874887ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:47:20.162475Z","caller":"traceutil/trace.go:171","msg":"trace[1800035675] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8382; }","duration":"130.755062ms","start":"2026-08-05T21:47:20.031709Z","end":"2026-08-05T21:47:20.162464Z","steps":["trace[1800035675] 'agreement among raft nodes before linearized reading' (duration: 130.586439ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T21:47:20.16266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.264982ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephblockpools/\" range_end:\"/registry/ceph.rook.io/cephblockpools0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-05T21:47:20.162779Z","caller":"traceutil/trace.go:171","msg":"trace[2072792615] range","detail":"{range_begin:/registry/ceph.rook.io/cephblockpools/; range_end:/registry/ceph.rook.io/cephblockpools0; response_count:0; response_revision:8382; }","duration":"130.411875ms","start":"2026-08-05T21:47:20.032343Z","end":"2026-08-05T21:47:20.162755Z","steps":["trace[2072792615] 'agreement among raft nodes before linearized reading' (duration: 130.210121ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T21:47:20.163405Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.442426ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephfilesystems/\" range_end:\"/registry/ceph.rook.io/cephfilesystems0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-05T21:47:20.163488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.885245ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephblockpools/\" range_end:\"/registry/ceph.rook.io/cephblockpools0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-05T21:47:20.163484Z","caller":"traceutil/trace.go:171","msg":"trace[502801248] range","detail":"{range_begin:/registry/ceph.rook.io/cephfilesystems/; range_end:/registry/ceph.rook.io/cephfilesystems0; response_count:0; response_revision:8382; }","duration":"108.549349ms","start":"2026-08-05T21:47:20.054918Z","end":"2026-08-05T21:47:20.163467Z","steps":["trace[502801248] 'agreement among raft nodes before linearized reading' (duration: 108.413505ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:47:20.163543Z","caller":"traceutil/trace.go:171","msg":"trace[951891543] range","detail":"{range_begin:/registry/ceph.rook.io/cephblockpools/; range_end:/registry/ceph.rook.io/cephblockpools0; response_count:0; response_revision:8382; }","duration":"129.944116ms","start":"2026-08-05T21:47:20.033587Z","end":"2026-08-05T21:47:20.163531Z","steps":["trace[951891543] 'agreement among raft nodes before linearized reading' (duration: 129.859774ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T21:47:20.163741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.318932ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephblockpools/\" range_end:\"/registry/ceph.rook.io/cephblockpools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-05T21:47:20.163782Z","caller":"traceutil/trace.go:171","msg":"trace[487645174] range","detail":"{range_begin:/registry/ceph.rook.io/cephblockpools/; range_end:/registry/ceph.rook.io/cephblockpools0; response_count:0; response_revision:8382; }","duration":"131.406884ms","start":"2026-08-05T21:47:20.032366Z","end":"2026-08-05T21:47:20.163773Z","steps":["trace[487645174] 'agreement among raft nodes before linearized reading' (duration: 131.309073ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T21:47:20.164489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.432625ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephfilesystems/\" range_end:\"/registry/ceph.rook.io/cephfilesystems0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-05T21:47:20.164533Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.478626ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephfilesystems/\" range_end:\"/registry/ceph.rook.io/cephfilesystems0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-05T21:47:20.164567Z","caller":"traceutil/trace.go:171","msg":"trace[1499728007] range","detail":"{range_begin:/registry/ceph.rook.io/cephfilesystems/; range_end:/registry/ceph.rook.io/cephfilesystems0; response_count:0; response_revision:8382; }","duration":"109.549268ms","start":"2026-08-05T21:47:20.054997Z","end":"2026-08-05T21:47:20.164546Z","steps":["trace[1499728007] 'agreement among raft nodes before linearized reading' (duration: 109.406905ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:47:20.164803Z","caller":"traceutil/trace.go:171","msg":"trace[1215794169] range","detail":"{range_begin:/registry/ceph.rook.io/cephfilesystems/; range_end:/registry/ceph.rook.io/cephfilesystems0; response_count:0; response_revision:8382; }","duration":"109.588308ms","start":"2026-08-05T21:47:20.054999Z","end":"2026-08-05T21:47:20.164588Z","steps":["trace[1215794169] 'agreement among raft nodes before linearized reading' (duration: 109.413505ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:47:43.806986Z","caller":"traceutil/trace.go:171","msg":"trace[671279706] transaction","detail":"{read_only:false; response_revision:8519; number_of_response:1; }","duration":"174.71329ms","start":"2026-08-05T21:47:43.632242Z","end":"2026-08-05T21:47:43.806956Z","steps":["trace[671279706] 'process raft request' (duration: 174.527756ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:47:46.632048Z","caller":"traceutil/trace.go:171","msg":"trace[94184300] transaction","detail":"{read_only:false; response_revision:8581; number_of_response:1; }","duration":"105.311796ms","start":"2026-08-05T21:47:46.526693Z","end":"2026-08-05T21:47:46.632005Z","steps":["trace[94184300] 'process raft request' (duration: 105.047391ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T21:47:50.335042Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"459.041237ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-05T21:47:50.335111Z","caller":"traceutil/trace.go:171","msg":"trace[269724922] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:8596; }","duration":"459.154139ms","start":"2026-08-05T21:47:49.875941Z","end":"2026-08-05T21:47:50.335095Z","steps":["trace[269724922] 'count revisions from in-memory index tree' (duration: 458.982736ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T21:47:50.33514Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T21:47:49.875927Z","time spent":"459.20684ms","remote":"127.0.0.1:58562","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":31,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "} {"level":"warn","ts":"2026-08-05T21:47:50.335693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"453.99257ms","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-05T21:47:50.335792Z","caller":"traceutil/trace.go:171","msg":"trace[1699312726] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:8596; }","duration":"454.135593ms","start":"2026-08-05T21:47:49.881649Z","end":"2026-08-05T21:47:50.335784Z","steps":["trace[1699312726] 'range keys from in-memory index tree' (duration: 453.827317ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T21:47:50.335811Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T21:47:49.881624Z","time spent":"454.181334ms","remote":"127.0.0.1:43146","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12240,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"info","ts":"2026-08-05T21:47:50.350053Z","caller":"traceutil/trace.go:171","msg":"trace[2011522539] transaction","detail":"{read_only:false; response_revision:8597; number_of_response:1; }","duration":"103.464731ms","start":"2026-08-05T21:47:50.246555Z","end":"2026-08-05T21:47:50.35002Z","steps":["trace[2011522539] 'process raft request' (duration: 103.246797ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:48:03.500264Z","caller":"traceutil/trace.go:171","msg":"trace[484847822] transaction","detail":"{read_only:false; response_revision:8714; number_of_response:1; }","duration":"235.808972ms","start":"2026-08-05T21:48:03.264405Z","end":"2026-08-05T21:48:03.500214Z","steps":["trace[484847822] 'process raft request' (duration: 235.503667ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:48:03.801894Z","caller":"traceutil/trace.go:171","msg":"trace[1063886565] transaction","detail":"{read_only:false; response_revision:8715; number_of_response:1; }","duration":"220.883348ms","start":"2026-08-05T21:48:03.580974Z","end":"2026-08-05T21:48:03.801857Z","steps":["trace[1063886565] 'process raft request' (duration: 220.636934ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:48:05.885808Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002351.wal"} {"level":"info","ts":"2026-08-05T21:49:47.361124Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"dbd0ffa4f8c99812","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-08-05T21:49:47.368497Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-08-05T21:49:47.368607Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-08-05T21:52:08.01748Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8322} {"level":"info","ts":"2026-08-05T21:52:08.099071Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8322,"took":"79.516565ms","hash":2577972847,"current-db-size-bytes":58777600,"current-db-size":"59 MB","current-db-size-in-use-bytes":25362432,"current-db-size-in-use":"25 MB"} {"level":"info","ts":"2026-08-05T21:52:08.099153Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2577972847,"revision":8322,"compact-revision":6125} {"level":"info","ts":"2026-08-05T21:54:34.130414Z","caller":"traceutil/trace.go:171","msg":"trace[53044469] transaction","detail":"{read_only:false; response_revision:11766; number_of_response:1; }","duration":"225.378092ms","start":"2026-08-05T21:54:33.905006Z","end":"2026-08-05T21:54:34.130384Z","steps":["trace[53044469] 'process raft request' (duration: 225.290161ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:54:34.130623Z","caller":"traceutil/trace.go:171","msg":"trace[112387159] transaction","detail":"{read_only:false; response_revision:11765; number_of_response:1; }","duration":"227.260479ms","start":"2026-08-05T21:54:33.903335Z","end":"2026-08-05T21:54:34.130595Z","steps":["trace[112387159] 'process raft request' (duration: 198.562113ms)","trace[112387159] 'compare' (duration: 28.203046ms)"],"step_count":2} {"level":"info","ts":"2026-08-05T21:54:52.10369Z","caller":"traceutil/trace.go:171","msg":"trace[635130412] transaction","detail":"{read_only:false; response_revision:11868; number_of_response:1; }","duration":"121.856139ms","start":"2026-08-05T21:54:51.981804Z","end":"2026-08-05T21:54:52.10366Z","steps":["trace[635130412] 'process raft request' (duration: 121.646745ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:54:52.125486Z","caller":"traceutil/trace.go:171","msg":"trace[185660651] transaction","detail":"{read_only:false; response_revision:11869; number_of_response:1; }","duration":"118.22407ms","start":"2026-08-05T21:54:52.007215Z","end":"2026-08-05T21:54:52.125439Z","steps":["trace[185660651] 'process raft request' (duration: 117.570007ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:57:08.026649Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10549} {"level":"info","ts":"2026-08-05T21:57:08.108Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10549,"took":"78.737477ms","hash":2471348041,"current-db-size-bytes":58777600,"current-db-size":"59 MB","current-db-size-in-use-bytes":26349568,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-08-05T21:57:08.108071Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2471348041,"revision":10549,"compact-revision":8322} {"level":"info","ts":"2026-08-05T22:01:35.804518Z","caller":"traceutil/trace.go:171","msg":"trace[701356120] transaction","detail":"{read_only:false; response_revision:14557; number_of_response:1; }","duration":"132.649426ms","start":"2026-08-05T22:01:35.671823Z","end":"2026-08-05T22:01:35.804472Z","steps":["trace[701356120] 'process raft request' (duration: 132.382571ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T22:01:35.80522Z","caller":"traceutil/trace.go:171","msg":"trace[148263188] transaction","detail":"{read_only:false; response_revision:14558; number_of_response:1; }","duration":"129.167509ms","start":"2026-08-05T22:01:35.676022Z","end":"2026-08-05T22:01:35.80519Z","steps":["trace[148263188] 'process raft request' (duration: 128.979766ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T22:01:35.805359Z","caller":"traceutil/trace.go:171","msg":"trace[1315312324] transaction","detail":"{read_only:false; response_revision:14559; number_of_response:1; }","duration":"126.60254ms","start":"2026-08-05T22:01:35.678722Z","end":"2026-08-05T22:01:35.805324Z","steps":["trace[1315312324] 'process raft request' (duration: 126.422087ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T22:02:00.258884Z","caller":"traceutil/trace.go:171","msg":"trace[2006113628] linearizableReadLoop","detail":"{readStateIndex:15384; appliedIndex:15383; }","duration":"141.441894ms","start":"2026-08-05T22:02:00.117426Z","end":"2026-08-05T22:02:00.258868Z","steps":["trace[2006113628] 'read index received' (duration: 139.311344ms)","trace[2006113628] 'applied index is now lower than readState.Index' (duration: 2.13002ms)"],"step_count":2} {"level":"info","ts":"2026-08-05T22:02:00.258896Z","caller":"traceutil/trace.go:171","msg":"trace[226920516] transaction","detail":"{read_only:false; response_revision:14876; number_of_response:1; }","duration":"173.023927ms","start":"2026-08-05T22:02:00.085844Z","end":"2026-08-05T22:02:00.258868Z","steps":["trace[226920516] 'process raft request' (duration: 170.884767ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T22:02:00.259062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.627777ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-05T22:02:00.259112Z","caller":"traceutil/trace.go:171","msg":"trace[1315692723] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:14877; }","duration":"141.75847ms","start":"2026-08-05T22:02:00.117339Z","end":"2026-08-05T22:02:00.259097Z","steps":["trace[1315692723] 'agreement among raft nodes before linearized reading' (duration: 141.626478ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T22:02:00.259349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.767255ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-794914fc-8577-4dc0-aee6-d7d90df921ed\" ","response":"range_response_count:1 size:3637"} {"level":"info","ts":"2026-08-05T22:02:00.259369Z","caller":"traceutil/trace.go:171","msg":"trace[903894708] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-794914fc-8577-4dc0-aee6-d7d90df921ed; range_end:; response_count:1; response_revision:14877; }","duration":"102.826616ms","start":"2026-08-05T22:02:00.156535Z","end":"2026-08-05T22:02:00.259362Z","steps":["trace[903894708] 'agreement among raft nodes before linearized reading' (duration: 102.460288ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T22:02:00.407822Z","caller":"traceutil/trace.go:171","msg":"trace[1125060974] transaction","detail":"{read_only:false; response_revision:14878; number_of_response:1; }","duration":"143.380862ms","start":"2026-08-05T22:02:00.264411Z","end":"2026-08-05T22:02:00.407791Z","steps":["trace[1125060974] 'process raft request' (duration: 138.541629ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T22:02:08.034847Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12774} {"level":"info","ts":"2026-08-05T22:02:08.117534Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12774,"took":"78.530231ms","hash":1978768911,"current-db-size-bytes":58777600,"current-db-size":"59 MB","current-db-size-in-use-bytes":28942336,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-08-05T22:02:08.117611Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1978768911,"revision":12774,"compact-revision":10549} {"level":"info","ts":"2026-08-05T22:03:26.29048Z","caller":"traceutil/trace.go:171","msg":"trace[511005186] transaction","detail":"{read_only:false; response_revision:15689; number_of_response:1; }","duration":"235.10749ms","start":"2026-08-05T22:03:26.055285Z","end":"2026-08-05T22:03:26.290393Z","steps":["trace[511005186] 'process raft request' (duration: 215.549736ms)","trace[511005186] 'compare' (duration: 19.073535ms)"],"step_count":2} {"level":"warn","ts":"2026-08-05T22:03:26.290621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.140121ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-bzstm\" ","response":"range_response_count:1 size:6530"} {"level":"info","ts":"2026-08-05T22:03:26.290734Z","caller":"traceutil/trace.go:171","msg":"trace[1713627233] range","detail":"{range_begin:/registry/pods/openstack/keepalived-bzstm; range_end:; response_count:1; response_revision:15689; }","duration":"136.306475ms","start":"2026-08-05T22:03:26.154408Z","end":"2026-08-05T22:03:26.290714Z","steps":["trace[1713627233] 'agreement among raft nodes before linearized reading' (duration: 136.08443ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T22:03:26.291199Z","caller":"traceutil/trace.go:171","msg":"trace[605605486] linearizableReadLoop","detail":"{readStateIndex:16223; appliedIndex:16222; }","duration":"135.908256ms","start":"2026-08-05T22:03:26.154453Z","end":"2026-08-05T22:03:26.290362Z","steps":["trace[605605486] 'read index received' (duration: 116.400924ms)","trace[605605486] 'applied index is now lower than readState.Index' (duration: 19.505692ms)"],"step_count":2} {"level":"info","ts":"2026-08-05T22:06:24.514144Z","caller":"traceutil/trace.go:171","msg":"trace[784621990] transaction","detail":"{read_only:false; response_revision:17000; number_of_response:1; }","duration":"103.276002ms","start":"2026-08-05T22:06:24.410825Z","end":"2026-08-05T22:06:24.514101Z","steps":["trace[784621990] 'process raft request' (duration: 58.042958ms)","trace[784621990] 'compare' (duration: 45.01955ms)"],"step_count":2} {"level":"info","ts":"2026-08-05T22:06:24.514217Z","caller":"traceutil/trace.go:171","msg":"trace[671235854] transaction","detail":"{read_only:false; response_revision:17001; number_of_response:1; }","duration":"102.836653ms","start":"2026-08-05T22:06:24.411334Z","end":"2026-08-05T22:06:24.514171Z","steps":["trace[671235854] 'process raft request' (duration: 102.68238ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T22:06:24.514368Z","caller":"traceutil/trace.go:171","msg":"trace[783386721] transaction","detail":"{read_only:false; response_revision:17002; number_of_response:1; }","duration":"102.897414ms","start":"2026-08-05T22:06:24.411454Z","end":"2026-08-05T22:06:24.514352Z","steps":["trace[783386721] 'process raft request' (duration: 102.634069ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T22:06:24.514457Z","caller":"traceutil/trace.go:171","msg":"trace[387265903] transaction","detail":"{read_only:false; response_revision:17004; number_of_response:1; }","duration":"101.64994ms","start":"2026-08-05T22:06:24.412795Z","end":"2026-08-05T22:06:24.514445Z","steps":["trace[387265903] 'process raft request' (duration: 101.556958ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T22:06:24.514519Z","caller":"traceutil/trace.go:171","msg":"trace[362676740] transaction","detail":"{read_only:false; response_revision:17005; number_of_response:1; }","duration":"101.336534ms","start":"2026-08-05T22:06:24.413176Z","end":"2026-08-05T22:06:24.514512Z","steps":["trace[362676740] 'process raft request' (duration: 101.205022ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T22:06:24.514577Z","caller":"traceutil/trace.go:171","msg":"trace[1026752255] transaction","detail":"{read_only:false; response_revision:17006; number_of_response:1; }","duration":"100.955217ms","start":"2026-08-05T22:06:24.413615Z","end":"2026-08-05T22:06:24.51457Z","steps":["trace[1026752255] 'process raft request' (duration: 100.800794ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T22:06:24.514635Z","caller":"traceutil/trace.go:171","msg":"trace[546210375] transaction","detail":"{read_only:false; response_revision:17007; number_of_response:1; }","duration":"100.928366ms","start":"2026-08-05T22:06:24.4137Z","end":"2026-08-05T22:06:24.514629Z","steps":["trace[546210375] 'process raft request' (duration: 100.744053ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T22:06:24.514583Z","caller":"traceutil/trace.go:171","msg":"trace[305220337] transaction","detail":"{read_only:false; response_revision:17003; number_of_response:1; }","duration":"102.568368ms","start":"2026-08-05T22:06:24.41194Z","end":"2026-08-05T22:06:24.514509Z","steps":["trace[305220337] 'process raft request' (duration: 102.372024ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T22:06:24.514698Z","caller":"traceutil/trace.go:171","msg":"trace[1258441040] transaction","detail":"{read_only:false; response_revision:17008; number_of_response:1; }","duration":"100.960757ms","start":"2026-08-05T22:06:24.41373Z","end":"2026-08-05T22:06:24.514691Z","steps":["trace[1258441040] 'process raft request' (duration: 100.798084ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T22:06:24.514762Z","caller":"traceutil/trace.go:171","msg":"trace[172890815] transaction","detail":"{read_only:false; response_revision:17009; number_of_response:1; }","duration":"100.957528ms","start":"2026-08-05T22:06:24.413796Z","end":"2026-08-05T22:06:24.514754Z","steps":["trace[172890815] 'process raft request' (duration: 100.781734ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T22:06:24.514837Z","caller":"traceutil/trace.go:171","msg":"trace[205703263] transaction","detail":"{read_only:false; response_revision:17010; number_of_response:1; }","duration":"100.971618ms","start":"2026-08-05T22:06:24.413842Z","end":"2026-08-05T22:06:24.514814Z","steps":["trace[205703263] 'process raft request' (duration: 100.783524ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T22:06:24.514997Z","caller":"traceutil/trace.go:171","msg":"trace[282659918] transaction","detail":"{read_only:false; response_revision:17011; number_of_response:1; }","duration":"100.156382ms","start":"2026-08-05T22:06:24.41479Z","end":"2026-08-05T22:06:24.514946Z","steps":["trace[282659918] 'process raft request' (duration: 99.882566ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T22:06:24.515127Z","caller":"traceutil/trace.go:171","msg":"trace[487207933] transaction","detail":"{read_only:false; response_revision:17012; number_of_response:1; }","duration":"100.058801ms","start":"2026-08-05T22:06:24.415059Z","end":"2026-08-05T22:06:24.515118Z","steps":["trace[487207933] 'process raft request' (duration: 99.660043ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T22:06:24.777982Z","caller":"traceutil/trace.go:171","msg":"trace[1442584677] transaction","detail":"{read_only:false; response_revision:17048; number_of_response:1; }","duration":"128.470892ms","start":"2026-08-05T22:06:24.649488Z","end":"2026-08-05T22:06:24.777959Z","steps":["trace[1442584677] 'process raft request' (duration: 79.361155ms)","trace[1442584677] 'compare' (duration: 48.620338ms)"],"step_count":2} {"level":"info","ts":"2026-08-05T22:06:24.778208Z","caller":"traceutil/trace.go:171","msg":"trace[795107677] transaction","detail":"{read_only:false; response_revision:17049; number_of_response:1; }","duration":"128.523815ms","start":"2026-08-05T22:06:24.649654Z","end":"2026-08-05T22:06:24.778178Z","steps":["trace[795107677] 'process raft request' (duration: 127.962823ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T22:06:24.778436Z","caller":"traceutil/trace.go:171","msg":"trace[1979284599] transaction","detail":"{read_only:false; response_revision:17050; number_of_response:1; }","duration":"128.702177ms","start":"2026-08-05T22:06:24.649723Z","end":"2026-08-05T22:06:24.778425Z","steps":["trace[1979284599] 'process raft request' (duration: 127.936172ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T22:06:24.778564Z","caller":"traceutil/trace.go:171","msg":"trace[112965249] transaction","detail":"{read_only:false; response_revision:17051; number_of_response:1; }","duration":"129.056933ms","start":"2026-08-05T22:06:24.649498Z","end":"2026-08-05T22:06:24.778555Z","steps":["trace[112965249] 'process raft request' (duration: 128.191496ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T22:06:24.778677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.234737ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/monitoring/\" range_end:\"/registry/resourcequotas/monitoring0\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-05T22:06:24.778755Z","caller":"traceutil/trace.go:171","msg":"trace[558927824] range","detail":"{range_begin:/registry/resourcequotas/monitoring/; range_end:/registry/resourcequotas/monitoring0; response_count:0; response_revision:17053; }","duration":"129.39036ms","start":"2026-08-05T22:06:24.649346Z","end":"2026-08-05T22:06:24.778736Z","steps":["trace[558927824] 'agreement among raft nodes before linearized reading' (duration: 129.242477ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T22:07:08.049635Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14942} {"level":"info","ts":"2026-08-05T22:07:08.148566Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14942,"took":"94.849982ms","hash":3003242275,"current-db-size-bytes":58777600,"current-db-size":"59 MB","current-db-size-in-use-bytes":30822400,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-08-05T22:07:08.148632Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3003242275,"revision":14942,"compact-revision":12774} {"level":"info","ts":"2026-08-05T22:09:39.743418Z","caller":"traceutil/trace.go:171","msg":"trace[1819294013] transaction","detail":"{read_only:false; response_revision:18433; number_of_response:1; }","duration":"117.000435ms","start":"2026-08-05T22:09:39.626383Z","end":"2026-08-05T22:09:39.743383Z","steps":["trace[1819294013] 'process raft request' (duration: 97.472762ms)","trace[1819294013] 'compare' (duration: 19.369771ms)"],"step_count":2} {"level":"info","ts":"2026-08-05T22:09:39.770157Z","caller":"traceutil/trace.go:171","msg":"trace[686616694] transaction","detail":"{read_only:false; response_revision:18434; number_of_response:1; }","duration":"143.744176ms","start":"2026-08-05T22:09:39.626386Z","end":"2026-08-05T22:09:39.77013Z","steps":["trace[686616694] 'process raft request' (duration: 143.559833ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T22:09:40.027583Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.037668ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-08-05T22:09:40.027698Z","caller":"traceutil/trace.go:171","msg":"trace[237452160] transaction","detail":"{read_only:false; response_revision:18439; number_of_response:1; }","duration":"180.057711ms","start":"2026-08-05T22:09:39.847623Z","end":"2026-08-05T22:09:40.027681Z","steps":["trace[237452160] 'process raft request' (duration: 75.666166ms)","trace[237452160] 'compare' (duration: 103.771214ms)"],"step_count":2} {"level":"warn","ts":"2026-08-05T22:09:40.374849Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.451626ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/libvirt-libvirt-default-mwztn\" ","response":"range_response_count:1 size:20747"} {"level":"info","ts":"2026-08-05T22:09:40.374979Z","caller":"traceutil/trace.go:171","msg":"trace[958320118] range","detail":"{range_begin:/registry/pods/openstack/libvirt-libvirt-default-mwztn; range_end:; response_count:1; response_revision:18439; }","duration":"216.67002ms","start":"2026-08-05T22:09:40.158281Z","end":"2026-08-05T22:09:40.374951Z","steps":["trace[958320118] 'range keys from in-memory index tree' (duration: 216.172102ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T22:09:40.939839Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.884488ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-05T22:09:40.939919Z","caller":"traceutil/trace.go:171","msg":"trace[832577008] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:18440; }","duration":"170.00988ms","start":"2026-08-05T22:09:40.76989Z","end":"2026-08-05T22:09:40.9399Z","steps":["trace[832577008] 'range keys from in-memory index tree' (duration: 169.792476ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T22:11:10.064426Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"dbd0ffa4f8c99812","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-08-05T22:11:10.06892Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-08-05T22:11:10.069012Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-08-05T22:12:08.058285Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17423} {"level":"info","ts":"2026-08-05T22:12:08.166371Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17423,"took":"103.236325ms","hash":616938451,"current-db-size-bytes":58777600,"current-db-size":"59 MB","current-db-size-in-use-bytes":34299904,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-08-05T22:12:08.166465Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":616938451,"revision":17423,"compact-revision":14942} {"level":"info","ts":"2026-08-05T22:15:37.558895Z","caller":"traceutil/trace.go:171","msg":"trace[18964874] linearizableReadLoop","detail":"{readStateIndex:21894; appliedIndex:21893; }","duration":"122.77965ms","start":"2026-08-05T22:15:37.436087Z","end":"2026-08-05T22:15:37.558867Z","steps":["trace[18964874] 'read index received' (duration: 122.026217ms)","trace[18964874] 'applied index is now lower than readState.Index' (duration: 752.163µs)"],"step_count":2} {"level":"warn","ts":"2026-08-05T22:15:37.559057Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.940773ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/federations/\" range_end:\"/registry/rabbitmq.com/federations0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-05T22:15:37.559099Z","caller":"traceutil/trace.go:171","msg":"trace[1290812324] range","detail":"{range_begin:/registry/rabbitmq.com/federations/; range_end:/registry/rabbitmq.com/federations0; response_count:0; response_revision:21180; }","duration":"123.046305ms","start":"2026-08-05T22:15:37.436037Z","end":"2026-08-05T22:15:37.559083Z","steps":["trace[1290812324] 'agreement among raft nodes before linearized reading' (duration: 122.948614ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T22:15:37.559175Z","caller":"traceutil/trace.go:171","msg":"trace[1950603696] transaction","detail":"{read_only:false; response_revision:21180; number_of_response:1; }","duration":"128.122873ms","start":"2026-08-05T22:15:37.430858Z","end":"2026-08-05T22:15:37.558981Z","steps":["trace[1950603696] 'process raft request' (duration: 127.309248ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T22:15:53.584064Z","caller":"traceutil/trace.go:171","msg":"trace[1528212174] transaction","detail":"{read_only:false; response_revision:21260; number_of_response:1; }","duration":"294.692024ms","start":"2026-08-05T22:15:53.289334Z","end":"2026-08-05T22:15:53.584026Z","steps":["trace[1528212174] 'process raft request' (duration: 294.47806ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T22:15:53.584223Z","caller":"traceutil/trace.go:171","msg":"trace[1607029825] linearizableReadLoop","detail":"{readStateIndex:21978; appliedIndex:21975; }","duration":"275.937444ms","start":"2026-08-05T22:15:53.308253Z","end":"2026-08-05T22:15:53.58419Z","steps":["trace[1607029825] 'read index received' (duration: 676.033µs)","trace[1607029825] 'applied index is now lower than readState.Index' (duration: 275.259011ms)"],"step_count":2} {"level":"warn","ts":"2026-08-05T22:15:53.584463Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.195058ms","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-05T22:15:53.584563Z","caller":"traceutil/trace.go:171","msg":"trace[1039561075] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:21261; }","duration":"276.351111ms","start":"2026-08-05T22:15:53.308191Z","end":"2026-08-05T22:15:53.584542Z","steps":["trace[1039561075] 'agreement among raft nodes before linearized reading' (duration: 276.101967ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T22:15:53.584304Z","caller":"traceutil/trace.go:171","msg":"trace[1213445990] transaction","detail":"{read_only:false; response_revision:21261; number_of_response:1; }","duration":"294.6036ms","start":"2026-08-05T22:15:53.289682Z","end":"2026-08-05T22:15:53.584285Z","steps":["trace[1213445990] 'process raft request' (duration: 294.303845ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T22:15:53.862805Z","caller":"traceutil/trace.go:171","msg":"trace[2097790089] transaction","detail":"{read_only:false; response_revision:21264; number_of_response:1; }","duration":"204.580667ms","start":"2026-08-05T22:15:53.658193Z","end":"2026-08-05T22:15:53.862773Z","steps":["trace[2097790089] 'process raft request' (duration: 114.618015ms)","trace[2097790089] 'compare' (duration: 89.84186ms)"],"step_count":2} {"level":"info","ts":"2026-08-05T22:15:54.092849Z","caller":"traceutil/trace.go:171","msg":"trace[1446893939] transaction","detail":"{read_only:false; response_revision:21266; number_of_response:1; }","duration":"130.081081ms","start":"2026-08-05T22:15:53.962744Z","end":"2026-08-05T22:15:54.092825Z","steps":["trace[1446893939] 'process raft request' (duration: 129.941519ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T22:15:54.226429Z","caller":"traceutil/trace.go:171","msg":"trace[1871335976] transaction","detail":"{read_only:false; response_revision:21267; number_of_response:1; }","duration":"263.000257ms","start":"2026-08-05T22:15:53.963348Z","end":"2026-08-05T22:15:54.226348Z","steps":["trace[1871335976] 'process raft request' (duration: 248.781923ms)","trace[1871335976] 'compare' (duration: 14.017739ms)"],"step_count":2} {"level":"info","ts":"2026-08-05T22:15:54.677885Z","caller":"traceutil/trace.go:171","msg":"trace[163372405] linearizableReadLoop","detail":"{readStateIndex:21985; appliedIndex:21984; }","duration":"216.148068ms","start":"2026-08-05T22:15:54.461715Z","end":"2026-08-05T22:15:54.677863Z","steps":["trace[163372405] 'read index received' (duration: 215.983505ms)","trace[163372405] 'applied index is now lower than readState.Index' (duration: 163.743µs)"],"step_count":2} {"level":"info","ts":"2026-08-05T22:15:54.678025Z","caller":"traceutil/trace.go:171","msg":"trace[522912996] transaction","detail":"{read_only:false; response_revision:21268; number_of_response:1; }","duration":"216.517166ms","start":"2026-08-05T22:15:54.461399Z","end":"2026-08-05T22:15:54.677916Z","steps":["trace[522912996] 'process raft request' (duration: 216.328703ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T22:15:54.677998Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.271741ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-05T22:15:54.678258Z","caller":"traceutil/trace.go:171","msg":"trace[811368987] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:21268; }","duration":"216.500955ms","start":"2026-08-05T22:15:54.461682Z","end":"2026-08-05T22:15:54.678183Z","steps":["trace[811368987] 'agreement among raft nodes before linearized reading' (duration: 216.267261ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T22:17:08.064759Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19726} {"level":"info","ts":"2026-08-05T22:17:08.178777Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19726,"took":"109.65624ms","hash":3452368463,"current-db-size-bytes":58777600,"current-db-size":"59 MB","current-db-size-in-use-bytes":29048832,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-08-05T22:17:08.17888Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3452368463,"revision":19726,"compact-revision":17423} {"level":"warn","ts":"2026-08-05T22:18:27.448156Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10957996575544161063,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-05T22:18:27.948591Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10957996575544161063,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-05T22:18:28.449525Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10957996575544161063,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-05T22:18:28.941687Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.231650943s","expected-duration":"1s"} {"level":"info","ts":"2026-08-05T22:18:28.949389Z","caller":"traceutil/trace.go:171","msg":"trace[1428443748] transaction","detail":"{read_only:false; response_revision:22459; number_of_response:1; }","duration":"2.143125237s","start":"2026-08-05T22:18:26.806232Z","end":"2026-08-05T22:18:28.949358Z","steps":["trace[1428443748] 'process raft request' (duration: 2.142780041s)"],"step_count":1} {"level":"warn","ts":"2026-08-05T22:18:28.949564Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T22:18:26.80619Z","time spent":"2.14327095s","remote":"127.0.0.1:43190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7356,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-05T22:18:28.949633Z","caller":"traceutil/trace.go:171","msg":"trace[186285137] transaction","detail":"{read_only:false; response_revision:22460; number_of_response:1; }","duration":"2.104325594s","start":"2026-08-05T22:18:26.845277Z","end":"2026-08-05T22:18:28.949603Z","steps":["trace[186285137] 'process raft request' (duration: 2.103952527s)"],"step_count":1} {"level":"warn","ts":"2026-08-05T22:18:28.949821Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T22:18:26.84525Z","time spent":"2.104459787s","remote":"127.0.0.1:43212","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":514,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-05T22:18:28.949981Z","caller":"traceutil/trace.go:171","msg":"trace[1587692952] transaction","detail":"{read_only:false; response_revision:22461; number_of_response:1; }","duration":"1.648705461s","start":"2026-08-05T22:18:27.301259Z","end":"2026-08-05T22:18:28.949965Z","steps":["trace[1587692952] 'process raft request' (duration: 1.648264703s)"],"step_count":1} {"level":"warn","ts":"2026-08-05T22:18:28.950068Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T22:18:27.301237Z","time spent":"1.648787322s","remote":"127.0.0.1:43212","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-05T22:18:28.950187Z","caller":"traceutil/trace.go:171","msg":"trace[996637009] transaction","detail":"{read_only:false; response_revision:22462; number_of_response:1; }","duration":"971.834589ms","start":"2026-08-05T22:18:27.978339Z","end":"2026-08-05T22:18:28.950174Z","steps":["trace[996637009] 'process raft request' (duration: 971.529633ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T22:18:28.950249Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T22:18:27.978327Z","time spent":"971.892231ms","remote":"127.0.0.1:43212","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-05T22:18:28.950522Z","caller":"traceutil/trace.go:171","msg":"trace[1782335011] transaction","detail":"{read_only:false; response_revision:22463; number_of_response:1; }","duration":"698.833891ms","start":"2026-08-05T22:18:28.251673Z","end":"2026-08-05T22:18:28.950506Z","steps":["trace[1782335011] 'process raft request' (duration: 698.370183ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T22:18:28.950521Z","caller":"traceutil/trace.go:171","msg":"trace[149695471] linearizableReadLoop","detail":"{readStateIndex:23231; appliedIndex:23224; }","duration":"2.002426313s","start":"2026-08-05T22:18:26.948077Z","end":"2026-08-05T22:18:28.950503Z","steps":["trace[149695471] 'read index received' (duration: 1.994086003s)","trace[149695471] 'applied index is now lower than readState.Index' (duration: 8.33928ms)"],"step_count":2} {"level":"warn","ts":"2026-08-05T22:18:28.950569Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T22:18:28.251652Z","time spent":"698.893723ms","remote":"127.0.0.1:43212","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-05T22:18:28.950565Z","caller":"traceutil/trace.go:171","msg":"trace[1082040183] transaction","detail":"{read_only:false; response_revision:22464; number_of_response:1; }","duration":"697.776971ms","start":"2026-08-05T22:18:28.252763Z","end":"2026-08-05T22:18:28.95054Z","steps":["trace[1082040183] 'process raft request' (duration: 697.701649ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T22:18:28.950664Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.483863723s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-05T22:18:28.950697Z","caller":"traceutil/trace.go:171","msg":"trace[80426621] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:22464; }","duration":"1.483940374s","start":"2026-08-05T22:18:27.466749Z","end":"2026-08-05T22:18:28.95069Z","steps":["trace[80426621] 'agreement among raft nodes before linearized reading' (duration: 1.483879843s)"],"step_count":1} {"level":"warn","ts":"2026-08-05T22:18:28.9507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.960885167s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/octavia-ks-user\" ","response":"range_response_count:1 size:7374"} {"level":"warn","ts":"2026-08-05T22:18:28.950722Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T22:18:27.466728Z","time spent":"1.483986557s","remote":"127.0.0.1:43316","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":0,"response size":30,"request content":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true "} {"level":"info","ts":"2026-08-05T22:18:28.950732Z","caller":"traceutil/trace.go:171","msg":"trace[1554877713] range","detail":"{range_begin:/registry/jobs/openstack/octavia-ks-user; range_end:; response_count:1; response_revision:22464; }","duration":"1.960967939s","start":"2026-08-05T22:18:26.989754Z","end":"2026-08-05T22:18:28.950722Z","steps":["trace[1554877713] 'agreement among raft nodes before linearized reading' (duration: 1.960871027s)"],"step_count":1} {"level":"warn","ts":"2026-08-05T22:18:28.950778Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T22:18:26.98973Z","time spent":"1.961037851s","remote":"127.0.0.1:43190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":1,"response size":7398,"request content":"key:\"/registry/jobs/openstack/octavia-ks-user\" "} {"level":"warn","ts":"2026-08-05T22:18:28.950797Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.002717379s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/octavia-api\" ","response":"range_response_count:1 size:674"} {"level":"warn","ts":"2026-08-05T22:18:28.950824Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T22:18:28.252755Z","time spent":"697.879802ms","remote":"127.0.0.1:43212","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-05T22:18:28.950856Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"837.348764ms","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-05T22:18:28.950886Z","caller":"traceutil/trace.go:171","msg":"trace[1367630628] range","detail":"{range_begin:/registry/services/endpoints/openstack/octavia-api; range_end:; response_count:1; response_revision:22464; }","duration":"2.002802501s","start":"2026-08-05T22:18:26.94806Z","end":"2026-08-05T22:18:28.950862Z","steps":["trace[1367630628] 'agreement among raft nodes before linearized reading' (duration: 2.002574846s)"],"step_count":1} {"level":"warn","ts":"2026-08-05T22:18:28.950936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.014271973s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-08-05T22:18:28.950955Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T22:18:26.948031Z","time spent":"2.002908973s","remote":"127.0.0.1:43132","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":698,"request content":"key:\"/registry/services/endpoints/openstack/octavia-api\" "} {"level":"warn","ts":"2026-08-05T22:18:28.951003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.801361ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/issuers/\" range_end:\"/registry/cert-manager.io/issuers0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-08-05T22:18:28.95103Z","caller":"traceutil/trace.go:171","msg":"trace[1997189785] range","detail":"{range_begin:/registry/cert-manager.io/issuers/; range_end:/registry/cert-manager.io/issuers0; response_count:0; response_revision:22464; }","duration":"323.877682ms","start":"2026-08-05T22:18:28.627142Z","end":"2026-08-05T22:18:28.951019Z","steps":["trace[1997189785] 'agreement among raft nodes before linearized reading' (duration: 323.829782ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T22:18:28.951055Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T22:18:28.627123Z","time spent":"323.925423ms","remote":"127.0.0.1:52130","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":6,"response size":32,"request content":"key:\"/registry/cert-manager.io/issuers/\" range_end:\"/registry/cert-manager.io/issuers0\" count_only:true "} {"level":"warn","ts":"2026-08-05T22:18:28.951133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.926617232s","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-05T22:18:28.950937Z","caller":"traceutil/trace.go:171","msg":"trace[1530382835] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:22464; }","duration":"837.440167ms","start":"2026-08-05T22:18:28.11348Z","end":"2026-08-05T22:18:28.95092Z","steps":["trace[1530382835] 'agreement among raft nodes before linearized reading' (duration: 837.236752ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T22:18:28.952213Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T22:18:28.113467Z","time spent":"838.73447ms","remote":"127.0.0.1:43146","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12241,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-08-05T22:18:28.951162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.926726564s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/octavia-api\" ","response":"range_response_count:1 size:674"} {"level":"info","ts":"2026-08-05T22:18:28.952374Z","caller":"traceutil/trace.go:171","msg":"trace[1175694267] range","detail":"{range_begin:/registry/services/endpoints/openstack/octavia-api; range_end:; response_count:1; response_revision:22464; }","duration":"1.927951837s","start":"2026-08-05T22:18:27.024406Z","end":"2026-08-05T22:18:28.952357Z","steps":["trace[1175694267] 'agreement among raft nodes before linearized reading' (duration: 1.926689413s)"],"step_count":1} {"level":"warn","ts":"2026-08-05T22:18:28.952401Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T22:18:27.024398Z","time spent":"1.927994549s","remote":"127.0.0.1:43132","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":698,"request content":"key:\"/registry/services/endpoints/openstack/octavia-api\" "} {"level":"info","ts":"2026-08-05T22:18:28.952532Z","caller":"traceutil/trace.go:171","msg":"trace[1483538149] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:22464; }","duration":"1.927448707s","start":"2026-08-05T22:18:27.024483Z","end":"2026-08-05T22:18:28.951931Z","steps":["trace[1483538149] 'agreement among raft nodes before linearized reading' (duration: 1.926186023s)"],"step_count":1} {"level":"info","ts":"2026-08-05T22:18:28.950969Z","caller":"traceutil/trace.go:171","msg":"trace[1938901642] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:22464; }","duration":"1.014323343s","start":"2026-08-05T22:18:27.936636Z","end":"2026-08-05T22:18:28.950959Z","steps":["trace[1938901642] 'agreement among raft nodes before linearized reading' (duration: 1.014279893s)"],"step_count":1} {"level":"warn","ts":"2026-08-05T22:18:28.95263Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T22:18:27.936623Z","time spent":"1.015996055s","remote":"127.0.0.1:43172","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":30,"request content":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true "} {"level":"warn","ts":"2026-08-05T22:18:28.951181Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.927413367s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/octavia-ks-user\" ","response":"range_response_count:1 size:7374"} {"level":"info","ts":"2026-08-05T22:18:28.952801Z","caller":"traceutil/trace.go:171","msg":"trace[52647759] range","detail":"{range_begin:/registry/jobs/openstack/octavia-ks-user; range_end:; response_count:1; response_revision:22464; }","duration":"1.92910949s","start":"2026-08-05T22:18:27.023679Z","end":"2026-08-05T22:18:28.952788Z","steps":["trace[52647759] 'agreement among raft nodes before linearized reading' (duration: 1.927439698s)"],"step_count":1} {"level":"warn","ts":"2026-08-05T22:18:28.952844Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T22:18:27.023658Z","time spent":"1.929173581s","remote":"127.0.0.1:43190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":1,"response size":7398,"request content":"key:\"/registry/jobs/openstack/octavia-ks-user\" "} {"level":"warn","ts":"2026-08-05T22:18:28.951198Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"439.559847ms","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-05T22:18:28.952963Z","caller":"traceutil/trace.go:171","msg":"trace[1368920720] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:22464; }","duration":"441.364271ms","start":"2026-08-05T22:18:28.511584Z","end":"2026-08-05T22:18:28.952948Z","steps":["trace[1368920720] 'agreement among raft nodes before linearized reading' (duration: 439.487855ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T22:18:28.953015Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T22:18:28.511571Z","time spent":"441.429232ms","remote":"127.0.0.1:43212","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":532,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-08-05T22:18:28.9526Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T22:18:27.024477Z","time spent":"1.92810775s","remote":"127.0.0.1:43212","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":518,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-08-05T22:18:28.950896Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.003392793s","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-05T22:18:28.953375Z","caller":"traceutil/trace.go:171","msg":"trace[933388055] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:22464; }","duration":"1.005878341s","start":"2026-08-05T22:18:27.947482Z","end":"2026-08-05T22:18:28.95336Z","steps":["trace[933388055] 'agreement among raft nodes before linearized reading' (duration: 1.003371162s)"],"step_count":1} {"level":"warn","ts":"2026-08-05T22:18:28.95342Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T22:18:27.947476Z","time spent":"1.005929991s","remote":"127.0.0.1:43358","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":13,"response size":32,"request content":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true "} {"level":"warn","ts":"2026-08-05T22:18:28.951292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.865763687s","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-05T22:18:28.95348Z","caller":"traceutil/trace.go:171","msg":"trace[2122681942] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:22464; }","duration":"1.867963209s","start":"2026-08-05T22:18:27.085504Z","end":"2026-08-05T22:18:28.953467Z","steps":["trace[2122681942] 'agreement among raft nodes before linearized reading' (duration: 1.865744097s)"],"step_count":1} {"level":"warn","ts":"2026-08-05T22:18:28.953523Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T22:18:27.085493Z","time spent":"1.868015799s","remote":"127.0.0.1:43212","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-08-05T22:18:28.951307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.867279847s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-08-05T22:18:28.953588Z","caller":"traceutil/trace.go:171","msg":"trace[558642963] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:22464; }","duration":"1.869598761s","start":"2026-08-05T22:18:27.083977Z","end":"2026-08-05T22:18:28.953576Z","steps":["trace[558642963] 'agreement among raft nodes before linearized reading' (duration: 1.867281887s)"],"step_count":1} {"level":"warn","ts":"2026-08-05T22:18:28.953633Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T22:18:27.083954Z","time spent":"1.869667971s","remote":"127.0.0.1:43212","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":505,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-08-05T22:18:28.951235Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.110664368s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-05T22:18:28.953711Z","caller":"traceutil/trace.go:171","msg":"trace[317773672] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:22464; }","duration":"1.113147546s","start":"2026-08-05T22:18:27.840554Z","end":"2026-08-05T22:18:28.953702Z","steps":["trace[317773672] 'agreement among raft nodes before linearized reading' (duration: 1.110653898s)"],"step_count":1} {"level":"warn","ts":"2026-08-05T22:18:28.953733Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T22:18:27.84055Z","time spent":"1.113176516s","remote":"127.0.0.1:42942","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":30,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-05T22:18:28.951309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.928429348s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/octavia-api\" ","response":"range_response_count:1 size:674"} {"level":"info","ts":"2026-08-05T22:18:28.953816Z","caller":"traceutil/trace.go:171","msg":"trace[689910334] range","detail":"{range_begin:/registry/services/endpoints/openstack/octavia-api; range_end:; response_count:1; response_revision:22464; }","duration":"1.930981127s","start":"2026-08-05T22:18:27.022815Z","end":"2026-08-05T22:18:28.953797Z","steps":["trace[689910334] 'agreement among raft nodes before linearized reading' (duration: 1.928419487s)"],"step_count":1} {"level":"warn","ts":"2026-08-05T22:18:28.953857Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T22:18:27.022787Z","time spent":"1.931057078s","remote":"127.0.0.1:43132","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":698,"request content":"key:\"/registry/services/endpoints/openstack/octavia-api\" "} {"level":"warn","ts":"2026-08-05T22:18:28.951405Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.790274101s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/valkey-data-valkey-node-0\" ","response":"range_response_count:1 size:1634"} {"level":"warn","ts":"2026-08-05T22:18:28.952643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.928553529s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/octavia-ks-user\" ","response":"range_response_count:1 size:7374"} {"level":"info","ts":"2026-08-05T22:18:28.954044Z","caller":"traceutil/trace.go:171","msg":"trace[720102670] range","detail":"{range_begin:/registry/jobs/openstack/octavia-ks-user; range_end:; response_count:1; response_revision:22464; }","duration":"1.930009298s","start":"2026-08-05T22:18:27.024012Z","end":"2026-08-05T22:18:28.954021Z","steps":["trace[720102670] 'agreement among raft nodes before linearized reading' (duration: 1.927037661s)"],"step_count":1} {"level":"warn","ts":"2026-08-05T22:18:28.954086Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T22:18:27.024005Z","time spent":"1.930068459s","remote":"127.0.0.1:43190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":1,"response size":7398,"request content":"key:\"/registry/jobs/openstack/octavia-ks-user\" "} {"level":"warn","ts":"2026-08-05T22:18:28.951542Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.861996035s","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-05T22:18:28.954189Z","caller":"traceutil/trace.go:171","msg":"trace[1152527220] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:22464; }","duration":"1.864623005s","start":"2026-08-05T22:18:27.089503Z","end":"2026-08-05T22:18:28.954126Z","steps":["trace[1152527220] 'agreement among raft nodes before linearized reading' (duration: 1.861858132s)"],"step_count":1} {"level":"warn","ts":"2026-08-05T22:18:28.954228Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T22:18:27.089477Z","time spent":"1.864738817s","remote":"127.0.0.1:43212","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-08-05T22:18:28.951765Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.111643296s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/octavia-ks-user\" ","response":"range_response_count:1 size:7374"} {"level":"info","ts":"2026-08-05T22:18:28.954348Z","caller":"traceutil/trace.go:171","msg":"trace[1160850711] range","detail":"{range_begin:/registry/jobs/openstack/octavia-ks-user; range_end:; response_count:1; response_revision:22464; }","duration":"1.114267667s","start":"2026-08-05T22:18:27.840072Z","end":"2026-08-05T22:18:28.95434Z","steps":["trace[1160850711] 'agreement among raft nodes before linearized reading' (duration: 1.110898293s)"],"step_count":1} {"level":"warn","ts":"2026-08-05T22:18:28.954366Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T22:18:27.840057Z","time spent":"1.114302597s","remote":"127.0.0.1:43190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":1,"response size":7398,"request content":"key:\"/registry/jobs/openstack/octavia-ks-user\" "} {"level":"info","ts":"2026-08-05T22:18:28.954546Z","caller":"traceutil/trace.go:171","msg":"trace[1959536043] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/valkey-data-valkey-node-0; range_end:; response_count:1; response_revision:22464; }","duration":"1.793432642s","start":"2026-08-05T22:18:27.16109Z","end":"2026-08-05T22:18:28.954523Z","steps":["trace[1959536043] 'agreement among raft nodes before linearized reading' (duration: 1.790252441s)"],"step_count":1} {"level":"warn","ts":"2026-08-05T22:18:28.95464Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T22:18:27.161073Z","time spent":"1.793554064s","remote":"127.0.0.1:43128","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":1658,"request content":"key:\"/registry/persistentvolumeclaims/openstack/valkey-data-valkey-node-0\" "} {"level":"info","ts":"2026-08-05T22:22:08.081008Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":21940} {"level":"info","ts":"2026-08-05T22:22:08.192242Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":21940,"took":"106.49813ms","hash":3481944885,"current-db-size-bytes":58777600,"current-db-size":"59 MB","current-db-size-in-use-bytes":44318720,"current-db-size-in-use":"44 MB"} {"level":"info","ts":"2026-08-05T22:22:08.192332Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3481944885,"revision":21940,"compact-revision":19726} {"level":"info","ts":"2026-08-05T22:26:02.838581Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-0000000000006c27.wal"} {"level":"info","ts":"2026-08-05T22:27:08.087364Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":25028} {"level":"info","ts":"2026-08-05T22:27:08.2274Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":25028,"took":"135.346903ms","hash":846836321,"current-db-size-bytes":58777600,"current-db-size":"59 MB","current-db-size-in-use-bytes":30732288,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-08-05T22:27:08.227471Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":846836321,"revision":25028,"compact-revision":21940}