{"level":"warn","ts":"2026-08-13T00:48:40.546241Z","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-13T00:48:40.546336Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.235: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.235:2380","--initial-cluster=instance=https://199.204.45.235:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.235:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.235: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-13T00:48:40.546419Z","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-13T00:48:40.546438Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.235:2380"]} {"level":"info","ts":"2026-08-13T00:48:40.546459Z","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-13T00:48:40.547279Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.235:2379"]} {"level":"info","ts":"2026-08-13T00:48:40.547441Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.235:2380"],"listen-peer-urls":["https://199.204.45.235:2380"],"advertise-client-urls":["https://199.204.45.235:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.235:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.235: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-13T00:48:40.549761Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.02905ms"} {"level":"info","ts":"2026-08-13T00:48:40.554132Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"aab6040abcf11","cluster-id":"2bae7d3d8857c059"} {"level":"info","ts":"2026-08-13T00:48:40.554253Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 switched to configuration voters=()"} {"level":"info","ts":"2026-08-13T00:48:40.554289Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 became follower at term 0"} {"level":"info","ts":"2026-08-13T00:48:40.554321Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft aab6040abcf11 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-13T00:48:40.554344Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 became follower at term 1"} {"level":"info","ts":"2026-08-13T00:48:40.55441Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 switched to configuration voters=(3003179657318161)"} {"level":"warn","ts":"2026-08-13T00:48:40.558012Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-13T00:48:40.559545Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-13T00:48:40.561117Z","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-13T00:48:40.564098Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"aab6040abcf11","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-13T00:48:40.56429Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"aab6040abcf11","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-13T00:48:40.564393Z","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-13T00:48:40.564539Z","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-13T00:48:40.564571Z","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-13T00:48:40.566662Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 switched to configuration voters=(3003179657318161)"} {"level":"info","ts":"2026-08-13T00:48:40.566797Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"2bae7d3d8857c059","local-member-id":"aab6040abcf11","added-peer-id":"aab6040abcf11","added-peer-peer-urls":["https://199.204.45.235:2380"]} {"level":"info","ts":"2026-08-13T00:48:40.569416Z","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-13T00:48:40.569505Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.235:2380"} {"level":"info","ts":"2026-08-13T00:48:40.56967Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.235:2380"} {"level":"info","ts":"2026-08-13T00:48:40.569771Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"aab6040abcf11","initial-advertise-peer-urls":["https://199.204.45.235:2380"],"listen-peer-urls":["https://199.204.45.235:2380"],"advertise-client-urls":["https://199.204.45.235:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.235:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-13T00:48:40.569835Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-13T00:48:40.755141Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 is starting a new election at term 1"} {"level":"info","ts":"2026-08-13T00:48:40.755208Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 became pre-candidate at term 1"} {"level":"info","ts":"2026-08-13T00:48:40.755241Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 received MsgPreVoteResp from aab6040abcf11 at term 1"} {"level":"info","ts":"2026-08-13T00:48:40.755269Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 became candidate at term 2"} {"level":"info","ts":"2026-08-13T00:48:40.755287Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 received MsgVoteResp from aab6040abcf11 at term 2"} {"level":"info","ts":"2026-08-13T00:48:40.755305Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 became leader at term 2"} {"level":"info","ts":"2026-08-13T00:48:40.755347Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: aab6040abcf11 elected leader aab6040abcf11 at term 2"} {"level":"info","ts":"2026-08-13T00:48:40.756873Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"aab6040abcf11","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.235:2379]}","request-path":"/0/members/aab6040abcf11/attributes","cluster-id":"2bae7d3d8857c059","publish-timeout":"7s"} {"level":"info","ts":"2026-08-13T00:48:40.756877Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-13T00:48:40.756925Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-13T00:48:40.757049Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-13T00:48:40.757241Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-13T00:48:40.757343Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-13T00:48:40.75848Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"2bae7d3d8857c059","local-member-id":"aab6040abcf11","cluster-version":"3.5"} {"level":"info","ts":"2026-08-13T00:48:40.758562Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-13T00:48:40.758589Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-08-13T00:48:40.759168Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.235:2379"} {"level":"info","ts":"2026-08-13T00:48:40.760182Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-08-13T00:48:46.255646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.656096ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/namespace-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-13T00:48:46.255768Z","caller":"traceutil/trace.go:171","msg":"trace[302222604] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/namespace-controller; range_end:; response_count:0; response_revision:245; }","duration":"180.843009ms","start":"2026-08-13T00:48:46.074909Z","end":"2026-08-13T00:48:46.255752Z","steps":["trace[302222604] 'range keys from in-memory index tree' (duration: 180.521823ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T00:48:46.255769Z","caller":"traceutil/trace.go:171","msg":"trace[1216707643] transaction","detail":"{read_only:false; response_revision:246; number_of_response:1; }","duration":"180.773788ms","start":"2026-08-13T00:48:46.074972Z","end":"2026-08-13T00:48:46.255745Z","steps":["trace[1216707643] 'process raft request' (duration: 149.467777ms)","trace[1216707643] 'compare' (duration: 31.176148ms)"],"step_count":2} {"level":"warn","ts":"2026-08-13T00:48:52.96972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.250612ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-13T00:48:52.969841Z","caller":"traceutil/trace.go:171","msg":"trace[66410181] transaction","detail":"{read_only:false; response_revision:356; number_of_response:1; }","duration":"252.856102ms","start":"2026-08-13T00:48:52.716968Z","end":"2026-08-13T00:48:52.969824Z","steps":["trace[66410181] 'process raft request' (duration: 115.954786ms)","trace[66410181] 'compare' (duration: 136.11018ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T00:48:52.974867Z","caller":"traceutil/trace.go:171","msg":"trace[1510562249] transaction","detail":"{read_only:false; response_revision:357; number_of_response:1; }","duration":"257.783855ms","start":"2026-08-13T00:48:52.717041Z","end":"2026-08-13T00:48:52.974825Z","steps":["trace[1510562249] 'process raft request' (duration: 257.662813ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T00:49:22.777149Z","caller":"traceutil/trace.go:171","msg":"trace[1404086373] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"151.81715ms","start":"2026-08-13T00:49:22.625306Z","end":"2026-08-13T00:49:22.777123Z","steps":["trace[1404086373] 'process raft request' (duration: 151.155708ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T00:49:23.393233Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.816955ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-08-13T00:49:23.393452Z","caller":"traceutil/trace.go:171","msg":"trace[211519655] linearizableReadLoop","detail":"{readStateIndex:612; appliedIndex:610; }","duration":"298.143715ms","start":"2026-08-13T00:49:23.095291Z","end":"2026-08-13T00:49:23.393434Z","steps":["trace[211519655] 'read index received' (duration: 51.053585ms)","trace[211519655] 'applied index is now lower than readState.Index' (duration: 247.08908ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T00:49:23.39354Z","caller":"traceutil/trace.go:171","msg":"trace[385737035] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"562.110509ms","start":"2026-08-13T00:49:22.831418Z","end":"2026-08-13T00:49:23.393528Z","steps":["trace[385737035] 'process raft request' (duration: 314.914117ms)","trace[385737035] 'compare' (duration: 246.516089ms)"],"step_count":2} {"level":"warn","ts":"2026-08-13T00:49:23.3936Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T00:49:22.831398Z","time spent":"562.17785ms","remote":"127.0.0.1:57624","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-13T00:49:23.393751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.434991ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-08-13T00:49:23.393841Z","caller":"traceutil/trace.go:171","msg":"trace[1418091507] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:593; }","duration":"298.565663ms","start":"2026-08-13T00:49:23.095254Z","end":"2026-08-13T00:49:23.39382Z","steps":["trace[1418091507] 'agreement among raft nodes before linearized reading' (duration: 298.296408ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T00:49:23.393845Z","caller":"traceutil/trace.go:171","msg":"trace[1038884309] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"333.896189ms","start":"2026-08-13T00:49:23.059903Z","end":"2026-08-13T00:49:23.393799Z","steps":["trace[1038884309] 'process raft request' (duration: 333.443311ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T00:49:23.393949Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.72069ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-13T00:49:23.394066Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T00:49:23.059878Z","time spent":"334.074112ms","remote":"127.0.0.1:57356","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-13T00:49:23.394087Z","caller":"traceutil/trace.go:171","msg":"trace[1470945945] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:593; }","duration":"183.928103ms","start":"2026-08-13T00:49:23.210126Z","end":"2026-08-13T00:49:23.394054Z","steps":["trace[1470945945] 'agreement among raft nodes before linearized reading' (duration: 183.676478ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T00:49:23.394086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.946231ms","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-13T00:49:23.394227Z","caller":"traceutil/trace.go:171","msg":"trace[418734811] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:593; }","duration":"298.145675ms","start":"2026-08-13T00:49:23.09605Z","end":"2026-08-13T00:49:23.394196Z","steps":["trace[418734811] 'agreement among raft nodes before linearized reading' (duration: 297.744468ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T00:49:37.465266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.690646ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-13T00:49:37.465384Z","caller":"traceutil/trace.go:171","msg":"trace[1159900693] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:749; }","duration":"254.861999ms","start":"2026-08-13T00:49:37.210489Z","end":"2026-08-13T00:49:37.465351Z","steps":["trace[1159900693] 'range keys from in-memory index tree' (duration: 254.573823ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T00:51:01.435087Z","caller":"traceutil/trace.go:171","msg":"trace[622820940] transaction","detail":"{read_only:false; response_revision:1857; number_of_response:1; }","duration":"137.965576ms","start":"2026-08-13T00:51:01.297094Z","end":"2026-08-13T00:51:01.435059Z","steps":["trace[622820940] 'process raft request' (duration: 137.801243ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T00:51:09.226149Z","caller":"traceutil/trace.go:171","msg":"trace[862156423] transaction","detail":"{read_only:false; response_revision:1927; number_of_response:1; }","duration":"113.178847ms","start":"2026-08-13T00:51:09.112941Z","end":"2026-08-13T00:51:09.22612Z","steps":["trace[862156423] 'process raft request' (duration: 112.991524ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T00:51:52.03979Z","caller":"traceutil/trace.go:171","msg":"trace[1294836558] linearizableReadLoop","detail":"{readStateIndex:2260; appliedIndex:2259; }","duration":"173.477223ms","start":"2026-08-13T00:51:51.866276Z","end":"2026-08-13T00:51:52.039753Z","steps":["trace[1294836558] 'read index received' (duration: 102.753116ms)","trace[1294836558] 'applied index is now lower than readState.Index' (duration: 70.722557ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T00:51:52.039813Z","caller":"traceutil/trace.go:171","msg":"trace[1710552412] transaction","detail":"{read_only:false; response_revision:2179; number_of_response:1; }","duration":"301.907636ms","start":"2026-08-13T00:51:51.737848Z","end":"2026-08-13T00:51:52.039756Z","steps":["trace[1710552412] 'process raft request' (duration: 231.174449ms)","trace[1710552412] 'compare' (duration: 70.588165ms)"],"step_count":2} {"level":"warn","ts":"2026-08-13T00:51:52.04002Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T00:51:51.737809Z","time spent":"302.108999ms","remote":"127.0.0.1:57356","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-13T00:51:52.040075Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.783969ms","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-13T00:51:52.040274Z","caller":"traceutil/trace.go:171","msg":"trace[1348815068] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2179; }","duration":"173.947592ms","start":"2026-08-13T00:51:51.866214Z","end":"2026-08-13T00:51:52.040162Z","steps":["trace[1348815068] 'agreement among raft nodes before linearized reading' (duration: 173.679467ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T00:51:52.405611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.553981ms","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-13T00:51:52.4057Z","caller":"traceutil/trace.go:171","msg":"trace[700323107] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2179; }","duration":"179.698293ms","start":"2026-08-13T00:51:52.22598Z","end":"2026-08-13T00:51:52.405679Z","steps":["trace[700323107] 'range keys from in-memory index tree' (duration: 179.369777ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T00:51:52.405722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.055652ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-08-13T00:51:52.405816Z","caller":"traceutil/trace.go:171","msg":"trace[263472107] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2179; }","duration":"178.198324ms","start":"2026-08-13T00:51:52.227597Z","end":"2026-08-13T00:51:52.405796Z","steps":["trace[263472107] 'range keys from in-memory index tree' (duration: 177.864518ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T00:51:52.406106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.444785ms","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-13T00:51:52.40624Z","caller":"traceutil/trace.go:171","msg":"trace[2134505610] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2179; }","duration":"185.626268ms","start":"2026-08-13T00:51:52.22059Z","end":"2026-08-13T00:51:52.406216Z","steps":["trace[2134505610] 'range keys from in-memory index tree' (duration: 185.060937ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T00:53:13.644806Z","caller":"traceutil/trace.go:171","msg":"trace[180205240] transaction","detail":"{read_only:false; response_revision:2813; number_of_response:1; }","duration":"101.258174ms","start":"2026-08-13T00:53:13.543519Z","end":"2026-08-13T00:53:13.644777Z","steps":["trace[180205240] 'process raft request' (duration: 101.040259ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T00:53:13.849238Z","caller":"traceutil/trace.go:171","msg":"trace[1901527467] transaction","detail":"{read_only:false; response_revision:2814; number_of_response:1; }","duration":"127.92331ms","start":"2026-08-13T00:53:13.721292Z","end":"2026-08-13T00:53:13.849215Z","steps":["trace[1901527467] 'process raft request' (duration: 127.800407ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T00:55:53.822641Z","caller":"traceutil/trace.go:171","msg":"trace[1815691986] transaction","detail":"{read_only:false; response_revision:3858; number_of_response:1; }","duration":"117.790532ms","start":"2026-08-13T00:55:53.704814Z","end":"2026-08-13T00:55:53.822605Z","steps":["trace[1815691986] 'process raft request' (duration: 90.250828ms)","trace[1815691986] 'compare' (duration: 27.291349ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T00:55:53.822796Z","caller":"traceutil/trace.go:171","msg":"trace[1922993403] transaction","detail":"{read_only:false; response_revision:3859; number_of_response:1; }","duration":"117.920324ms","start":"2026-08-13T00:55:53.704841Z","end":"2026-08-13T00:55:53.822761Z","steps":["trace[1922993403] 'process raft request' (duration: 117.71096ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T00:57:12.789745Z","caller":"traceutil/trace.go:171","msg":"trace[138134934] linearizableReadLoop","detail":"{readStateIndex:5049; appliedIndex:5048; }","duration":"109.97591ms","start":"2026-08-13T00:57:12.679745Z","end":"2026-08-13T00:57:12.789721Z","steps":["trace[138134934] 'read index received' (duration: 109.722615ms)","trace[138134934] 'applied index is now lower than readState.Index' (duration: 252.395µs)"],"step_count":2} {"level":"info","ts":"2026-08-13T00:57:12.789877Z","caller":"traceutil/trace.go:171","msg":"trace[1804497881] transaction","detail":"{read_only:false; response_revision:4869; number_of_response:1; }","duration":"115.627859ms","start":"2026-08-13T00:57:12.674234Z","end":"2026-08-13T00:57:12.789862Z","steps":["trace[1804497881] 'process raft request' (duration: 115.340894ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T00:57:12.79055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.206933ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config\" ","response":"range_response_count:1 size:708"} {"level":"info","ts":"2026-08-13T00:57:12.790603Z","caller":"traceutil/trace.go:171","msg":"trace[1229604660] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config; range_end:; response_count:1; response_revision:4869; }","duration":"112.316955ms","start":"2026-08-13T00:57:12.678273Z","end":"2026-08-13T00:57:12.79059Z","steps":["trace[1229604660] 'agreement among raft nodes before linearized reading' (duration: 112.120132ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T00:57:12.849853Z","caller":"traceutil/trace.go:171","msg":"trace[1759738165] transaction","detail":"{read_only:false; response_revision:4870; number_of_response:1; }","duration":"168.059944ms","start":"2026-08-13T00:57:12.681763Z","end":"2026-08-13T00:57:12.849823Z","steps":["trace[1759738165] 'process raft request' (duration: 167.741398ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T00:57:12.849971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.074654ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:16233"} {"level":"info","ts":"2026-08-13T00:57:12.850417Z","caller":"traceutil/trace.go:171","msg":"trace[1123014242] range","detail":"{range_begin:/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4870; }","duration":"169.564204ms","start":"2026-08-13T00:57:12.680828Z","end":"2026-08-13T00:57:12.850392Z","steps":["trace[1123014242] 'agreement among raft nodes before linearized reading' (duration: 168.88251ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T00:57:13.866872Z","caller":"traceutil/trace.go:171","msg":"trace[1137951156] transaction","detail":"{read_only:false; response_revision:4893; number_of_response:1; }","duration":"141.50341ms","start":"2026-08-13T00:57:13.725311Z","end":"2026-08-13T00:57:13.866815Z","steps":["trace[1137951156] 'process raft request' (duration: 123.40932ms)","trace[1137951156] 'compare' (duration: 17.782784ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T00:57:15.804195Z","caller":"traceutil/trace.go:171","msg":"trace[84894151] transaction","detail":"{read_only:false; response_revision:5015; number_of_response:1; }","duration":"135.909243ms","start":"2026-08-13T00:57:15.668245Z","end":"2026-08-13T00:57:15.804155Z","steps":["trace[84894151] 'process raft request' (duration: 113.744384ms)","trace[84894151] 'compare' (duration: 22.015136ms)"],"step_count":2} {"level":"warn","ts":"2026-08-13T00:57:17.848273Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.287484ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-13T00:57:17.848349Z","caller":"traceutil/trace.go:171","msg":"trace[1228323179] range","detail":"{range_begin:/registry/roles/; range_end:/registry/roles0; response_count:0; response_revision:5047; }","duration":"113.381536ms","start":"2026-08-13T00:57:17.734953Z","end":"2026-08-13T00:57:17.848335Z","steps":["trace[1228323179] 'count revisions from in-memory index tree' (duration: 113.188553ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T00:57:29.9524Z","caller":"traceutil/trace.go:171","msg":"trace[518321782] transaction","detail":"{read_only:false; response_revision:5281; number_of_response:1; }","duration":"305.291928ms","start":"2026-08-13T00:57:29.647092Z","end":"2026-08-13T00:57:29.952384Z","steps":["trace[518321782] 'process raft request' (duration: 305.181906ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T00:57:29.952533Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T00:57:29.647082Z","time spent":"305.388371ms","remote":"127.0.0.1:57298","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8038,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-13T00:57:29.96514Z","caller":"traceutil/trace.go:171","msg":"trace[1270893216] transaction","detail":"{read_only:false; response_revision:5282; number_of_response:1; }","duration":"245.631434ms","start":"2026-08-13T00:57:29.719478Z","end":"2026-08-13T00:57:29.965109Z","steps":["trace[1270893216] 'process raft request' (duration: 244.331339ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T00:57:37.284939Z","caller":"traceutil/trace.go:171","msg":"trace[1048462925] transaction","detail":"{read_only:false; response_revision:5451; number_of_response:1; }","duration":"263.196723ms","start":"2026-08-13T00:57:37.021713Z","end":"2026-08-13T00:57:37.284909Z","steps":["trace[1048462925] 'process raft request' (duration: 254.403933ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T00:58:41.117119Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2967} {"level":"info","ts":"2026-08-13T00:58:41.409803Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2967,"took":"291.056303ms","hash":1540271685,"current-db-size-bytes":58290176,"current-db-size":"58 MB","current-db-size-in-use-bytes":34045952,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-08-13T00:58:41.409904Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1540271685,"revision":2967,"compact-revision":-1} {"level":"info","ts":"2026-08-13T01:03:41.124609Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6042} {"level":"info","ts":"2026-08-13T01:03:41.229791Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6042,"took":"102.97703ms","hash":1481748527,"current-db-size-bytes":58290176,"current-db-size":"58 MB","current-db-size-in-use-bytes":21155840,"current-db-size-in-use":"21 MB"} {"level":"info","ts":"2026-08-13T01:03:41.229872Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1481748527,"revision":6042,"compact-revision":2967} {"level":"warn","ts":"2026-08-13T01:04:06.556061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.422431ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-13T01:04:06.556163Z","caller":"traceutil/trace.go:171","msg":"trace[1212091788] linearizableReadLoop","detail":"{readStateIndex:8680; appliedIndex:8679; }","duration":"303.106082ms","start":"2026-08-13T01:04:06.253043Z","end":"2026-08-13T01:04:06.556149Z","steps":["trace[1212091788] 'read index received' (duration: 191.419297ms)","trace[1212091788] 'applied index is now lower than readState.Index' (duration: 111.685895ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T01:04:06.556232Z","caller":"traceutil/trace.go:171","msg":"trace[1559712969] transaction","detail":"{read_only:false; response_revision:8390; number_of_response:1; }","duration":"319.569569ms","start":"2026-08-13T01:04:06.236655Z","end":"2026-08-13T01:04:06.556224Z","steps":["trace[1559712969] 'process raft request' (duration: 207.902474ms)","trace[1559712969] 'compare' (duration: 111.310338ms)"],"step_count":2} {"level":"warn","ts":"2026-08-13T01:04:06.556281Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T01:04:06.236628Z","time spent":"319.621659ms","remote":"127.0.0.1:57356","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-13T01:04:06.556663Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.294219ms","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-13T01:04:06.556685Z","caller":"traceutil/trace.go:171","msg":"trace[1586733186] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8390; }","duration":"173.317769ms","start":"2026-08-13T01:04:06.38336Z","end":"2026-08-13T01:04:06.556678Z","steps":["trace[1586733186] 'agreement among raft nodes before linearized reading' (duration: 173.225288ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T01:04:06.556677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.625482ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-13T01:04:06.556678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.143631ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-r267x\" ","response":"range_response_count:1 size:6524"} {"level":"warn","ts":"2026-08-13T01:04:06.556817Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.468892ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-08-13T01:04:06.556834Z","caller":"traceutil/trace.go:171","msg":"trace[695226261] range","detail":"{range_begin:/registry/pods/openstack/keepalived-r267x; range_end:; response_count:1; response_revision:8390; }","duration":"191.367196ms","start":"2026-08-13T01:04:06.365441Z","end":"2026-08-13T01:04:06.556808Z","steps":["trace[695226261] 'agreement among raft nodes before linearized reading' (duration: 191.028689ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:04:06.556737Z","caller":"traceutil/trace.go:171","msg":"trace[1256820101] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8390; }","duration":"303.722634ms","start":"2026-08-13T01:04:06.252997Z","end":"2026-08-13T01:04:06.55672Z","steps":["trace[1256820101] 'agreement among raft nodes before linearized reading' (duration: 303.620632ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:04:06.556944Z","caller":"traceutil/trace.go:171","msg":"trace[645271648] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8390; }","duration":"173.656126ms","start":"2026-08-13T01:04:06.383263Z","end":"2026-08-13T01:04:06.556919Z","steps":["trace[645271648] 'agreement among raft nodes before linearized reading' (duration: 173.33207ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T01:04:06.556994Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T01:04:06.252983Z","time spent":"303.996779ms","remote":"127.0.0.1:57126","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":26,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-08-13T01:04:14.873772Z","caller":"traceutil/trace.go:171","msg":"trace[1584427755] linearizableReadLoop","detail":"{readStateIndex:8723; appliedIndex:8722; }","duration":"203.355067ms","start":"2026-08-13T01:04:14.670394Z","end":"2026-08-13T01:04:14.873749Z","steps":["trace[1584427755] 'read index received' (duration: 153.235514ms)","trace[1584427755] 'applied index is now lower than readState.Index' (duration: 50.118322ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T01:04:14.873917Z","caller":"traceutil/trace.go:171","msg":"trace[696119348] transaction","detail":"{read_only:false; response_revision:8431; number_of_response:1; }","duration":"259.414433ms","start":"2026-08-13T01:04:14.614489Z","end":"2026-08-13T01:04:14.873903Z","steps":["trace[696119348] 'process raft request' (duration: 209.121918ms)","trace[696119348] 'compare' (duration: 49.868347ms)"],"step_count":2} {"level":"warn","ts":"2026-08-13T01:04:14.874226Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.810895ms","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-13T01:04:14.87431Z","caller":"traceutil/trace.go:171","msg":"trace[21307764] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8432; }","duration":"203.973948ms","start":"2026-08-13T01:04:14.670318Z","end":"2026-08-13T01:04:14.874292Z","steps":["trace[21307764] 'agreement among raft nodes before linearized reading' (duration: 203.779864ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T01:04:14.874445Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.473019ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-08-13T01:04:14.874493Z","caller":"traceutil/trace.go:171","msg":"trace[731941307] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8432; }","duration":"203.5552ms","start":"2026-08-13T01:04:14.670927Z","end":"2026-08-13T01:04:14.874482Z","steps":["trace[731941307] 'agreement among raft nodes before linearized reading' (duration: 203.404557ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T01:04:14.87464Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.02985ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-r267x\" ","response":"range_response_count:1 size:6524"} {"level":"info","ts":"2026-08-13T01:04:14.874674Z","caller":"traceutil/trace.go:171","msg":"trace[2043988166] range","detail":"{range_begin:/registry/pods/openstack/keepalived-r267x; range_end:; response_count:1; response_revision:8432; }","duration":"189.095672ms","start":"2026-08-13T01:04:14.68557Z","end":"2026-08-13T01:04:14.874666Z","steps":["trace[2043988166] 'agreement among raft nodes before linearized reading' (duration: 188.99883ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:04:30.351708Z","caller":"traceutil/trace.go:171","msg":"trace[1105569591] transaction","detail":"{read_only:false; response_revision:8520; number_of_response:1; }","duration":"114.738354ms","start":"2026-08-13T01:04:30.236915Z","end":"2026-08-13T01:04:30.351654Z","steps":["trace[1105569591] 'process raft request' (duration: 114.486199ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:04:30.654984Z","caller":"traceutil/trace.go:171","msg":"trace[1870164839] transaction","detail":"{read_only:false; response_revision:8522; number_of_response:1; }","duration":"158.088406ms","start":"2026-08-13T01:04:30.496839Z","end":"2026-08-13T01:04:30.654928Z","steps":["trace[1870164839] 'process raft request' (duration: 155.325133ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:04:42.840712Z","caller":"traceutil/trace.go:171","msg":"trace[169251616] linearizableReadLoop","detail":"{readStateIndex:8934; appliedIndex:8933; }","duration":"341.497719ms","start":"2026-08-13T01:04:42.499184Z","end":"2026-08-13T01:04:42.840682Z","steps":["trace[169251616] 'read index received' (duration: 341.318606ms)","trace[169251616] 'applied index is now lower than readState.Index' (duration: 177.613µs)"],"step_count":2} {"level":"info","ts":"2026-08-13T01:04:42.840771Z","caller":"traceutil/trace.go:171","msg":"trace[1988260340] transaction","detail":"{read_only:false; response_revision:8635; number_of_response:1; }","duration":"432.563399ms","start":"2026-08-13T01:04:42.408176Z","end":"2026-08-13T01:04:42.84074Z","steps":["trace[1988260340] 'process raft request' (duration: 432.332524ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T01:04:42.840924Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T01:04:42.408153Z","time spent":"432.689561ms","remote":"127.0.0.1:57356","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-13T01:04:42.840999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.792556ms","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-13T01:04:42.841037Z","caller":"traceutil/trace.go:171","msg":"trace[807894870] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8635; }","duration":"341.892177ms","start":"2026-08-13T01:04:42.499134Z","end":"2026-08-13T01:04:42.841026Z","steps":["trace[807894870] 'agreement among raft nodes before linearized reading' (duration: 341.678063ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T01:04:42.841067Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T01:04:42.499092Z","time spent":"341.968899ms","remote":"127.0.0.1:57356","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-13T01:04:47.316228Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.060128ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-13T01:04:47.316352Z","caller":"traceutil/trace.go:171","msg":"trace[406613458] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8663; }","duration":"106.248841ms","start":"2026-08-13T01:04:47.210073Z","end":"2026-08-13T01:04:47.316322Z","steps":["trace[406613458] 'range keys from in-memory index tree' (duration: 105.960005ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:04:53.120383Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002345.wal"} {"level":"info","ts":"2026-08-13T01:04:55.851812Z","caller":"traceutil/trace.go:171","msg":"trace[1418241784] transaction","detail":"{read_only:false; response_revision:8751; number_of_response:1; }","duration":"129.617631ms","start":"2026-08-13T01:04:55.722159Z","end":"2026-08-13T01:04:55.851776Z","steps":["trace[1418241784] 'process raft request' (duration: 129.404957ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:04:55.968365Z","caller":"traceutil/trace.go:171","msg":"trace[1595328142] linearizableReadLoop","detail":"{readStateIndex:9058; appliedIndex:9057; }","duration":"193.266292ms","start":"2026-08-13T01:04:55.775068Z","end":"2026-08-13T01:04:55.968334Z","steps":["trace[1595328142] 'read index received' (duration: 77.422197ms)","trace[1595328142] 'applied index is now lower than readState.Index' (duration: 115.843105ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T01:04:55.968486Z","caller":"traceutil/trace.go:171","msg":"trace[1074848778] transaction","detail":"{read_only:false; response_revision:8752; number_of_response:1; }","duration":"241.333926ms","start":"2026-08-13T01:04:55.727087Z","end":"2026-08-13T01:04:55.968421Z","steps":["trace[1074848778] 'process raft request' (duration: 206.258912ms)","trace[1074848778] 'compare' (duration: 34.837499ms)"],"step_count":2} {"level":"warn","ts":"2026-08-13T01:04:55.96855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.448395ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/servicemonitors/\" range_end:\"/registry/monitoring.coreos.com/servicemonitors0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-13T01:04:55.968597Z","caller":"traceutil/trace.go:171","msg":"trace[86695691] range","detail":"{range_begin:/registry/monitoring.coreos.com/servicemonitors/; range_end:/registry/monitoring.coreos.com/servicemonitors0; response_count:0; response_revision:8752; }","duration":"193.562338ms","start":"2026-08-13T01:04:55.775022Z","end":"2026-08-13T01:04:55.968585Z","steps":["trace[86695691] 'agreement among raft nodes before linearized reading' (duration: 193.435956ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:04:56.503881Z","caller":"traceutil/trace.go:171","msg":"trace[713411542] transaction","detail":"{read_only:false; response_revision:8754; number_of_response:1; }","duration":"103.094651ms","start":"2026-08-13T01:04:56.400757Z","end":"2026-08-13T01:04:56.503852Z","steps":["trace[713411542] 'process raft request' (duration: 102.924666ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:04:56.519684Z","caller":"traceutil/trace.go:171","msg":"trace[33566348] transaction","detail":"{read_only:false; response_revision:8755; number_of_response:1; }","duration":"111.190706ms","start":"2026-08-13T01:04:56.408466Z","end":"2026-08-13T01:04:56.519657Z","steps":["trace[33566348] 'process raft request' (duration: 111.020613ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:06:17.36667Z","caller":"traceutil/trace.go:171","msg":"trace[57661836] transaction","detail":"{read_only:false; response_revision:9524; number_of_response:1; }","duration":"156.239493ms","start":"2026-08-13T01:06:17.210414Z","end":"2026-08-13T01:06:17.366653Z","steps":["trace[57661836] 'process raft request' (duration: 156.131071ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T01:06:17.366854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.216122ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-13T01:06:17.366918Z","caller":"traceutil/trace.go:171","msg":"trace[1410802202] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:9524; }","duration":"156.316614ms","start":"2026-08-13T01:06:17.210581Z","end":"2026-08-13T01:06:17.366898Z","steps":["trace[1410802202] 'agreement among raft nodes before linearized reading' (duration: 156.200512ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:06:17.366722Z","caller":"traceutil/trace.go:171","msg":"trace[694962114] linearizableReadLoop","detail":"{readStateIndex:9853; appliedIndex:9853; }","duration":"156.053879ms","start":"2026-08-13T01:06:17.21062Z","end":"2026-08-13T01:06:17.366674Z","steps":["trace[694962114] 'read index received' (duration: 156.045729ms)","trace[694962114] 'applied index is now lower than readState.Index' (duration: 6.75µs)"],"step_count":2} {"level":"warn","ts":"2026-08-13T01:06:17.384794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.9394ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-13T01:06:17.384877Z","caller":"traceutil/trace.go:171","msg":"trace[207501737] range","detail":"{range_begin:/registry/endpointslices/; range_end:/registry/endpointslices0; response_count:0; response_revision:9525; }","duration":"152.067333ms","start":"2026-08-13T01:06:17.232792Z","end":"2026-08-13T01:06:17.384859Z","steps":["trace[207501737] 'agreement among raft nodes before linearized reading' (duration: 151.819637ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:06:17.555466Z","caller":"traceutil/trace.go:171","msg":"trace[1748151522] transaction","detail":"{read_only:false; response_revision:9527; number_of_response:1; }","duration":"165.960329ms","start":"2026-08-13T01:06:17.389482Z","end":"2026-08-13T01:06:17.555442Z","steps":["trace[1748151522] 'process raft request' (duration: 94.052588ms)","trace[1748151522] 'compare' (duration: 71.775899ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T01:06:17.555452Z","caller":"traceutil/trace.go:171","msg":"trace[2119277110] linearizableReadLoop","detail":"{readStateIndex:9856; appliedIndex:9855; }","duration":"114.070801ms","start":"2026-08-13T01:06:17.441362Z","end":"2026-08-13T01:06:17.555432Z","steps":["trace[2119277110] 'read index received' (duration: 42.119599ms)","trace[2119277110] 'applied index is now lower than readState.Index' (duration: 71.950092ms)"],"step_count":2} {"level":"warn","ts":"2026-08-13T01:06:17.555555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.172924ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-13T01:06:17.555594Z","caller":"traceutil/trace.go:171","msg":"trace[1535991113] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:9527; }","duration":"114.256445ms","start":"2026-08-13T01:06:17.441328Z","end":"2026-08-13T01:06:17.555584Z","steps":["trace[1535991113] 'agreement among raft nodes before linearized reading' (duration: 114.172933ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:06:34.020636Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"aab6040abcf11","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-08-13T01:06:34.026736Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-08-13T01:06:34.026882Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-08-13T01:08:41.134661Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8081} {"level":"info","ts":"2026-08-13T01:08:41.195868Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8081,"took":"59.649017ms","hash":3328584105,"current-db-size-bytes":58290176,"current-db-size":"58 MB","current-db-size-in-use-bytes":27922432,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-08-13T01:08:41.195927Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3328584105,"revision":8081,"compact-revision":6042} {"level":"info","ts":"2026-08-13T01:13:41.142682Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10488} {"level":"info","ts":"2026-08-13T01:13:41.228274Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10488,"took":"81.71046ms","hash":4103042374,"current-db-size-bytes":58290176,"current-db-size":"58 MB","current-db-size-in-use-bytes":26501120,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-08-13T01:13:41.228351Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4103042374,"revision":10488,"compact-revision":8081} {"level":"warn","ts":"2026-08-13T01:18:34.393222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.259775ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-13T01:18:34.393389Z","caller":"traceutil/trace.go:171","msg":"trace[1155522382] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:14616; }","duration":"113.50714ms","start":"2026-08-13T01:18:34.279831Z","end":"2026-08-13T01:18:34.393338Z","steps":["trace[1155522382] 'count revisions from in-memory index tree' (duration: 113.141754ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T01:18:35.18268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.152485ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/topicpermissions/\" range_end:\"/registry/rabbitmq.com/topicpermissions0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-13T01:18:35.182801Z","caller":"traceutil/trace.go:171","msg":"trace[1532529868] range","detail":"{range_begin:/registry/rabbitmq.com/topicpermissions/; range_end:/registry/rabbitmq.com/topicpermissions0; response_count:0; response_revision:14619; }","duration":"212.331597ms","start":"2026-08-13T01:18:34.970443Z","end":"2026-08-13T01:18:35.182774Z","steps":["trace[1532529868] 'count revisions from in-memory index tree' (duration: 212.051992ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T01:18:35.183314Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.468079ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-barbican-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-08-13T01:18:35.183434Z","caller":"traceutil/trace.go:171","msg":"trace[1491620994] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-barbican-server-0; range_end:; response_count:1; response_revision:14619; }","duration":"201.628762ms","start":"2026-08-13T01:18:34.981789Z","end":"2026-08-13T01:18:35.183417Z","steps":["trace[1491620994] 'range keys from in-memory index tree' (duration: 201.264935ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:18:41.151188Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12674} {"level":"info","ts":"2026-08-13T01:18:41.224306Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12674,"took":"70.545315ms","hash":1726648612,"current-db-size-bytes":58290176,"current-db-size":"58 MB","current-db-size-in-use-bytes":27328512,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-08-13T01:18:41.224352Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1726648612,"revision":12674,"compact-revision":10488} {"level":"info","ts":"2026-08-13T01:20:25.407402Z","caller":"traceutil/trace.go:171","msg":"trace[495084838] transaction","detail":"{read_only:false; response_revision:15877; number_of_response:1; }","duration":"173.39096ms","start":"2026-08-13T01:20:25.233966Z","end":"2026-08-13T01:20:25.407357Z","steps":["trace[495084838] 'process raft request' (duration: 107.667588ms)","trace[495084838] 'compare' (duration: 65.541819ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T01:20:26.519744Z","caller":"traceutil/trace.go:171","msg":"trace[2127776651] transaction","detail":"{read_only:false; response_revision:15884; number_of_response:1; }","duration":"145.85944ms","start":"2026-08-13T01:20:26.373859Z","end":"2026-08-13T01:20:26.519718Z","steps":["trace[2127776651] 'process raft request' (duration: 145.685197ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:20:26.614241Z","caller":"traceutil/trace.go:171","msg":"trace[267752865] linearizableReadLoop","detail":"{readStateIndex:16429; appliedIndex:16426; }","duration":"132.351881ms","start":"2026-08-13T01:20:26.481841Z","end":"2026-08-13T01:20:26.614193Z","steps":["trace[267752865] 'read index received' (duration: 37.699483ms)","trace[267752865] 'applied index is now lower than readState.Index' (duration: 94.651118ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T01:20:26.614333Z","caller":"traceutil/trace.go:171","msg":"trace[1318601232] transaction","detail":"{read_only:false; response_revision:15885; number_of_response:1; }","duration":"237.737336ms","start":"2026-08-13T01:20:26.376556Z","end":"2026-08-13T01:20:26.614293Z","steps":["trace[1318601232] 'process raft request' (duration: 237.41677ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:20:26.614371Z","caller":"traceutil/trace.go:171","msg":"trace[1007278823] transaction","detail":"{read_only:false; response_revision:15886; number_of_response:1; }","duration":"214.636941ms","start":"2026-08-13T01:20:26.399692Z","end":"2026-08-13T01:20:26.614329Z","steps":["trace[1007278823] 'process raft request' (duration: 214.429347ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T01:20:26.61444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.559755ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-13T01:20:26.614474Z","caller":"traceutil/trace.go:171","msg":"trace[1290287890] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:15886; }","duration":"132.680427ms","start":"2026-08-13T01:20:26.481783Z","end":"2026-08-13T01:20:26.614464Z","steps":["trace[1290287890] 'agreement among raft nodes before linearized reading' (duration: 132.561935ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T01:20:26.614679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.674938ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:667"} {"level":"info","ts":"2026-08-13T01:20:26.614733Z","caller":"traceutil/trace.go:171","msg":"trace[1523513682] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:15886; }","duration":"132.83097ms","start":"2026-08-13T01:20:26.481887Z","end":"2026-08-13T01:20:26.614718Z","steps":["trace[1523513682] 'agreement among raft nodes before linearized reading' (duration: 132.598886ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T01:20:26.614839Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.815926ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5521"} {"level":"info","ts":"2026-08-13T01:20:26.614946Z","caller":"traceutil/trace.go:171","msg":"trace[1242528273] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:15886; }","duration":"113.962128ms","start":"2026-08-13T01:20:26.500961Z","end":"2026-08-13T01:20:26.614923Z","steps":["trace[1242528273] 'agreement among raft nodes before linearized reading' (duration: 113.658442ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:23:23.03031Z","caller":"traceutil/trace.go:171","msg":"trace[459898809] transaction","detail":"{read_only:false; response_revision:17290; number_of_response:1; }","duration":"122.8862ms","start":"2026-08-13T01:23:22.907395Z","end":"2026-08-13T01:23:23.030281Z","steps":["trace[459898809] 'process raft request' (duration: 122.707806ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:23:23.041891Z","caller":"traceutil/trace.go:171","msg":"trace[24266409] transaction","detail":"{read_only:false; response_revision:17291; number_of_response:1; }","duration":"115.572099ms","start":"2026-08-13T01:23:22.926292Z","end":"2026-08-13T01:23:23.041864Z","steps":["trace[24266409] 'process raft request' (duration: 115.432406ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:23:41.15742Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14664} {"level":"info","ts":"2026-08-13T01:23:41.234729Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14664,"took":"74.304067ms","hash":1272190596,"current-db-size-bytes":58290176,"current-db-size":"58 MB","current-db-size-in-use-bytes":34213888,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-08-13T01:23:41.234789Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1272190596,"revision":14664,"compact-revision":12674} {"level":"info","ts":"2026-08-13T01:26:07.987178Z","caller":"traceutil/trace.go:171","msg":"trace[356428051] transaction","detail":"{read_only:false; response_revision:18475; number_of_response:1; }","duration":"208.31483ms","start":"2026-08-13T01:26:07.778835Z","end":"2026-08-13T01:26:07.98715Z","steps":["trace[356428051] 'process raft request' (duration: 208.138967ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:26:07.988413Z","caller":"traceutil/trace.go:171","msg":"trace[740070813] transaction","detail":"{read_only:false; response_revision:18476; number_of_response:1; }","duration":"207.86454ms","start":"2026-08-13T01:26:07.78052Z","end":"2026-08-13T01:26:07.988385Z","steps":["trace[740070813] 'process raft request' (duration: 207.538134ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:26:09.826474Z","caller":"traceutil/trace.go:171","msg":"trace[1060416417] linearizableReadLoop","detail":"{readStateIndex:19112; appliedIndex:19111; }","duration":"103.813373ms","start":"2026-08-13T01:26:09.722634Z","end":"2026-08-13T01:26:09.826447Z","steps":["trace[1060416417] 'read index received' (duration: 103.64032ms)","trace[1060416417] 'applied index is now lower than readState.Index' (duration: 172.293µs)"],"step_count":2} {"level":"warn","ts":"2026-08-13T01:26:09.827136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.445566ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-001781e3-324f-479c-9352-0d4377b91e09\" ","response":"range_response_count:1 size:3943"} {"level":"info","ts":"2026-08-13T01:26:09.827293Z","caller":"traceutil/trace.go:171","msg":"trace[469580091] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-001781e3-324f-479c-9352-0d4377b91e09; range_end:; response_count:1; response_revision:18486; }","duration":"104.638029ms","start":"2026-08-13T01:26:09.722627Z","end":"2026-08-13T01:26:09.827265Z","steps":["trace[469580091] 'agreement among raft nodes before linearized reading' (duration: 104.158109ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:26:09.82735Z","caller":"traceutil/trace.go:171","msg":"trace[1234599873] transaction","detail":"{read_only:false; response_revision:18486; number_of_response:1; }","duration":"105.959864ms","start":"2026-08-13T01:26:09.721347Z","end":"2026-08-13T01:26:09.827307Z","steps":["trace[1234599873] 'process raft request' (duration: 104.827202ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:27:36.124158Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"aab6040abcf11","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-08-13T01:27:36.130673Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-08-13T01:27:36.130817Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-08-13T01:28:41.167043Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17422} {"level":"info","ts":"2026-08-13T01:28:41.271626Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17422,"took":"99.050012ms","hash":2256951618,"current-db-size-bytes":58290176,"current-db-size":"58 MB","current-db-size-in-use-bytes":34840576,"current-db-size-in-use":"35 MB"} {"level":"info","ts":"2026-08-13T01:28:41.271739Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2256951618,"revision":17422,"compact-revision":14664} {"level":"warn","ts":"2026-08-13T01:31:53.387539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.294683ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-13T01:31:53.38763Z","caller":"traceutil/trace.go:171","msg":"trace[1420810601] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:21094; }","duration":"177.443316ms","start":"2026-08-13T01:31:53.210172Z","end":"2026-08-13T01:31:53.387615Z","steps":["trace[1420810601] 'range keys from in-memory index tree' (duration: 177.216392ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T01:31:53.387851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.023706ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephcosidrivers/\" range_end:\"/registry/ceph.rook.io/cephcosidrivers0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-13T01:31:53.387876Z","caller":"traceutil/trace.go:171","msg":"trace[905033201] range","detail":"{range_begin:/registry/ceph.rook.io/cephcosidrivers/; range_end:/registry/ceph.rook.io/cephcosidrivers0; response_count:0; response_revision:21094; }","duration":"218.154268ms","start":"2026-08-13T01:31:53.169714Z","end":"2026-08-13T01:31:53.387868Z","steps":["trace[905033201] 'count revisions from in-memory index tree' (duration: 217.866323ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:31:53.398353Z","caller":"traceutil/trace.go:171","msg":"trace[762633865] transaction","detail":"{read_only:false; response_revision:21095; number_of_response:1; }","duration":"141.808303ms","start":"2026-08-13T01:31:53.25651Z","end":"2026-08-13T01:31:53.398318Z","steps":["trace[762633865] 'process raft request' (duration: 141.476176ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:32:03.867978Z","caller":"traceutil/trace.go:171","msg":"trace[182768552] linearizableReadLoop","detail":"{readStateIndex:21864; appliedIndex:21863; }","duration":"109.633964ms","start":"2026-08-13T01:32:03.758317Z","end":"2026-08-13T01:32:03.86795Z","steps":["trace[182768552] 'read index received' (duration: 109.41273ms)","trace[182768552] 'applied index is now lower than readState.Index' (duration: 220.274µs)"],"step_count":2} {"level":"warn","ts":"2026-08-13T01:32:03.8682Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.853028ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-08-13T01:32:03.868239Z","caller":"traceutil/trace.go:171","msg":"trace[296711209] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:21149; }","duration":"109.94452ms","start":"2026-08-13T01:32:03.758283Z","end":"2026-08-13T01:32:03.868227Z","steps":["trace[296711209] 'agreement among raft nodes before linearized reading' (duration: 109.774287ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:32:03.868592Z","caller":"traceutil/trace.go:171","msg":"trace[1626697512] transaction","detail":"{read_only:false; response_revision:21149; number_of_response:1; }","duration":"127.15876ms","start":"2026-08-13T01:32:03.741423Z","end":"2026-08-13T01:32:03.868581Z","steps":["trace[1626697512] 'process raft request' (duration: 126.364065ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T01:32:09.552354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.49482ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-08-13T01:32:09.558496Z","caller":"traceutil/trace.go:171","msg":"trace[1871252113] transaction","detail":"{read_only:false; response_revision:21177; number_of_response:1; }","duration":"100.450418ms","start":"2026-08-13T01:32:09.458017Z","end":"2026-08-13T01:32:09.558467Z","steps":["trace[1871252113] 'process raft request' (duration: 100.285344ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T01:32:09.822133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.091335ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-08-13T01:32:09.822235Z","caller":"traceutil/trace.go:171","msg":"trace[1213466774] linearizableReadLoop","detail":"{readStateIndex:21896; appliedIndex:21895; }","duration":"240.028039ms","start":"2026-08-13T01:32:09.58219Z","end":"2026-08-13T01:32:09.822218Z","steps":["trace[1213466774] 'read index received' (duration: 119.716009ms)","trace[1213466774] 'applied index is now lower than readState.Index' (duration: 120.3109ms)"],"step_count":2} {"level":"warn","ts":"2026-08-13T01:32:09.822459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.054222ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-08-13T01:32:09.822494Z","caller":"traceutil/trace.go:171","msg":"trace[1180648360] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:21178; }","duration":"236.090374ms","start":"2026-08-13T01:32:09.586394Z","end":"2026-08-13T01:32:09.822484Z","steps":["trace[1180648360] 'agreement among raft nodes before linearized reading' (duration: 235.91952ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:32:09.822532Z","caller":"traceutil/trace.go:171","msg":"trace[1723325572] transaction","detail":"{read_only:false; response_revision:21178; number_of_response:1; }","duration":"282.586314ms","start":"2026-08-13T01:32:09.539841Z","end":"2026-08-13T01:32:09.822427Z","steps":["trace[1723325572] 'process raft request' (duration: 162.118492ms)","trace[1723325572] 'compare' (duration: 119.852841ms)"],"step_count":2} {"level":"warn","ts":"2026-08-13T01:32:09.822571Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.352915ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-08-13T01:32:09.822688Z","caller":"traceutil/trace.go:171","msg":"trace[439172652] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:21178; }","duration":"240.515198ms","start":"2026-08-13T01:32:09.582147Z","end":"2026-08-13T01:32:09.822662Z","steps":["trace[439172652] 'agreement among raft nodes before linearized reading' (duration: 240.160361ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:32:09.974202Z","caller":"traceutil/trace.go:171","msg":"trace[62137436] transaction","detail":"{read_only:false; response_revision:21179; number_of_response:1; }","duration":"147.213307ms","start":"2026-08-13T01:32:09.826939Z","end":"2026-08-13T01:32:09.974152Z","steps":["trace[62137436] 'process raft request' (duration: 131.680759ms)","trace[62137436] 'compare' (duration: 15.320114ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T01:32:10.182785Z","caller":"traceutil/trace.go:171","msg":"trace[684619001] transaction","detail":"{read_only:false; response_revision:21180; number_of_response:1; }","duration":"355.721059ms","start":"2026-08-13T01:32:09.82701Z","end":"2026-08-13T01:32:10.182731Z","steps":["trace[684619001] 'process raft request' (duration: 292.649159ms)","trace[684619001] 'compare' (duration: 62.884827ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T01:32:10.182937Z","caller":"traceutil/trace.go:171","msg":"trace[1193775019] transaction","detail":"{read_only:false; response_revision:21182; number_of_response:1; }","duration":"272.722975ms","start":"2026-08-13T01:32:09.910187Z","end":"2026-08-13T01:32:10.18291Z","steps":["trace[1193775019] 'process raft request' (duration: 272.503011ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T01:32:10.183056Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T01:32:09.826978Z","time spent":"355.976074ms","remote":"127.0.0.1:57356","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-13T01:32:10.183236Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"332.271299ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-08-13T01:32:10.182793Z","caller":"traceutil/trace.go:171","msg":"trace[1463971304] linearizableReadLoop","detail":"{readStateIndex:21898; appliedIndex:21896; }","duration":"331.786159ms","start":"2026-08-13T01:32:09.850935Z","end":"2026-08-13T01:32:10.182721Z","steps":["trace[1463971304] 'read index received' (duration: 107.700817ms)","trace[1463971304] 'applied index is now lower than readState.Index' (duration: 224.084662ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T01:32:10.184417Z","caller":"traceutil/trace.go:171","msg":"trace[2055847280] transaction","detail":"{read_only:false; response_revision:21181; number_of_response:1; }","duration":"286.567211ms","start":"2026-08-13T01:32:09.896451Z","end":"2026-08-13T01:32:10.183018Z","steps":["trace[2055847280] 'process raft request' (duration: 286.207835ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T01:32:10.184655Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.071162ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-08-13T01:32:10.183308Z","caller":"traceutil/trace.go:171","msg":"trace[1457752498] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:21182; }","duration":"332.403452ms","start":"2026-08-13T01:32:09.850887Z","end":"2026-08-13T01:32:10.183291Z","steps":["trace[1457752498] 'agreement among raft nodes before linearized reading' (duration: 332.175516ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T01:32:10.184773Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T01:32:09.85087Z","time spent":"333.895449ms","remote":"127.0.0.1:49362","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":65,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true "} {"level":"info","ts":"2026-08-13T01:32:10.184762Z","caller":"traceutil/trace.go:171","msg":"trace[1455773145] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:21182; }","duration":"212.248655ms","start":"2026-08-13T01:32:09.972458Z","end":"2026-08-13T01:32:10.184706Z","steps":["trace[1455773145] 'agreement among raft nodes before linearized reading' (duration: 211.798717ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T01:32:10.18528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.264817ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-08-13T01:32:10.185341Z","caller":"traceutil/trace.go:171","msg":"trace[1463904166] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:21182; }","duration":"210.363639ms","start":"2026-08-13T01:32:09.974959Z","end":"2026-08-13T01:32:10.185323Z","steps":["trace[1463904166] 'agreement among raft nodes before linearized reading' (duration: 210.167125ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T01:32:10.185406Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.198323ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"info","ts":"2026-08-13T01:32:10.1855Z","caller":"traceutil/trace.go:171","msg":"trace[1306975743] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:21182; }","duration":"212.346686ms","start":"2026-08-13T01:32:09.973131Z","end":"2026-08-13T01:32:10.185478Z","steps":["trace[1306975743] 'agreement among raft nodes before linearized reading' (duration: 212.04715ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T01:32:10.449948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.219948ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-08-13T01:32:10.450164Z","caller":"traceutil/trace.go:171","msg":"trace[486243579] transaction","detail":"{read_only:false; response_revision:21183; number_of_response:1; }","duration":"260.316867ms","start":"2026-08-13T01:32:10.189827Z","end":"2026-08-13T01:32:10.450144Z","steps":["trace[486243579] 'process raft request' (duration: 138.820844ms)","trace[486243579] 'compare' (duration: 121.123146ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T01:32:10.450518Z","caller":"traceutil/trace.go:171","msg":"trace[715209370] transaction","detail":"{read_only:false; response_revision:21184; number_of_response:1; }","duration":"259.794037ms","start":"2026-08-13T01:32:10.190682Z","end":"2026-08-13T01:32:10.450476Z","steps":["trace[715209370] 'process raft request' (duration: 259.41543ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:32:10.450686Z","caller":"traceutil/trace.go:171","msg":"trace[316980253] transaction","detail":"{read_only:false; response_revision:21185; number_of_response:1; }","duration":"259.982981ms","start":"2026-08-13T01:32:10.190682Z","end":"2026-08-13T01:32:10.450665Z","steps":["trace[316980253] 'process raft request' (duration: 259.690145ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:32:10.450682Z","caller":"traceutil/trace.go:171","msg":"trace[428177143] linearizableReadLoop","detail":"{readStateIndex:21903; appliedIndex:21900; }","duration":"240.414836ms","start":"2026-08-13T01:32:10.210236Z","end":"2026-08-13T01:32:10.450651Z","steps":["trace[428177143] 'read index received' (duration: 118.510275ms)","trace[428177143] 'applied index is now lower than readState.Index' (duration: 121.903301ms)"],"step_count":2} {"level":"warn","ts":"2026-08-13T01:32:10.450846Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.578228ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-13T01:32:10.452276Z","caller":"traceutil/trace.go:171","msg":"trace[857101515] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:21185; }","duration":"240.734092ms","start":"2026-08-13T01:32:10.210177Z","end":"2026-08-13T01:32:10.450911Z","steps":["trace[857101515] 'agreement among raft nodes before linearized reading' (duration: 240.585379ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:33:41.177899Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19759} {"level":"info","ts":"2026-08-13T01:33:41.292766Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19759,"took":"111.071923ms","hash":1139901278,"current-db-size-bytes":58290176,"current-db-size":"58 MB","current-db-size-in-use-bytes":29917184,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-08-13T01:33:41.292832Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1139901278,"revision":19759,"compact-revision":17422} {"level":"info","ts":"2026-08-13T01:36:08.225559Z","caller":"traceutil/trace.go:171","msg":"trace[792919743] transaction","detail":"{read_only:false; response_revision:23660; number_of_response:1; }","duration":"121.216697ms","start":"2026-08-13T01:36:08.104321Z","end":"2026-08-13T01:36:08.225538Z","steps":["trace[792919743] 'process raft request' (duration: 120.718568ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:36:08.512027Z","caller":"traceutil/trace.go:171","msg":"trace[1369300335] linearizableReadLoop","detail":"{readStateIndex:24454; appliedIndex:24453; }","duration":"172.534414ms","start":"2026-08-13T01:36:08.33946Z","end":"2026-08-13T01:36:08.511995Z","steps":["trace[1369300335] 'read index received' (duration: 132.726588ms)","trace[1369300335] 'applied index is now lower than readState.Index' (duration: 39.806286ms)"],"step_count":2} {"level":"warn","ts":"2026-08-13T01:36:08.512226Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.745437ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-08-13T01:36:08.51227Z","caller":"traceutil/trace.go:171","msg":"trace[1300036819] range","detail":"{range_begin:/registry/ingressclasses/; range_end:/registry/ingressclasses0; response_count:0; response_revision:23661; }","duration":"172.854889ms","start":"2026-08-13T01:36:08.3394Z","end":"2026-08-13T01:36:08.512254Z","steps":["trace[1300036819] 'agreement among raft nodes before linearized reading' (duration: 172.718007ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:36:08.512448Z","caller":"traceutil/trace.go:171","msg":"trace[1298593651] transaction","detail":"{read_only:false; response_revision:23661; number_of_response:1; }","duration":"201.138572ms","start":"2026-08-13T01:36:08.311274Z","end":"2026-08-13T01:36:08.512413Z","steps":["trace[1298593651] 'process raft request' (duration: 160.892239ms)","trace[1298593651] 'compare' (duration: 39.308555ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T01:36:08.515636Z","caller":"traceutil/trace.go:171","msg":"trace[429295672] transaction","detail":"{read_only:false; response_revision:23662; number_of_response:1; }","duration":"125.834897ms","start":"2026-08-13T01:36:08.389772Z","end":"2026-08-13T01:36:08.515607Z","steps":["trace[429295672] 'process raft request' (duration: 125.676184ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:38:41.185187Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":21973} {"level":"info","ts":"2026-08-13T01:38:41.294078Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":21973,"took":"104.728981ms","hash":795546477,"current-db-size-bytes":58290176,"current-db-size":"58 MB","current-db-size-in-use-bytes":43712512,"current-db-size-in-use":"44 MB"} {"level":"info","ts":"2026-08-13T01:38:41.294162Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":795546477,"revision":21973,"compact-revision":19759} {"level":"info","ts":"2026-08-13T01:43:41.191218Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":25092} {"level":"info","ts":"2026-08-13T01:43:41.331352Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":25092,"took":"136.528441ms","hash":962624887,"current-db-size-bytes":58290176,"current-db-size":"58 MB","current-db-size-in-use-bytes":30289920,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-08-13T01:43:41.331409Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":962624887,"revision":25092,"compact-revision":21973} {"level":"info","ts":"2026-08-13T01:45:40.168512Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-00000000000071d2.wal"}