{"level":"warn","ts":"2026-08-14T09:09:27.95423Z","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-14T09:09:27.954359Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.143:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.143:2380","--initial-cluster=instance=https://199.19.213.143:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.143:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.143: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-14T09:09:27.95447Z","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-14T09:09:27.954493Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.143:2380"]}
{"level":"info","ts":"2026-08-14T09:09:27.954523Z","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-14T09:09:27.95572Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.143:2379"]}
{"level":"info","ts":"2026-08-14T09:09:27.955848Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.143:2380"],"listen-peer-urls":["https://199.19.213.143:2380"],"advertise-client-urls":["https://199.19.213.143:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.143:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.143: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-14T09:09:27.960622Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.413293ms"}
{"level":"info","ts":"2026-08-14T09:09:27.971686Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"e5bed6df0e44a0b1","cluster-id":"4e2f0a715964d622"}
{"level":"info","ts":"2026-08-14T09:09:27.971769Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e5bed6df0e44a0b1 switched to configuration voters=()"}
{"level":"info","ts":"2026-08-14T09:09:27.971795Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e5bed6df0e44a0b1 became follower at term 0"}
{"level":"info","ts":"2026-08-14T09:09:27.971809Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft e5bed6df0e44a0b1 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-08-14T09:09:27.971823Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e5bed6df0e44a0b1 became follower at term 1"}
{"level":"info","ts":"2026-08-14T09:09:27.971863Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e5bed6df0e44a0b1 switched to configuration voters=(16554905533765951665)"}
{"level":"warn","ts":"2026-08-14T09:09:27.977353Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-08-14T09:09:27.97843Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-08-14T09:09:27.979362Z","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-14T09:09:27.982066Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"e5bed6df0e44a0b1","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-08-14T09:09:27.982217Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"e5bed6df0e44a0b1","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-08-14T09:09:27.982476Z","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-14T09:09:27.984696Z","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-14T09:09:27.985394Z","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-14T09:09:27.985746Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e5bed6df0e44a0b1 switched to configuration voters=(16554905533765951665)"}
{"level":"info","ts":"2026-08-14T09:09:27.98597Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"4e2f0a715964d622","local-member-id":"e5bed6df0e44a0b1","added-peer-id":"e5bed6df0e44a0b1","added-peer-peer-urls":["https://199.19.213.143:2380"]}
{"level":"info","ts":"2026-08-14T09:09:27.98804Z","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-14T09:09:27.98815Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.143:2380"}
{"level":"info","ts":"2026-08-14T09:09:27.989323Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.143:2380"}
{"level":"info","ts":"2026-08-14T09:09:27.989462Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"e5bed6df0e44a0b1","initial-advertise-peer-urls":["https://199.19.213.143:2380"],"listen-peer-urls":["https://199.19.213.143:2380"],"advertise-client-urls":["https://199.19.213.143:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.143:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-08-14T09:09:27.989538Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-08-14T09:09:28.372299Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e5bed6df0e44a0b1 is starting a new election at term 1"}
{"level":"info","ts":"2026-08-14T09:09:28.372376Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e5bed6df0e44a0b1 became pre-candidate at term 1"}
{"level":"info","ts":"2026-08-14T09:09:28.372439Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e5bed6df0e44a0b1 received MsgPreVoteResp from e5bed6df0e44a0b1 at term 1"}
{"level":"info","ts":"2026-08-14T09:09:28.37246Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e5bed6df0e44a0b1 became candidate at term 2"}
{"level":"info","ts":"2026-08-14T09:09:28.37247Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e5bed6df0e44a0b1 received MsgVoteResp from e5bed6df0e44a0b1 at term 2"}
{"level":"info","ts":"2026-08-14T09:09:28.372486Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e5bed6df0e44a0b1 became leader at term 2"}
{"level":"info","ts":"2026-08-14T09:09:28.372499Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: e5bed6df0e44a0b1 elected leader e5bed6df0e44a0b1 at term 2"}
{"level":"info","ts":"2026-08-14T09:09:28.373328Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-08-14T09:09:28.375271Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-08-14T09:09:28.375303Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-08-14T09:09:28.376803Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-08-14T09:09:28.377056Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-08-14T09:09:28.376987Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"4e2f0a715964d622","local-member-id":"e5bed6df0e44a0b1","cluster-version":"3.5"}
{"level":"info","ts":"2026-08-14T09:09:28.37735Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-08-14T09:09:28.377454Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-08-14T09:09:28.377789Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"e5bed6df0e44a0b1","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.143:2379]}","request-path":"/0/members/e5bed6df0e44a0b1/attributes","cluster-id":"4e2f0a715964d622","publish-timeout":"7s"}
{"level":"info","ts":"2026-08-14T09:09:28.380811Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.143:2379"}
{"level":"info","ts":"2026-08-14T09:09:28.381426Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-08-14T09:09:31.03617Z","caller":"traceutil/trace.go:171","msg":"trace[2126330516] linearizableReadLoop","detail":"{readStateIndex:77; appliedIndex:76; }","duration":"359.992722ms","start":"2026-08-14T09:09:30.676155Z","end":"2026-08-14T09:09:31.036148Z","steps":["trace[2126330516] 'read index received'  (duration: 359.797419ms)","trace[2126330516] 'applied index is now lower than readState.Index'  (duration: 194.043µs)"],"step_count":2}
{"level":"info","ts":"2026-08-14T09:09:31.036292Z","caller":"traceutil/trace.go:171","msg":"trace[2118609936] transaction","detail":"{read_only:false; response_revision:73; number_of_response:1; }","duration":"360.778741ms","start":"2026-08-14T09:09:30.675477Z","end":"2026-08-14T09:09:31.036255Z","steps":["trace[2118609936] 'process raft request'  (duration: 360.529708ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T09:09:31.036449Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"331.199863ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-08-14T09:09:31.036698Z","caller":"traceutil/trace.go:171","msg":"trace[933285865] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:73; }","duration":"331.434637ms","start":"2026-08-14T09:09:30.705217Z","end":"2026-08-14T09:09:31.036652Z","steps":["trace[933285865] 'agreement among raft nodes before linearized reading'  (duration: 331.204424ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T09:09:31.036471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"360.204224ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:aggregate-to-edit\" ","response":"range_response_count:0 size:4"}
{"level":"warn","ts":"2026-08-14T09:09:31.036877Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:09:30.705205Z","time spent":"331.597299ms","remote":"127.0.0.1:60062","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-08-14T09:09:31.036864Z","caller":"traceutil/trace.go:171","msg":"trace[1345432101] range","detail":"{range_begin:/registry/clusterroles/system:aggregate-to-edit; range_end:; response_count:0; response_revision:73; }","duration":"360.699181ms","start":"2026-08-14T09:09:30.67613Z","end":"2026-08-14T09:09:31.03683Z","steps":["trace[1345432101] 'agreement among raft nodes before linearized reading'  (duration: 360.141393ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T09:09:31.037132Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:09:30.67612Z","time spent":"360.989604ms","remote":"127.0.0.1:60438","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":0,"response size":27,"request content":"key:\"/registry/clusterroles/system:aggregate-to-edit\" "}
{"level":"warn","ts":"2026-08-14T09:09:31.037244Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:09:30.675462Z","time spent":"361.157655ms","remote":"127.0.0.1:60454","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/priorityclasses/system-cluster-critical\" mod_revision:0 > success:<request_put:<key:\"/registry/priorityclasses/system-cluster-critical\" value_size:407 >> failure:<>"}
{"level":"info","ts":"2026-08-14T09:10:04.448667Z","caller":"traceutil/trace.go:171","msg":"trace[1928687133] transaction","detail":"{read_only:false; response_revision:564; number_of_response:1; }","duration":"124.444956ms","start":"2026-08-14T09:10:04.324187Z","end":"2026-08-14T09:10:04.448632Z","steps":["trace[1928687133] 'process raft request'  (duration: 59.016875ms)","trace[1928687133] 'compare'  (duration: 65.138507ms)"],"step_count":2}
{"level":"info","ts":"2026-08-14T09:10:04.448998Z","caller":"traceutil/trace.go:171","msg":"trace[636392700] transaction","detail":"{read_only:false; response_revision:565; number_of_response:1; }","duration":"101.850124ms","start":"2026-08-14T09:10:04.347132Z","end":"2026-08-14T09:10:04.448982Z","steps":["trace[636392700] 'process raft request'  (duration: 101.49225ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T09:10:05.161452Z","caller":"traceutil/trace.go:171","msg":"trace[1827631355] linearizableReadLoop","detail":"{readStateIndex:605; appliedIndex:604; }","duration":"104.818997ms","start":"2026-08-14T09:10:05.056604Z","end":"2026-08-14T09:10:05.161423Z","steps":["trace[1827631355] 'read index received'  (duration: 93.487425ms)","trace[1827631355] 'applied index is now lower than readState.Index'  (duration: 11.330222ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-14T09:10:05.161689Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.056089ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/backends.gateway.envoyproxy.io\" ","response":"range_response_count:1 size:18056"}
{"level":"info","ts":"2026-08-14T09:10:05.161732Z","caller":"traceutil/trace.go:171","msg":"trace[1320464770] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/backends.gateway.envoyproxy.io; range_end:; response_count:1; response_revision:585; }","duration":"105.14414ms","start":"2026-08-14T09:10:05.056575Z","end":"2026-08-14T09:10:05.161719Z","steps":["trace[1320464770] 'agreement among raft nodes before linearized reading'  (duration: 104.954538ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T09:10:05.162016Z","caller":"traceutil/trace.go:171","msg":"trace[921303098] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"110.462082ms","start":"2026-08-14T09:10:05.051505Z","end":"2026-08-14T09:10:05.161967Z","steps":["trace[921303098] 'process raft request'  (duration: 98.645625ms)","trace[921303098] 'compare'  (duration: 11.137679ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-14T09:10:11.680075Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.857762ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-kxbkz\" ","response":"range_response_count:1 size:16965"}
{"level":"info","ts":"2026-08-14T09:10:11.680168Z","caller":"traceutil/trace.go:171","msg":"trace[1177399147] range","detail":"{range_begin:/registry/pods/kube-system/cilium-kxbkz; range_end:; response_count:1; response_revision:648; }","duration":"111.998093ms","start":"2026-08-14T09:10:11.568149Z","end":"2026-08-14T09:10:11.680147Z","steps":["trace[1177399147] 'range keys from in-memory index tree'  (duration: 111.700469ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T09:10:11.811875Z","caller":"traceutil/trace.go:171","msg":"trace[991311289] transaction","detail":"{read_only:false; response_revision:649; number_of_response:1; }","duration":"118.875982ms","start":"2026-08-14T09:10:11.692956Z","end":"2026-08-14T09:10:11.811832Z","steps":["trace[991311289] 'process raft request'  (duration: 118.609539ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T09:10:27.488235Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.215151ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-14T09:10:27.488314Z","caller":"traceutil/trace.go:171","msg":"trace[928031090] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:762; }","duration":"247.337192ms","start":"2026-08-14T09:10:27.240958Z","end":"2026-08-14T09:10:27.488295Z","steps":["trace[928031090] 'range keys from in-memory index tree'  (duration: 247.13596ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T09:10:56.327301Z","caller":"traceutil/trace.go:171","msg":"trace[1199469922] transaction","detail":"{read_only:false; response_revision:1159; number_of_response:1; }","duration":"101.42607ms","start":"2026-08-14T09:10:56.225835Z","end":"2026-08-14T09:10:56.327261Z","steps":["trace[1199469922] 'process raft request'  (duration: 101.155197ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T09:11:42.780144Z","caller":"traceutil/trace.go:171","msg":"trace[748212786] transaction","detail":"{read_only:false; response_revision:1832; number_of_response:1; }","duration":"220.605925ms","start":"2026-08-14T09:11:42.559512Z","end":"2026-08-14T09:11:42.780118Z","steps":["trace[748212786] 'process raft request'  (duration: 220.399513ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T09:11:42.815929Z","caller":"traceutil/trace.go:171","msg":"trace[943754664] transaction","detail":"{read_only:false; response_revision:1833; number_of_response:1; }","duration":"255.877337ms","start":"2026-08-14T09:11:42.560032Z","end":"2026-08-14T09:11:42.815909Z","steps":["trace[943754664] 'process raft request'  (duration: 255.692115ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T09:11:42.816111Z","caller":"traceutil/trace.go:171","msg":"trace[2125348995] linearizableReadLoop","detail":"{readStateIndex:1903; appliedIndex:1900; }","duration":"171.730354ms","start":"2026-08-14T09:11:42.644354Z","end":"2026-08-14T09:11:42.816085Z","steps":["trace[2125348995] 'read index received'  (duration: 135.692764ms)","trace[2125348995] 'applied index is now lower than readState.Index'  (duration: 36.03562ms)"],"step_count":2}
{"level":"info","ts":"2026-08-14T09:11:42.81626Z","caller":"traceutil/trace.go:171","msg":"trace[1147441641] transaction","detail":"{read_only:false; response_revision:1834; number_of_response:1; }","duration":"209.419032ms","start":"2026-08-14T09:11:42.606828Z","end":"2026-08-14T09:11:42.816248Z","steps":["trace[1147441641] 'process raft request'  (duration: 209.013418ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T09:11:42.816306Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.938076ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-b8364fe1-53d0-4ee5-88a7-e3fcf9a97c39\" ","response":"range_response_count:1 size:3627"}
{"level":"info","ts":"2026-08-14T09:11:42.816344Z","caller":"traceutil/trace.go:171","msg":"trace[1686282293] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-b8364fe1-53d0-4ee5-88a7-e3fcf9a97c39; range_end:; response_count:1; response_revision:1834; }","duration":"172.020817ms","start":"2026-08-14T09:11:42.644311Z","end":"2026-08-14T09:11:42.816332Z","steps":["trace[1686282293] 'agreement among raft nodes before linearized reading'  (duration: 171.863766ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T09:11:43.150548Z","caller":"traceutil/trace.go:171","msg":"trace[556656981] linearizableReadLoop","detail":"{readStateIndex:1904; appliedIndex:1903; }","duration":"111.696127ms","start":"2026-08-14T09:11:43.03883Z","end":"2026-08-14T09:11:43.150526Z","steps":["trace[556656981] 'read index received'  (duration: 111.448285ms)","trace[556656981] 'applied index is now lower than readState.Index'  (duration: 246.932µs)"],"step_count":2}
{"level":"warn","ts":"2026-08-14T09:11:43.150752Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.901239ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-b8364fe1-53d0-4ee5-88a7-e3fcf9a97c39\" ","response":"range_response_count:1 size:3627"}
{"level":"info","ts":"2026-08-14T09:11:43.150779Z","caller":"traceutil/trace.go:171","msg":"trace[1060385719] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-b8364fe1-53d0-4ee5-88a7-e3fcf9a97c39; range_end:; response_count:1; response_revision:1835; }","duration":"111.98478ms","start":"2026-08-14T09:11:43.038787Z","end":"2026-08-14T09:11:43.150771Z","steps":["trace[1060385719] 'agreement among raft nodes before linearized reading'  (duration: 111.824138ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T09:11:43.150977Z","caller":"traceutil/trace.go:171","msg":"trace[1784215561] transaction","detail":"{read_only:false; response_revision:1835; number_of_response:1; }","duration":"163.831286ms","start":"2026-08-14T09:11:42.987115Z","end":"2026-08-14T09:11:43.150947Z","steps":["trace[1784215561] 'process raft request'  (duration: 163.238429ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T09:11:55.706495Z","caller":"traceutil/trace.go:171","msg":"trace[787967477] linearizableReadLoop","detail":"{readStateIndex:2011; appliedIndex:2010; }","duration":"197.154847ms","start":"2026-08-14T09:11:55.509314Z","end":"2026-08-14T09:11:55.706469Z","steps":["trace[787967477] 'read index received'  (duration: 188.104621ms)","trace[787967477] 'applied index is now lower than readState.Index'  (duration: 9.049196ms)"],"step_count":2}
{"level":"info","ts":"2026-08-14T09:11:55.706547Z","caller":"traceutil/trace.go:171","msg":"trace[1634674620] transaction","detail":"{read_only:false; response_revision:1939; number_of_response:1; }","duration":"215.126385ms","start":"2026-08-14T09:11:55.491395Z","end":"2026-08-14T09:11:55.706522Z","steps":["trace[1634674620] 'process raft request'  (duration: 206.040537ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T09:11:55.706617Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.284522ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-14T09:11:55.707279Z","caller":"traceutil/trace.go:171","msg":"trace[1255574286] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1939; }","duration":"197.985827ms","start":"2026-08-14T09:11:55.509274Z","end":"2026-08-14T09:11:55.70726Z","steps":["trace[1255574286] 'agreement among raft nodes before linearized reading'  (duration: 197.285152ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T09:11:55.800322Z","caller":"traceutil/trace.go:171","msg":"trace[1910194201] transaction","detail":"{read_only:false; response_revision:1940; number_of_response:1; }","duration":"200.467534ms","start":"2026-08-14T09:11:55.599818Z","end":"2026-08-14T09:11:55.800286Z","steps":["trace[1910194201] 'process raft request'  (duration: 200.204105ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T09:11:55.800368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.374396ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/\" range_end:\"/registry/cert-manager.io/certificates0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-08-14T09:11:55.800472Z","caller":"traceutil/trace.go:171","msg":"trace[1672712519] range","detail":"{range_begin:/registry/cert-manager.io/certificates/; range_end:/registry/cert-manager.io/certificates0; response_count:0; response_revision:1940; }","duration":"106.557052ms","start":"2026-08-14T09:11:55.693893Z","end":"2026-08-14T09:11:55.80045Z","steps":["trace[1672712519] 'agreement among raft nodes before linearized reading'  (duration: 106.356546ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T09:11:58.503516Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.282721ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"}
{"level":"info","ts":"2026-08-14T09:11:58.503602Z","caller":"traceutil/trace.go:171","msg":"trace[147680290] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1955; }","duration":"187.411525ms","start":"2026-08-14T09:11:58.31617Z","end":"2026-08-14T09:11:58.503581Z","steps":["trace[147680290] 'range keys from in-memory index tree'  (duration: 187.100804ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T09:12:17.400364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.359229ms","expected-duration":"100ms","prefix":"","request":"header:<ID:11579212036802950056 > lease_revoke:<id:20b19fff889132d6>","response":"size:28"}
{"level":"info","ts":"2026-08-14T09:12:17.400473Z","caller":"traceutil/trace.go:171","msg":"trace[1864608829] linearizableReadLoop","detail":"{readStateIndex:2148; appliedIndex:2147; }","duration":"161.420718ms","start":"2026-08-14T09:12:17.239036Z","end":"2026-08-14T09:12:17.400457Z","steps":["trace[1864608829] 'read index received'  (duration: 16.77425ms)","trace[1864608829] 'applied index is now lower than readState.Index'  (duration: 144.645448ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-14T09:12:17.400637Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.557432ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-14T09:12:17.400665Z","caller":"traceutil/trace.go:171","msg":"trace[793907106] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2071; }","duration":"161.651195ms","start":"2026-08-14T09:12:17.239006Z","end":"2026-08-14T09:12:17.400657Z","steps":["trace[793907106] 'agreement among raft nodes before linearized reading'  (duration: 161.551292ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T09:12:17.975648Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.147703ms","expected-duration":"100ms","prefix":"","request":"header:<ID:11579212036802950063 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:2062 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-08-14T09:12:17.975882Z","caller":"traceutil/trace.go:171","msg":"trace[243411520] transaction","detail":"{read_only:false; response_revision:2074; number_of_response:1; }","duration":"395.362497ms","start":"2026-08-14T09:12:17.580411Z","end":"2026-08-14T09:12:17.975773Z","steps":["trace[243411520] 'process raft request'  (duration: 187.814732ms)","trace[243411520] 'compare'  (duration: 206.919676ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-14T09:12:17.976034Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:12:17.580373Z","time spent":"395.577374ms","remote":"127.0.0.1:60340","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:2062 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-08-14T09:12:17.976094Z","caller":"traceutil/trace.go:171","msg":"trace[697167021] linearizableReadLoop","detail":"{readStateIndex:2151; appliedIndex:2150; }","duration":"342.744935ms","start":"2026-08-14T09:12:17.633329Z","end":"2026-08-14T09:12:17.976074Z","steps":["trace[697167021] 'read index received'  (duration: 134.806847ms)","trace[697167021] 'applied index is now lower than readState.Index'  (duration: 207.936258ms)"],"step_count":2}
{"level":"info","ts":"2026-08-14T09:12:17.976076Z","caller":"traceutil/trace.go:171","msg":"trace[1244653448] transaction","detail":"{read_only:false; response_revision:2075; number_of_response:1; }","duration":"195.3394ms","start":"2026-08-14T09:12:17.780717Z","end":"2026-08-14T09:12:17.976057Z","steps":["trace[1244653448] 'process raft request'  (duration: 195.043181ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T09:12:17.97626Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"342.922261ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"}
{"level":"info","ts":"2026-08-14T09:12:17.976297Z","caller":"traceutil/trace.go:171","msg":"trace[1223890915] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2075; }","duration":"342.994213ms","start":"2026-08-14T09:12:17.633292Z","end":"2026-08-14T09:12:17.976286Z","steps":["trace[1223890915] 'agreement among raft nodes before linearized reading'  (duration: 342.848239ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T09:12:17.976329Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:12:17.633278Z","time spent":"343.043516ms","remote":"127.0.0.1:38228","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "}
{"level":"info","ts":"2026-08-14T09:12:18.028303Z","caller":"traceutil/trace.go:171","msg":"trace[829396187] transaction","detail":"{read_only:false; response_revision:2076; number_of_response:1; }","duration":"158.953357ms","start":"2026-08-14T09:12:17.869324Z","end":"2026-08-14T09:12:18.028277Z","steps":["trace[829396187] 'process raft request'  (duration: 158.835843ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T09:12:18.259158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.6555ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"}
{"level":"info","ts":"2026-08-14T09:12:18.259249Z","caller":"traceutil/trace.go:171","msg":"trace[1973577361] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2077; }","duration":"179.801984ms","start":"2026-08-14T09:12:18.079428Z","end":"2026-08-14T09:12:18.25923Z","steps":["trace[1973577361] 'range keys from in-memory index tree'  (duration: 179.389021ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T09:12:18.26828Z","caller":"traceutil/trace.go:171","msg":"trace[1596882956] transaction","detail":"{read_only:false; response_revision:2078; number_of_response:1; }","duration":"102.298667ms","start":"2026-08-14T09:12:18.165964Z","end":"2026-08-14T09:12:18.268263Z","steps":["trace[1596882956] 'process raft request'  (duration: 102.204934ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T09:13:05.3071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.026952ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-14T09:13:05.307199Z","caller":"traceutil/trace.go:171","msg":"trace[1403618635] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:2380; }","duration":"215.192866ms","start":"2026-08-14T09:13:05.091986Z","end":"2026-08-14T09:13:05.307179Z","steps":["trace[1403618635] 'count revisions from in-memory index tree'  (duration: 214.865327ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T09:13:06.449134Z","caller":"traceutil/trace.go:171","msg":"trace[186168909] transaction","detail":"{read_only:false; response_revision:2393; number_of_response:1; }","duration":"148.98663ms","start":"2026-08-14T09:13:06.300119Z","end":"2026-08-14T09:13:06.449106Z","steps":["trace[186168909] 'process raft request'  (duration: 130.761669ms)","trace[186168909] 'compare'  (duration: 18.104648ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-14T09:13:11.780165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.44792ms","expected-duration":"100ms","prefix":"","request":"header:<ID:11579212036802950874 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/serviceaccounts/auth-system/default\" mod_revision:0 > success:<request_put:<key:\"/registry/serviceaccounts/auth-system/default\" value_size:112 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-08-14T09:13:11.780269Z","caller":"traceutil/trace.go:171","msg":"trace[1752074036] transaction","detail":"{read_only:false; response_revision:2424; number_of_response:1; }","duration":"174.157322ms","start":"2026-08-14T09:13:11.60609Z","end":"2026-08-14T09:13:11.780248Z","steps":["trace[1752074036] 'process raft request'  (duration: 52.558088ms)","trace[1752074036] 'compare'  (duration: 121.334717ms)"],"step_count":2}
{"level":"info","ts":"2026-08-14T09:13:11.851635Z","caller":"traceutil/trace.go:171","msg":"trace[139269797] transaction","detail":"{read_only:false; response_revision:2425; number_of_response:1; }","duration":"199.703452ms","start":"2026-08-14T09:13:11.651891Z","end":"2026-08-14T09:13:11.851595Z","steps":["trace[139269797] 'process raft request'  (duration: 199.376243ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T09:13:12.046724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.073324ms","expected-duration":"100ms","prefix":"","request":"header:<ID:11579212036802950879 username:\"kube-apiserver-etcd-client\" auth_revision:1 > lease_grant:<ttl:15-second id:20b19fff889136de>","response":"size:40"}
{"level":"info","ts":"2026-08-14T09:13:12.047055Z","caller":"traceutil/trace.go:171","msg":"trace[942201641] transaction","detail":"{read_only:false; response_revision:2427; number_of_response:1; }","duration":"187.536318ms","start":"2026-08-14T09:13:11.859497Z","end":"2026-08-14T09:13:12.047033Z","steps":["trace[942201641] 'process raft request'  (duration: 187.491656ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T09:13:12.04713Z","caller":"traceutil/trace.go:171","msg":"trace[68224581] transaction","detail":"{read_only:false; response_revision:2426; number_of_response:1; }","duration":"190.498773ms","start":"2026-08-14T09:13:11.856584Z","end":"2026-08-14T09:13:12.047083Z","steps":["trace[68224581] 'process raft request'  (duration: 190.243456ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T09:13:12.294858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.919268ms","expected-duration":"100ms","prefix":"","request":"header:<ID:11579212036802950886 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/auth-system/keycloak.18cba115c8eb5349\" mod_revision:0 > success:<request_put:<key:\"/registry/events/auth-system/keycloak.18cba115c8eb5349\" value_size:581 lease:2355839999948174479 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-08-14T09:13:12.295236Z","caller":"traceutil/trace.go:171","msg":"trace[1573899627] transaction","detail":"{read_only:false; response_revision:2430; number_of_response:1; }","duration":"173.481148ms","start":"2026-08-14T09:13:12.121739Z","end":"2026-08-14T09:13:12.29522Z","steps":["trace[1573899627] 'process raft request'  (duration: 48.13577ms)","trace[1573899627] 'compare'  (duration: 124.581199ms)"],"step_count":2}
{"level":"info","ts":"2026-08-14T09:13:12.295354Z","caller":"traceutil/trace.go:171","msg":"trace[697233876] linearizableReadLoop","detail":"{readStateIndex:2520; appliedIndex:2519; }","duration":"173.427928ms","start":"2026-08-14T09:13:12.121916Z","end":"2026-08-14T09:13:12.295344Z","steps":["trace[697233876] 'read index received'  (duration: 47.938496ms)","trace[697233876] 'applied index is now lower than readState.Index'  (duration: 125.486461ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-14T09:13:12.295454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.53094ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:481"}
{"level":"info","ts":"2026-08-14T09:13:12.295479Z","caller":"traceutil/trace.go:171","msg":"trace[771788026] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:2433; }","duration":"173.596682ms","start":"2026-08-14T09:13:12.121876Z","end":"2026-08-14T09:13:12.295472Z","steps":["trace[771788026] 'agreement among raft nodes before linearized reading'  (duration: 173.499989ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T09:13:12.295516Z","caller":"traceutil/trace.go:171","msg":"trace[437119902] transaction","detail":"{read_only:false; response_revision:2432; number_of_response:1; }","duration":"171.069987ms","start":"2026-08-14T09:13:12.124383Z","end":"2026-08-14T09:13:12.295453Z","steps":["trace[437119902] 'process raft request'  (duration: 170.612406ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T09:13:12.295781Z","caller":"traceutil/trace.go:171","msg":"trace[283323592] transaction","detail":"{read_only:false; response_revision:2431; number_of_response:1; }","duration":"173.690664ms","start":"2026-08-14T09:13:12.122083Z","end":"2026-08-14T09:13:12.295773Z","steps":["trace[283323592] 'process raft request'  (duration: 172.863554ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T09:13:14.944332Z","caller":"traceutil/trace.go:171","msg":"trace[81052933] transaction","detail":"{read_only:false; response_revision:2488; number_of_response:1; }","duration":"271.28159ms","start":"2026-08-14T09:13:14.673011Z","end":"2026-08-14T09:13:14.944293Z","steps":["trace[81052933] 'process raft request'  (duration: 267.264158ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T09:13:52.247295Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:13:51.82261Z","time spent":"424.677028ms","remote":"127.0.0.1:60100","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"info","ts":"2026-08-14T09:13:52.24731Z","caller":"traceutil/trace.go:171","msg":"trace[1779988134] linearizableReadLoop","detail":"{readStateIndex:2787; appliedIndex:2786; }","duration":"345.915882ms","start":"2026-08-14T09:13:51.901287Z","end":"2026-08-14T09:13:52.247203Z","steps":["trace[1779988134] 'read index received'  (duration: 345.734477ms)","trace[1779988134] 'applied index is now lower than readState.Index'  (duration: 179.475µs)"],"step_count":2}
{"level":"warn","ts":"2026-08-14T09:13:52.247571Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"346.146126ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-08-14T09:13:52.247756Z","caller":"traceutil/trace.go:171","msg":"trace[477905570] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:2688; }","duration":"346.490664ms","start":"2026-08-14T09:13:51.901243Z","end":"2026-08-14T09:13:52.247734Z","steps":["trace[477905570] 'agreement among raft nodes before linearized reading'  (duration: 346.071465ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T09:13:52.24786Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:13:51.901228Z","time spent":"346.621027ms","remote":"127.0.0.1:60442","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":67,"response size":30,"request content":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true "}
{"level":"warn","ts":"2026-08-14T09:13:52.748713Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11579212036802951540,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-08-14T09:13:53.169847Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.31724ms","expected-duration":"100ms","prefix":"","request":"header:<ID:11579212036802951539 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" mod_revision:2651 > success:<request_put:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" value_size:415 >> failure:<request_range:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" > >>","response":"size:16"}
{"level":"info","ts":"2026-08-14T09:13:53.170092Z","caller":"traceutil/trace.go:171","msg":"trace[940134739] transaction","detail":"{read_only:false; response_revision:2689; number_of_response:1; }","duration":"1.00481021s","start":"2026-08-14T09:13:52.165124Z","end":"2026-08-14T09:13:53.169935Z","steps":["trace[940134739] 'process raft request'  (duration: 735.326396ms)","trace[940134739] 'compare'  (duration: 268.85344ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-14T09:13:53.170219Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:13:52.165107Z","time spent":"1.005025614s","remote":"127.0.0.1:60340","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" mod_revision:2651 > success:<request_put:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" value_size:415 >> failure:<request_range:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" > >"}
{"level":"info","ts":"2026-08-14T09:13:53.175621Z","caller":"traceutil/trace.go:171","msg":"trace[1271371135] transaction","detail":"{read_only:false; response_revision:2693; number_of_response:1; }","duration":"536.452482ms","start":"2026-08-14T09:13:52.63914Z","end":"2026-08-14T09:13:53.175593Z","steps":["trace[1271371135] 'process raft request'  (duration: 536.38412ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T09:13:53.175628Z","caller":"traceutil/trace.go:171","msg":"trace[1744468328] transaction","detail":"{read_only:false; response_revision:2691; number_of_response:1; }","duration":"538.816814ms","start":"2026-08-14T09:13:52.636776Z","end":"2026-08-14T09:13:53.175593Z","steps":["trace[1744468328] 'process raft request'  (duration: 538.67236ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T09:13:53.175673Z","caller":"traceutil/trace.go:171","msg":"trace[1840906419] transaction","detail":"{read_only:false; response_revision:2692; number_of_response:1; }","duration":"536.593945ms","start":"2026-08-14T09:13:52.639047Z","end":"2026-08-14T09:13:53.175641Z","steps":["trace[1840906419] 'process raft request'  (duration: 536.447441ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T09:13:53.175782Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:13:52.639134Z","time spent":"536.563024ms","remote":"127.0.0.1:60340","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:2683 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"info","ts":"2026-08-14T09:13:53.175644Z","caller":"traceutil/trace.go:171","msg":"trace[2074421005] transaction","detail":"{read_only:false; response_revision:2690; number_of_response:1; }","duration":"926.574839ms","start":"2026-08-14T09:13:52.249032Z","end":"2026-08-14T09:13:53.175606Z","steps":["trace[2074421005] 'process raft request'  (duration: 926.274112ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T09:13:53.175965Z","caller":"traceutil/trace.go:171","msg":"trace[1330869647] linearizableReadLoop","detail":"{readStateIndex:2793; appliedIndex:2787; }","duration":"928.308948ms","start":"2026-08-14T09:13:52.247646Z","end":"2026-08-14T09:13:53.175955Z","steps":["trace[1330869647] 'read index received'  (duration: 652.79724ms)","trace[1330869647] 'applied index is now lower than readState.Index'  (duration: 275.506617ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-14T09:13:53.175821Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:13:52.639026Z","time spent":"536.718158ms","remote":"127.0.0.1:60340","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:2682 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:465 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"info","ts":"2026-08-14T09:13:53.176037Z","caller":"traceutil/trace.go:171","msg":"trace[39009287] transaction","detail":"{read_only:false; response_revision:2694; number_of_response:1; }","duration":"440.490027ms","start":"2026-08-14T09:13:52.735533Z","end":"2026-08-14T09:13:53.176023Z","steps":["trace[39009287] 'process raft request'  (duration: 440.023137ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T09:13:53.175817Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:13:52.636753Z","time spent":"538.976278ms","remote":"127.0.0.1:60340","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:2681 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:477 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-08-14T09:13:53.176011Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:13:52.249007Z","time spent":"926.866626ms","remote":"127.0.0.1:60100","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/masterleases/199.19.213.143\" mod_revision:2636 > success:<request_put:<key:\"/registry/masterleases/199.19.213.143\" value_size:67 lease:2355839999948175729 >> failure:<request_range:<key:\"/registry/masterleases/199.19.213.143\" > >"}
{"level":"warn","ts":"2026-08-14T09:13:53.176106Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:13:52.735515Z","time spent":"440.554788ms","remote":"127.0.0.1:60340","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:2684 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:459 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"warn","ts":"2026-08-14T09:13:53.17623Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"669.311366ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-08-14T09:13:53.176271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"532.931463ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"}
{"level":"info","ts":"2026-08-14T09:13:53.176272Z","caller":"traceutil/trace.go:171","msg":"trace[1217518420] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2694; }","duration":"669.386478ms","start":"2026-08-14T09:13:52.506874Z","end":"2026-08-14T09:13:53.176261Z","steps":["trace[1217518420] 'agreement among raft nodes before linearized reading'  (duration: 669.324227ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T09:13:53.176296Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"399.347752ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"}
{"level":"warn","ts":"2026-08-14T09:13:53.176314Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:13:52.506831Z","time spent":"669.47675ms","remote":"127.0.0.1:60062","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-08-14T09:13:53.176352Z","caller":"traceutil/trace.go:171","msg":"trace[1724500223] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2694; }","duration":"399.450534ms","start":"2026-08-14T09:13:52.776886Z","end":"2026-08-14T09:13:53.176337Z","steps":["trace[1724500223] 'agreement among raft nodes before linearized reading'  (duration: 399.232909ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T09:13:53.176348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"893.033303ms","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-14T09:13:53.176411Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:13:52.77687Z","time spent":"399.512655ms","remote":"127.0.0.1:60340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-08-14T09:13:53.176436Z","caller":"traceutil/trace.go:171","msg":"trace[1399344270] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2694; }","duration":"893.172357ms","start":"2026-08-14T09:13:52.28325Z","end":"2026-08-14T09:13:53.176422Z","steps":["trace[1399344270] 'agreement among raft nodes before linearized reading'  (duration: 892.808929ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T09:13:53.17647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.77283ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/auth-system/keycloak-0.18cba11978accbf3\" ","response":"range_response_count:1 size:779"}
{"level":"info","ts":"2026-08-14T09:13:53.176309Z","caller":"traceutil/trace.go:171","msg":"trace[1027726543] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2694; }","duration":"532.988754ms","start":"2026-08-14T09:13:52.643312Z","end":"2026-08-14T09:13:53.176301Z","steps":["trace[1027726543] 'agreement among raft nodes before linearized reading'  (duration: 532.82ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T09:13:53.176496Z","caller":"traceutil/trace.go:171","msg":"trace[612082946] range","detail":"{range_begin:/registry/events/auth-system/keycloak-0.18cba11978accbf3; range_end:; response_count:1; response_revision:2694; }","duration":"220.839861ms","start":"2026-08-14T09:13:52.955651Z","end":"2026-08-14T09:13:53.17649Z","steps":["trace[612082946] 'agreement among raft nodes before linearized reading'  (duration: 220.77871ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T09:13:53.176509Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:13:52.643304Z","time spent":"533.195328ms","remote":"127.0.0.1:60266","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":1392,"request content":"key:\"/registry/services/specs/auth-system/keycloak-headless\" "}
{"level":"warn","ts":"2026-08-14T09:13:53.176472Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:13:52.283226Z","time spent":"893.237388ms","remote":"127.0.0.1:60340","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":"warn","ts":"2026-08-14T09:13:53.176735Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.050045945s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-14T09:13:53.176847Z","caller":"traceutil/trace.go:171","msg":"trace[241321144] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:2694; }","duration":"1.050195739s","start":"2026-08-14T09:13:52.126641Z","end":"2026-08-14T09:13:53.176837Z","steps":["trace[241321144] 'agreement among raft nodes before linearized reading'  (duration: 1.049381491s)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T09:13:53.17687Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:13:52.126621Z","time spent":"1.0502421s","remote":"127.0.0.1:37484","response type":"/etcdserverpb.KV/Range","request count":0,"request size":88,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true "}
{"level":"info","ts":"2026-08-14T09:17:19.698926Z","caller":"traceutil/trace.go:171","msg":"trace[1767141085] transaction","detail":"{read_only:false; response_revision:4388; number_of_response:1; }","duration":"111.977291ms","start":"2026-08-14T09:17:19.586921Z","end":"2026-08-14T09:17:19.698899Z","steps":["trace[1767141085] 'process raft request'  (duration: 111.834259ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T09:17:19.741067Z","caller":"traceutil/trace.go:171","msg":"trace[1382506025] transaction","detail":"{read_only:false; response_revision:4389; number_of_response:1; }","duration":"140.396691ms","start":"2026-08-14T09:17:19.60065Z","end":"2026-08-14T09:17:19.741047Z","steps":["trace[1382506025] 'process raft request'  (duration: 140.069756ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T09:17:28.786907Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.178722ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-14T09:17:28.787021Z","caller":"traceutil/trace.go:171","msg":"trace[758572072] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4553; }","duration":"278.343464ms","start":"2026-08-14T09:17:28.508654Z","end":"2026-08-14T09:17:28.786997Z","steps":["trace[758572072] 'range keys from in-memory index tree'  (duration: 278.07622ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T09:17:28.787084Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.415164ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-grafana-6c6cfbf67-dqbdj.18cba151483dd1ce\" ","response":"range_response_count:1 size:895"}
{"level":"info","ts":"2026-08-14T09:17:28.787174Z","caller":"traceutil/trace.go:171","msg":"trace[724401781] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-grafana-6c6cfbf67-dqbdj.18cba151483dd1ce; range_end:; response_count:1; response_revision:4553; }","duration":"119.530645ms","start":"2026-08-14T09:17:28.667617Z","end":"2026-08-14T09:17:28.787148Z","steps":["trace[724401781] 'range keys from in-memory index tree'  (duration: 119.300852ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T09:17:28.787202Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.279138ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"}
{"level":"info","ts":"2026-08-14T09:17:28.787237Z","caller":"traceutil/trace.go:171","msg":"trace[1841217511] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4553; }","duration":"154.356349ms","start":"2026-08-14T09:17:28.632869Z","end":"2026-08-14T09:17:28.787225Z","steps":["trace[1841217511] 'range keys from in-memory index tree'  (duration: 154.121276ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T09:17:28.786928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.397723ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:12975"}
{"level":"info","ts":"2026-08-14T09:17:28.78754Z","caller":"traceutil/trace.go:171","msg":"trace[1341559551] range","detail":"{range_begin:/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4553; }","duration":"120.072014ms","start":"2026-08-14T09:17:28.667448Z","end":"2026-08-14T09:17:28.78752Z","steps":["trace[1341559551] 'range keys from in-memory index tree'  (duration: 119.223061ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T09:17:28.787688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.496995ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"}
{"level":"info","ts":"2026-08-14T09:17:28.787744Z","caller":"traceutil/trace.go:171","msg":"trace[712735770] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4553; }","duration":"106.554506ms","start":"2026-08-14T09:17:28.681172Z","end":"2026-08-14T09:17:28.787726Z","steps":["trace[712735770] 'range keys from in-memory index tree'  (duration: 106.369973ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T09:17:29.29919Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.056936ms","expected-duration":"100ms","prefix":"","request":"header:<ID:11579212036802955982 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/monitoring/prometheus-kube-prometheus-stack-prometheus-0.18cba15198e7ac8b\" mod_revision:0 > success:<request_put:<key:\"/registry/events/monitoring/prometheus-kube-prometheus-stack-prometheus-0.18cba15198e7ac8b\" value_size:816 lease:2355839999948179866 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-08-14T09:17:29.299306Z","caller":"traceutil/trace.go:171","msg":"trace[1719167984] transaction","detail":"{read_only:false; response_revision:4564; number_of_response:1; }","duration":"285.294925ms","start":"2026-08-14T09:17:29.01399Z","end":"2026-08-14T09:17:29.299285Z","steps":["trace[1719167984] 'process raft request'  (duration: 35.062037ms)","trace[1719167984] 'compare'  (duration: 249.853053ms)"],"step_count":2}
{"level":"info","ts":"2026-08-14T09:17:29.355232Z","caller":"traceutil/trace.go:171","msg":"trace[2098898090] transaction","detail":"{read_only:false; response_revision:4565; number_of_response:1; }","duration":"240.471469ms","start":"2026-08-14T09:17:29.114735Z","end":"2026-08-14T09:17:29.355207Z","steps":["trace[2098898090] 'process raft request'  (duration: 239.91343ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T09:17:29.36676Z","caller":"traceutil/trace.go:171","msg":"trace[2131326043] transaction","detail":"{read_only:false; response_revision:4566; number_of_response:1; }","duration":"229.232207ms","start":"2026-08-14T09:17:29.137459Z","end":"2026-08-14T09:17:29.366692Z","steps":["trace[2131326043] 'process raft request'  (duration: 228.518895ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T09:17:29.502029Z","caller":"traceutil/trace.go:171","msg":"trace[659782417] transaction","detail":"{read_only:false; response_revision:4569; number_of_response:1; }","duration":"109.241806ms","start":"2026-08-14T09:17:29.39275Z","end":"2026-08-14T09:17:29.501992Z","steps":["trace[659782417] 'process raft request'  (duration: 108.959732ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T09:17:29.502447Z","caller":"traceutil/trace.go:171","msg":"trace[392000974] transaction","detail":"{read_only:false; response_revision:4570; number_of_response:1; }","duration":"109.466449ms","start":"2026-08-14T09:17:29.392947Z","end":"2026-08-14T09:17:29.502413Z","steps":["trace[392000974] 'process raft request'  (duration: 108.897261ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T09:17:29.503753Z","caller":"traceutil/trace.go:171","msg":"trace[4587877] transaction","detail":"{read_only:false; response_revision:4571; number_of_response:1; }","duration":"109.057522ms","start":"2026-08-14T09:17:29.394667Z","end":"2026-08-14T09:17:29.503724Z","steps":["trace[4587877] 'process raft request'  (duration: 107.993896ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T09:17:29.822347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.696658ms","expected-duration":"100ms","prefix":"","request":"header:<ID:11579212036802956005 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/configmaps/openstack/rabbitmq-keystone-plugins-conf\" mod_revision:0 > success:<request_put:<key:\"/registry/configmaps/openstack/rabbitmq-keystone-plugins-conf\" value_size:763 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-08-14T09:17:29.822753Z","caller":"traceutil/trace.go:171","msg":"trace[878745787] transaction","detail":"{read_only:false; response_revision:4580; number_of_response:1; }","duration":"276.39828ms","start":"2026-08-14T09:17:29.546332Z","end":"2026-08-14T09:17:29.82273Z","steps":["trace[878745787] 'process raft request'  (duration: 49.262565ms)","trace[878745787] 'compare'  (duration: 226.479465ms)"],"step_count":2}
{"level":"info","ts":"2026-08-14T09:17:29.823568Z","caller":"traceutil/trace.go:171","msg":"trace[164267420] linearizableReadLoop","detail":"{readStateIndex:4753; appliedIndex:4751; }","duration":"269.311591ms","start":"2026-08-14T09:17:29.554244Z","end":"2026-08-14T09:17:29.823555Z","steps":["trace[164267420] 'read index received'  (duration: 41.364383ms)","trace[164267420] 'applied index is now lower than readState.Index'  (duration: 227.946428ms)"],"step_count":2}
{"level":"info","ts":"2026-08-14T09:17:29.823704Z","caller":"traceutil/trace.go:171","msg":"trace[1177563369] transaction","detail":"{read_only:false; response_revision:4581; number_of_response:1; }","duration":"276.644654ms","start":"2026-08-14T09:17:29.547025Z","end":"2026-08-14T09:17:29.823669Z","steps":["trace[1177563369] 'process raft request'  (duration: 275.651328ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T09:17:29.824223Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.953421ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated\" ","response":"range_response_count:1 size:1343"}
{"level":"info","ts":"2026-08-14T09:17:29.824302Z","caller":"traceutil/trace.go:171","msg":"trace[193851691] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated; range_end:; response_count:1; response_revision:4581; }","duration":"270.075574ms","start":"2026-08-14T09:17:29.554206Z","end":"2026-08-14T09:17:29.824282Z","steps":["trace[193851691] 'agreement among raft nodes before linearized reading'  (duration: 269.78292ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T09:17:30.006071Z","caller":"traceutil/trace.go:171","msg":"trace[709316857] transaction","detail":"{read_only:false; response_revision:4588; number_of_response:1; }","duration":"125.300472ms","start":"2026-08-14T09:17:29.88074Z","end":"2026-08-14T09:17:30.00604Z","steps":["trace[709316857] 'process raft request'  (duration: 125.015928ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T09:17:30.00679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.31744ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" ","response":"range_response_count:72 size:60103"}
{"level":"info","ts":"2026-08-14T09:17:30.006874Z","caller":"traceutil/trace.go:171","msg":"trace[177891165] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:72; response_revision:4588; }","duration":"132.415132ms","start":"2026-08-14T09:17:29.874439Z","end":"2026-08-14T09:17:30.006854Z","steps":["trace[177891165] 'agreement among raft nodes before linearized reading'  (duration: 131.66876ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T09:17:30.007454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.323863ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:3506"}
{"level":"info","ts":"2026-08-14T09:17:30.007898Z","caller":"traceutil/trace.go:171","msg":"trace[1809314110] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:4588; }","duration":"112.444515ms","start":"2026-08-14T09:17:29.89507Z","end":"2026-08-14T09:17:30.007514Z","steps":["trace[1809314110] 'agreement among raft nodes before linearized reading'  (duration: 111.006904ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T09:18:08.399987Z","caller":"traceutil/trace.go:171","msg":"trace[2008415332] transaction","detail":"{read_only:false; response_revision:4953; number_of_response:1; }","duration":"136.991156ms","start":"2026-08-14T09:18:08.262974Z","end":"2026-08-14T09:18:08.399965Z","steps":["trace[2008415332] 'process raft request'  (duration: 136.834204ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T09:18:08.432303Z","caller":"traceutil/trace.go:171","msg":"trace[1704793618] transaction","detail":"{read_only:false; response_revision:4954; number_of_response:1; }","duration":"116.606353ms","start":"2026-08-14T09:18:08.31567Z","end":"2026-08-14T09:18:08.432276Z","steps":["trace[1704793618] 'process raft request'  (duration: 116.300608ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T09:18:16.140168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.964889ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/keystone-credential-setup\" ","response":"range_response_count:1 size:6084"}
{"level":"warn","ts":"2026-08-14T09:18:16.140218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.399334ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/keystone-db-sync\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-14T09:18:16.140261Z","caller":"traceutil/trace.go:171","msg":"trace[367296936] range","detail":"{range_begin:/registry/jobs/openstack/keystone-credential-setup; range_end:; response_count:1; response_revision:5093; }","duration":"113.114681ms","start":"2026-08-14T09:18:16.027126Z","end":"2026-08-14T09:18:16.140241Z","steps":["trace[367296936] 'range keys from in-memory index tree'  (duration: 112.804207ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T09:18:16.140262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.418695ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/keystone-fernet-setup\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-14T09:18:16.14028Z","caller":"traceutil/trace.go:171","msg":"trace[2126431633] range","detail":"{range_begin:/registry/jobs/openstack/keystone-db-sync; range_end:; response_count:0; response_revision:5093; }","duration":"119.502376ms","start":"2026-08-14T09:18:16.020758Z","end":"2026-08-14T09:18:16.140261Z","steps":["trace[2126431633] 'range keys from in-memory index tree'  (duration: 119.310693ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T09:18:16.140376Z","caller":"traceutil/trace.go:171","msg":"trace[648815711] range","detail":"{range_begin:/registry/jobs/openstack/keystone-fernet-setup; range_end:; response_count:0; response_revision:5093; }","duration":"119.563727ms","start":"2026-08-14T09:18:16.020758Z","end":"2026-08-14T09:18:16.140322Z","steps":["trace[648815711] 'range keys from in-memory index tree'  (duration: 119.315583ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T09:19:28.405447Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2879}
{"level":"info","ts":"2026-08-14T09:19:28.483238Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2879,"took":"76.352261ms","hash":3041944476,"current-db-size-bytes":53870592,"current-db-size":"54 MB","current-db-size-in-use-bytes":29532160,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-08-14T09:19:28.483295Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3041944476,"revision":2879,"compact-revision":-1}
{"level":"info","ts":"2026-08-14T09:21:27.468882Z","caller":"traceutil/trace.go:171","msg":"trace[1879882807] transaction","detail":"{read_only:false; response_revision:6402; number_of_response:1; }","duration":"285.812726ms","start":"2026-08-14T09:21:27.183045Z","end":"2026-08-14T09:21:27.468857Z","steps":["trace[1879882807] 'process raft request'  (duration: 285.642281ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T09:21:27.571735Z","caller":"traceutil/trace.go:171","msg":"trace[1655172537] transaction","detail":"{read_only:false; response_revision:6404; number_of_response:1; }","duration":"298.101068ms","start":"2026-08-14T09:21:27.273604Z","end":"2026-08-14T09:21:27.571705Z","steps":["trace[1655172537] 'process raft request'  (duration: 298.018745ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T09:21:27.571754Z","caller":"traceutil/trace.go:171","msg":"trace[1693500705] transaction","detail":"{read_only:false; response_revision:6403; number_of_response:1; }","duration":"380.127299ms","start":"2026-08-14T09:21:27.191593Z","end":"2026-08-14T09:21:27.57172Z","steps":["trace[1693500705] 'process raft request'  (duration: 326.611885ms)","trace[1693500705] 'compare'  (duration: 53.271647ms)"],"step_count":2}
{"level":"info","ts":"2026-08-14T09:21:27.57189Z","caller":"traceutil/trace.go:171","msg":"trace[1246607612] linearizableReadLoop","detail":"{readStateIndex:6634; appliedIndex:6632; }","duration":"359.367845ms","start":"2026-08-14T09:21:27.212488Z","end":"2026-08-14T09:21:27.571856Z","steps":["trace[1246607612] 'read index received'  (duration: 256.191259ms)","trace[1246607612] 'applied index is now lower than readState.Index'  (duration: 103.173876ms)"],"step_count":2}
{"level":"info","ts":"2026-08-14T09:21:27.571948Z","caller":"traceutil/trace.go:171","msg":"trace[1900585863] transaction","detail":"{read_only:false; response_revision:6405; number_of_response:1; }","duration":"290.55339ms","start":"2026-08-14T09:21:27.281384Z","end":"2026-08-14T09:21:27.571937Z","steps":["trace[1900585863] 'process raft request'  (duration: 290.281383ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T09:21:27.571951Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:21:27.191572Z","time spent":"380.252632ms","remote":"127.0.0.1:60340","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:6394 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"warn","ts":"2026-08-14T09:21:27.572141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.355029ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"warn","ts":"2026-08-14T09:21:27.572144Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"359.660942ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"}
{"level":"info","ts":"2026-08-14T09:21:27.572181Z","caller":"traceutil/trace.go:171","msg":"trace[1241136258] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:6405; }","duration":"204.450242ms","start":"2026-08-14T09:21:27.367721Z","end":"2026-08-14T09:21:27.572171Z","steps":["trace[1241136258] 'agreement among raft nodes before linearized reading'  (duration: 204.310459ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T09:21:27.572187Z","caller":"traceutil/trace.go:171","msg":"trace[1000457131] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:6405; }","duration":"359.737504ms","start":"2026-08-14T09:21:27.212439Z","end":"2026-08-14T09:21:27.572176Z","steps":["trace[1000457131] 'agreement among raft nodes before linearized reading'  (duration: 359.57571ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T09:21:27.572216Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:21:27.21242Z","time spent":"359.789796ms","remote":"127.0.0.1:60258","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12238,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "}
{"level":"warn","ts":"2026-08-14T09:21:27.822732Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.894899ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-14T09:21:27.822889Z","caller":"traceutil/trace.go:171","msg":"trace[1928428086] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:6408; }","duration":"140.059803ms","start":"2026-08-14T09:21:27.682792Z","end":"2026-08-14T09:21:27.822852Z","steps":["trace[1928428086] 'range keys from in-memory index tree'  (duration: 139.798687ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T09:21:28.407734Z","caller":"traceutil/trace.go:171","msg":"trace[142846180] linearizableReadLoop","detail":"{readStateIndex:6640; appliedIndex:6639; }","duration":"277.731132ms","start":"2026-08-14T09:21:28.12998Z","end":"2026-08-14T09:21:28.407712Z","steps":["trace[142846180] 'read index received'  (duration: 277.500536ms)","trace[142846180] 'applied index is now lower than readState.Index'  (duration: 229.556µs)"],"step_count":2}
{"level":"info","ts":"2026-08-14T09:21:28.407862Z","caller":"traceutil/trace.go:171","msg":"trace[1353915759] transaction","detail":"{read_only:false; response_revision:6409; number_of_response:1; }","duration":"312.752209ms","start":"2026-08-14T09:21:28.095074Z","end":"2026-08-14T09:21:28.407826Z","steps":["trace[1353915759] 'process raft request'  (duration: 312.501613ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T09:21:28.408048Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:21:28.095047Z","time spent":"312.898023ms","remote":"127.0.0.1:60340","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:6400 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-08-14T09:21:28.408102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.043544ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/users/\" range_end:\"/registry/rabbitmq.com/users0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-14T09:21:28.40823Z","caller":"traceutil/trace.go:171","msg":"trace[943342268] range","detail":"{range_begin:/registry/rabbitmq.com/users/; range_end:/registry/rabbitmq.com/users0; response_count:0; response_revision:6409; }","duration":"146.235719ms","start":"2026-08-14T09:21:28.261968Z","end":"2026-08-14T09:21:28.408204Z","steps":["trace[943342268] 'agreement among raft nodes before linearized reading'  (duration: 145.986542ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T09:21:28.408276Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.279936ms","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-14T09:21:28.40834Z","caller":"traceutil/trace.go:171","msg":"trace[485797273] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:6409; }","duration":"278.369188ms","start":"2026-08-14T09:21:28.129953Z","end":"2026-08-14T09:21:28.408323Z","steps":["trace[485797273] 'agreement among raft nodes before linearized reading'  (duration: 277.897306ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T09:21:28.541934Z","caller":"traceutil/trace.go:171","msg":"trace[820668491] transaction","detail":"{read_only:false; response_revision:6410; number_of_response:1; }","duration":"128.239458ms","start":"2026-08-14T09:21:28.413647Z","end":"2026-08-14T09:21:28.541887Z","steps":["trace[820668491] 'process raft request'  (duration: 41.65657ms)","trace[820668491] 'compare'  (duration: 86.244439ms)"],"step_count":2}
{"level":"info","ts":"2026-08-14T09:21:29.690862Z","caller":"traceutil/trace.go:171","msg":"trace[3460566] transaction","detail":"{read_only:false; response_revision:6414; number_of_response:1; }","duration":"112.941362ms","start":"2026-08-14T09:21:29.577897Z","end":"2026-08-14T09:21:29.690838Z","steps":["trace[3460566] 'process raft request'  (duration: 112.84422ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T09:21:29.690896Z","caller":"traceutil/trace.go:171","msg":"trace[646935690] transaction","detail":"{read_only:false; response_revision:6413; number_of_response:1; }","duration":"113.004864ms","start":"2026-08-14T09:21:29.577849Z","end":"2026-08-14T09:21:29.690854Z","steps":["trace[646935690] 'process raft request'  (duration: 112.761437ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T09:21:41.937045Z","caller":"traceutil/trace.go:171","msg":"trace[860471684] transaction","detail":"{read_only:false; response_revision:6533; number_of_response:1; }","duration":"130.166538ms","start":"2026-08-14T09:21:41.806852Z","end":"2026-08-14T09:21:41.937019Z","steps":["trace[860471684] 'process raft request'  (duration: 129.911242ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T09:21:41.937137Z","caller":"traceutil/trace.go:171","msg":"trace[910167337] transaction","detail":"{read_only:false; response_revision:6534; number_of_response:1; }","duration":"130.182309ms","start":"2026-08-14T09:21:41.806905Z","end":"2026-08-14T09:21:41.937088Z","steps":["trace[910167337] 'process raft request'  (duration: 129.959433ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T09:24:28.411583Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5598}
{"level":"info","ts":"2026-08-14T09:24:28.516516Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5598,"took":"103.072551ms","hash":2648944586,"current-db-size-bytes":53870592,"current-db-size":"54 MB","current-db-size-in-use-bytes":18194432,"current-db-size-in-use":"18 MB"}
{"level":"info","ts":"2026-08-14T09:24:28.516596Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2648944586,"revision":5598,"compact-revision":2879}