{"level":"warn","ts":"2026-10-17T11:30:35.477452Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-17T11:30:35.477556Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.208: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://162.253.55.208:2380","--initial-cluster=instance=https://162.253.55.208:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.208:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.208: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-10-17T11:30:35.477625Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-17T11:30:35.477638Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.208:2380"]} {"level":"info","ts":"2026-10-17T11:30:35.477655Z","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-10-17T11:30:35.478302Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.208:2379"]} {"level":"info","ts":"2026-10-17T11:30:35.47841Z","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://162.253.55.208:2380"],"listen-peer-urls":["https://162.253.55.208:2380"],"advertise-client-urls":["https://162.253.55.208:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.208:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.208: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-10-17T11:30:35.482919Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.25502ms"} {"level":"info","ts":"2026-10-17T11:30:35.492829Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"5019b1666ea94ec4","cluster-id":"5aff54f2fc6d3e3d"} {"level":"info","ts":"2026-10-17T11:30:35.492961Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5019b1666ea94ec4 switched to configuration voters=()"} {"level":"info","ts":"2026-10-17T11:30:35.492992Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5019b1666ea94ec4 became follower at term 0"} {"level":"info","ts":"2026-10-17T11:30:35.493007Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 5019b1666ea94ec4 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-10-17T11:30:35.493025Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5019b1666ea94ec4 became follower at term 1"} {"level":"info","ts":"2026-10-17T11:30:35.493091Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5019b1666ea94ec4 switched to configuration voters=(5771839450953371332)"} {"level":"warn","ts":"2026-10-17T11:30:35.501525Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-10-17T11:30:35.505158Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-10-17T11:30:35.507227Z","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-10-17T11:30:35.510711Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"5019b1666ea94ec4","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-10-17T11:30:35.511416Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"5019b1666ea94ec4","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-10-17T11:30:35.511362Z","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-10-17T11:30:35.511557Z","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-10-17T11:30:35.511583Z","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-10-17T11:30:35.514242Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5019b1666ea94ec4 switched to configuration voters=(5771839450953371332)"} {"level":"info","ts":"2026-10-17T11:30:35.514949Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"5aff54f2fc6d3e3d","local-member-id":"5019b1666ea94ec4","added-peer-id":"5019b1666ea94ec4","added-peer-peer-urls":["https://162.253.55.208:2380"]} {"level":"info","ts":"2026-10-17T11:30:35.517804Z","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-10-17T11:30:35.518028Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.208:2380"} {"level":"info","ts":"2026-10-17T11:30:35.518088Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.208:2380"} {"level":"info","ts":"2026-10-17T11:30:35.518351Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"5019b1666ea94ec4","initial-advertise-peer-urls":["https://162.253.55.208:2380"],"listen-peer-urls":["https://162.253.55.208:2380"],"advertise-client-urls":["https://162.253.55.208:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.208:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-10-17T11:30:35.518443Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-10-17T11:30:35.89423Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5019b1666ea94ec4 is starting a new election at term 1"} {"level":"info","ts":"2026-10-17T11:30:35.894301Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5019b1666ea94ec4 became pre-candidate at term 1"} {"level":"info","ts":"2026-10-17T11:30:35.894339Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5019b1666ea94ec4 received MsgPreVoteResp from 5019b1666ea94ec4 at term 1"} {"level":"info","ts":"2026-10-17T11:30:35.89436Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5019b1666ea94ec4 became candidate at term 2"} {"level":"info","ts":"2026-10-17T11:30:35.894388Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5019b1666ea94ec4 received MsgVoteResp from 5019b1666ea94ec4 at term 2"} {"level":"info","ts":"2026-10-17T11:30:35.894406Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5019b1666ea94ec4 became leader at term 2"} {"level":"info","ts":"2026-10-17T11:30:35.894427Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 5019b1666ea94ec4 elected leader 5019b1666ea94ec4 at term 2"} {"level":"info","ts":"2026-10-17T11:30:35.898753Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-10-17T11:30:35.939792Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"5019b1666ea94ec4","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.208:2379]}","request-path":"/0/members/5019b1666ea94ec4/attributes","cluster-id":"5aff54f2fc6d3e3d","publish-timeout":"7s"} {"level":"info","ts":"2026-10-17T11:30:35.939802Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-17T11:30:35.939923Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-17T11:30:35.940225Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-10-17T11:30:35.940323Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-10-17T11:30:35.943244Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.208:2379"} {"level":"info","ts":"2026-10-17T11:30:35.943473Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-10-17T11:30:35.986141Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"5aff54f2fc6d3e3d","local-member-id":"5019b1666ea94ec4","cluster-version":"3.5"} {"level":"info","ts":"2026-10-17T11:30:35.986323Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-10-17T11:30:35.986369Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-10-17T11:30:49.998691Z","caller":"traceutil/trace.go:171","msg":"trace[553541464] transaction","detail":"{read_only:false; response_revision:402; number_of_response:1; }","duration":"135.922747ms","start":"2026-10-17T11:30:49.862734Z","end":"2026-10-17T11:30:49.998657Z","steps":["trace[553541464] 'process raft request' (duration: 135.525218ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:30:50.235052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.559527ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-17T11:30:50.235191Z","caller":"traceutil/trace.go:171","msg":"trace[1575846225] linearizableReadLoop","detail":"{readStateIndex:417; appliedIndex:416; }","duration":"155.469905ms","start":"2026-10-17T11:30:50.079703Z","end":"2026-10-17T11:30:50.235173Z","steps":["trace[1575846225] 'read index received' (duration: 46.841µs)","trace[1575846225] 'applied index is now lower than readState.Index' (duration: 155.421624ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T11:30:50.235309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.605479ms","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-10-17T11:30:50.235297Z","caller":"traceutil/trace.go:171","msg":"trace[1723368978] transaction","detail":"{read_only:false; response_revision:403; number_of_response:1; }","duration":"232.40802ms","start":"2026-10-17T11:30:50.002846Z","end":"2026-10-17T11:30:50.235255Z","steps":["trace[1723368978] 'process raft request' (duration: 56.020874ms)","trace[1723368978] 'compare' (duration: 175.413124ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:30:50.235344Z","caller":"traceutil/trace.go:171","msg":"trace[1414060564] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:403; }","duration":"155.67957ms","start":"2026-10-17T11:30:50.079654Z","end":"2026-10-17T11:30:50.235334Z","steps":["trace[1414060564] 'agreement among raft nodes before linearized reading' (duration: 155.611759ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:30:50.576053Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.999488ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-17T11:30:50.576245Z","caller":"traceutil/trace.go:171","msg":"trace[431173699] transaction","detail":"{read_only:false; response_revision:405; number_of_response:1; }","duration":"335.777195ms","start":"2026-10-17T11:30:50.240452Z","end":"2026-10-17T11:30:50.576229Z","steps":["trace[431173699] 'process raft request' (duration: 335.716213ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:30:50.576323Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:30:50.240435Z","time spent":"335.857036ms","remote":"127.0.0.1:44522","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T11:30:50.576392Z","caller":"traceutil/trace.go:171","msg":"trace[334496660] transaction","detail":"{read_only:false; response_revision:404; number_of_response:1; }","duration":"335.853846ms","start":"2026-10-17T11:30:50.240447Z","end":"2026-10-17T11:30:50.576301Z","steps":["trace[334496660] 'process raft request' (duration: 133.528022ms)","trace[334496660] 'compare' (duration: 201.843643ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T11:30:50.57671Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:30:50.240422Z","time spent":"336.098192ms","remote":"127.0.0.1:44522","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T11:30:50.690621Z","caller":"traceutil/trace.go:171","msg":"trace[1507449182] transaction","detail":"{read_only:false; response_revision:406; number_of_response:1; }","duration":"441.740969ms","start":"2026-10-17T11:30:50.24884Z","end":"2026-10-17T11:30:50.690581Z","steps":["trace[1507449182] 'process raft request' (duration: 441.510364ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:30:50.690837Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:30:50.248819Z","time spent":"441.901554ms","remote":"127.0.0.1:44428","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7288,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T11:31:20.515443Z","caller":"traceutil/trace.go:171","msg":"trace[656438601] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"116.992302ms","start":"2026-10-17T11:31:20.398402Z","end":"2026-10-17T11:31:20.515394Z","steps":["trace[656438601] 'process raft request' (duration: 116.723386ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:31:21.33837Z","caller":"traceutil/trace.go:171","msg":"trace[875653704] transaction","detail":"{read_only:false; response_revision:561; number_of_response:1; }","duration":"221.272638ms","start":"2026-10-17T11:31:21.117022Z","end":"2026-10-17T11:31:21.338295Z","steps":["trace[875653704] 'process raft request' (duration: 203.842001ms)","trace[875653704] 'compare' (duration: 16.960916ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:31:21.338464Z","caller":"traceutil/trace.go:171","msg":"trace[56233165] transaction","detail":"{read_only:false; response_revision:562; number_of_response:1; }","duration":"219.530017ms","start":"2026-10-17T11:31:21.118899Z","end":"2026-10-17T11:31:21.338429Z","steps":["trace[56233165] 'process raft request' (duration: 219.24139ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:31:21.338797Z","caller":"traceutil/trace.go:171","msg":"trace[904578654] transaction","detail":"{read_only:false; response_revision:563; number_of_response:1; }","duration":"217.729505ms","start":"2026-10-17T11:31:21.121012Z","end":"2026-10-17T11:31:21.338742Z","steps":["trace[904578654] 'process raft request' (duration: 217.279395ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:31:21.338869Z","caller":"traceutil/trace.go:171","msg":"trace[716940897] transaction","detail":"{read_only:false; response_revision:564; number_of_response:1; }","duration":"213.513767ms","start":"2026-10-17T11:31:21.12534Z","end":"2026-10-17T11:31:21.338854Z","steps":["trace[716940897] 'process raft request' (duration: 213.290142ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:31:21.338876Z","caller":"traceutil/trace.go:171","msg":"trace[1316515916] transaction","detail":"{read_only:false; response_revision:565; number_of_response:1; }","duration":"205.169761ms","start":"2026-10-17T11:31:21.133673Z","end":"2026-10-17T11:31:21.338843Z","steps":["trace[1316515916] 'process raft request' (duration: 205.09068ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:31:21.376666Z","caller":"traceutil/trace.go:171","msg":"trace[1353556013] transaction","detail":"{read_only:false; response_revision:566; number_of_response:1; }","duration":"209.115424ms","start":"2026-10-17T11:31:21.167517Z","end":"2026-10-17T11:31:21.376633Z","steps":["trace[1353556013] 'process raft request' (duration: 208.822067ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:31:21.377172Z","caller":"traceutil/trace.go:171","msg":"trace[334599220] transaction","detail":"{read_only:false; response_revision:569; number_of_response:1; }","duration":"134.658965ms","start":"2026-10-17T11:31:21.242502Z","end":"2026-10-17T11:31:21.377161Z","steps":["trace[334599220] 'process raft request' (duration: 134.593744ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:31:21.377444Z","caller":"traceutil/trace.go:171","msg":"trace[1330530057] transaction","detail":"{read_only:false; number_of_response:1; response_revision:566; }","duration":"207.643859ms","start":"2026-10-17T11:31:21.169746Z","end":"2026-10-17T11:31:21.37739Z","steps":["trace[1330530057] 'process raft request' (duration: 206.83875ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:31:21.377459Z","caller":"traceutil/trace.go:171","msg":"trace[279959838] transaction","detail":"{read_only:false; response_revision:568; number_of_response:1; }","duration":"200.39977ms","start":"2026-10-17T11:31:21.177Z","end":"2026-10-17T11:31:21.3774Z","steps":["trace[279959838] 'process raft request' (duration: 199.98956ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:31:21.377729Z","caller":"traceutil/trace.go:171","msg":"trace[2014102363] transaction","detail":"{read_only:false; response_revision:567; number_of_response:1; }","duration":"206.81833ms","start":"2026-10-17T11:31:21.170898Z","end":"2026-10-17T11:31:21.377716Z","steps":["trace[2014102363] 'process raft request' (duration: 205.990771ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:31:27.402575Z","caller":"traceutil/trace.go:171","msg":"trace[876694128] transaction","detail":"{read_only:false; response_revision:646; number_of_response:1; }","duration":"318.238232ms","start":"2026-10-17T11:31:27.084274Z","end":"2026-10-17T11:31:27.402512Z","steps":["trace[876694128] 'process raft request' (duration: 312.291633ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:31:27.402912Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:31:27.084229Z","time spent":"318.459317ms","remote":"127.0.0.1:44336","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036221,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T11:31:27.560555Z","caller":"traceutil/trace.go:171","msg":"trace[377280592] transaction","detail":"{read_only:false; response_revision:647; number_of_response:1; }","duration":"131.060321ms","start":"2026-10-17T11:31:27.429454Z","end":"2026-10-17T11:31:27.560515Z","steps":["trace[377280592] 'process raft request' (duration: 124.450527ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:31:28.431978Z","caller":"traceutil/trace.go:171","msg":"trace[2015296944] linearizableReadLoop","detail":"{readStateIndex:672; appliedIndex:671; }","duration":"407.64666ms","start":"2026-10-17T11:31:28.024303Z","end":"2026-10-17T11:31:28.431949Z","steps":["trace[2015296944] 'read index received' (duration: 405.881799ms)","trace[2015296944] 'applied index is now lower than readState.Index' (duration: 1.763351ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T11:31:28.432154Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"407.839175ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-17T11:31:28.432195Z","caller":"traceutil/trace.go:171","msg":"trace[673786086] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:649; }","duration":"407.954807ms","start":"2026-10-17T11:31:28.024227Z","end":"2026-10-17T11:31:28.432182Z","steps":["trace[673786086] 'agreement among raft nodes before linearized reading' (duration: 407.862115ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:31:28.432165Z","caller":"traceutil/trace.go:171","msg":"trace[1789961080] transaction","detail":"{read_only:false; response_revision:649; number_of_response:1; }","duration":"444.680765ms","start":"2026-10-17T11:31:27.987444Z","end":"2026-10-17T11:31:28.432125Z","steps":["trace[1789961080] 'process raft request' (duration: 443.130129ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:31:28.432238Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:31:28.024201Z","time spent":"408.02913ms","remote":"127.0.0.1:44238","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-10-17T11:31:28.432452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.268127ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-10-17T11:31:28.432564Z","caller":"traceutil/trace.go:171","msg":"trace[988284516] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:649; }","duration":"203.450842ms","start":"2026-10-17T11:31:28.229088Z","end":"2026-10-17T11:31:28.432539Z","steps":["trace[988284516] 'agreement among raft nodes before linearized reading' (duration: 203.123954ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:31:28.43256Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:31:27.987404Z","time spent":"444.930031ms","remote":"127.0.0.1:44336","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036257,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T11:31:29.609574Z","caller":"traceutil/trace.go:171","msg":"trace[547760370] transaction","detail":"{read_only:false; response_revision:663; number_of_response:1; }","duration":"115.526408ms","start":"2026-10-17T11:31:29.493986Z","end":"2026-10-17T11:31:29.609512Z","steps":["trace[547760370] 'process raft request' (duration: 101.188413ms)","trace[547760370] 'compare' (duration: 13.819663ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:31:44.724297Z","caller":"traceutil/trace.go:171","msg":"trace[237595094] linearizableReadLoop","detail":"{readStateIndex:848; appliedIndex:847; }","duration":"184.947689ms","start":"2026-10-17T11:31:44.539321Z","end":"2026-10-17T11:31:44.724269Z","steps":["trace[237595094] 'read index received' (duration: 184.637112ms)","trace[237595094] 'applied index is now lower than readState.Index' (duration: 308.977µs)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:31:44.724463Z","caller":"traceutil/trace.go:171","msg":"trace[1192372529] transaction","detail":"{read_only:false; response_revision:820; number_of_response:1; }","duration":"230.888703ms","start":"2026-10-17T11:31:44.493539Z","end":"2026-10-17T11:31:44.724428Z","steps":["trace[1192372529] 'process raft request' (duration: 230.532085ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:31:44.724775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.41881ms","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-10-17T11:31:44.724854Z","caller":"traceutil/trace.go:171","msg":"trace[2120310330] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:820; }","duration":"185.565283ms","start":"2026-10-17T11:31:44.539271Z","end":"2026-10-17T11:31:44.724836Z","steps":["trace[2120310330] 'agreement among raft nodes before linearized reading' (duration: 185.275067ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:33:08.062281Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.438959ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-17T11:33:08.062624Z","caller":"traceutil/trace.go:171","msg":"trace[425070127] transaction","detail":"{read_only:false; response_revision:1923; number_of_response:1; }","duration":"504.701172ms","start":"2026-10-17T11:33:07.557847Z","end":"2026-10-17T11:33:08.062548Z","steps":["trace[425070127] 'process raft request' (duration: 255.549076ms)","trace[425070127] 'compare' (duration: 248.227694ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T11:33:08.062871Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:33:07.557826Z","time spent":"504.905156ms","remote":"127.0.0.1:44522","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T11:33:08.063257Z","caller":"traceutil/trace.go:171","msg":"trace[1505508045] transaction","detail":"{read_only:false; response_revision:1924; number_of_response:1; }","duration":"496.824797ms","start":"2026-10-17T11:33:07.566415Z","end":"2026-10-17T11:33:08.06324Z","steps":["trace[1505508045] 'process raft request' (duration: 496.007718ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:33:08.063371Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:33:07.566399Z","time spent":"496.896248ms","remote":"127.0.0.1:44522","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T11:33:08.063588Z","caller":"traceutil/trace.go:171","msg":"trace[1758217271] transaction","detail":"{read_only:false; response_revision:1925; number_of_response:1; }","duration":"219.001678ms","start":"2026-10-17T11:33:07.844572Z","end":"2026-10-17T11:33:08.063574Z","steps":["trace[1758217271] 'process raft request' (duration: 218.518017ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:33:08.063513Z","caller":"traceutil/trace.go:171","msg":"trace[762963953] linearizableReadLoop","detail":"{readStateIndex:1997; appliedIndex:1994; }","duration":"121.094671ms","start":"2026-10-17T11:33:07.942397Z","end":"2026-10-17T11:33:08.063492Z","steps":["trace[762963953] 'read index received' (duration: 72.532µs)","trace[762963953] 'applied index is now lower than readState.Index' (duration: 121.021059ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T11:33:08.063955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.48924ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-0973aa3c-15c5-4671-b52e-ad579bd5e00c\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-10-17T11:33:08.064086Z","caller":"traceutil/trace.go:171","msg":"trace[1542174528] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-0973aa3c-15c5-4671-b52e-ad579bd5e00c; range_end:; response_count:1; response_revision:1925; }","duration":"121.736206ms","start":"2026-10-17T11:33:07.942318Z","end":"2026-10-17T11:33:08.064055Z","steps":["trace[1542174528] 'agreement among raft nodes before linearized reading' (duration: 121.390298ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:33:08.483385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.130165ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-17T11:33:08.483657Z","caller":"traceutil/trace.go:171","msg":"trace[312211002] linearizableReadLoop","detail":"{readStateIndex:1999; appliedIndex:1997; }","duration":"226.688699ms","start":"2026-10-17T11:33:08.256947Z","end":"2026-10-17T11:33:08.483636Z","steps":["trace[312211002] 'read index received' (duration: 88.072µs)","trace[312211002] 'applied index is now lower than readState.Index' (duration: 226.599267ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:33:08.483719Z","caller":"traceutil/trace.go:171","msg":"trace[1646435741] transaction","detail":"{read_only:false; response_revision:1927; number_of_response:1; }","duration":"410.723276ms","start":"2026-10-17T11:33:08.072967Z","end":"2026-10-17T11:33:08.48369Z","steps":["trace[1646435741] 'process raft request' (duration: 410.567803ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:33:08.483842Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:33:08.072922Z","time spent":"410.858129ms","remote":"127.0.0.1:44522","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T11:33:08.483933Z","caller":"traceutil/trace.go:171","msg":"trace[24460793] transaction","detail":"{read_only:false; response_revision:1926; number_of_response:1; }","duration":"411.254239ms","start":"2026-10-17T11:33:08.072641Z","end":"2026-10-17T11:33:08.483895Z","steps":["trace[24460793] 'process raft request' (duration: 92.423278ms)","trace[24460793] 'compare' (duration: 317.839988ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T11:33:08.483948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.904562ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-0973aa3c-15c5-4671-b52e-ad579bd5e00c\" ","response":"range_response_count:1 size:3747"} {"level":"info","ts":"2026-10-17T11:33:08.484044Z","caller":"traceutil/trace.go:171","msg":"trace[330210025] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-0973aa3c-15c5-4671-b52e-ad579bd5e00c; range_end:; response_count:1; response_revision:1927; }","duration":"137.081936ms","start":"2026-10-17T11:33:08.346944Z","end":"2026-10-17T11:33:08.484026Z","steps":["trace[330210025] 'agreement among raft nodes before linearized reading' (duration: 136.901822ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:33:08.484121Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:33:08.072604Z","time spent":"411.413343ms","remote":"127.0.0.1:44428","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3732,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-17T11:33:08.484022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.051807ms","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-10-17T11:33:08.484263Z","caller":"traceutil/trace.go:171","msg":"trace[1010495239] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1927; }","duration":"227.388185ms","start":"2026-10-17T11:33:08.256857Z","end":"2026-10-17T11:33:08.484246Z","steps":["trace[1010495239] 'agreement among raft nodes before linearized reading' (duration: 226.930785ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:33:21.95093Z","caller":"traceutil/trace.go:171","msg":"trace[143411011] transaction","detail":"{read_only:false; response_revision:2044; number_of_response:1; }","duration":"297.751346ms","start":"2026-10-17T11:33:21.653143Z","end":"2026-10-17T11:33:21.950894Z","steps":["trace[143411011] 'process raft request' (duration: 297.562572ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:33:59.066971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.701698ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-17T11:33:59.067124Z","caller":"traceutil/trace.go:171","msg":"trace[114556808] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:2253; }","duration":"226.870502ms","start":"2026-10-17T11:33:58.840238Z","end":"2026-10-17T11:33:59.067108Z","steps":["trace[114556808] 'range keys from in-memory index tree' (duration: 226.684527ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:33:59.067197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.336837ms","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-10-17T11:33:59.067305Z","caller":"traceutil/trace.go:171","msg":"trace[1770160494] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2253; }","duration":"203.514361ms","start":"2026-10-17T11:33:58.863764Z","end":"2026-10-17T11:33:59.067279Z","steps":["trace[1770160494] 'range keys from in-memory index tree' (duration: 203.102511ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:33:59.755087Z","caller":"traceutil/trace.go:171","msg":"trace[1291052537] linearizableReadLoop","detail":"{readStateIndex:2338; appliedIndex:2336; }","duration":"132.058586ms","start":"2026-10-17T11:33:59.622999Z","end":"2026-10-17T11:33:59.755058Z","steps":["trace[1291052537] 'read index received' (duration: 119.52138ms)","trace[1291052537] 'applied index is now lower than readState.Index' (duration: 12.535746ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:33:59.755188Z","caller":"traceutil/trace.go:171","msg":"trace[1291511719] transaction","detail":"{read_only:false; response_revision:2254; number_of_response:1; }","duration":"195.967283ms","start":"2026-10-17T11:33:59.559193Z","end":"2026-10-17T11:33:59.75516Z","steps":["trace[1291511719] 'process raft request' (duration: 195.653026ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:33:59.755307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.312602ms","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-10-17T11:33:59.755368Z","caller":"traceutil/trace.go:171","msg":"trace[1631425064] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2254; }","duration":"132.451355ms","start":"2026-10-17T11:33:59.622906Z","end":"2026-10-17T11:33:59.755358Z","steps":["trace[1631425064] 'agreement among raft nodes before linearized reading' (duration: 132.26362ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:34:05.185026Z","caller":"traceutil/trace.go:171","msg":"trace[1674230947] linearizableReadLoop","detail":"{readStateIndex:2368; appliedIndex:2367; }","duration":"283.98018ms","start":"2026-10-17T11:34:04.90102Z","end":"2026-10-17T11:34:05.185Z","steps":["trace[1674230947] 'read index received' (duration: 283.882978ms)","trace[1674230947] 'applied index is now lower than readState.Index' (duration: 95.802µs)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:34:05.185152Z","caller":"traceutil/trace.go:171","msg":"trace[1025643551] transaction","detail":"{read_only:false; response_revision:2283; number_of_response:1; }","duration":"353.034679ms","start":"2026-10-17T11:34:04.832078Z","end":"2026-10-17T11:34:05.185113Z","steps":["trace[1025643551] 'process raft request' (duration: 352.770082ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:34:05.185359Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:34:04.83205Z","time spent":"353.185012ms","remote":"127.0.0.1:44522","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-17T11:34:05.185321Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.257396ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-17T11:34:05.185465Z","caller":"traceutil/trace.go:171","msg":"trace[2075695426] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:2283; }","duration":"284.462291ms","start":"2026-10-17T11:34:04.900977Z","end":"2026-10-17T11:34:05.185439Z","steps":["trace[2075695426] 'agreement among raft nodes before linearized reading' (duration: 284.155824ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:34:05.188954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.101482ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-17T11:34:05.188994Z","caller":"traceutil/trace.go:171","msg":"trace[627509335] transaction","detail":"{read_only:false; response_revision:2284; number_of_response:1; }","duration":"269.664392ms","start":"2026-10-17T11:34:04.919288Z","end":"2026-10-17T11:34:05.188953Z","steps":["trace[627509335] 'process raft request' (duration: 269.459107ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:34:05.18904Z","caller":"traceutil/trace.go:171","msg":"trace[1099159076] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2284; }","duration":"164.237495ms","start":"2026-10-17T11:34:05.024782Z","end":"2026-10-17T11:34:05.18902Z","steps":["trace[1099159076] 'agreement among raft nodes before linearized reading' (duration: 164.108782ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:34:51.54394Z","caller":"traceutil/trace.go:171","msg":"trace[1785672566] linearizableReadLoop","detail":"{readStateIndex:2807; appliedIndex:2806; }","duration":"234.012695ms","start":"2026-10-17T11:34:51.309897Z","end":"2026-10-17T11:34:51.54391Z","steps":["trace[1785672566] 'read index received' (duration: 233.860692ms)","trace[1785672566] 'applied index is now lower than readState.Index' (duration: 150.763µs)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:34:51.544096Z","caller":"traceutil/trace.go:171","msg":"trace[1790335324] transaction","detail":"{read_only:false; response_revision:2705; number_of_response:1; }","duration":"234.847725ms","start":"2026-10-17T11:34:51.309206Z","end":"2026-10-17T11:34:51.544054Z","steps":["trace[1790335324] 'process raft request' (duration: 234.515997ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:34:51.544272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.338743ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"} {"level":"info","ts":"2026-10-17T11:34:51.544363Z","caller":"traceutil/trace.go:171","msg":"trace[1943783516] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2705; }","duration":"234.457996ms","start":"2026-10-17T11:34:51.309858Z","end":"2026-10-17T11:34:51.544316Z","steps":["trace[1943783516] 'agreement among raft nodes before linearized reading' (duration: 234.225541ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:35:23.906213Z","caller":"traceutil/trace.go:171","msg":"trace[1520528377] transaction","detail":"{read_only:false; response_revision:2902; number_of_response:1; }","duration":"142.683609ms","start":"2026-10-17T11:35:23.763498Z","end":"2026-10-17T11:35:23.906182Z","steps":["trace[1520528377] 'process raft request' (duration: 142.552145ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:38:41.847804Z","caller":"traceutil/trace.go:171","msg":"trace[953762817] transaction","detail":"{read_only:false; response_revision:4146; number_of_response:1; }","duration":"126.570859ms","start":"2026-10-17T11:38:41.721199Z","end":"2026-10-17T11:38:41.84777Z","steps":["trace[953762817] 'process raft request' (duration: 126.323024ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:40:15.732891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.487832ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1821"} {"level":"info","ts":"2026-10-17T11:40:15.733041Z","caller":"traceutil/trace.go:171","msg":"trace[18031793] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:5241; }","duration":"101.718768ms","start":"2026-10-17T11:40:15.631297Z","end":"2026-10-17T11:40:15.733015Z","steps":["trace[18031793] 'range keys from in-memory index tree' (duration: 101.145244ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:40:15.992259Z","caller":"traceutil/trace.go:171","msg":"trace[1667397606] linearizableReadLoop","detail":"{readStateIndex:5439; appliedIndex:5438; }","duration":"200.788703ms","start":"2026-10-17T11:40:15.79144Z","end":"2026-10-17T11:40:15.992229Z","steps":["trace[1667397606] 'read index received' (duration: 173.324262ms)","trace[1667397606] 'applied index is now lower than readState.Index' (duration: 27.462591ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T11:40:15.992732Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.241964ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-1\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-17T11:40:15.992821Z","caller":"traceutil/trace.go:171","msg":"trace[970948030] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-1; range_end:; response_count:0; response_revision:5243; }","duration":"201.394238ms","start":"2026-10-17T11:40:15.791405Z","end":"2026-10-17T11:40:15.992799Z","steps":["trace[970948030] 'agreement among raft nodes before linearized reading' (duration: 201.191363ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:40:15.992799Z","caller":"traceutil/trace.go:171","msg":"trace[1530149459] transaction","detail":"{read_only:false; response_revision:5243; number_of_response:1; }","duration":"203.883506ms","start":"2026-10-17T11:40:15.788835Z","end":"2026-10-17T11:40:15.992719Z","steps":["trace[1530149459] 'process raft request' (duration: 175.953483ms)","trace[1530149459] 'compare' (duration: 27.126574ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T11:40:16.221656Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.185342ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-17T11:40:16.221772Z","caller":"traceutil/trace.go:171","msg":"trace[1936069455] linearizableReadLoop","detail":"{readStateIndex:5440; appliedIndex:5439; }","duration":"229.397712ms","start":"2026-10-17T11:40:15.992353Z","end":"2026-10-17T11:40:16.221751Z","steps":["trace[1936069455] 'read index received' (duration: 126.066487ms)","trace[1936069455] 'applied index is now lower than readState.Index' (duration: 103.329895ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:40:16.221881Z","caller":"traceutil/trace.go:171","msg":"trace[1705782518] transaction","detail":"{read_only:false; response_revision:5244; number_of_response:1; }","duration":"415.968283ms","start":"2026-10-17T11:40:15.805899Z","end":"2026-10-17T11:40:16.221867Z","steps":["trace[1705782518] 'process raft request' (duration: 312.474924ms)","trace[1705782518] 'compare' (duration: 103.060889ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T11:40:16.221977Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:40:15.805867Z","time spent":"416.043335ms","remote":"127.0.0.1:44522","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-17T11:40:16.222224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.900427ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/kube-prometheus-stack-kube-state-metrics-5c97764fc9-lfs6v\" ","response":"range_response_count:1 size:5151"} {"level":"info","ts":"2026-10-17T11:40:16.222255Z","caller":"traceutil/trace.go:171","msg":"trace[1973556627] range","detail":"{range_begin:/registry/pods/monitoring/kube-prometheus-stack-kube-state-metrics-5c97764fc9-lfs6v; range_end:; response_count:1; response_revision:5244; }","duration":"236.9944ms","start":"2026-10-17T11:40:15.985251Z","end":"2026-10-17T11:40:16.222245Z","steps":["trace[1973556627] 'agreement among raft nodes before linearized reading' (duration: 236.847576ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:40:16.222309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.54328ms","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-10-17T11:40:16.222356Z","caller":"traceutil/trace.go:171","msg":"trace[1832052622] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5244; }","duration":"251.658572ms","start":"2026-10-17T11:40:15.970684Z","end":"2026-10-17T11:40:16.222343Z","steps":["trace[1832052622] 'agreement among raft nodes before linearized reading' (duration: 251.500358ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:40:16.222441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.794376ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-10-17T11:40:16.222522Z","caller":"traceutil/trace.go:171","msg":"trace[96156455] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5244; }","duration":"245.924138ms","start":"2026-10-17T11:40:15.976581Z","end":"2026-10-17T11:40:16.222505Z","steps":["trace[96156455] 'agreement among raft nodes before linearized reading' (duration: 245.639351ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:40:16.222549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.736637ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-web-config\" ","response":"range_response_count:1 size:696"} {"level":"info","ts":"2026-10-17T11:40:16.222612Z","caller":"traceutil/trace.go:171","msg":"trace[1188623306] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-web-config; range_end:; response_count:1; response_revision:5244; }","duration":"225.851189ms","start":"2026-10-17T11:40:15.996743Z","end":"2026-10-17T11:40:16.222595Z","steps":["trace[1188623306] 'agreement among raft nodes before linearized reading' (duration: 225.693425ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:40:16.222618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.373214ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-17T11:40:16.222754Z","caller":"traceutil/trace.go:171","msg":"trace[1944894228] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5244; }","duration":"197.589998ms","start":"2026-10-17T11:40:16.025133Z","end":"2026-10-17T11:40:16.222723Z","steps":["trace[1944894228] 'agreement among raft nodes before linearized reading' (duration: 197.373953ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:40:21.685078Z","caller":"traceutil/trace.go:171","msg":"trace[1885928709] linearizableReadLoop","detail":"{readStateIndex:5601; appliedIndex:5600; }","duration":"175.707587ms","start":"2026-10-17T11:40:21.509331Z","end":"2026-10-17T11:40:21.685039Z","steps":["trace[1885928709] 'read index received' (duration: 175.454931ms)","trace[1885928709] 'applied index is now lower than readState.Index' (duration: 251.266µs)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:40:21.685145Z","caller":"traceutil/trace.go:171","msg":"trace[136841586] transaction","detail":"{read_only:false; response_revision:5400; number_of_response:1; }","duration":"181.991524ms","start":"2026-10-17T11:40:21.503104Z","end":"2026-10-17T11:40:21.685096Z","steps":["trace[136841586] 'process raft request' (duration: 181.677617ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:40:21.685452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.085826ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-17T11:40:21.685598Z","caller":"traceutil/trace.go:171","msg":"trace[2022830388] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:5400; }","duration":"176.27726ms","start":"2026-10-17T11:40:21.509286Z","end":"2026-10-17T11:40:21.685563Z","steps":["trace[2022830388] 'agreement among raft nodes before linearized reading' (duration: 175.936492ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:40:21.685866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.122476ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:25 size:787144"} {"level":"info","ts":"2026-10-17T11:40:21.685916Z","caller":"traceutil/trace.go:171","msg":"trace[438782242] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:25; response_revision:5400; }","duration":"140.251498ms","start":"2026-10-17T11:40:21.545651Z","end":"2026-10-17T11:40:21.685902Z","steps":["trace[438782242] 'agreement among raft nodes before linearized reading' (duration: 139.591583ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:40:22.060829Z","caller":"traceutil/trace.go:171","msg":"trace[364268570] transaction","detail":"{read_only:false; response_revision:5403; number_of_response:1; }","duration":"150.227061ms","start":"2026-10-17T11:40:21.91057Z","end":"2026-10-17T11:40:22.060797Z","steps":["trace[364268570] 'process raft request' (duration: 121.054759ms)","trace[364268570] 'compare' (duration: 28.992418ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:40:36.066309Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2968} {"level":"info","ts":"2026-10-17T11:40:36.207057Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2968,"took":"138.931958ms","hash":350300579,"current-db-size-bytes":56557568,"current-db-size":"57 MB","current-db-size-in-use-bytes":31305728,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-10-17T11:40:36.20716Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":350300579,"revision":2968,"compact-revision":-1} {"level":"info","ts":"2026-10-17T11:40:37.166324Z","caller":"traceutil/trace.go:171","msg":"trace[1281903160] transaction","detail":"{read_only:false; response_revision:5667; number_of_response:1; }","duration":"432.50461ms","start":"2026-10-17T11:40:36.733781Z","end":"2026-10-17T11:40:37.166285Z","steps":["trace[1281903160] 'process raft request' (duration: 367.536971ms)","trace[1281903160] 'compare' (duration: 64.284723ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:40:37.166384Z","caller":"traceutil/trace.go:171","msg":"trace[1725185802] transaction","detail":"{read_only:false; response_revision:5669; number_of_response:1; }","duration":"432.183272ms","start":"2026-10-17T11:40:36.734162Z","end":"2026-10-17T11:40:37.166346Z","steps":["trace[1725185802] 'process raft request' (duration: 432.08818ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:40:37.166425Z","caller":"traceutil/trace.go:171","msg":"trace[1135884917] transaction","detail":"{read_only:false; response_revision:5668; number_of_response:1; }","duration":"432.726385ms","start":"2026-10-17T11:40:36.733641Z","end":"2026-10-17T11:40:37.166367Z","steps":["trace[1135884917] 'process raft request' (duration: 432.415207ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:40:37.166554Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:40:36.733754Z","time spent":"432.686894ms","remote":"127.0.0.1:44538","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1039,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-17T11:40:37.166605Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:40:36.733559Z","time spent":"432.97078ms","remote":"127.0.0.1:44412","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":682,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-17T11:40:37.166669Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:40:36.734139Z","time spent":"432.352846ms","remote":"127.0.0.1:44538","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1068,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T11:40:37.195567Z","caller":"traceutil/trace.go:171","msg":"trace[1031773340] linearizableReadLoop","detail":"{readStateIndex:5880; appliedIndex:5876; }","duration":"322.329264ms","start":"2026-10-17T11:40:36.873187Z","end":"2026-10-17T11:40:37.195516Z","steps":["trace[1031773340] 'read index received' (duration: 228.146793ms)","trace[1031773340] 'applied index is now lower than readState.Index' (duration: 94.181231ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:40:37.195718Z","caller":"traceutil/trace.go:171","msg":"trace[2137824523] transaction","detail":"{read_only:false; response_revision:5670; number_of_response:1; }","duration":"364.297356ms","start":"2026-10-17T11:40:36.831373Z","end":"2026-10-17T11:40:37.19567Z","steps":["trace[2137824523] 'process raft request' (duration: 363.971088ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:40:37.19589Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:40:36.83134Z","time spent":"364.48237ms","remote":"127.0.0.1:44428","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4986,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-17T11:40:37.196186Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"322.970669ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-17T11:40:37.196295Z","caller":"traceutil/trace.go:171","msg":"trace[423572985] range","detail":"{range_begin:/registry/networkpolicies/; range_end:/registry/networkpolicies0; response_count:0; response_revision:5670; }","duration":"323.151684ms","start":"2026-10-17T11:40:36.873118Z","end":"2026-10-17T11:40:37.19627Z","steps":["trace[423572985] 'agreement among raft nodes before linearized reading' (duration: 322.609551ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:40:37.196406Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:40:36.873099Z","time spent":"323.292747ms","remote":"127.0.0.1:44546","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":4,"response size":29,"request content":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true "} {"level":"warn","ts":"2026-10-17T11:40:37.210793Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.694477ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-17T11:40:37.210926Z","caller":"traceutil/trace.go:171","msg":"trace[1216375998] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5671; }","duration":"184.861931ms","start":"2026-10-17T11:40:37.026011Z","end":"2026-10-17T11:40:37.210873Z","steps":["trace[1216375998] 'agreement among raft nodes before linearized reading' (duration: 183.729184ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:40:45.082622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.307483ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-10-17T11:40:45.082773Z","caller":"traceutil/trace.go:171","msg":"trace[2019485853] linearizableReadLoop","detail":"{readStateIndex:6072; appliedIndex:6071; }","duration":"259.28999ms","start":"2026-10-17T11:40:44.823459Z","end":"2026-10-17T11:40:45.082749Z","steps":["trace[2019485853] 'read index received' (duration: 40.651µs)","trace[2019485853] 'applied index is now lower than readState.Index' (duration: 259.247109ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T11:40:45.083037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.526616ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-56767a52-5efa-40a6-b5a3-55906664112b\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-10-17T11:40:45.083085Z","caller":"traceutil/trace.go:171","msg":"trace[127183058] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-56767a52-5efa-40a6-b5a3-55906664112b; range_end:; response_count:1; response_revision:5858; }","duration":"259.68509ms","start":"2026-10-17T11:40:44.823386Z","end":"2026-10-17T11:40:45.083071Z","steps":["trace[127183058] 'agreement among raft nodes before linearized reading' (duration: 259.420354ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:40:45.229545Z","caller":"traceutil/trace.go:171","msg":"trace[434496528] transaction","detail":"{read_only:false; response_revision:5859; number_of_response:1; }","duration":"137.382592ms","start":"2026-10-17T11:40:45.092124Z","end":"2026-10-17T11:40:45.229507Z","steps":["trace[434496528] 'process raft request' (duration: 137.160056ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:45:36.075603Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5644} {"level":"info","ts":"2026-10-17T11:45:36.163465Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5644,"took":"85.747576ms","hash":1454274202,"current-db-size-bytes":56557568,"current-db-size":"57 MB","current-db-size-in-use-bytes":28213248,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-10-17T11:45:36.163565Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1454274202,"revision":5644,"compact-revision":2968} {"level":"info","ts":"2026-10-17T11:47:08.993594Z","caller":"traceutil/trace.go:171","msg":"trace[1247224341] linearizableReadLoop","detail":"{readStateIndex:9050; appliedIndex:9049; }","duration":"196.447655ms","start":"2026-10-17T11:47:08.79712Z","end":"2026-10-17T11:47:08.993567Z","steps":["trace[1247224341] 'read index received' (duration: 196.282931ms)","trace[1247224341] 'applied index is now lower than readState.Index' (duration: 163.334µs)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:47:08.99368Z","caller":"traceutil/trace.go:171","msg":"trace[1529302569] transaction","detail":"{read_only:false; response_revision:8744; number_of_response:1; }","duration":"200.5246ms","start":"2026-10-17T11:47:08.793091Z","end":"2026-10-17T11:47:08.993616Z","steps":["trace[1529302569] 'process raft request' (duration: 200.283115ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:47:08.993924Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.632612ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-10-17T11:47:08.993942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.903801ms","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-10-17T11:47:08.994013Z","caller":"traceutil/trace.go:171","msg":"trace[63790566] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8744; }","duration":"191.780185ms","start":"2026-10-17T11:47:08.802208Z","end":"2026-10-17T11:47:08.993988Z","steps":["trace[63790566] 'agreement among raft nodes before linearized reading' (duration: 191.54559ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:47:08.994032Z","caller":"traceutil/trace.go:171","msg":"trace[1349815249] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8744; }","duration":"169.051995ms","start":"2026-10-17T11:47:08.824952Z","end":"2026-10-17T11:47:08.994004Z","steps":["trace[1349815249] 'agreement among raft nodes before linearized reading' (duration: 168.832689ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:47:08.993912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.779829ms","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-10-17T11:47:08.994213Z","caller":"traceutil/trace.go:171","msg":"trace[1271853740] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:8744; }","duration":"128.134437ms","start":"2026-10-17T11:47:08.86605Z","end":"2026-10-17T11:47:08.994184Z","steps":["trace[1271853740] 'agreement among raft nodes before linearized reading' (duration: 127.721037ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:47:08.994234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.033239ms","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-10-17T11:47:08.994359Z","caller":"traceutil/trace.go:171","msg":"trace[521661718] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8744; }","duration":"197.220513ms","start":"2026-10-17T11:47:08.797097Z","end":"2026-10-17T11:47:08.994318Z","steps":["trace[521661718] 'agreement among raft nodes before linearized reading' (duration: 196.631349ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:47:08.998475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.96698ms","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-10-17T11:47:08.998582Z","caller":"traceutil/trace.go:171","msg":"trace[1578285603] range","detail":"{range_begin:/registry/endpointslices/; range_end:/registry/endpointslices0; response_count:0; response_revision:8744; }","duration":"139.128064ms","start":"2026-10-17T11:47:08.859432Z","end":"2026-10-17T11:47:08.99856Z","steps":["trace[1578285603] 'agreement among raft nodes before linearized reading' (duration: 134.340372ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:47:12.595552Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002373.wal"} {"level":"info","ts":"2026-10-17T11:47:21.245865Z","caller":"traceutil/trace.go:171","msg":"trace[2141448590] linearizableReadLoop","detail":"{readStateIndex:9116; appliedIndex:9115; }","duration":"237.323611ms","start":"2026-10-17T11:47:21.008512Z","end":"2026-10-17T11:47:21.245836Z","steps":["trace[2141448590] 'read index received' (duration: 237.119096ms)","trace[2141448590] 'applied index is now lower than readState.Index' (duration: 203.135µs)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:47:21.24596Z","caller":"traceutil/trace.go:171","msg":"trace[956400933] transaction","detail":"{read_only:false; response_revision:8807; number_of_response:1; }","duration":"243.353432ms","start":"2026-10-17T11:47:21.00256Z","end":"2026-10-17T11:47:21.245913Z","steps":["trace[956400933] 'process raft request' (duration: 243.071566ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:47:21.246094Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.537745ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-17T11:47:21.246179Z","caller":"traceutil/trace.go:171","msg":"trace[1833573487] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:8807; }","duration":"237.666468ms","start":"2026-10-17T11:47:21.008493Z","end":"2026-10-17T11:47:21.24616Z","steps":["trace[1833573487] 'agreement among raft nodes before linearized reading' (duration: 237.477614ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:47:21.251744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.40217ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-10-17T11:47:21.251826Z","caller":"traceutil/trace.go:171","msg":"trace[783195054] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8808; }","duration":"192.553114ms","start":"2026-10-17T11:47:21.059254Z","end":"2026-10-17T11:47:21.251807Z","steps":["trace[783195054] 'agreement among raft nodes before linearized reading' (duration: 192.266857ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:47:21.251929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.932882ms","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-10-17T11:47:21.251991Z","caller":"traceutil/trace.go:171","msg":"trace[251875113] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8808; }","duration":"184.019904ms","start":"2026-10-17T11:47:21.067958Z","end":"2026-10-17T11:47:21.251978Z","steps":["trace[251875113] 'agreement among raft nodes before linearized reading' (duration: 183.745008ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:47:21.252056Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.425334ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-10-17T11:47:21.252113Z","caller":"traceutil/trace.go:171","msg":"trace[494527384] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8808; }","duration":"187.513906ms","start":"2026-10-17T11:47:21.064585Z","end":"2026-10-17T11:47:21.252099Z","steps":["trace[494527384] 'agreement among raft nodes before linearized reading' (duration: 187.373283ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:47:21.252179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.176141ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-10-17T11:47:21.252282Z","caller":"traceutil/trace.go:171","msg":"trace[1953793434] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8808; }","duration":"185.323495ms","start":"2026-10-17T11:47:21.066932Z","end":"2026-10-17T11:47:21.252256Z","steps":["trace[1953793434] 'agreement among raft nodes before linearized reading' (duration: 184.998977ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:47:21.982958Z","caller":"traceutil/trace.go:171","msg":"trace[361435495] transaction","detail":"{read_only:false; response_revision:8814; number_of_response:1; }","duration":"127.058502ms","start":"2026-10-17T11:47:21.855859Z","end":"2026-10-17T11:47:21.982918Z","steps":["trace[361435495] 'process raft request' (duration: 126.443517ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:47:51.83639Z","caller":"traceutil/trace.go:171","msg":"trace[292572062] linearizableReadLoop","detail":"{readStateIndex:9343; appliedIndex:9342; }","duration":"254.547247ms","start":"2026-10-17T11:47:51.581814Z","end":"2026-10-17T11:47:51.836361Z","steps":["trace[292572062] 'read index received' (duration: 254.344872ms)","trace[292572062] 'applied index is now lower than readState.Index' (duration: 200.754µs)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:47:51.836446Z","caller":"traceutil/trace.go:171","msg":"trace[961925458] transaction","detail":"{read_only:false; response_revision:9025; number_of_response:1; }","duration":"256.950133ms","start":"2026-10-17T11:47:51.57946Z","end":"2026-10-17T11:47:51.83641Z","steps":["trace[961925458] 'process raft request' (duration: 256.718277ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:47:51.836737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.861424ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-10-17T11:47:51.836826Z","caller":"traceutil/trace.go:171","msg":"trace[856850966] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:9025; }","duration":"255.015138ms","start":"2026-10-17T11:47:51.581789Z","end":"2026-10-17T11:47:51.836804Z","steps":["trace[856850966] 'agreement among raft nodes before linearized reading' (duration: 254.69054ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:47:52.08964Z","caller":"traceutil/trace.go:171","msg":"trace[1556197821] transaction","detail":"{read_only:false; response_revision:9026; number_of_response:1; }","duration":"318.215337ms","start":"2026-10-17T11:47:51.77139Z","end":"2026-10-17T11:47:52.089606Z","steps":["trace[1556197821] 'process raft request' (duration: 277.528795ms)","trace[1556197821] 'compare' (duration: 40.377455ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T11:47:52.090001Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:47:51.771333Z","time spent":"318.574565ms","remote":"127.0.0.1:44522","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T11:47:52.089768Z","caller":"traceutil/trace.go:171","msg":"trace[234700796] transaction","detail":"{read_only:false; response_revision:9027; number_of_response:1; }","duration":"242.366202ms","start":"2026-10-17T11:47:51.84737Z","end":"2026-10-17T11:47:52.089736Z","steps":["trace[234700796] 'process raft request' (duration: 242.234789ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:47:52.09034Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"508.151881ms","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-10-17T11:47:52.090393Z","caller":"traceutil/trace.go:171","msg":"trace[2145377298] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:9027; }","duration":"508.243184ms","start":"2026-10-17T11:47:51.582138Z","end":"2026-10-17T11:47:52.090381Z","steps":["trace[2145377298] 'agreement among raft nodes before linearized reading' (duration: 507.758853ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:47:52.090367Z","caller":"traceutil/trace.go:171","msg":"trace[304659970] linearizableReadLoop","detail":"{readStateIndex:9344; appliedIndex:9343; }","duration":"253.3951ms","start":"2026-10-17T11:47:51.836472Z","end":"2026-10-17T11:47:52.089867Z","steps":["trace[304659970] 'read index received' (duration: 212.463092ms)","trace[304659970] 'applied index is now lower than readState.Index' (duration: 40.929558ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T11:47:52.090428Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:47:51.582132Z","time spent":"508.288025ms","remote":"127.0.0.1:44522","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-10-17T11:47:52.090519Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"508.51973ms","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-10-17T11:47:52.090674Z","caller":"traceutil/trace.go:171","msg":"trace[423418056] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:9027; }","duration":"508.763216ms","start":"2026-10-17T11:47:51.581873Z","end":"2026-10-17T11:47:52.090636Z","steps":["trace[423418056] 'agreement among raft nodes before linearized reading' (duration: 508.338376ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:47:52.090793Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:47:51.581848Z","time spent":"508.92939ms","remote":"127.0.0.1:44522","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-10-17T11:48:04.061387Z","caller":"traceutil/trace.go:171","msg":"trace[1202178404] transaction","detail":"{read_only:false; response_revision:9089; number_of_response:1; }","duration":"129.615233ms","start":"2026-10-17T11:48:03.931741Z","end":"2026-10-17T11:48:04.061356Z","steps":["trace[1202178404] 'process raft request' (duration: 129.389718ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:48:04.280539Z","caller":"traceutil/trace.go:171","msg":"trace[1104037308] transaction","detail":"{read_only:false; response_revision:9090; number_of_response:1; }","duration":"129.174523ms","start":"2026-10-17T11:48:04.151339Z","end":"2026-10-17T11:48:04.280514Z","steps":["trace[1104037308] 'process raft request' (duration: 128.949598ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:48:04.280791Z","caller":"traceutil/trace.go:171","msg":"trace[297738449] linearizableReadLoop","detail":"{readStateIndex:9410; appliedIndex:9409; }","duration":"123.91504ms","start":"2026-10-17T11:48:04.156552Z","end":"2026-10-17T11:48:04.280467Z","steps":["trace[297738449] 'read index received' (duration: 123.795827ms)","trace[297738449] 'applied index is now lower than readState.Index' (duration: 117.753µs)"],"step_count":2} {"level":"warn","ts":"2026-10-17T11:48:04.280901Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.317409ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-10-17T11:48:04.281008Z","caller":"traceutil/trace.go:171","msg":"trace[1276833171] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:9090; }","duration":"124.473433ms","start":"2026-10-17T11:48:04.156509Z","end":"2026-10-17T11:48:04.280983Z","steps":["trace[1276833171] 'agreement among raft nodes before linearized reading' (duration: 124.170746ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:48:04.314543Z","caller":"traceutil/trace.go:171","msg":"trace[354788994] transaction","detail":"{read_only:false; response_revision:9091; number_of_response:1; }","duration":"145.471204ms","start":"2026-10-17T11:48:04.169052Z","end":"2026-10-17T11:48:04.314523Z","steps":["trace[354788994] 'process raft request' (duration: 145.32202ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:48:04.314833Z","caller":"traceutil/trace.go:171","msg":"trace[1642358859] transaction","detail":"{read_only:false; response_revision:9092; number_of_response:1; }","duration":"142.944085ms","start":"2026-10-17T11:48:04.171849Z","end":"2026-10-17T11:48:04.314793Z","steps":["trace[1642358859] 'process raft request' (duration: 142.627068ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:48:04.314944Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.119097ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-10-17T11:48:04.315057Z","caller":"traceutil/trace.go:171","msg":"trace[1983938853] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:9092; }","duration":"157.2419ms","start":"2026-10-17T11:48:04.157794Z","end":"2026-10-17T11:48:04.315036Z","steps":["trace[1983938853] 'agreement among raft nodes before linearized reading' (duration: 157.003334ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:49:06.550915Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"5019b1666ea94ec4","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-17T11:49:06.580298Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-10-17T11:49:06.580463Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-10-17T11:50:36.08861Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8022} {"level":"info","ts":"2026-10-17T11:50:36.177234Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8022,"took":"85.699126ms","hash":4251008834,"current-db-size-bytes":56557568,"current-db-size":"57 MB","current-db-size-in-use-bytes":25047040,"current-db-size-in-use":"25 MB"} {"level":"info","ts":"2026-10-17T11:50:36.177326Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4251008834,"revision":8022,"compact-revision":5644} {"level":"info","ts":"2026-10-17T11:55:14.880168Z","caller":"traceutil/trace.go:171","msg":"trace[762998443] linearizableReadLoop","detail":"{readStateIndex:12822; appliedIndex:12821; }","duration":"125.294534ms","start":"2026-10-17T11:55:14.754845Z","end":"2026-10-17T11:55:14.88014Z","steps":["trace[762998443] 'read index received' (duration: 125.11882ms)","trace[762998443] 'applied index is now lower than readState.Index' (duration: 174.274µs)"],"step_count":2} {"level":"warn","ts":"2026-10-17T11:55:14.880382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.5266ms","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-10-17T11:55:14.88043Z","caller":"traceutil/trace.go:171","msg":"trace[452373889] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:12398; }","duration":"125.671933ms","start":"2026-10-17T11:55:14.754744Z","end":"2026-10-17T11:55:14.880416Z","steps":["trace[452373889] 'agreement among raft nodes before linearized reading' (duration: 125.52111ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:55:14.880259Z","caller":"traceutil/trace.go:171","msg":"trace[89777631] transaction","detail":"{read_only:false; response_revision:12398; number_of_response:1; }","duration":"154.607128ms","start":"2026-10-17T11:55:14.725595Z","end":"2026-10-17T11:55:14.880202Z","steps":["trace[89777631] 'process raft request' (duration: 154.356782ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:55:15.018494Z","caller":"traceutil/trace.go:171","msg":"trace[2067558207] linearizableReadLoop","detail":"{readStateIndex:12823; appliedIndex:12822; }","duration":"138.223016ms","start":"2026-10-17T11:55:14.880242Z","end":"2026-10-17T11:55:15.018465Z","steps":["trace[2067558207] 'read index received' (duration: 65.917479ms)","trace[2067558207] 'applied index is now lower than readState.Index' (duration: 72.302227ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T11:55:15.018698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.682004ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-ks-user\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-17T11:55:15.018687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.637502ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-storage-init\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-17T11:55:15.018783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.713474ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-rabbit-init\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-17T11:55:15.018687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.595201ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-ks-endpoints\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-17T11:55:15.01885Z","caller":"traceutil/trace.go:171","msg":"trace[1193330722] range","detail":"{range_begin:/registry/jobs/openstack/cinder-ks-endpoints; range_end:; response_count:0; response_revision:12399; }","duration":"212.822577ms","start":"2026-10-17T11:55:14.806015Z","end":"2026-10-17T11:55:15.018837Z","steps":["trace[1193330722] 'agreement among raft nodes before linearized reading' (duration: 212.491739ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:55:15.018863Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.520197ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-10-17T11:55:15.018761Z","caller":"traceutil/trace.go:171","msg":"trace[831549679] transaction","detail":"{read_only:false; response_revision:12399; number_of_response:1; }","duration":"134.07734ms","start":"2026-10-17T11:55:14.884615Z","end":"2026-10-17T11:55:15.018692Z","steps":["trace[831549679] 'process raft request' (duration: 133.761072ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:55:15.018897Z","caller":"traceutil/trace.go:171","msg":"trace[387049530] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:12399; }","duration":"262.585698ms","start":"2026-10-17T11:55:14.756303Z","end":"2026-10-17T11:55:15.018889Z","steps":["trace[387049530] 'agreement among raft nodes before linearized reading' (duration: 262.458395ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:55:15.018795Z","caller":"traceutil/trace.go:171","msg":"trace[1654582520] range","detail":"{range_begin:/registry/jobs/openstack/cinder-storage-init; range_end:; response_count:0; response_revision:12399; }","duration":"212.794316ms","start":"2026-10-17T11:55:14.805974Z","end":"2026-10-17T11:55:15.018768Z","steps":["trace[1654582520] 'agreement among raft nodes before linearized reading' (duration: 212.619472ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:55:15.018712Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.461942ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-db-sync\" ","response":"range_response_count:1 size:5077"} {"level":"info","ts":"2026-10-17T11:55:15.01885Z","caller":"traceutil/trace.go:171","msg":"trace[202620751] range","detail":"{range_begin:/registry/jobs/openstack/cinder-rabbit-init; range_end:; response_count:0; response_revision:12399; }","duration":"212.798547ms","start":"2026-10-17T11:55:14.806036Z","end":"2026-10-17T11:55:15.018835Z","steps":["trace[202620751] 'agreement among raft nodes before linearized reading' (duration: 212.716915ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:55:15.019167Z","caller":"traceutil/trace.go:171","msg":"trace[1879574811] range","detail":"{range_begin:/registry/jobs/openstack/cinder-db-sync; range_end:; response_count:1; response_revision:12399; }","duration":"204.963803ms","start":"2026-10-17T11:55:14.814182Z","end":"2026-10-17T11:55:15.019146Z","steps":["trace[1879574811] 'agreement among raft nodes before linearized reading' (duration: 204.351379ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:55:15.018741Z","caller":"traceutil/trace.go:171","msg":"trace[344861115] range","detail":"{range_begin:/registry/jobs/openstack/cinder-ks-user; range_end:; response_count:0; response_revision:12399; }","duration":"212.736615ms","start":"2026-10-17T11:55:14.805993Z","end":"2026-10-17T11:55:15.01873Z","steps":["trace[344861115] 'agreement among raft nodes before linearized reading' (duration: 212.644513ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:55:36.128324Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10392} {"level":"info","ts":"2026-10-17T11:55:36.213258Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10392,"took":"82.645989ms","hash":1399361512,"current-db-size-bytes":56557568,"current-db-size":"57 MB","current-db-size-in-use-bytes":25460736,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-10-17T11:55:36.213407Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1399361512,"revision":10392,"compact-revision":8022} {"level":"info","ts":"2026-10-17T12:00:36.135869Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12556} {"level":"info","ts":"2026-10-17T12:00:36.222409Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12556,"took":"83.924632ms","hash":3220960718,"current-db-size-bytes":56557568,"current-db-size":"57 MB","current-db-size-in-use-bytes":28377088,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-10-17T12:00:36.222481Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3220960718,"revision":12556,"compact-revision":10392} {"level":"info","ts":"2026-10-17T12:01:44.826679Z","caller":"traceutil/trace.go:171","msg":"trace[908728098] transaction","detail":"{read_only:false; response_revision:15032; number_of_response:1; }","duration":"169.506522ms","start":"2026-10-17T12:01:44.65714Z","end":"2026-10-17T12:01:44.826646Z","steps":["trace[908728098] 'process raft request' (duration: 88.337715ms)","trace[908728098] 'compare' (duration: 81.048045ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T12:01:44.873576Z","caller":"traceutil/trace.go:171","msg":"trace[1677726794] transaction","detail":"{read_only:false; response_revision:15033; number_of_response:1; }","duration":"121.420308ms","start":"2026-10-17T12:01:44.752127Z","end":"2026-10-17T12:01:44.873547Z","steps":["trace[1677726794] 'process raft request' (duration: 121.279805ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T12:01:53.930296Z","caller":"traceutil/trace.go:171","msg":"trace[2027862273] transaction","detail":"{read_only:false; response_revision:15080; number_of_response:1; }","duration":"235.29919ms","start":"2026-10-17T12:01:53.694971Z","end":"2026-10-17T12:01:53.930271Z","steps":["trace[2027862273] 'process raft request' (duration: 235.122076ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T12:01:53.942043Z","caller":"traceutil/trace.go:171","msg":"trace[1700826357] transaction","detail":"{read_only:false; response_revision:15081; number_of_response:1; }","duration":"244.973337ms","start":"2026-10-17T12:01:53.697039Z","end":"2026-10-17T12:01:53.942013Z","steps":["trace[1700826357] 'process raft request' (duration: 244.817193ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T12:02:03.275563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.751318ms","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:7"} {"level":"info","ts":"2026-10-17T12:02:03.275653Z","caller":"traceutil/trace.go:171","msg":"trace[348341069] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:15140; }","duration":"160.885731ms","start":"2026-10-17T12:02:03.114747Z","end":"2026-10-17T12:02:03.275633Z","steps":["trace[348341069] 'count revisions from in-memory index tree' (duration: 160.643346ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T12:02:26.571864Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5675838767995682426,"retry-timeout":"500ms"} {"level":"info","ts":"2026-10-17T12:02:26.593591Z","caller":"traceutil/trace.go:171","msg":"trace[1750730785] transaction","detail":"{read_only:false; response_revision:15456; number_of_response:1; }","duration":"541.880216ms","start":"2026-10-17T12:02:26.051682Z","end":"2026-10-17T12:02:26.593562Z","steps":["trace[1750730785] 'process raft request' (duration: 541.709722ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T12:02:26.593809Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T12:02:26.051649Z","time spent":"542.08438ms","remote":"127.0.0.1:44522","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T12:02:26.614481Z","caller":"traceutil/trace.go:171","msg":"trace[347424987] linearizableReadLoop","detail":"{readStateIndex:15994; appliedIndex:15992; }","duration":"542.861109ms","start":"2026-10-17T12:02:26.071602Z","end":"2026-10-17T12:02:26.614463Z","steps":["trace[347424987] 'read index received' (duration: 521.907389ms)","trace[347424987] 'applied index is now lower than readState.Index' (duration: 20.9523ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T12:02:26.614567Z","caller":"traceutil/trace.go:171","msg":"trace[1492417564] transaction","detail":"{read_only:false; response_revision:15457; number_of_response:1; }","duration":"562.581961ms","start":"2026-10-17T12:02:26.051943Z","end":"2026-10-17T12:02:26.614525Z","steps":["trace[1492417564] 'process raft request' (duration: 562.433937ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T12:02:26.614745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"543.129695ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephclusters/openstack/ceph\" ","response":"range_response_count:1 size:7695"} {"level":"info","ts":"2026-10-17T12:02:26.614857Z","caller":"traceutil/trace.go:171","msg":"trace[1918990311] range","detail":"{range_begin:/registry/ceph.rook.io/cephclusters/openstack/ceph; range_end:; response_count:1; response_revision:15457; }","duration":"543.270968ms","start":"2026-10-17T12:02:26.071571Z","end":"2026-10-17T12:02:26.614842Z","steps":["trace[1918990311] 'agreement among raft nodes before linearized reading' (duration: 543.031542ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T12:02:26.614894Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T12:02:26.07156Z","time spent":"543.32328ms","remote":"127.0.0.1:58352","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":7717,"request content":"key:\"/registry/ceph.rook.io/cephclusters/openstack/ceph\" "} {"level":"warn","ts":"2026-10-17T12:02:26.614788Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T12:02:26.051915Z","time spent":"562.757114ms","remote":"127.0.0.1:44522","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-17T12:02:26.615478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.50002ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/libvirt-libvirt-default-h72hb\" ","response":"range_response_count:1 size:20644"} {"level":"info","ts":"2026-10-17T12:02:26.615526Z","caller":"traceutil/trace.go:171","msg":"trace[768877361] range","detail":"{range_begin:/registry/pods/openstack/libvirt-libvirt-default-h72hb; range_end:; response_count:1; response_revision:15457; }","duration":"106.583072ms","start":"2026-10-17T12:02:26.50893Z","end":"2026-10-17T12:02:26.615513Z","steps":["trace[768877361] 'agreement among raft nodes before linearized reading' (duration: 106.386437ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T12:02:26.61557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.719967ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephclients/\" range_end:\"/registry/ceph.rook.io/cephclients0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-17T12:02:26.615655Z","caller":"traceutil/trace.go:171","msg":"trace[1356540765] range","detail":"{range_begin:/registry/ceph.rook.io/cephclients/; range_end:/registry/ceph.rook.io/cephclients0; response_count:0; response_revision:15457; }","duration":"237.855191ms","start":"2026-10-17T12:02:26.377778Z","end":"2026-10-17T12:02:26.615633Z","steps":["trace[1356540765] 'agreement among raft nodes before linearized reading' (duration: 237.701857ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T12:02:26.615697Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.492674ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-e112a3ec-2932-4aa9-979b-222c888119f5\" ","response":"range_response_count:1 size:3637"} {"level":"info","ts":"2026-10-17T12:02:26.615814Z","caller":"traceutil/trace.go:171","msg":"trace[2096746835] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-e112a3ec-2932-4aa9-979b-222c888119f5; range_end:; response_count:1; response_revision:15457; }","duration":"229.695839ms","start":"2026-10-17T12:02:26.386098Z","end":"2026-10-17T12:02:26.615793Z","steps":["trace[2096746835] 'agreement among raft nodes before linearized reading' (duration: 229.330741ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T12:02:26.615981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"436.369599ms","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-10-17T12:02:26.616034Z","caller":"traceutil/trace.go:171","msg":"trace[1673284940] 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:15457; }","duration":"436.41987ms","start":"2026-10-17T12:02:26.179598Z","end":"2026-10-17T12:02:26.616018Z","steps":["trace[1673284940] 'agreement among raft nodes before linearized reading' (duration: 435.705564ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T12:02:26.616063Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T12:02:26.179588Z","time spent":"436.466832ms","remote":"127.0.0.1:44402","response type":"/etcdserverpb.KV/Range","request count":0,"request size":147,"response count":1,"response size":1957,"request content":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" "} {"level":"info","ts":"2026-10-17T12:02:26.747523Z","caller":"traceutil/trace.go:171","msg":"trace[1689484574] transaction","detail":"{read_only:false; response_revision:15458; number_of_response:1; }","duration":"122.997576ms","start":"2026-10-17T12:02:26.624487Z","end":"2026-10-17T12:02:26.747484Z","steps":["trace[1689484574] 'process raft request' (duration: 104.299828ms)","trace[1689484574] 'compare' (duration: 18.469312ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T12:03:19.863626Z","caller":"traceutil/trace.go:171","msg":"trace[669200408] linearizableReadLoop","detail":"{readStateIndex:16643; appliedIndex:16642; }","duration":"192.507381ms","start":"2026-10-17T12:03:19.671095Z","end":"2026-10-17T12:03:19.863602Z","steps":["trace[669200408] 'read index received' (duration: 192.369688ms)","trace[669200408] 'applied index is now lower than readState.Index' (duration: 136.233µs)"],"step_count":2} {"level":"warn","ts":"2026-10-17T12:03:19.863733Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.607783ms","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-10-17T12:03:19.863802Z","caller":"traceutil/trace.go:171","msg":"trace[767783372] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:16088; }","duration":"192.734256ms","start":"2026-10-17T12:03:19.671053Z","end":"2026-10-17T12:03:19.863787Z","steps":["trace[767783372] 'agreement among raft nodes before linearized reading' (duration: 192.583353ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T12:03:19.86389Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.511757ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5521"} {"level":"warn","ts":"2026-10-17T12:03:19.863926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.805278ms","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-10-17T12:03:19.864021Z","caller":"traceutil/trace.go:171","msg":"trace[832017954] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:16088; }","duration":"192.944261ms","start":"2026-10-17T12:03:19.671054Z","end":"2026-10-17T12:03:19.863999Z","steps":["trace[832017954] 'agreement among raft nodes before linearized reading' (duration: 192.674545ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T12:03:19.863938Z","caller":"traceutil/trace.go:171","msg":"trace[928783601] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:16088; }","duration":"185.588789ms","start":"2026-10-17T12:03:19.678336Z","end":"2026-10-17T12:03:19.863925Z","steps":["trace[928783601] 'agreement among raft nodes before linearized reading' (duration: 185.420965ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T12:03:53.401672Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.247025ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-zx4tg\" ","response":"range_response_count:1 size:22100"} {"level":"info","ts":"2026-10-17T12:03:53.401754Z","caller":"traceutil/trace.go:171","msg":"trace[1939124415] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-zx4tg; range_end:; response_count:1; response_revision:16267; }","duration":"136.398019ms","start":"2026-10-17T12:03:53.265339Z","end":"2026-10-17T12:03:53.401737Z","steps":["trace[1939124415] 'range keys from in-memory index tree' (duration: 136.091591ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T12:03:53.752202Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.392705ms","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-10-17T12:03:53.752301Z","caller":"traceutil/trace.go:171","msg":"trace[1585489213] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:16268; }","duration":"123.542328ms","start":"2026-10-17T12:03:53.628735Z","end":"2026-10-17T12:03:53.752278Z","steps":["trace[1585489213] 'range keys from in-memory index tree' (duration: 123.327964ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T12:03:53.752311Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.428615ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-endpoints\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-17T12:03:53.752404Z","caller":"traceutil/trace.go:171","msg":"trace[1310342678] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-endpoints; range_end:; response_count:0; response_revision:16268; }","duration":"123.544968ms","start":"2026-10-17T12:03:53.628822Z","end":"2026-10-17T12:03:53.752367Z","steps":["trace[1310342678] 'range keys from in-memory index tree' (duration: 123.313223ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T12:03:53.752528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.120689ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-user\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-17T12:03:53.752561Z","caller":"traceutil/trace.go:171","msg":"trace[218665911] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-user; range_end:; response_count:0; response_revision:16268; }","duration":"123.20136ms","start":"2026-10-17T12:03:53.629351Z","end":"2026-10-17T12:03:53.752552Z","steps":["trace[218665911] 'range keys from in-memory index tree' (duration: 123.064638ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T12:03:53.752748Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.768856ms","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-10-17T12:03:53.752789Z","caller":"traceutil/trace.go:171","msg":"trace[1663773267] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:16268; }","duration":"239.840837ms","start":"2026-10-17T12:03:53.512939Z","end":"2026-10-17T12:03:53.752779Z","steps":["trace[1663773267] 'range keys from in-memory index tree' (duration: 239.715694ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T12:03:53.752803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.997871ms","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-10-17T12:03:53.752842Z","caller":"traceutil/trace.go:171","msg":"trace[18343599] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:16268; }","duration":"107.036872ms","start":"2026-10-17T12:03:53.645796Z","end":"2026-10-17T12:03:53.752833Z","steps":["trace[18343599] 'range keys from in-memory index tree' (duration: 106.873448ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T12:03:53.753003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.94178ms","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-10-17T12:03:53.753038Z","caller":"traceutil/trace.go:171","msg":"trace[1788306255] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:16268; }","duration":"240.012681ms","start":"2026-10-17T12:03:53.513017Z","end":"2026-10-17T12:03:53.753029Z","steps":["trace[1788306255] 'range keys from in-memory index tree' (duration: 239.800696ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T12:03:53.753297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.986331ms","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-10-17T12:03:53.753333Z","caller":"traceutil/trace.go:171","msg":"trace[310059037] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:16268; }","duration":"234.021691ms","start":"2026-10-17T12:03:53.519302Z","end":"2026-10-17T12:03:53.753324Z","steps":["trace[310059037] 'range keys from in-memory index tree' (duration: 233.824756ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T12:03:53.753639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.789538ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/libvirt-libvirt-default-h72hb\" ","response":"range_response_count:1 size:20644"} {"level":"info","ts":"2026-10-17T12:03:53.753676Z","caller":"traceutil/trace.go:171","msg":"trace[1262124609] range","detail":"{range_begin:/registry/pods/openstack/libvirt-libvirt-default-h72hb; range_end:; response_count:1; response_revision:16268; }","duration":"195.855378ms","start":"2026-10-17T12:03:53.557811Z","end":"2026-10-17T12:03:53.753666Z","steps":["trace[1262124609] 'range keys from in-memory index tree' (duration: 195.665224ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T12:03:53.906619Z","caller":"traceutil/trace.go:171","msg":"trace[122437709] linearizableReadLoop","detail":"{readStateIndex:16830; appliedIndex:16829; }","duration":"145.615665ms","start":"2026-10-17T12:03:53.760965Z","end":"2026-10-17T12:03:53.906581Z","steps":["trace[122437709] 'read index received' (duration: 145.468011ms)","trace[122437709] 'applied index is now lower than readState.Index' (duration: 146.444µs)"],"step_count":2} {"level":"info","ts":"2026-10-17T12:03:53.906893Z","caller":"traceutil/trace.go:171","msg":"trace[1002422109] transaction","detail":"{read_only:false; response_revision:16269; number_of_response:1; }","duration":"148.84527ms","start":"2026-10-17T12:03:53.758033Z","end":"2026-10-17T12:03:53.906878Z","steps":["trace[1002422109] 'process raft request' (duration: 148.396599ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T12:03:53.907195Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.229588ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"} {"level":"info","ts":"2026-10-17T12:03:53.907237Z","caller":"traceutil/trace.go:171","msg":"trace[976814597] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:16269; }","duration":"146.329152ms","start":"2026-10-17T12:03:53.760897Z","end":"2026-10-17T12:03:53.907226Z","steps":["trace[976814597] 'agreement among raft nodes before linearized reading' (duration: 146.185638ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T12:03:53.908041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.659335ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:77 size:744679"} {"level":"info","ts":"2026-10-17T12:03:53.908085Z","caller":"traceutil/trace.go:171","msg":"trace[1088181739] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:77; response_revision:16269; }","duration":"142.765208ms","start":"2026-10-17T12:03:53.76531Z","end":"2026-10-17T12:03:53.908075Z","steps":["trace[1088181739] 'agreement among raft nodes before linearized reading' (duration: 142.053261ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T12:03:54.326366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"370.777528ms","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-10-17T12:03:54.326482Z","caller":"traceutil/trace.go:171","msg":"trace[402351088] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:16269; }","duration":"370.941383ms","start":"2026-10-17T12:03:53.955517Z","end":"2026-10-17T12:03:54.326458Z","steps":["trace[402351088] 'range keys from in-memory index tree' (duration: 370.603665ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T12:03:54.326521Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T12:03:53.955503Z","time spent":"371.008724ms","remote":"127.0.0.1:44484","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":5543,"request content":"key:\"/registry/jobs/openstack/nova-db-sync\" "} {"level":"warn","ts":"2026-10-17T12:03:54.326854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.381711ms","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-10-17T12:03:54.326936Z","caller":"traceutil/trace.go:171","msg":"trace[398814434] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:16269; }","duration":"270.505454ms","start":"2026-10-17T12:03:54.056411Z","end":"2026-10-17T12:03:54.326917Z","steps":["trace[398814434] 'range keys from in-memory index tree' (duration: 270.226448ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T12:03:54.327303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.976675ms","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":"warn","ts":"2026-10-17T12:03:54.327335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"326.825461ms","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-10-17T12:03:54.327369Z","caller":"traceutil/trace.go:171","msg":"trace[3035599] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:16269; }","duration":"326.909343ms","start":"2026-10-17T12:03:54.000449Z","end":"2026-10-17T12:03:54.327358Z","steps":["trace[3035599] 'range keys from in-memory index tree' (duration: 326.720258ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T12:03:54.327445Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T12:03:54.000423Z","time spent":"327.011705ms","remote":"127.0.0.1:44712","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":0,"response size":27,"request content":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" "} {"level":"info","ts":"2026-10-17T12:03:54.32735Z","caller":"traceutil/trace.go:171","msg":"trace[503663225] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:16269; }","duration":"262.038556ms","start":"2026-10-17T12:03:54.065297Z","end":"2026-10-17T12:03:54.327336Z","steps":["trace[503663225] 'range keys from in-memory index tree' (duration: 261.877703ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T12:03:54.327869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.714595ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-10-17T12:03:54.327915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.5738ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-17T12:03:54.327976Z","caller":"traceutil/trace.go:171","msg":"trace[1760430377] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:16269; }","duration":"304.675073ms","start":"2026-10-17T12:03:54.02329Z","end":"2026-10-17T12:03:54.327965Z","steps":["trace[1760430377] 'range keys from in-memory index tree' (duration: 304.465378ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T12:03:54.328002Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T12:03:54.023269Z","time spent":"304.725254ms","remote":"127.0.0.1:44238","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-10-17T12:03:54.327908Z","caller":"traceutil/trace.go:171","msg":"trace[469911405] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:16269; }","duration":"260.771226ms","start":"2026-10-17T12:03:54.067126Z","end":"2026-10-17T12:03:54.327897Z","steps":["trace[469911405] 'range keys from in-memory index tree' (duration: 260.631253ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T12:03:54.392879Z","caller":"traceutil/trace.go:171","msg":"trace[840459489] transaction","detail":"{read_only:false; response_revision:16270; number_of_response:1; }","duration":"318.398664ms","start":"2026-10-17T12:03:54.07445Z","end":"2026-10-17T12:03:54.392849Z","steps":["trace[840459489] 'process raft request' (duration: 318.23621ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T12:03:54.393035Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T12:03:54.074434Z","time spent":"318.523346ms","remote":"127.0.0.1:44522","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T12:03:54.395574Z","caller":"traceutil/trace.go:171","msg":"trace[1338455323] transaction","detail":"{read_only:false; response_revision:16271; number_of_response:1; }","duration":"310.364926ms","start":"2026-10-17T12:03:54.085185Z","end":"2026-10-17T12:03:54.39555Z","steps":["trace[1338455323] 'process raft request' (duration: 309.838314ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T12:03:54.395719Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T12:03:54.085164Z","time spent":"310.475988ms","remote":"127.0.0.1:44522","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-17T12:03:54.397246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.528043ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-cell-setup-xvvvh\" ","response":"range_response_count:1 size:9791"} {"level":"info","ts":"2026-10-17T12:03:54.397302Z","caller":"traceutil/trace.go:171","msg":"trace[325006258] range","detail":"{range_begin:/registry/pods/openstack/nova-cell-setup-xvvvh; range_end:; response_count:1; response_revision:16274; }","duration":"101.641937ms","start":"2026-10-17T12:03:54.295646Z","end":"2026-10-17T12:03:54.397288Z","steps":["trace[325006258] 'agreement among raft nodes before linearized reading' (duration: 100.208103ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T12:05:36.152982Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14598} {"level":"info","ts":"2026-10-17T12:05:36.252056Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14598,"took":"94.936259ms","hash":214512008,"current-db-size-bytes":56557568,"current-db-size":"57 MB","current-db-size-in-use-bytes":31600640,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-10-17T12:05:36.252126Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":214512008,"revision":14598,"compact-revision":12556} {"level":"warn","ts":"2026-10-17T12:10:04.677218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.18276ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-17T12:10:04.677421Z","caller":"traceutil/trace.go:171","msg":"trace[880326544] transaction","detail":"{read_only:false; response_revision:19007; number_of_response:1; }","duration":"250.971831ms","start":"2026-10-17T12:10:04.426427Z","end":"2026-10-17T12:10:04.677399Z","steps":["trace[880326544] 'process raft request' (duration: 250.906859ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T12:10:04.677853Z","caller":"traceutil/trace.go:171","msg":"trace[1949951481] transaction","detail":"{read_only:false; response_revision:19006; number_of_response:1; }","duration":"274.207763ms","start":"2026-10-17T12:10:04.403627Z","end":"2026-10-17T12:10:04.677834Z","steps":["trace[1949951481] 'process raft request' (duration: 30.324828ms)","trace[1949951481] 'compare' (duration: 242.498013ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T12:10:04.678037Z","caller":"traceutil/trace.go:171","msg":"trace[710414920] linearizableReadLoop","detail":"{readStateIndex:19655; appliedIndex:19654; }","duration":"256.899198ms","start":"2026-10-17T12:10:04.421125Z","end":"2026-10-17T12:10:04.678024Z","steps":["trace[710414920] 'read index received' (duration: 12.843189ms)","trace[710414920] 'applied index is now lower than readState.Index' (duration: 244.052189ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T12:10:04.67837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.147278ms","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-10-17T12:10:04.678411Z","caller":"traceutil/trace.go:171","msg":"trace[175266451] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:19007; }","duration":"258.23314ms","start":"2026-10-17T12:10:04.420163Z","end":"2026-10-17T12:10:04.678396Z","steps":["trace[175266451] 'agreement among raft nodes before linearized reading' (duration: 258.102547ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T12:10:04.679708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.492369ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:96 size:961155"} {"level":"info","ts":"2026-10-17T12:10:04.679765Z","caller":"traceutil/trace.go:171","msg":"trace[142401666] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:96; response_revision:19007; }","duration":"250.553001ms","start":"2026-10-17T12:10:04.429199Z","end":"2026-10-17T12:10:04.679752Z","steps":["trace[142401666] 'agreement among raft nodes before linearized reading' (duration: 249.401124ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T12:10:05.428835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.455314ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-10-17T12:10:05.428958Z","caller":"traceutil/trace.go:171","msg":"trace[261081258] linearizableReadLoop","detail":"{readStateIndex:19658; appliedIndex:19657; }","duration":"404.530952ms","start":"2026-10-17T12:10:05.024405Z","end":"2026-10-17T12:10:05.428936Z","steps":["trace[261081258] 'read index received' (duration: 182.913195ms)","trace[261081258] 'applied index is now lower than readState.Index' (duration: 221.615547ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T12:10:05.429117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"404.706936ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-17T12:10:05.429159Z","caller":"traceutil/trace.go:171","msg":"trace[1547943029] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:19008; }","duration":"404.794468ms","start":"2026-10-17T12:10:05.024348Z","end":"2026-10-17T12:10:05.429143Z","steps":["trace[1547943029] 'agreement among raft nodes before linearized reading' (duration: 404.694905ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T12:10:05.429201Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T12:10:05.024322Z","time spent":"404.86792ms","remote":"127.0.0.1:44238","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-10-17T12:10:05.489119Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.016035ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"warn","ts":"2026-10-17T12:10:05.489122Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"416.781178ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-cell-setup-xvvvh\" ","response":"range_response_count:1 size:9792"} {"level":"info","ts":"2026-10-17T12:10:05.489217Z","caller":"traceutil/trace.go:171","msg":"trace[519972981] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:19009; }","duration":"306.152039ms","start":"2026-10-17T12:10:05.183039Z","end":"2026-10-17T12:10:05.489192Z","steps":["trace[519972981] 'agreement among raft nodes before linearized reading' (duration: 305.915003ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T12:10:05.489198Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"371.447811ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/prometheuses/\" range_end:\"/registry/monitoring.coreos.com/prometheuses0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-10-17T12:10:05.489254Z","caller":"traceutil/trace.go:171","msg":"trace[1786492014] range","detail":"{range_begin:/registry/pods/openstack/nova-cell-setup-xvvvh; range_end:; response_count:1; response_revision:19009; }","duration":"416.944592ms","start":"2026-10-17T12:10:05.072294Z","end":"2026-10-17T12:10:05.489239Z","steps":["trace[1786492014] 'agreement among raft nodes before linearized reading' (duration: 416.699226ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T12:10:05.489272Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T12:10:05.183018Z","time spent":"306.23919ms","remote":"127.0.0.1:44522","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-10-17T12:10:05.489297Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T12:10:05.072278Z","time spent":"417.007113ms","remote":"127.0.0.1:44428","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":9814,"request content":"key:\"/registry/pods/openstack/nova-cell-setup-xvvvh\" "} {"level":"info","ts":"2026-10-17T12:10:05.489307Z","caller":"traceutil/trace.go:171","msg":"trace[1816616818] range","detail":"{range_begin:/registry/monitoring.coreos.com/prometheuses/; range_end:/registry/monitoring.coreos.com/prometheuses0; response_count:0; response_revision:19009; }","duration":"371.608245ms","start":"2026-10-17T12:10:05.117668Z","end":"2026-10-17T12:10:05.489276Z","steps":["trace[1816616818] 'agreement among raft nodes before linearized reading' (duration: 371.4138ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T12:10:05.489301Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.452693ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectrealms/\" range_end:\"/registry/ceph.rook.io/cephobjectrealms0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-10-17T12:10:05.489369Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T12:10:05.117654Z","time spent":"371.697637ms","remote":"127.0.0.1:38368","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":1,"response size":30,"request content":"key:\"/registry/monitoring.coreos.com/prometheuses/\" range_end:\"/registry/monitoring.coreos.com/prometheuses0\" count_only:true "} {"level":"info","ts":"2026-10-17T12:10:05.4894Z","caller":"traceutil/trace.go:171","msg":"trace[1939968959] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectrealms/; range_end:/registry/ceph.rook.io/cephobjectrealms0; response_count:0; response_revision:19009; }","duration":"254.587936ms","start":"2026-10-17T12:10:05.234788Z","end":"2026-10-17T12:10:05.489376Z","steps":["trace[1939968959] 'agreement among raft nodes before linearized reading' (duration: 254.353711ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T12:10:34.969325Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"5019b1666ea94ec4","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-17T12:10:34.974906Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-10-17T12:10:34.975116Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-10-17T12:10:36.16205Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":16951} {"level":"info","ts":"2026-10-17T12:10:36.267555Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":16951,"took":"101.693151ms","hash":3295136474,"current-db-size-bytes":56557568,"current-db-size":"57 MB","current-db-size-in-use-bytes":32964608,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-10-17T12:10:36.26765Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3295136474,"revision":16951,"compact-revision":14598} {"level":"info","ts":"2026-10-17T12:11:30.850433Z","caller":"traceutil/trace.go:171","msg":"trace[1853594689] transaction","detail":"{read_only:false; response_revision:19899; number_of_response:1; }","duration":"114.999881ms","start":"2026-10-17T12:11:30.735407Z","end":"2026-10-17T12:11:30.850407Z","steps":["trace[1853594689] 'process raft request' (duration: 114.848498ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T12:11:30.86469Z","caller":"traceutil/trace.go:171","msg":"trace[1379658182] transaction","detail":"{read_only:false; response_revision:19900; number_of_response:1; }","duration":"106.429741ms","start":"2026-10-17T12:11:30.758234Z","end":"2026-10-17T12:11:30.864664Z","steps":["trace[1379658182] 'process raft request' (duration: 106.282528ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T12:15:36.168889Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19345} {"level":"info","ts":"2026-10-17T12:15:36.279056Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19345,"took":"106.530448ms","hash":4172109929,"current-db-size-bytes":56557568,"current-db-size":"57 MB","current-db-size-in-use-bytes":33894400,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-10-17T12:15:36.279139Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4172109929,"revision":19345,"compact-revision":16951} {"level":"info","ts":"2026-10-17T12:16:11.136694Z","caller":"traceutil/trace.go:171","msg":"trace[1171338685] linearizableReadLoop","detail":"{readStateIndex:22539; appliedIndex:22538; }","duration":"324.699752ms","start":"2026-10-17T12:16:10.811968Z","end":"2026-10-17T12:16:11.136667Z","steps":["trace[1171338685] 'read index received' (duration: 324.564529ms)","trace[1171338685] 'applied index is now lower than readState.Index' (duration: 134.193µs)"],"step_count":2} {"level":"info","ts":"2026-10-17T12:16:11.136801Z","caller":"traceutil/trace.go:171","msg":"trace[592840574] transaction","detail":"{read_only:false; response_revision:21795; number_of_response:1; }","duration":"340.824479ms","start":"2026-10-17T12:16:10.795966Z","end":"2026-10-17T12:16:11.136791Z","steps":["trace[592840574] 'process raft request' (duration: 340.558393ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T12:16:11.136906Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T12:16:10.795935Z","time spent":"340.89143ms","remote":"127.0.0.1:44522","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-17T12:16:11.137054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.093271ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-17T12:16:11.13709Z","caller":"traceutil/trace.go:171","msg":"trace[1609878039] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:21795; }","duration":"325.167603ms","start":"2026-10-17T12:16:10.811912Z","end":"2026-10-17T12:16:11.13708Z","steps":["trace[1609878039] 'agreement among raft nodes before linearized reading' (duration: 325.106591ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T12:16:11.13712Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T12:16:10.811894Z","time spent":"325.218633ms","remote":"127.0.0.1:60722","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"info","ts":"2026-10-17T12:16:11.143041Z","caller":"traceutil/trace.go:171","msg":"trace[1537130504] transaction","detail":"{read_only:false; response_revision:21796; number_of_response:1; }","duration":"141.32116ms","start":"2026-10-17T12:16:11.001693Z","end":"2026-10-17T12:16:11.143014Z","steps":["trace[1537130504] 'process raft request' (duration: 141.118156ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T12:16:11.143089Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.917613ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-10-17T12:16:11.143351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.559852ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-10-17T12:16:11.143458Z","caller":"traceutil/trace.go:171","msg":"trace[811687484] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:21796; }","duration":"285.049215ms","start":"2026-10-17T12:16:10.858102Z","end":"2026-10-17T12:16:11.143151Z","steps":["trace[811687484] 'agreement among raft nodes before linearized reading' (duration: 284.837861ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T12:16:11.143485Z","caller":"traceutil/trace.go:171","msg":"trace[906321218] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:21796; }","duration":"128.704396ms","start":"2026-10-17T12:16:11.014753Z","end":"2026-10-17T12:16:11.143457Z","steps":["trace[906321218] 'agreement among raft nodes before linearized reading' (duration: 128.281516ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T12:16:11.38672Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.814061ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12214"} {"level":"info","ts":"2026-10-17T12:16:11.386799Z","caller":"traceutil/trace.go:171","msg":"trace[1190088150] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:21796; }","duration":"135.926044ms","start":"2026-10-17T12:16:11.250856Z","end":"2026-10-17T12:16:11.386782Z","steps":["trace[1190088150] 'range keys from in-memory index tree' (duration: 135.657278ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T12:16:11.736823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.40067ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-17T12:16:11.736932Z","caller":"traceutil/trace.go:171","msg":"trace[358549041] linearizableReadLoop","detail":"{readStateIndex:22542; appliedIndex:22541; }","duration":"262.803336ms","start":"2026-10-17T12:16:11.474113Z","end":"2026-10-17T12:16:11.736916Z","steps":["trace[358549041] 'read index received' (duration: 74.242183ms)","trace[358549041] 'applied index is now lower than readState.Index' (duration: 188.560113ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T12:16:11.737023Z","caller":"traceutil/trace.go:171","msg":"trace[1238703878] transaction","detail":"{read_only:false; response_revision:21798; number_of_response:1; }","duration":"323.538935ms","start":"2026-10-17T12:16:11.413459Z","end":"2026-10-17T12:16:11.736998Z","steps":["trace[1238703878] 'process raft request' (duration: 134.89064ms)","trace[1238703878] 'compare' (duration: 188.200645ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T12:16:11.737108Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.993221ms","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-10-17T12:16:11.737134Z","caller":"traceutil/trace.go:171","msg":"trace[1577028423] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:21798; }","duration":"263.054922ms","start":"2026-10-17T12:16:11.47407Z","end":"2026-10-17T12:16:11.737125Z","steps":["trace[1577028423] 'agreement among raft nodes before linearized reading' (duration: 262.936169ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T12:16:11.73716Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T12:16:11.413427Z","time spent":"323.656597ms","remote":"127.0.0.1:44522","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-17T12:16:11.737311Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.985271ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/queues/\" range_end:\"/registry/rabbitmq.com/queues0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-10-17T12:16:11.737341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.102174ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-17T12:16:11.737432Z","caller":"traceutil/trace.go:171","msg":"trace[803635814] range","detail":"{range_begin:/registry/rabbitmq.com/queues/; range_end:/registry/rabbitmq.com/queues0; response_count:0; response_revision:21798; }","duration":"263.141825ms","start":"2026-10-17T12:16:11.474264Z","end":"2026-10-17T12:16:11.737406Z","steps":["trace[803635814] 'agreement among raft nodes before linearized reading' (duration: 262.94491ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T12:16:11.737438Z","caller":"traceutil/trace.go:171","msg":"trace[1474553003] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:21798; }","duration":"254.264607ms","start":"2026-10-17T12:16:11.483154Z","end":"2026-10-17T12:16:11.737418Z","steps":["trace[1474553003] 'agreement among raft nodes before linearized reading' (duration: 254.110884ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T12:16:11.9491Z","caller":"traceutil/trace.go:171","msg":"trace[201244510] linearizableReadLoop","detail":"{readStateIndex:22543; appliedIndex:22542; }","duration":"201.862423ms","start":"2026-10-17T12:16:11.747205Z","end":"2026-10-17T12:16:11.949067Z","steps":["trace[201244510] 'read index received' (duration: 171.247808ms)","trace[201244510] 'applied index is now lower than readState.Index' (duration: 30.613135ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T12:16:11.949703Z","caller":"traceutil/trace.go:171","msg":"trace[1448574388] transaction","detail":"{read_only:false; response_revision:21799; number_of_response:1; }","duration":"207.842773ms","start":"2026-10-17T12:16:11.741824Z","end":"2026-10-17T12:16:11.949667Z","steps":["trace[1448574388] 'process raft request' (duration: 176.618914ms)","trace[1448574388] 'compare' (duration: 30.491452ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T12:16:11.949876Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.094718ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"warn","ts":"2026-10-17T12:16:11.949948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.720823ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12214"} {"level":"info","ts":"2026-10-17T12:16:11.949952Z","caller":"traceutil/trace.go:171","msg":"trace[454572933] range","detail":"{range_begin:/registry/validatingwebhookconfigurations/; range_end:/registry/validatingwebhookconfigurations0; response_count:0; response_revision:21799; }","duration":"130.239361ms","start":"2026-10-17T12:16:11.819689Z","end":"2026-10-17T12:16:11.949928Z","steps":["trace[454572933] 'agreement among raft nodes before linearized reading' (duration: 130.086818ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T12:16:11.949995Z","caller":"traceutil/trace.go:171","msg":"trace[2138224738] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:21799; }","duration":"202.822886ms","start":"2026-10-17T12:16:11.747159Z","end":"2026-10-17T12:16:11.949982Z","steps":["trace[2138224738] 'agreement among raft nodes before linearized reading' (duration: 202.5979ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T12:20:19.144016Z","caller":"traceutil/trace.go:171","msg":"trace[281044583] transaction","detail":"{read_only:false; response_revision:24346; number_of_response:1; }","duration":"312.360284ms","start":"2026-10-17T12:20:18.831631Z","end":"2026-10-17T12:20:19.143991Z","steps":["trace[281044583] 'process raft request' (duration: 312.166899ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T12:20:19.144287Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T12:20:18.8316Z","time spent":"312.556999ms","remote":"127.0.0.1:44522","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T12:20:36.178415Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":21614} {"level":"info","ts":"2026-10-17T12:20:36.296818Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":21614,"took":"114.425622ms","hash":795929867,"current-db-size-bytes":56557568,"current-db-size":"57 MB","current-db-size-in-use-bytes":42479616,"current-db-size-in-use":"42 MB"} {"level":"info","ts":"2026-10-17T12:20:36.296908Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":795929867,"revision":21614,"compact-revision":19345} {"level":"info","ts":"2026-10-17T12:21:59.179518Z","caller":"traceutil/trace.go:171","msg":"trace[1788616293] transaction","detail":"{read_only:false; response_revision:25362; number_of_response:1; }","duration":"139.566159ms","start":"2026-10-17T12:21:59.039898Z","end":"2026-10-17T12:21:59.179464Z","steps":["trace[1788616293] 'process raft request' (duration: 104.791397ms)","trace[1788616293] 'compare' (duration: 34.659829ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T12:23:03.363445Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-00000000000068b9.wal"} {"level":"warn","ts":"2026-10-17T12:24:11.98758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.603856ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-17T12:24:11.987961Z","caller":"traceutil/trace.go:171","msg":"trace[10687906] linearizableReadLoop","detail":"{readStateIndex:27423; appliedIndex:27420; }","duration":"256.544169ms","start":"2026-10-17T12:24:11.731396Z","end":"2026-10-17T12:24:11.98794Z","steps":["trace[10687906] 'read index received' (duration: 88.458521ms)","trace[10687906] 'applied index is now lower than readState.Index' (duration: 168.084438ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T12:24:11.98806Z","caller":"traceutil/trace.go:171","msg":"trace[1274689771] transaction","detail":"{read_only:false; response_revision:26544; number_of_response:1; }","duration":"486.404186ms","start":"2026-10-17T12:24:11.501639Z","end":"2026-10-17T12:24:11.988044Z","steps":["trace[1274689771] 'process raft request' (duration: 318.202966ms)","trace[1274689771] 'compare' (duration: 167.048204ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T12:24:11.98813Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T12:24:11.501616Z","time spent":"486.472837ms","remote":"127.0.0.1:44522","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T12:24:11.98818Z","caller":"traceutil/trace.go:171","msg":"trace[657510396] transaction","detail":"{read_only:false; response_revision:26547; number_of_response:1; }","duration":"216.607619ms","start":"2026-10-17T12:24:11.771541Z","end":"2026-10-17T12:24:11.988148Z","steps":["trace[657510396] 'process raft request' (duration: 216.351983ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T12:24:11.988404Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.99711ms","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-10-17T12:24:11.988462Z","caller":"traceutil/trace.go:171","msg":"trace[1969780175] transaction","detail":"{read_only:false; response_revision:26545; number_of_response:1; }","duration":"439.129365ms","start":"2026-10-17T12:24:11.549322Z","end":"2026-10-17T12:24:11.988451Z","steps":["trace[1969780175] 'process raft request' (duration: 438.411828ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T12:24:11.988497Z","caller":"traceutil/trace.go:171","msg":"trace[2122419290] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26547; }","duration":"257.181544ms","start":"2026-10-17T12:24:11.731293Z","end":"2026-10-17T12:24:11.988475Z","steps":["trace[2122419290] 'agreement among raft nodes before linearized reading' (duration: 256.887818ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T12:24:11.988575Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T12:24:11.549267Z","time spent":"439.221037ms","remote":"127.0.0.1:44522","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T12:24:11.98868Z","caller":"traceutil/trace.go:171","msg":"trace[1484895324] transaction","detail":"{read_only:false; response_revision:26546; number_of_response:1; }","duration":"278.351967ms","start":"2026-10-17T12:24:11.710284Z","end":"2026-10-17T12:24:11.988636Z","steps":["trace[1484895324] 'process raft request' (duration: 277.560089ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T12:24:11.990712Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.079867ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/magnum-api-c6549c9dc-5jfc7\" ","response":"range_response_count:1 size:8645"} {"level":"info","ts":"2026-10-17T12:24:11.990807Z","caller":"traceutil/trace.go:171","msg":"trace[1664568950] range","detail":"{range_begin:/registry/pods/openstack/magnum-api-c6549c9dc-5jfc7; range_end:; response_count:1; response_revision:26547; }","duration":"171.19953ms","start":"2026-10-17T12:24:11.819567Z","end":"2026-10-17T12:24:11.990766Z","steps":["trace[1664568950] 'agreement among raft nodes before linearized reading' (duration: 168.597659ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T12:24:12.234216Z","caller":"traceutil/trace.go:171","msg":"trace[924725024] transaction","detail":"{read_only:false; response_revision:26548; number_of_response:1; }","duration":"228.833653ms","start":"2026-10-17T12:24:12.005285Z","end":"2026-10-17T12:24:12.234119Z","steps":["trace[924725024] 'process raft request' (duration: 152.985966ms)","trace[924725024] 'compare' (duration: 74.881105ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T12:24:12.566018Z","caller":"traceutil/trace.go:171","msg":"trace[1969312494] transaction","detail":"{read_only:false; response_revision:26549; number_of_response:1; }","duration":"555.058106ms","start":"2026-10-17T12:24:12.01092Z","end":"2026-10-17T12:24:12.565978Z","steps":["trace[1969312494] 'process raft request' (duration: 543.950437ms)","trace[1969312494] 'compare' (duration: 10.832152ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T12:24:12.566232Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T12:24:12.010899Z","time spent":"555.21798ms","remote":"127.0.0.1:44428","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8443,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T12:24:12.56647Z","caller":"traceutil/trace.go:171","msg":"trace[77590220] transaction","detail":"{read_only:false; response_revision:26551; number_of_response:1; }","duration":"449.64433ms","start":"2026-10-17T12:24:12.116798Z","end":"2026-10-17T12:24:12.566443Z","steps":["trace[77590220] 'process raft request' (duration: 449.469306ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T12:24:12.566502Z","caller":"traceutil/trace.go:171","msg":"trace[43362427] transaction","detail":"{read_only:false; response_revision:26550; number_of_response:1; }","duration":"461.193518ms","start":"2026-10-17T12:24:12.10528Z","end":"2026-10-17T12:24:12.566473Z","steps":["trace[43362427] 'process raft request' (duration: 460.590414ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T12:24:12.566538Z","caller":"traceutil/trace.go:171","msg":"trace[135369101] linearizableReadLoop","detail":"{readStateIndex:27426; appliedIndex:27424; }","duration":"542.006162ms","start":"2026-10-17T12:24:12.024497Z","end":"2026-10-17T12:24:12.566503Z","steps":["trace[135369101] 'read index received' (duration: 133.706116ms)","trace[135369101] 'applied index is now lower than readState.Index' (duration: 408.296556ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T12:24:12.566624Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T12:24:12.116779Z","time spent":"449.763262ms","remote":"127.0.0.1:44522","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-17T12:24:12.566649Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T12:24:12.105255Z","time spent":"461.327372ms","remote":"127.0.0.1:44522","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T12:24:12.566685Z","caller":"traceutil/trace.go:171","msg":"trace[1623242563] transaction","detail":"{read_only:false; response_revision:26552; number_of_response:1; }","duration":"444.896319ms","start":"2026-10-17T12:24:12.121777Z","end":"2026-10-17T12:24:12.566674Z","steps":["trace[1623242563] 'process raft request' (duration: 444.623793ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T12:24:12.566795Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T12:24:12.121759Z","time spent":"444.95154ms","remote":"127.0.0.1:44522","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":605,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-17T12:24:12.567134Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"435.222363ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/nfd.k8s-sigs.io/nodefeatures/monitoring/instance\" ","response":"range_response_count:1 size:419209"} {"level":"info","ts":"2026-10-17T12:24:12.567229Z","caller":"traceutil/trace.go:171","msg":"trace[1017221752] range","detail":"{range_begin:/registry/nfd.k8s-sigs.io/nodefeatures/monitoring/instance; range_end:; response_count:1; response_revision:26552; }","duration":"435.327936ms","start":"2026-10-17T12:24:12.131853Z","end":"2026-10-17T12:24:12.567181Z","steps":["trace[1017221752] 'agreement among raft nodes before linearized reading' (duration: 434.962447ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T12:24:12.567266Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T12:24:12.131835Z","time spent":"435.420679ms","remote":"127.0.0.1:59210","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":419231,"request content":"key:\"/registry/nfd.k8s-sigs.io/nodefeatures/monitoring/instance\" "} {"level":"warn","ts":"2026-10-17T12:24:12.567596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"543.075538ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-17T12:24:12.567701Z","caller":"traceutil/trace.go:171","msg":"trace[1492596762] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26552; }","duration":"543.22038ms","start":"2026-10-17T12:24:12.024458Z","end":"2026-10-17T12:24:12.567678Z","steps":["trace[1492596762] 'agreement among raft nodes before linearized reading' (duration: 543.022216ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T12:24:12.567747Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T12:24:12.024446Z","time spent":"543.291642ms","remote":"127.0.0.1:44238","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-10-17T12:24:12.757943Z","caller":"traceutil/trace.go:171","msg":"trace[1129317653] transaction","detail":"{read_only:false; response_revision:26553; number_of_response:1; }","duration":"184.454968ms","start":"2026-10-17T12:24:12.573454Z","end":"2026-10-17T12:24:12.757909Z","steps":["trace[1129317653] 'process raft request' (duration: 164.874532ms)","trace[1129317653] 'compare' (duration: 19.33726ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T12:24:12.777853Z","caller":"traceutil/trace.go:171","msg":"trace[1076435417] transaction","detail":"{read_only:false; response_revision:26554; number_of_response:1; }","duration":"203.779508ms","start":"2026-10-17T12:24:12.574047Z","end":"2026-10-17T12:24:12.777826Z","steps":["trace[1076435417] 'process raft request' (duration: 203.564673ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T12:24:12.778149Z","caller":"traceutil/trace.go:171","msg":"trace[1156494852] transaction","detail":"{read_only:false; response_revision:26555; number_of_response:1; }","duration":"203.899961ms","start":"2026-10-17T12:24:12.574229Z","end":"2026-10-17T12:24:12.778129Z","steps":["trace[1156494852] 'process raft request' (duration: 203.532903ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T12:24:12.778181Z","caller":"traceutil/trace.go:171","msg":"trace[1054068222] transaction","detail":"{read_only:false; response_revision:26556; number_of_response:1; }","duration":"203.657315ms","start":"2026-10-17T12:24:12.574511Z","end":"2026-10-17T12:24:12.778168Z","steps":["trace[1054068222] 'process raft request' (duration: 203.473801ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T12:24:12.778264Z","caller":"traceutil/trace.go:171","msg":"trace[1587497942] transaction","detail":"{read_only:false; response_revision:26557; number_of_response:1; }","duration":"203.601544ms","start":"2026-10-17T12:24:12.574629Z","end":"2026-10-17T12:24:12.77823Z","steps":["trace[1587497942] 'process raft request' (duration: 203.481582ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T12:24:12.778369Z","caller":"traceutil/trace.go:171","msg":"trace[366982084] linearizableReadLoop","detail":"{readStateIndex:27435; appliedIndex:27429; }","duration":"154.767556ms","start":"2026-10-17T12:24:12.623596Z","end":"2026-10-17T12:24:12.778363Z","steps":["trace[366982084] 'read index received' (duration: 114.672862ms)","trace[366982084] 'applied index is now lower than readState.Index' (duration: 40.094004ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T12:24:12.778471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.877789ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificaterequests/\" range_end:\"/registry/cert-manager.io/certificaterequests0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-10-17T12:24:12.778502Z","caller":"traceutil/trace.go:171","msg":"trace[2098073158] range","detail":"{range_begin:/registry/cert-manager.io/certificaterequests/; range_end:/registry/cert-manager.io/certificaterequests0; response_count:0; response_revision:26558; }","duration":"155.009512ms","start":"2026-10-17T12:24:12.623485Z","end":"2026-10-17T12:24:12.778495Z","steps":["trace[2098073158] 'agreement among raft nodes before linearized reading' (duration: 154.898939ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T12:24:12.778623Z","caller":"traceutil/trace.go:171","msg":"trace[655141775] transaction","detail":"{read_only:false; response_revision:26558; number_of_response:1; }","duration":"198.26025ms","start":"2026-10-17T12:24:12.580345Z","end":"2026-10-17T12:24:12.778606Z","steps":["trace[655141775] 'process raft request' (duration: 197.82376ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T12:24:17.715204Z","caller":"traceutil/trace.go:171","msg":"trace[874081275] transaction","detail":"{read_only:false; response_revision:26592; number_of_response:1; }","duration":"141.929187ms","start":"2026-10-17T12:24:17.573248Z","end":"2026-10-17T12:24:17.715177Z","steps":["trace[874081275] 'process raft request' (duration: 141.765384ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T12:25:07.730454Z","caller":"traceutil/trace.go:171","msg":"trace[1702307798] transaction","detail":"{read_only:false; response_revision:27079; number_of_response:1; }","duration":"290.608124ms","start":"2026-10-17T12:25:07.439822Z","end":"2026-10-17T12:25:07.73043Z","steps":["trace[1702307798] 'process raft request' (duration: 290.43877ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T12:25:08.08712Z","caller":"traceutil/trace.go:171","msg":"trace[568445124] transaction","detail":"{read_only:false; response_revision:27080; number_of_response:1; }","duration":"172.649494ms","start":"2026-10-17T12:25:07.914441Z","end":"2026-10-17T12:25:08.08709Z","steps":["trace[568445124] 'process raft request' (duration: 137.846473ms)","trace[568445124] 'compare' (duration: 34.490434ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T12:25:08.471864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.933579ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-17T12:25:08.472128Z","caller":"traceutil/trace.go:171","msg":"trace[2030966024] transaction","detail":"{read_only:false; response_revision:27082; number_of_response:1; }","duration":"276.155376ms","start":"2026-10-17T12:25:08.195951Z","end":"2026-10-17T12:25:08.472106Z","steps":["trace[2030966024] 'process raft request' (duration: 276.033703ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T12:25:08.472291Z","caller":"traceutil/trace.go:171","msg":"trace[264788452] transaction","detail":"{read_only:false; response_revision:27081; number_of_response:1; }","duration":"379.925674ms","start":"2026-10-17T12:25:08.092319Z","end":"2026-10-17T12:25:08.472245Z","steps":["trace[264788452] 'process raft request' (duration: 158.531465ms)","trace[264788452] 'compare' (duration: 220.808616ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T12:25:08.472376Z","caller":"traceutil/trace.go:171","msg":"trace[570066582] transaction","detail":"{read_only:false; response_revision:27083; number_of_response:1; }","duration":"234.70521ms","start":"2026-10-17T12:25:08.23764Z","end":"2026-10-17T12:25:08.472345Z","steps":["trace[570066582] 'process raft request' (duration: 234.417413ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T12:25:08.472379Z","caller":"traceutil/trace.go:171","msg":"trace[1211818142] linearizableReadLoop","detail":"{readStateIndex:27971; appliedIndex:27969; }","duration":"274.321153ms","start":"2026-10-17T12:25:08.198001Z","end":"2026-10-17T12:25:08.472323Z","steps":["trace[1211818142] 'read index received' (duration: 52.77238ms)","trace[1211818142] 'applied index is now lower than readState.Index' (duration: 221.523142ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T12:25:08.472472Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T12:25:08.092267Z","time spent":"380.12461ms","remote":"127.0.0.1:44522","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T12:25:08.472395Z","caller":"traceutil/trace.go:171","msg":"trace[1541223735] transaction","detail":"{read_only:false; response_revision:27084; number_of_response:1; }","duration":"232.388156ms","start":"2026-10-17T12:25:08.239984Z","end":"2026-10-17T12:25:08.472372Z","steps":["trace[1541223735] 'process raft request' (duration: 232.213102ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T12:25:08.472556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.535088ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/storage-loki-0\" ","response":"range_response_count:1 size:1782"} {"level":"info","ts":"2026-10-17T12:25:08.4726Z","caller":"traceutil/trace.go:171","msg":"trace[1305048507] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/storage-loki-0; range_end:; response_count:1; response_revision:27084; }","duration":"274.61948ms","start":"2026-10-17T12:25:08.197966Z","end":"2026-10-17T12:25:08.472585Z","steps":["trace[1305048507] 'agreement among raft nodes before linearized reading' (duration: 274.464407ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T12:25:08.472628Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.192273ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-10-17T12:25:08.472634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.102147ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-10-17T12:25:08.472685Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.918637ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"} {"level":"info","ts":"2026-10-17T12:25:08.4727Z","caller":"traceutil/trace.go:171","msg":"trace[1847413712] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:27084; }","duration":"175.288895ms","start":"2026-10-17T12:25:08.297388Z","end":"2026-10-17T12:25:08.472677Z","steps":["trace[1847413712] 'agreement among raft nodes before linearized reading' (duration: 175.170923ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T12:25:08.47272Z","caller":"traceutil/trace.go:171","msg":"trace[42415561] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:27084; }","duration":"138.973599ms","start":"2026-10-17T12:25:08.333735Z","end":"2026-10-17T12:25:08.472708Z","steps":["trace[42415561] 'agreement among raft nodes before linearized reading' (duration: 138.819225ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T12:25:08.47272Z","caller":"traceutil/trace.go:171","msg":"trace[836714579] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0; response_count:0; response_revision:27084; }","duration":"234.198379ms","start":"2026-10-17T12:25:08.238498Z","end":"2026-10-17T12:25:08.472696Z","steps":["trace[836714579] 'agreement among raft nodes before linearized reading' (duration: 234.054985ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T12:25:08.83835Z","caller":"traceutil/trace.go:171","msg":"trace[1480968082] linearizableReadLoop","detail":"{readStateIndex:27974; appliedIndex:27973; }","duration":"356.073839ms","start":"2026-10-17T12:25:08.482211Z","end":"2026-10-17T12:25:08.838285Z","steps":["trace[1480968082] 'read index received' (duration: 342.259527ms)","trace[1480968082] 'applied index is now lower than readState.Index' (duration: 13.813202ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T12:25:08.838382Z","caller":"traceutil/trace.go:171","msg":"trace[351708614] transaction","detail":"{read_only:false; response_revision:27085; number_of_response:1; }","duration":"359.237552ms","start":"2026-10-17T12:25:08.479114Z","end":"2026-10-17T12:25:08.838352Z","steps":["trace[351708614] 'process raft request' (duration: 345.162234ms)","trace[351708614] 'compare' (duration: 13.488855ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T12:25:08.838495Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"356.272573ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/magnum-system/\" range_end:\"/registry/endpointslices/magnum-system0\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-17T12:25:08.838538Z","caller":"traceutil/trace.go:171","msg":"trace[253946656] range","detail":"{range_begin:/registry/endpointslices/magnum-system/; range_end:/registry/endpointslices/magnum-system0; response_count:0; response_revision:27085; }","duration":"356.351695ms","start":"2026-10-17T12:25:08.482171Z","end":"2026-10-17T12:25:08.838523Z","steps":["trace[253946656] 'agreement among raft nodes before linearized reading' (duration: 356.265903ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T12:25:08.838546Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T12:25:08.479095Z","time spent":"359.356625ms","remote":"127.0.0.1:44522","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-17T12:25:08.838569Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T12:25:08.482157Z","time spent":"356.402906ms","remote":"127.0.0.1:44538","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":28,"request content":"key:\"/registry/endpointslices/magnum-system/\" range_end:\"/registry/endpointslices/magnum-system0\" "} {"level":"info","ts":"2026-10-17T12:25:08.846361Z","caller":"traceutil/trace.go:171","msg":"trace[948434406] transaction","detail":"{read_only:false; response_revision:27086; number_of_response:1; }","duration":"141.130059ms","start":"2026-10-17T12:25:08.705211Z","end":"2026-10-17T12:25:08.846341Z","steps":["trace[948434406] 'process raft request' (duration: 140.950774ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T12:25:08.8471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.672644ms","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-10-17T12:25:08.847182Z","caller":"traceutil/trace.go:171","msg":"trace[40018417] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:27090; }","duration":"284.803328ms","start":"2026-10-17T12:25:08.56236Z","end":"2026-10-17T12:25:08.847163Z","steps":["trace[40018417] 'agreement among raft nodes before linearized reading' (duration: 284.535372ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T12:25:36.187327Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":24508} {"level":"info","ts":"2026-10-17T12:25:36.345902Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":24508,"took":"154.060551ms","hash":2561988738,"current-db-size-bytes":59514880,"current-db-size":"60 MB","current-db-size-in-use-bytes":36487168,"current-db-size-in-use":"36 MB"} {"level":"info","ts":"2026-10-17T12:25:36.345975Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2561988738,"revision":24508,"compact-revision":21614} {"level":"info","ts":"2026-10-17T12:28:31.403799Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"5019b1666ea94ec4","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-17T12:28:31.410477Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003} {"level":"info","ts":"2026-10-17T12:28:31.410595Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003} {"level":"info","ts":"2026-10-17T12:30:36.194667Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":27299} {"level":"info","ts":"2026-10-17T12:30:36.331359Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":27299,"took":"131.953126ms","hash":199411018,"current-db-size-bytes":59965440,"current-db-size":"60 MB","current-db-size-in-use-bytes":37875712,"current-db-size-in-use":"38 MB"} {"level":"info","ts":"2026-10-17T12:30:36.331444Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":199411018,"revision":27299,"compact-revision":24508} {"level":"info","ts":"2026-10-17T12:35:36.201622Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":30178} {"level":"info","ts":"2026-10-17T12:35:36.347366Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":30178,"took":"141.842324ms","hash":2169715214,"current-db-size-bytes":59965440,"current-db-size":"60 MB","current-db-size-in-use-bytes":31215616,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-10-17T12:35:36.347502Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2169715214,"revision":30178,"compact-revision":27299} {"level":"info","ts":"2026-10-17T12:40:36.208995Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":32434} {"level":"info","ts":"2026-10-17T12:40:36.378051Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":32434,"took":"164.271748ms","hash":2354786999,"current-db-size-bytes":61005824,"current-db-size":"61 MB","current-db-size-in-use-bytes":30273536,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-10-17T12:40:36.378123Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2354786999,"revision":32434,"compact-revision":30178} {"level":"info","ts":"2026-10-17T12:45:36.222038Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":34663} {"level":"info","ts":"2026-10-17T12:45:36.375341Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":34663,"took":"148.598092ms","hash":4199738098,"current-db-size-bytes":61005824,"current-db-size":"61 MB","current-db-size-in-use-bytes":31399936,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-10-17T12:45:36.375416Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4199738098,"revision":34663,"compact-revision":32434} {"level":"info","ts":"2026-10-17T12:49:40.321606Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"5019b1666ea94ec4","local-member-applied-index":40004,"local-member-snapshot-index":30003,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-17T12:49:40.328822Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40004} {"level":"info","ts":"2026-10-17T12:49:40.328963Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35004} {"level":"info","ts":"2026-10-17T12:50:36.232204Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":36966} {"level":"info","ts":"2026-10-17T12:50:36.390942Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":36966,"took":"154.632277ms","hash":1991856445,"current-db-size-bytes":61005824,"current-db-size":"61 MB","current-db-size-in-use-bytes":33173504,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-10-17T12:50:36.39105Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1991856445,"revision":36966,"compact-revision":34663} {"level":"info","ts":"2026-10-17T12:55:36.240039Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":39237} {"level":"info","ts":"2026-10-17T12:55:36.387016Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":39237,"took":"142.726659ms","hash":2251137321,"current-db-size-bytes":61005824,"current-db-size":"61 MB","current-db-size-in-use-bytes":30511104,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-10-17T12:55:36.387097Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2251137321,"revision":39237,"compact-revision":36966}