{"level":"warn","ts":"2026-08-19T23:11:33.389712Z","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-19T23:11:33.389899Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.129:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.129:2380","--initial-cluster=instance=https://199.204.45.129:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.129:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.129: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-19T23:11:33.389989Z","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-19T23:11:33.390004Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.129:2380"]} {"level":"info","ts":"2026-08-19T23:11:33.390022Z","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-19T23:11:33.390661Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.129:2379"]} {"level":"info","ts":"2026-08-19T23:11:33.390734Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.129:2380"],"listen-peer-urls":["https://199.204.45.129:2380"],"advertise-client-urls":["https://199.204.45.129:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.129:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.129: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-19T23:11:33.399364Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"7.90508ms"} {"level":"info","ts":"2026-08-19T23:11:33.411126Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"3cec112083e8d3ff","cluster-id":"3f68255a3b440659"} {"level":"info","ts":"2026-08-19T23:11:33.411215Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff switched to configuration voters=()"} {"level":"info","ts":"2026-08-19T23:11:33.411255Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff became follower at term 0"} {"level":"info","ts":"2026-08-19T23:11:33.411274Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 3cec112083e8d3ff [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-19T23:11:33.411285Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff became follower at term 1"} {"level":"info","ts":"2026-08-19T23:11:33.411354Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff switched to configuration voters=(4389902568129090559)"} {"level":"warn","ts":"2026-08-19T23:11:33.417605Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-19T23:11:33.419274Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-19T23:11:33.421189Z","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-19T23:11:33.423444Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"3cec112083e8d3ff","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-19T23:11:33.42356Z","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-19T23:11:33.42411Z","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-19T23:11:33.424162Z","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-19T23:11:33.42383Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"3cec112083e8d3ff","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-19T23:11:33.425535Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff switched to configuration voters=(4389902568129090559)"} {"level":"info","ts":"2026-08-19T23:11:33.425795Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"3f68255a3b440659","local-member-id":"3cec112083e8d3ff","added-peer-id":"3cec112083e8d3ff","added-peer-peer-urls":["https://199.204.45.129:2380"]} {"level":"info","ts":"2026-08-19T23:11:33.435021Z","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-19T23:11:33.43526Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.129:2380"} {"level":"info","ts":"2026-08-19T23:11:33.435288Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"3cec112083e8d3ff","initial-advertise-peer-urls":["https://199.204.45.129:2380"],"listen-peer-urls":["https://199.204.45.129:2380"],"advertise-client-urls":["https://199.204.45.129:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.129:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-19T23:11:33.435337Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-19T23:11:33.435327Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.129:2380"} {"level":"info","ts":"2026-08-19T23:11:33.512389Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff is starting a new election at term 1"} {"level":"info","ts":"2026-08-19T23:11:33.51245Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff became pre-candidate at term 1"} {"level":"info","ts":"2026-08-19T23:11:33.512481Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff received MsgPreVoteResp from 3cec112083e8d3ff at term 1"} {"level":"info","ts":"2026-08-19T23:11:33.512505Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff became candidate at term 2"} {"level":"info","ts":"2026-08-19T23:11:33.512521Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff received MsgVoteResp from 3cec112083e8d3ff at term 2"} {"level":"info","ts":"2026-08-19T23:11:33.512541Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff became leader at term 2"} {"level":"info","ts":"2026-08-19T23:11:33.512562Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 3cec112083e8d3ff elected leader 3cec112083e8d3ff at term 2"} {"level":"info","ts":"2026-08-19T23:11:33.513295Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-19T23:11:33.514154Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"3cec112083e8d3ff","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.129:2379]}","request-path":"/0/members/3cec112083e8d3ff/attributes","cluster-id":"3f68255a3b440659","publish-timeout":"7s"} {"level":"info","ts":"2026-08-19T23:11:33.514321Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-19T23:11:33.514432Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-19T23:11:33.514801Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"3f68255a3b440659","local-member-id":"3cec112083e8d3ff","cluster-version":"3.5"} {"level":"info","ts":"2026-08-19T23:11:33.514905Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-19T23:11:33.514937Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-08-19T23:11:33.514984Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-19T23:11:33.515003Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-19T23:11:33.51803Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-08-19T23:11:33.518082Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.129:2379"} {"level":"info","ts":"2026-08-19T23:11:37.653805Z","caller":"traceutil/trace.go:171","msg":"trace[1525187788] linearizableReadLoop","detail":"{readStateIndex:206; appliedIndex:205; }","duration":"288.043678ms","start":"2026-08-19T23:11:37.36573Z","end":"2026-08-19T23:11:37.653774Z","steps":["trace[1525187788] 'read index received' (duration: 287.6398ms)","trace[1525187788] 'applied index is now lower than readState.Index' (duration: 402.668µs)"],"step_count":2} {"level":"warn","ts":"2026-08-19T23:11:37.654156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.973649ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-08-19T23:11:37.654286Z","caller":"traceutil/trace.go:171","msg":"trace[601284932] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:202; }","duration":"287.127507ms","start":"2026-08-19T23:11:37.367131Z","end":"2026-08-19T23:11:37.654259Z","steps":["trace[601284932] 'agreement among raft nodes before linearized reading' (duration: 286.855324ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T23:11:37.653952Z","caller":"traceutil/trace.go:171","msg":"trace[941290641] transaction","detail":"{read_only:false; response_revision:202; number_of_response:1; }","duration":"354.311329ms","start":"2026-08-19T23:11:37.299582Z","end":"2026-08-19T23:11:37.653893Z","steps":["trace[941290641] 'process raft request' (duration: 353.952042ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T23:11:37.654234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.482349ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-08-19T23:11:37.65486Z","caller":"traceutil/trace.go:171","msg":"trace[1011608612] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:202; }","duration":"288.879977ms","start":"2026-08-19T23:11:37.36568Z","end":"2026-08-19T23:11:37.65456Z","steps":["trace[1011608612] 'agreement among raft nodes before linearized reading' (duration: 288.226576ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T23:11:37.655246Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T23:11:37.299556Z","time spent":"354.845973ms","remote":"127.0.0.1:59404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1069,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-19T23:11:38.029791Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.353867ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-19T23:11:38.030043Z","caller":"traceutil/trace.go:171","msg":"trace[697194994] transaction","detail":"{read_only:false; response_revision:205; number_of_response:1; }","duration":"368.775031ms","start":"2026-08-19T23:11:37.66125Z","end":"2026-08-19T23:11:38.030025Z","steps":["trace[697194994] 'process raft request' (duration: 368.722738ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T23:11:38.030141Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T23:11:37.661216Z","time spent":"368.876745ms","remote":"127.0.0.1:59558","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-19T23:11:38.030484Z","caller":"traceutil/trace.go:171","msg":"trace[973889553] transaction","detail":"{read_only:false; response_revision:204; number_of_response:1; }","duration":"370.792523ms","start":"2026-08-19T23:11:37.659637Z","end":"2026-08-19T23:11:38.03043Z","steps":["trace[973889553] 'process raft request' (duration: 370.266699ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T23:11:38.030533Z","caller":"traceutil/trace.go:171","msg":"trace[1037548359] transaction","detail":"{read_only:false; response_revision:203; number_of_response:1; }","duration":"372.216499ms","start":"2026-08-19T23:11:37.658292Z","end":"2026-08-19T23:11:38.030509Z","steps":["trace[1037548359] 'process raft request' (duration: 200.74656ms)","trace[1037548359] 'compare' (duration: 170.217272ms)"],"step_count":2} {"level":"warn","ts":"2026-08-19T23:11:38.030637Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T23:11:37.658263Z","time spent":"372.326973ms","remote":"127.0.0.1:59558","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-19T23:11:38.030652Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T23:11:37.659621Z","time spent":"370.956371ms","remote":"127.0.0.1:59618","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":342,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-19T23:12:28.172375Z","caller":"traceutil/trace.go:171","msg":"trace[486269965] transaction","detail":"{read_only:false; response_revision:608; number_of_response:1; }","duration":"131.838498ms","start":"2026-08-19T23:12:28.040513Z","end":"2026-08-19T23:12:28.172351Z","steps":["trace[486269965] 'process raft request' (duration: 131.712785ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T23:12:30.147502Z","caller":"traceutil/trace.go:171","msg":"trace[985022139] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"103.687834ms","start":"2026-08-19T23:12:30.043784Z","end":"2026-08-19T23:12:30.147472Z","steps":["trace[985022139] 'process raft request' (duration: 102.680426ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T23:12:35.005876Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.628194ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-gnlhv\" ","response":"range_response_count:1 size:16965"} {"level":"warn","ts":"2026-08-19T23:12:35.005877Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.05698ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-19T23:12:35.005975Z","caller":"traceutil/trace.go:171","msg":"trace[364587535] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:641; }","duration":"130.169113ms","start":"2026-08-19T23:12:34.87579Z","end":"2026-08-19T23:12:35.005959Z","steps":["trace[364587535] 'range keys from in-memory index tree' (duration: 130.041688ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T23:12:35.005976Z","caller":"traceutil/trace.go:171","msg":"trace[1816651120] range","detail":"{range_begin:/registry/pods/kube-system/cilium-gnlhv; range_end:; response_count:1; response_revision:641; }","duration":"277.776397ms","start":"2026-08-19T23:12:34.728177Z","end":"2026-08-19T23:12:35.005953Z","steps":["trace[1816651120] 'range keys from in-memory index tree' (duration: 277.438989ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T23:12:35.133763Z","caller":"traceutil/trace.go:171","msg":"trace[808070806] linearizableReadLoop","detail":"{readStateIndex:668; appliedIndex:667; }","duration":"102.238777ms","start":"2026-08-19T23:12:35.031491Z","end":"2026-08-19T23:12:35.13373Z","steps":["trace[808070806] 'read index received' (duration: 102.061082ms)","trace[808070806] 'applied index is now lower than readState.Index' (duration: 176.365µs)"],"step_count":2} {"level":"info","ts":"2026-08-19T23:12:35.133822Z","caller":"traceutil/trace.go:171","msg":"trace[117474441] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"112.563544ms","start":"2026-08-19T23:12:35.021214Z","end":"2026-08-19T23:12:35.133778Z","steps":["trace[117474441] 'process raft request' (duration: 112.348048ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T23:12:35.133909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.405021ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-19T23:12:35.133944Z","caller":"traceutil/trace.go:171","msg":"trace[1539700136] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:642; }","duration":"102.487163ms","start":"2026-08-19T23:12:35.031448Z","end":"2026-08-19T23:12:35.133935Z","steps":["trace[1539700136] 'agreement among raft nodes before linearized reading' (duration: 102.3774ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T23:13:02.163686Z","caller":"traceutil/trace.go:171","msg":"trace[306406540] transaction","detail":"{read_only:false; response_revision:952; number_of_response:1; }","duration":"223.561579ms","start":"2026-08-19T23:13:01.940077Z","end":"2026-08-19T23:13:02.163639Z","steps":["trace[306406540] 'process raft request' (duration: 223.393006ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T23:13:02.165482Z","caller":"traceutil/trace.go:171","msg":"trace[416413361] transaction","detail":"{read_only:false; response_revision:953; number_of_response:1; }","duration":"160.664971ms","start":"2026-08-19T23:13:02.004798Z","end":"2026-08-19T23:13:02.165463Z","steps":["trace[416413361] 'process raft request' (duration: 160.087658ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T23:13:04.399418Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.067444627s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-78446f96c9-jrhwc\" ","response":"range_response_count:1 size:5677"} {"level":"info","ts":"2026-08-19T23:13:04.399492Z","caller":"traceutil/trace.go:171","msg":"trace[2116758078] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-78446f96c9-jrhwc; range_end:; response_count:1; response_revision:959; }","duration":"1.06754968s","start":"2026-08-19T23:13:03.331926Z","end":"2026-08-19T23:13:04.399476Z","steps":["trace[2116758078] 'range keys from in-memory index tree' (duration: 1.067291033s)"],"step_count":1} {"level":"warn","ts":"2026-08-19T23:13:04.39952Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T23:13:03.331916Z","time spent":"1.067599081s","remote":"127.0.0.1:59476","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":1,"response size":5699,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-78446f96c9-jrhwc\" "} {"level":"warn","ts":"2026-08-19T23:13:05.561719Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15276104504447216421,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-19T23:13:05.598291Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.194324683s","expected-duration":"1s"} {"level":"info","ts":"2026-08-19T23:13:05.598766Z","caller":"traceutil/trace.go:171","msg":"trace[2022955189] transaction","detail":"{read_only:false; response_revision:960; number_of_response:1; }","duration":"1.194881766s","start":"2026-08-19T23:13:04.403849Z","end":"2026-08-19T23:13:05.598731Z","steps":["trace[2022955189] 'process raft request' (duration: 1.194732202s)"],"step_count":1} {"level":"warn","ts":"2026-08-19T23:13:05.598964Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T23:13:04.403826Z","time spent":"1.195037058s","remote":"127.0.0.1:59558","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-19T23:13:05.603059Z","caller":"traceutil/trace.go:171","msg":"trace[1752864545] transaction","detail":"{read_only:false; response_revision:961; number_of_response:1; }","duration":"1.198341081s","start":"2026-08-19T23:13:04.404696Z","end":"2026-08-19T23:13:05.603037Z","steps":["trace[1752864545] 'process raft request' (duration: 1.198086606s)"],"step_count":1} {"level":"warn","ts":"2026-08-19T23:13:05.603158Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T23:13:04.404665Z","time spent":"1.198444964s","remote":"127.0.0.1:59558","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-19T23:13:05.603089Z","caller":"traceutil/trace.go:171","msg":"trace[1690495762] linearizableReadLoop","detail":"{readStateIndex:997; appliedIndex:993; }","duration":"1.197088254s","start":"2026-08-19T23:13:04.405974Z","end":"2026-08-19T23:13:05.603063Z","steps":["trace[1690495762] 'read index received' (duration: 1.192650776s)","trace[1690495762] 'applied index is now lower than readState.Index' (duration: 4.435618ms)"],"step_count":2} {"level":"info","ts":"2026-08-19T23:13:05.603299Z","caller":"traceutil/trace.go:171","msg":"trace[993099651] transaction","detail":"{read_only:false; response_revision:962; number_of_response:1; }","duration":"1.197966053s","start":"2026-08-19T23:13:04.405302Z","end":"2026-08-19T23:13:05.603268Z","steps":["trace[993099651] 'process raft request' (duration: 1.197634875s)"],"step_count":1} {"level":"warn","ts":"2026-08-19T23:13:05.603483Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T23:13:04.405295Z","time spent":"1.198088476s","remote":"127.0.0.1:59558","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-19T23:13:05.603542Z","caller":"traceutil/trace.go:171","msg":"trace[1663676781] transaction","detail":"{read_only:false; response_revision:963; number_of_response:1; }","duration":"1.194979186s","start":"2026-08-19T23:13:04.40855Z","end":"2026-08-19T23:13:05.603529Z","steps":["trace[1663676781] 'process raft request' (duration: 1.194444625s)"],"step_count":1} {"level":"warn","ts":"2026-08-19T23:13:05.60362Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T23:13:04.408538Z","time spent":"1.195045548s","remote":"127.0.0.1:59476","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5472,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-19T23:13:05.603614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.197620945s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-19T23:13:05.603701Z","caller":"traceutil/trace.go:171","msg":"trace[953711340] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:963; }","duration":"1.197757729s","start":"2026-08-19T23:13:04.405918Z","end":"2026-08-19T23:13:05.603675Z","steps":["trace[953711340] 'agreement among raft nodes before linearized reading' (duration: 1.197617255s)"],"step_count":1} {"level":"warn","ts":"2026-08-19T23:13:05.603764Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T23:13:04.405894Z","time spent":"1.19785712s","remote":"127.0.0.1:59300","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-19T23:13:05.604479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.070360165s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-08-19T23:13:05.604537Z","caller":"traceutil/trace.go:171","msg":"trace[550422668] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:963; }","duration":"1.070495959s","start":"2026-08-19T23:13:04.534027Z","end":"2026-08-19T23:13:05.604523Z","steps":["trace[550422668] 'agreement among raft nodes before linearized reading' (duration: 1.070165012s)"],"step_count":1} {"level":"warn","ts":"2026-08-19T23:13:05.605023Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T23:13:04.534003Z","time spent":"1.07100043s","remote":"127.0.0.1:59558","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-08-19T23:13:21.944094Z","caller":"traceutil/trace.go:171","msg":"trace[526856992] linearizableReadLoop","detail":"{readStateIndex:1240; appliedIndex:1239; }","duration":"257.552034ms","start":"2026-08-19T23:13:21.686519Z","end":"2026-08-19T23:13:21.944071Z","steps":["trace[526856992] 'read index received' (duration: 257.398541ms)","trace[526856992] 'applied index is now lower than readState.Index' (duration: 151.723µs)"],"step_count":2} {"level":"info","ts":"2026-08-19T23:13:21.944274Z","caller":"traceutil/trace.go:171","msg":"trace[694480548] transaction","detail":"{read_only:false; response_revision:1202; number_of_response:1; }","duration":"264.432303ms","start":"2026-08-19T23:13:21.679832Z","end":"2026-08-19T23:13:21.944264Z","steps":["trace[694480548] 'process raft request' (duration: 264.092567ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T23:13:21.944537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.996203ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-08-19T23:13:21.944594Z","caller":"traceutil/trace.go:171","msg":"trace[1957379345] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1202; }","duration":"258.094005ms","start":"2026-08-19T23:13:21.686491Z","end":"2026-08-19T23:13:21.944585Z","steps":["trace[1957379345] 'agreement among raft nodes before linearized reading' (duration: 257.923141ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T23:13:21.973847Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.998589ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-08-19T23:13:21.973858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.05806ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-08-19T23:13:21.973914Z","caller":"traceutil/trace.go:171","msg":"trace[1625033304] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1203; }","duration":"281.087091ms","start":"2026-08-19T23:13:21.692818Z","end":"2026-08-19T23:13:21.973905Z","steps":["trace[1625033304] 'agreement among raft nodes before linearized reading' (duration: 280.953618ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T23:13:21.974193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.341756ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-08-19T23:13:21.974271Z","caller":"traceutil/trace.go:171","msg":"trace[1620892119] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1203; }","duration":"281.443858ms","start":"2026-08-19T23:13:21.692807Z","end":"2026-08-19T23:13:21.974251Z","steps":["trace[1620892119] 'agreement among raft nodes before linearized reading' (duration: 281.191402ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T23:13:21.973949Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.196441ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-08-19T23:13:21.973988Z","caller":"traceutil/trace.go:171","msg":"trace[1455555881] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1203; }","duration":"282.214733ms","start":"2026-08-19T23:13:21.691709Z","end":"2026-08-19T23:13:21.973924Z","steps":["trace[1455555881] 'agreement among raft nodes before linearized reading' (duration: 281.981768ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T23:13:21.974042Z","caller":"traceutil/trace.go:171","msg":"trace[498971951] transaction","detail":"{read_only:false; response_revision:1203; number_of_response:1; }","duration":"172.448281ms","start":"2026-08-19T23:13:21.801573Z","end":"2026-08-19T23:13:21.974022Z","steps":["trace[498971951] 'process raft request' (duration: 171.974391ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T23:13:21.976322Z","caller":"traceutil/trace.go:171","msg":"trace[2104820875] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1203; }","duration":"274.964496ms","start":"2026-08-19T23:13:21.700687Z","end":"2026-08-19T23:13:21.975652Z","steps":["trace[2104820875] 'agreement among raft nodes before linearized reading' (duration: 273.070518ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T23:14:10.53543Z","caller":"traceutil/trace.go:171","msg":"trace[696098975] linearizableReadLoop","detail":"{readStateIndex:1951; appliedIndex:1950; }","duration":"348.645991ms","start":"2026-08-19T23:14:10.186753Z","end":"2026-08-19T23:14:10.535399Z","steps":["trace[696098975] 'read index received' (duration: 348.256845ms)","trace[696098975] 'applied index is now lower than readState.Index' (duration: 387.416µs)"],"step_count":2} {"level":"info","ts":"2026-08-19T23:14:10.535582Z","caller":"traceutil/trace.go:171","msg":"trace[212306322] transaction","detail":"{read_only:false; response_revision:1875; number_of_response:1; }","duration":"376.244338ms","start":"2026-08-19T23:14:10.15932Z","end":"2026-08-19T23:14:10.535564Z","steps":["trace[212306322] 'process raft request' (duration: 375.73221ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T23:14:10.535745Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T23:14:10.159295Z","time spent":"376.329899ms","remote":"127.0.0.1:59558","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-19T23:14:10.535806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"349.031239ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-e1e00872-66ff-4515-b4b9-61636ef8306a\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-08-19T23:14:10.535893Z","caller":"traceutil/trace.go:171","msg":"trace[1836493154] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-e1e00872-66ff-4515-b4b9-61636ef8306a; range_end:; response_count:1; response_revision:1875; }","duration":"349.18361ms","start":"2026-08-19T23:14:10.186686Z","end":"2026-08-19T23:14:10.53587Z","steps":["trace[1836493154] 'agreement among raft nodes before linearized reading' (duration: 348.952396ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T23:14:10.535951Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T23:14:10.186659Z","time spent":"349.277212ms","remote":"127.0.0.1:59476","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3649,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-e1e00872-66ff-4515-b4b9-61636ef8306a\" "} {"level":"warn","ts":"2026-08-19T23:14:10.567836Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"343.936872ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-19T23:14:10.567865Z","caller":"traceutil/trace.go:171","msg":"trace[499394184] transaction","detail":"{read_only:false; response_revision:1876; number_of_response:1; }","duration":"200.461257ms","start":"2026-08-19T23:14:10.367362Z","end":"2026-08-19T23:14:10.567824Z","steps":["trace[499394184] 'process raft request' (duration: 200.130222ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T23:14:10.567951Z","caller":"traceutil/trace.go:171","msg":"trace[1716880311] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1876; }","duration":"344.149666ms","start":"2026-08-19T23:14:10.223776Z","end":"2026-08-19T23:14:10.567925Z","steps":["trace[1716880311] 'agreement among raft nodes before linearized reading' (duration: 343.891992ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T23:14:10.567996Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.889821ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-08-19T23:14:10.568047Z","caller":"traceutil/trace.go:171","msg":"trace[1994509109] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1876; }","duration":"153.977982ms","start":"2026-08-19T23:14:10.414047Z","end":"2026-08-19T23:14:10.568025Z","steps":["trace[1994509109] 'agreement among raft nodes before linearized reading' (duration: 153.86021ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T23:14:10.568003Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T23:14:10.223764Z","time spent":"344.230497ms","remote":"127.0.0.1:59310","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-19T23:14:10.567861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"320.614378ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-08-19T23:14:10.568364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"321.562174ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-08-19T23:14:10.568383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"321.591515ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"warn","ts":"2026-08-19T23:14:10.568444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.26651ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-08-19T23:14:10.56845Z","caller":"traceutil/trace.go:171","msg":"trace[987346552] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1876; }","duration":"321.717046ms","start":"2026-08-19T23:14:10.246711Z","end":"2026-08-19T23:14:10.568428Z","steps":["trace[987346552] 'agreement among raft nodes before linearized reading' (duration: 321.396241ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T23:14:10.568464Z","caller":"traceutil/trace.go:171","msg":"trace[1552452269] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1876; }","duration":"321.753108ms","start":"2026-08-19T23:14:10.24669Z","end":"2026-08-19T23:14:10.568443Z","steps":["trace[1552452269] 'agreement among raft nodes before linearized reading' (duration: 321.377801ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T23:14:10.56849Z","caller":"traceutil/trace.go:171","msg":"trace[2020398039] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1876; }","duration":"327.358181ms","start":"2026-08-19T23:14:10.24112Z","end":"2026-08-19T23:14:10.568478Z","steps":["trace[2020398039] 'agreement among raft nodes before linearized reading' (duration: 327.240569ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T23:14:10.568515Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T23:14:10.24668Z","time spent":"321.824329ms","remote":"127.0.0.1:59558","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-08-19T23:14:10.568394Z","caller":"traceutil/trace.go:171","msg":"trace[1128508989] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1876; }","duration":"321.189808ms","start":"2026-08-19T23:14:10.247191Z","end":"2026-08-19T23:14:10.568381Z","steps":["trace[1128508989] 'agreement among raft nodes before linearized reading' (duration: 320.529386ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T23:14:10.568526Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T23:14:10.246659Z","time spent":"321.856789ms","remote":"127.0.0.1:59558","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-08-19T23:14:10.568592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"321.850739ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-08-19T23:14:10.568522Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T23:14:10.241111Z","time spent":"327.402383ms","remote":"127.0.0.1:59558","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-08-19T23:14:10.568596Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T23:14:10.247161Z","time spent":"321.404902ms","remote":"127.0.0.1:59558","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-08-19T23:14:10.568621Z","caller":"traceutil/trace.go:171","msg":"trace[1146390182] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1876; }","duration":"321.91404ms","start":"2026-08-19T23:14:10.2467Z","end":"2026-08-19T23:14:10.568614Z","steps":["trace[1146390182] 'agreement among raft nodes before linearized reading' (duration: 321.840728ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T23:14:10.568649Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T23:14:10.246664Z","time spent":"321.978701ms","remote":"127.0.0.1:59558","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-08-19T23:14:22.814429Z","caller":"traceutil/trace.go:171","msg":"trace[524201498] transaction","detail":"{read_only:false; response_revision:1979; number_of_response:1; }","duration":"221.29887ms","start":"2026-08-19T23:14:22.593049Z","end":"2026-08-19T23:14:22.814348Z","steps":["trace[524201498] 'process raft request' (duration: 221.098667ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T23:14:22.821133Z","caller":"traceutil/trace.go:171","msg":"trace[1316376553] linearizableReadLoop","detail":"{readStateIndex:2059; appliedIndex:2057; }","duration":"165.578546ms","start":"2026-08-19T23:14:22.655522Z","end":"2026-08-19T23:14:22.8211Z","steps":["trace[1316376553] 'read index received' (duration: 158.657162ms)","trace[1316376553] 'applied index is now lower than readState.Index' (duration: 6.919244ms)"],"step_count":2} {"level":"info","ts":"2026-08-19T23:14:22.82125Z","caller":"traceutil/trace.go:171","msg":"trace[100157625] transaction","detail":"{read_only:false; response_revision:1980; number_of_response:1; }","duration":"210.594045ms","start":"2026-08-19T23:14:22.610623Z","end":"2026-08-19T23:14:22.821217Z","steps":["trace[100157625] 'process raft request' (duration: 210.28325ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T23:14:22.821499Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.151768ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-08-19T23:14:22.821548Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.753947ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-08-19T23:14:22.821609Z","caller":"traceutil/trace.go:171","msg":"trace[1519866639] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1980; }","duration":"160.853638ms","start":"2026-08-19T23:14:22.660741Z","end":"2026-08-19T23:14:22.821595Z","steps":["trace[1519866639] 'agreement among raft nodes before linearized reading' (duration: 160.618554ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T23:14:22.821566Z","caller":"traceutil/trace.go:171","msg":"trace[2120437750] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1980; }","duration":"157.270879ms","start":"2026-08-19T23:14:22.664281Z","end":"2026-08-19T23:14:22.821552Z","steps":["trace[2120437750] 'agreement among raft nodes before linearized reading' (duration: 157.006065ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T23:14:22.821848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.954314ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-08-19T23:14:22.821951Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.435231ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-08-19T23:14:22.821979Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.689352ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-08-19T23:14:22.822016Z","caller":"traceutil/trace.go:171","msg":"trace[878969124] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1980; }","duration":"166.538842ms","start":"2026-08-19T23:14:22.655462Z","end":"2026-08-19T23:14:22.822001Z","steps":["trace[878969124] 'agreement among raft nodes before linearized reading' (duration: 166.375709ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T23:14:22.822062Z","caller":"traceutil/trace.go:171","msg":"trace[552418294] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1980; }","duration":"161.978967ms","start":"2026-08-19T23:14:22.660037Z","end":"2026-08-19T23:14:22.822016Z","steps":["trace[552418294] 'agreement among raft nodes before linearized reading' (duration: 161.236915ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T23:14:22.821943Z","caller":"traceutil/trace.go:171","msg":"trace[462817620] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1980; }","duration":"160.095276ms","start":"2026-08-19T23:14:22.661825Z","end":"2026-08-19T23:14:22.82192Z","steps":["trace[462817620] 'agreement among raft nodes before linearized reading' (duration: 159.513757ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T23:14:29.221445Z","caller":"traceutil/trace.go:171","msg":"trace[1268688184] transaction","detail":"{read_only:false; response_revision:2021; number_of_response:1; }","duration":"385.471453ms","start":"2026-08-19T23:14:28.835947Z","end":"2026-08-19T23:14:29.221419Z","steps":["trace[1268688184] 'process raft request' (duration: 385.29025ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T23:14:29.221622Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T23:14:28.835896Z","time spent":"385.629325ms","remote":"127.0.0.1:59558","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-19T23:14:29.252774Z","caller":"traceutil/trace.go:171","msg":"trace[1462446976] linearizableReadLoop","detail":"{readStateIndex:2102; appliedIndex:2101; }","duration":"378.859834ms","start":"2026-08-19T23:14:28.873893Z","end":"2026-08-19T23:14:29.252753Z","steps":["trace[1462446976] 'read index received' (duration: 348.329681ms)","trace[1462446976] 'applied index is now lower than readState.Index' (duration: 30.528653ms)"],"step_count":2} {"level":"info","ts":"2026-08-19T23:14:29.252886Z","caller":"traceutil/trace.go:171","msg":"trace[1763831109] transaction","detail":"{read_only:false; response_revision:2022; number_of_response:1; }","duration":"410.06524ms","start":"2026-08-19T23:14:28.842813Z","end":"2026-08-19T23:14:29.252878Z","steps":["trace[1763831109] 'process raft request' (duration: 409.803496ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T23:14:29.253049Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T23:14:28.842804Z","time spent":"410.108071ms","remote":"127.0.0.1:59558","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-19T23:14:29.253071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"321.359924ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-08-19T23:14:29.253118Z","caller":"traceutil/trace.go:171","msg":"trace[288448837] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2022; }","duration":"321.461005ms","start":"2026-08-19T23:14:28.931644Z","end":"2026-08-19T23:14:29.253105Z","steps":["trace[288448837] 'agreement among raft nodes before linearized reading' (duration: 321.302902ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T23:14:29.253154Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T23:14:28.931615Z","time spent":"321.529307ms","remote":"127.0.0.1:59558","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-08-19T23:14:29.253252Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.141169ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"info","ts":"2026-08-19T23:14:29.253282Z","caller":"traceutil/trace.go:171","msg":"trace[1932362089] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2022; }","duration":"316.188891ms","start":"2026-08-19T23:14:28.937084Z","end":"2026-08-19T23:14:29.253273Z","steps":["trace[1932362089] 'agreement among raft nodes before linearized reading' (duration: 316.075299ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T23:14:29.253288Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.386826ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-08-19T23:14:29.253322Z","caller":"traceutil/trace.go:171","msg":"trace[1986917702] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2022; }","duration":"318.439096ms","start":"2026-08-19T23:14:28.934873Z","end":"2026-08-19T23:14:29.253312Z","steps":["trace[1986917702] 'agreement among raft nodes before linearized reading' (duration: 318.354245ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T23:14:29.253346Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"379.457504ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-08-19T23:14:29.253359Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T23:14:28.934863Z","time spent":"318.489007ms","remote":"127.0.0.1:59558","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-08-19T23:14:29.253415Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.328791ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-08-19T23:14:29.253435Z","caller":"traceutil/trace.go:171","msg":"trace[1805368930] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2022; }","duration":"285.370611ms","start":"2026-08-19T23:14:28.96806Z","end":"2026-08-19T23:14:29.25343Z","steps":["trace[1805368930] 'agreement among raft nodes before linearized reading' (duration: 285.31947ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T23:14:29.253512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.613009ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-08-19T23:14:29.253548Z","caller":"traceutil/trace.go:171","msg":"trace[529001907] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2022; }","duration":"318.67367ms","start":"2026-08-19T23:14:28.934866Z","end":"2026-08-19T23:14:29.253539Z","steps":["trace[529001907] 'agreement among raft nodes before linearized reading' (duration: 318.561078ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T23:14:29.253582Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T23:14:28.934855Z","time spent":"318.720591ms","remote":"127.0.0.1:59558","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-08-19T23:14:29.253298Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T23:14:28.937073Z","time spent":"316.222361ms","remote":"127.0.0.1:59558","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":577,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"warn","ts":"2026-08-19T23:14:29.253705Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"320.200785ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-08-19T23:14:29.253365Z","caller":"traceutil/trace.go:171","msg":"trace[1721934355] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2022; }","duration":"379.523495ms","start":"2026-08-19T23:14:28.873836Z","end":"2026-08-19T23:14:29.253359Z","steps":["trace[1721934355] 'agreement among raft nodes before linearized reading' (duration: 379.472474ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T23:14:29.253727Z","caller":"traceutil/trace.go:171","msg":"trace[1745225662] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2022; }","duration":"320.260596ms","start":"2026-08-19T23:14:28.933461Z","end":"2026-08-19T23:14:29.253722Z","steps":["trace[1745225662] 'agreement among raft nodes before linearized reading' (duration: 320.209235ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T23:14:29.253743Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T23:14:28.93344Z","time spent":"320.300006ms","remote":"127.0.0.1:59558","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-08-19T23:14:29.253755Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T23:14:28.873806Z","time spent":"379.931892ms","remote":"127.0.0.1:59558","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-08-19T23:14:43.891908Z","caller":"traceutil/trace.go:171","msg":"trace[1286066803] transaction","detail":"{read_only:false; response_revision:2110; number_of_response:1; }","duration":"295.355017ms","start":"2026-08-19T23:14:43.596525Z","end":"2026-08-19T23:14:43.89188Z","steps":["trace[1286066803] 'process raft request' (duration: 295.177774ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T23:14:43.892638Z","caller":"traceutil/trace.go:171","msg":"trace[478556786] linearizableReadLoop","detail":"{readStateIndex:2195; appliedIndex:2194; }","duration":"271.289698ms","start":"2026-08-19T23:14:43.621334Z","end":"2026-08-19T23:14:43.892624Z","steps":["trace[478556786] 'read index received' (duration: 270.922942ms)","trace[478556786] 'applied index is now lower than readState.Index' (duration: 365.556µs)"],"step_count":2} {"level":"info","ts":"2026-08-19T23:14:43.892697Z","caller":"traceutil/trace.go:171","msg":"trace[511547020] transaction","detail":"{read_only:false; response_revision:2111; number_of_response:1; }","duration":"284.122289ms","start":"2026-08-19T23:14:43.608555Z","end":"2026-08-19T23:14:43.892678Z","steps":["trace[511547020] 'process raft request' (duration: 283.963337ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T23:14:43.89284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.48018ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12386"} {"level":"info","ts":"2026-08-19T23:14:43.89287Z","caller":"traceutil/trace.go:171","msg":"trace[1844077912] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2112; }","duration":"271.572172ms","start":"2026-08-19T23:14:43.621288Z","end":"2026-08-19T23:14:43.89286Z","steps":["trace[1844077912] 'agreement among raft nodes before linearized reading' (duration: 271.386469ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T23:14:49.450151Z","caller":"traceutil/trace.go:171","msg":"trace[397446255] transaction","detail":"{read_only:false; response_revision:2135; number_of_response:1; }","duration":"143.15272ms","start":"2026-08-19T23:14:49.306963Z","end":"2026-08-19T23:14:49.450115Z","steps":["trace[397446255] 'process raft request' (duration: 142.933996ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T23:14:49.478276Z","caller":"traceutil/trace.go:171","msg":"trace[122518487] linearizableReadLoop","detail":"{readStateIndex:2221; appliedIndex:2219; }","duration":"100.306602ms","start":"2026-08-19T23:14:49.377934Z","end":"2026-08-19T23:14:49.478241Z","steps":["trace[122518487] 'read index received' (duration: 71.96431ms)","trace[122518487] 'applied index is now lower than readState.Index' (duration: 28.340652ms)"],"step_count":2} {"level":"info","ts":"2026-08-19T23:14:49.478432Z","caller":"traceutil/trace.go:171","msg":"trace[62415784] transaction","detail":"{read_only:false; response_revision:2136; number_of_response:1; }","duration":"134.730569ms","start":"2026-08-19T23:14:49.343646Z","end":"2026-08-19T23:14:49.478376Z","steps":["trace[62415784] 'process raft request' (duration: 134.412914ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T23:14:49.478757Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.78943ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-08-19T23:14:49.479228Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.11945ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-08-19T23:14:49.479292Z","caller":"traceutil/trace.go:171","msg":"trace[1669431999] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2136; }","duration":"100.217751ms","start":"2026-08-19T23:14:49.379056Z","end":"2026-08-19T23:14:49.479273Z","steps":["trace[1669431999] 'agreement among raft nodes before linearized reading' (duration: 99.439729ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T23:14:49.47882Z","caller":"traceutil/trace.go:171","msg":"trace[2052744540] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2136; }","duration":"100.935303ms","start":"2026-08-19T23:14:49.377865Z","end":"2026-08-19T23:14:49.478801Z","steps":["trace[2052744540] 'agreement among raft nodes before linearized reading' (duration: 100.580467ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T23:14:50.306781Z","caller":"traceutil/trace.go:171","msg":"trace[566871800] transaction","detail":"{read_only:false; response_revision:2143; number_of_response:1; }","duration":"427.053326ms","start":"2026-08-19T23:14:49.879694Z","end":"2026-08-19T23:14:50.306748Z","steps":["trace[566871800] 'process raft request' (duration: 426.829442ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T23:14:50.306989Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T23:14:49.879671Z","time spent":"427.204328ms","remote":"127.0.0.1:59558","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-19T23:14:50.352956Z","caller":"traceutil/trace.go:171","msg":"trace[1761317260] linearizableReadLoop","detail":"{readStateIndex:2229; appliedIndex:2227; }","duration":"353.247685ms","start":"2026-08-19T23:14:49.999679Z","end":"2026-08-19T23:14:50.352926Z","steps":["trace[1761317260] 'read index received' (duration: 307.027746ms)","trace[1761317260] 'applied index is now lower than readState.Index' (duration: 46.218689ms)"],"step_count":2} {"level":"warn","ts":"2026-08-19T23:14:50.353181Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"353.478808ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-19T23:14:50.353239Z","caller":"traceutil/trace.go:171","msg":"trace[1615397258] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:2144; }","duration":"353.57051ms","start":"2026-08-19T23:14:49.999652Z","end":"2026-08-19T23:14:50.353223Z","steps":["trace[1615397258] 'agreement among raft nodes before linearized reading' (duration: 353.441388ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T23:14:50.353292Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T23:14:49.999607Z","time spent":"353.670452ms","remote":"127.0.0.1:60624","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":27,"request content":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true "} {"level":"warn","ts":"2026-08-19T23:14:50.353325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.561734ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificaterequests/\" range_end:\"/registry/cert-manager.io/certificaterequests0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-19T23:14:50.353446Z","caller":"traceutil/trace.go:171","msg":"trace[1590040907] range","detail":"{range_begin:/registry/cert-manager.io/certificaterequests/; range_end:/registry/cert-manager.io/certificaterequests0; response_count:0; response_revision:2144; }","duration":"199.732757ms","start":"2026-08-19T23:14:50.153683Z","end":"2026-08-19T23:14:50.353416Z","steps":["trace[1590040907] 'agreement among raft nodes before linearized reading' (duration: 199.487483ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T23:14:50.353408Z","caller":"traceutil/trace.go:171","msg":"trace[1036849651] transaction","detail":"{read_only:false; response_revision:2144; number_of_response:1; }","duration":"436.491672ms","start":"2026-08-19T23:14:49.916853Z","end":"2026-08-19T23:14:50.353345Z","steps":["trace[1036849651] 'process raft request' (duration: 432.53832ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T23:14:50.353678Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T23:14:49.916829Z","time spent":"436.704766ms","remote":"127.0.0.1:59558","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-19T23:14:50.353946Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.475085ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-19T23:14:50.354029Z","caller":"traceutil/trace.go:171","msg":"trace[420989462] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2144; }","duration":"131.629887ms","start":"2026-08-19T23:14:50.222381Z","end":"2026-08-19T23:14:50.354011Z","steps":["trace[420989462] 'agreement among raft nodes before linearized reading' (duration: 131.026518ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T23:16:48.109092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.005356ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-19T23:16:48.109233Z","caller":"traceutil/trace.go:171","msg":"trace[836357811] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:2878; }","duration":"133.219775ms","start":"2026-08-19T23:16:47.975988Z","end":"2026-08-19T23:16:48.109208Z","steps":["trace[836357811] 'count revisions from in-memory index tree' (duration: 132.919653ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T23:16:48.5137Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.847146ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-19T23:16:48.514062Z","caller":"traceutil/trace.go:171","msg":"trace[829060468] transaction","detail":"{read_only:false; response_revision:2884; number_of_response:1; }","duration":"236.919069ms","start":"2026-08-19T23:16:48.277113Z","end":"2026-08-19T23:16:48.514032Z","steps":["trace[829060468] 'process raft request' (duration: 236.868677ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T23:16:48.514067Z","caller":"traceutil/trace.go:171","msg":"trace[607398591] transaction","detail":"{read_only:false; response_revision:2880; number_of_response:1; }","duration":"237.793874ms","start":"2026-08-19T23:16:48.276227Z","end":"2026-08-19T23:16:48.514021Z","steps":["trace[607398591] 'process raft request' (duration: 84.506291ms)","trace[607398591] 'compare' (duration: 152.70897ms)"],"step_count":2} {"level":"info","ts":"2026-08-19T23:16:48.514373Z","caller":"traceutil/trace.go:171","msg":"trace[2108223028] transaction","detail":"{read_only:false; response_revision:2881; number_of_response:1; }","duration":"237.841476ms","start":"2026-08-19T23:16:48.276518Z","end":"2026-08-19T23:16:48.51436Z","steps":["trace[2108223028] 'process raft request' (duration: 237.321846ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T23:16:48.514753Z","caller":"traceutil/trace.go:171","msg":"trace[1587754921] transaction","detail":"{read_only:false; response_revision:2882; number_of_response:1; }","duration":"238.085646ms","start":"2026-08-19T23:16:48.276623Z","end":"2026-08-19T23:16:48.514708Z","steps":["trace[1587754921] 'process raft request' (duration: 237.268634ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T23:16:48.514804Z","caller":"traceutil/trace.go:171","msg":"trace[1352568916] transaction","detail":"{read_only:false; response_revision:2883; number_of_response:1; }","duration":"238.001813ms","start":"2026-08-19T23:16:48.276742Z","end":"2026-08-19T23:16:48.514744Z","steps":["trace[1352568916] 'process raft request' (duration: 237.19387ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T23:19:15.786727Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.395787ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5651"} {"level":"info","ts":"2026-08-19T23:19:15.791386Z","caller":"traceutil/trace.go:171","msg":"trace[570962288] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:3745; }","duration":"224.060247ms","start":"2026-08-19T23:19:15.567287Z","end":"2026-08-19T23:19:15.791347Z","steps":["trace[570962288] 'range keys from bolt db' (duration: 219.328566ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T23:20:54.202896Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.740469ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"warn","ts":"2026-08-19T23:20:54.20299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.323473ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-c33034ff-f5ef-4261-b2c0-dda88ae80127\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-08-19T23:20:54.203092Z","caller":"traceutil/trace.go:171","msg":"trace[1702892839] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-c33034ff-f5ef-4261-b2c0-dda88ae80127; range_end:; response_count:1; response_revision:4929; }","duration":"150.518877ms","start":"2026-08-19T23:20:54.052547Z","end":"2026-08-19T23:20:54.203066Z","steps":["trace[1702892839] 'range keys from in-memory index tree' (duration: 150.078548ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T23:20:54.203108Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.090907ms","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-19T23:20:54.203138Z","caller":"traceutil/trace.go:171","msg":"trace[1020195829] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4929; }","duration":"316.167768ms","start":"2026-08-19T23:20:53.886961Z","end":"2026-08-19T23:20:54.203129Z","steps":["trace[1020195829] 'range keys from in-memory index tree' (duration: 315.972454ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T23:20:54.203199Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T23:20:53.886937Z","time spent":"316.252671ms","remote":"127.0.0.1:59558","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-08-19T23:20:54.20302Z","caller":"traceutil/trace.go:171","msg":"trace[602254486] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4929; }","duration":"305.928634ms","start":"2026-08-19T23:20:53.89707Z","end":"2026-08-19T23:20:54.202998Z","steps":["trace[602254486] 'range keys from in-memory index tree' (duration: 305.510244ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T23:20:54.203341Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T23:20:53.897048Z","time spent":"306.271942ms","remote":"127.0.0.1:59558","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":578,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"warn","ts":"2026-08-19T23:20:54.203484Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.693947ms","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-19T23:20:54.203538Z","caller":"traceutil/trace.go:171","msg":"trace[959800386] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4929; }","duration":"309.774788ms","start":"2026-08-19T23:20:53.893753Z","end":"2026-08-19T23:20:54.203528Z","steps":["trace[959800386] 'range keys from in-memory index tree' (duration: 309.590014ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T23:20:54.203566Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T23:20:53.893735Z","time spent":"309.82537ms","remote":"127.0.0.1:59558","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-08-19T23:20:54.203706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.231707ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-08-19T23:20:54.203768Z","caller":"traceutil/trace.go:171","msg":"trace[1520005392] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4929; }","duration":"309.294808ms","start":"2026-08-19T23:20:53.894456Z","end":"2026-08-19T23:20:54.20375Z","steps":["trace[1520005392] 'range keys from in-memory index tree' (duration: 309.116294ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T23:20:54.203644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.755336ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-c33034ff-f5ef-4261-b2c0-dda88ae80127\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-08-19T23:20:54.203955Z","caller":"traceutil/trace.go:171","msg":"trace[1586312229] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-c33034ff-f5ef-4261-b2c0-dda88ae80127; range_end:; response_count:1; response_revision:4929; }","duration":"200.139164ms","start":"2026-08-19T23:20:54.003795Z","end":"2026-08-19T23:20:54.203934Z","steps":["trace[1586312229] 'range keys from in-memory index tree' (duration: 199.310686ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T23:20:54.203817Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T23:20:53.894421Z","time spent":"309.37915ms","remote":"127.0.0.1:59558","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-08-19T23:20:56.285426Z","caller":"traceutil/trace.go:171","msg":"trace[684901725] transaction","detail":"{read_only:false; response_revision:4951; number_of_response:1; }","duration":"110.010574ms","start":"2026-08-19T23:20:56.17539Z","end":"2026-08-19T23:20:56.285401Z","steps":["trace[684901725] 'process raft request' (duration: 94.25744ms)","trace[684901725] 'compare' (duration: 15.463978ms)"],"step_count":2} {"level":"warn","ts":"2026-08-19T23:21:08.126828Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"405.214271ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-19T23:21:08.126973Z","caller":"traceutil/trace.go:171","msg":"trace[369999142] linearizableReadLoop","detail":"{readStateIndex:5310; appliedIndex:5309; }","duration":"480.60493ms","start":"2026-08-19T23:21:07.646344Z","end":"2026-08-19T23:21:08.126949Z","steps":["trace[369999142] 'read index received' (duration: 75.141663ms)","trace[369999142] 'applied index is now lower than readState.Index' (duration: 405.461697ms)"],"step_count":2} {"level":"info","ts":"2026-08-19T23:21:08.127066Z","caller":"traceutil/trace.go:171","msg":"trace[1965137186] transaction","detail":"{read_only:false; response_revision:5113; number_of_response:1; }","duration":"548.048327ms","start":"2026-08-19T23:21:07.579003Z","end":"2026-08-19T23:21:08.127051Z","steps":["trace[1965137186] 'process raft request' (duration: 142.496088ms)","trace[1965137186] 'compare' (duration: 405.035598ms)"],"step_count":2} {"level":"warn","ts":"2026-08-19T23:21:08.127133Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T23:21:07.578988Z","time spent":"548.114219ms","remote":"127.0.0.1:59476","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":11650,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-19T23:21:08.127652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"481.288855ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-08-19T23:21:08.128056Z","caller":"traceutil/trace.go:171","msg":"trace[283443983] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5113; }","duration":"481.741595ms","start":"2026-08-19T23:21:07.646288Z","end":"2026-08-19T23:21:08.12803Z","steps":["trace[283443983] 'agreement among raft nodes before linearized reading' (duration: 480.767524ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T23:21:08.128138Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T23:21:07.646265Z","time spent":"481.855977ms","remote":"127.0.0.1:59558","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-08-19T23:21:08.13213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"406.655352ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:3243"} {"level":"info","ts":"2026-08-19T23:21:08.132247Z","caller":"traceutil/trace.go:171","msg":"trace[247426352] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:5114; }","duration":"406.795425ms","start":"2026-08-19T23:21:07.72544Z","end":"2026-08-19T23:21:08.132235Z","steps":["trace[247426352] 'agreement among raft nodes before linearized reading' (duration: 406.58728ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T23:21:08.132312Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T23:21:07.725422Z","time spent":"406.880767ms","remote":"127.0.0.1:35852","response type":"/etcdserverpb.KV/Range","request count":0,"request size":69,"response count":1,"response size":3265,"request content":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" "} {"level":"warn","ts":"2026-08-19T23:21:08.132413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.990291ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-19T23:21:08.132503Z","caller":"traceutil/trace.go:171","msg":"trace[1599168122] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:5114; }","duration":"239.122834ms","start":"2026-08-19T23:21:07.893358Z","end":"2026-08-19T23:21:08.132481Z","steps":["trace[1599168122] 'agreement among raft nodes before linearized reading' (duration: 238.94293ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T23:21:08.132699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.898751ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-08-19T23:21:08.132824Z","caller":"traceutil/trace.go:171","msg":"trace[1551023706] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5114; }","duration":"265.058573ms","start":"2026-08-19T23:21:07.867755Z","end":"2026-08-19T23:21:08.132814Z","steps":["trace[1551023706] 'agreement among raft nodes before linearized reading' (duration: 264.708756ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T23:21:08.132909Z","caller":"traceutil/trace.go:171","msg":"trace[433317814] transaction","detail":"{read_only:false; response_revision:5114; number_of_response:1; }","duration":"365.681758ms","start":"2026-08-19T23:21:07.767214Z","end":"2026-08-19T23:21:08.132895Z","steps":["trace[433317814] 'process raft request' (duration: 364.682687ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T23:21:08.135572Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T23:21:07.767162Z","time spent":"368.346986ms","remote":"127.0.0.1:59558","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-19T23:21:08.133225Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.891291ms","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-19T23:21:08.135758Z","caller":"traceutil/trace.go:171","msg":"trace[1921988091] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5114; }","duration":"317.421065ms","start":"2026-08-19T23:21:07.818286Z","end":"2026-08-19T23:21:08.135707Z","steps":["trace[1921988091] 'agreement among raft nodes before linearized reading' (duration: 314.788928ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T23:21:08.13587Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T23:21:07.818267Z","time spent":"317.551948ms","remote":"127.0.0.1:59476","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12238,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"info","ts":"2026-08-19T23:21:08.289208Z","caller":"traceutil/trace.go:171","msg":"trace[1429160356] linearizableReadLoop","detail":"{readStateIndex:5315; appliedIndex:5312; }","duration":"150.115361ms","start":"2026-08-19T23:21:08.139029Z","end":"2026-08-19T23:21:08.289145Z","steps":["trace[1429160356] 'read index received' (duration: 45.791389ms)","trace[1429160356] 'applied index is now lower than readState.Index' (duration: 104.322772ms)"],"step_count":2} {"level":"info","ts":"2026-08-19T23:21:08.289323Z","caller":"traceutil/trace.go:171","msg":"trace[815152984] transaction","detail":"{read_only:false; response_revision:5116; number_of_response:1; }","duration":"152.040192ms","start":"2026-08-19T23:21:08.137212Z","end":"2026-08-19T23:21:08.289253Z","steps":["trace[815152984] 'process raft request' (duration: 94.558611ms)","trace[815152984] 'compare' (duration: 56.689074ms)"],"step_count":2} {"level":"info","ts":"2026-08-19T23:21:08.289436Z","caller":"traceutil/trace.go:171","msg":"trace[1321869158] transaction","detail":"{read_only:false; response_revision:5118; number_of_response:1; }","duration":"150.692063ms","start":"2026-08-19T23:21:08.138702Z","end":"2026-08-19T23:21:08.289394Z","steps":["trace[1321869158] 'process raft request' (duration: 150.205193ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T23:21:08.289829Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.784395ms","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-19T23:21:08.289815Z","caller":"traceutil/trace.go:171","msg":"trace[1501070629] transaction","detail":"{read_only:false; response_revision:5117; number_of_response:1; }","duration":"152.280808ms","start":"2026-08-19T23:21:08.137499Z","end":"2026-08-19T23:21:08.289779Z","steps":["trace[1501070629] 'process raft request' (duration: 151.304786ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T23:21:08.28988Z","caller":"traceutil/trace.go:171","msg":"trace[526038273] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5119; }","duration":"150.861356ms","start":"2026-08-19T23:21:08.139005Z","end":"2026-08-19T23:21:08.289866Z","steps":["trace[526038273] 'agreement among raft nodes before linearized reading' (duration: 150.675182ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T23:21:08.290086Z","caller":"traceutil/trace.go:171","msg":"trace[892313162] transaction","detail":"{read_only:false; response_revision:5119; number_of_response:1; }","duration":"148.783841ms","start":"2026-08-19T23:21:08.141291Z","end":"2026-08-19T23:21:08.290075Z","steps":["trace[892313162] 'process raft request' (duration: 147.748889ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T23:21:08.290173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.574333ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:10392"} {"level":"info","ts":"2026-08-19T23:21:08.290235Z","caller":"traceutil/trace.go:171","msg":"trace[1781813960] range","detail":"{range_begin:/registry/pods/openstack/rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5119; }","duration":"114.696976ms","start":"2026-08-19T23:21:08.17552Z","end":"2026-08-19T23:21:08.290217Z","steps":["trace[1781813960] 'agreement among raft nodes before linearized reading' (duration: 114.360669ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T23:21:08.2904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.276959ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-08-19T23:21:08.290453Z","caller":"traceutil/trace.go:171","msg":"trace[1773593467] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5119; }","duration":"109.369661ms","start":"2026-08-19T23:21:08.181069Z","end":"2026-08-19T23:21:08.290439Z","steps":["trace[1773593467] 'agreement among raft nodes before linearized reading' (duration: 109.245658ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T23:21:08.439703Z","caller":"traceutil/trace.go:171","msg":"trace[535835078] transaction","detail":"{read_only:false; response_revision:5121; number_of_response:1; }","duration":"133.140034ms","start":"2026-08-19T23:21:08.306531Z","end":"2026-08-19T23:21:08.439671Z","steps":["trace[535835078] 'process raft request' (duration: 99.499138ms)","trace[535835078] 'compare' (duration: 33.445871ms)"],"step_count":2} {"level":"info","ts":"2026-08-19T23:21:34.023913Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2802} {"level":"info","ts":"2026-08-19T23:21:34.088064Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2802,"took":"62.964828ms","hash":949699868,"current-db-size-bytes":50655232,"current-db-size":"51 MB","current-db-size-in-use-bytes":27377664,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-08-19T23:21:34.088114Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":949699868,"revision":2802,"compact-revision":-1} {"level":"info","ts":"2026-08-19T23:21:48.488397Z","caller":"traceutil/trace.go:171","msg":"trace[916545232] transaction","detail":"{read_only:false; response_revision:5468; number_of_response:1; }","duration":"114.68992ms","start":"2026-08-19T23:21:48.373668Z","end":"2026-08-19T23:21:48.488358Z","steps":["trace[916545232] 'process raft request' (duration: 114.506696ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T23:26:34.030223Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5295} {"level":"info","ts":"2026-08-19T23:26:34.109219Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5295,"took":"77.512941ms","hash":3951749270,"current-db-size-bytes":50655232,"current-db-size":"51 MB","current-db-size-in-use-bytes":18563072,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-08-19T23:26:34.109287Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3951749270,"revision":5295,"compact-revision":2802}