{"level":"warn","ts":"2026-06-13T22:46:49.423391Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-13T22:46:49.423496Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.19:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.19:2380","--initial-cluster=instance=https://199.204.45.19:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.19:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.19: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-06-13T22:46:49.423578Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-13T22:46:49.423593Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.19:2380"]} {"level":"info","ts":"2026-06-13T22:46:49.423617Z","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-06-13T22:46:49.424334Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.19:2379"]} {"level":"info","ts":"2026-06-13T22:46:49.424418Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.19:2380"],"listen-peer-urls":["https://199.204.45.19:2380"],"advertise-client-urls":["https://199.204.45.19:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.19:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.19: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-06-13T22:46:49.428181Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.556675ms"} {"level":"info","ts":"2026-06-13T22:46:49.434977Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"a847c2e9c7010db6","cluster-id":"2b11a68e27507b05"} {"level":"info","ts":"2026-06-13T22:46:49.435098Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 switched to configuration voters=()"} {"level":"info","ts":"2026-06-13T22:46:49.435132Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 became follower at term 0"} {"level":"info","ts":"2026-06-13T22:46:49.435159Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft a847c2e9c7010db6 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-13T22:46:49.43517Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 became follower at term 1"} {"level":"info","ts":"2026-06-13T22:46:49.435217Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 switched to configuration voters=(12125874831040253366)"} {"level":"warn","ts":"2026-06-13T22:46:49.447822Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-13T22:46:49.453913Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-13T22:46:49.455444Z","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-06-13T22:46:49.458279Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"a847c2e9c7010db6","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-13T22:46:49.458755Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"a847c2e9c7010db6","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-13T22:46:49.458766Z","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-06-13T22:46:49.458929Z","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-06-13T22:46:49.458966Z","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-06-13T22:46:49.459496Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 switched to configuration voters=(12125874831040253366)"} {"level":"info","ts":"2026-06-13T22:46:49.459673Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"2b11a68e27507b05","local-member-id":"a847c2e9c7010db6","added-peer-id":"a847c2e9c7010db6","added-peer-peer-urls":["https://199.204.45.19:2380"]} {"level":"info","ts":"2026-06-13T22:46:49.462129Z","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-06-13T22:46:49.462491Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"a847c2e9c7010db6","initial-advertise-peer-urls":["https://199.204.45.19:2380"],"listen-peer-urls":["https://199.204.45.19:2380"],"advertise-client-urls":["https://199.204.45.19:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.19:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-13T22:46:49.462542Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-13T22:46:49.46276Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.19:2380"} {"level":"info","ts":"2026-06-13T22:46:49.462787Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.19:2380"} {"level":"info","ts":"2026-06-13T22:46:50.035463Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 is starting a new election at term 1"} {"level":"info","ts":"2026-06-13T22:46:50.035526Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 became pre-candidate at term 1"} {"level":"info","ts":"2026-06-13T22:46:50.03555Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 received MsgPreVoteResp from a847c2e9c7010db6 at term 1"} {"level":"info","ts":"2026-06-13T22:46:50.035571Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 became candidate at term 2"} {"level":"info","ts":"2026-06-13T22:46:50.035583Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 received MsgVoteResp from a847c2e9c7010db6 at term 2"} {"level":"info","ts":"2026-06-13T22:46:50.0356Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 became leader at term 2"} {"level":"info","ts":"2026-06-13T22:46:50.035634Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: a847c2e9c7010db6 elected leader a847c2e9c7010db6 at term 2"} {"level":"info","ts":"2026-06-13T22:46:50.042358Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-13T22:46:50.042401Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-13T22:46:50.04291Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-13T22:46:50.043779Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-13T22:46:50.043894Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-13T22:46:50.044078Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"2b11a68e27507b05","local-member-id":"a847c2e9c7010db6","cluster-version":"3.5"} {"level":"info","ts":"2026-06-13T22:46:50.044302Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-13T22:46:50.044349Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-13T22:46:50.046626Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.19:2379"} {"level":"info","ts":"2026-06-13T22:46:50.04679Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"a847c2e9c7010db6","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.19:2379]}","request-path":"/0/members/a847c2e9c7010db6/attributes","cluster-id":"2b11a68e27507b05","publish-timeout":"7s"} {"level":"info","ts":"2026-06-13T22:46:50.048095Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-13T22:46:51.578825Z","caller":"traceutil/trace.go:171","msg":"trace[968787263] linearizableReadLoop","detail":"{readStateIndex:7; appliedIndex:6; }","duration":"112.899498ms","start":"2026-06-13T22:46:51.465889Z","end":"2026-06-13T22:46:51.578789Z","steps":["trace[968787263] 'read index received' (duration: 112.644842ms)","trace[968787263] 'applied index is now lower than readState.Index' (duration: 253.286µs)"],"step_count":2} {"level":"info","ts":"2026-06-13T22:46:51.579007Z","caller":"traceutil/trace.go:171","msg":"trace[1262814508] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"114.112667ms","start":"2026-06-13T22:46:51.46488Z","end":"2026-06-13T22:46:51.578992Z","steps":["trace[1262814508] 'process raft request' (duration: 113.746279ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:46:51.579172Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.232966ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-13T22:46:51.579274Z","caller":"traceutil/trace.go:171","msg":"trace[124669567] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:4; }","duration":"113.39735ms","start":"2026-06-13T22:46:51.465855Z","end":"2026-06-13T22:46:51.579253Z","steps":["trace[124669567] 'agreement among raft nodes before linearized reading' (duration: 113.171694ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:46:51.594342Z","caller":"traceutil/trace.go:171","msg":"trace[1179963630] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"127.963536ms","start":"2026-06-13T22:46:51.466334Z","end":"2026-06-13T22:46:51.594297Z","steps":["trace[1179963630] 'process raft request' (duration: 127.652569ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:46:51.594453Z","caller":"traceutil/trace.go:171","msg":"trace[1637576804] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"128.058809ms","start":"2026-06-13T22:46:51.466386Z","end":"2026-06-13T22:46:51.594445Z","steps":["trace[1637576804] 'process raft request' (duration: 127.835584ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:46:51.594411Z","caller":"traceutil/trace.go:171","msg":"trace[579693460] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"127.989857ms","start":"2026-06-13T22:46:51.4664Z","end":"2026-06-13T22:46:51.59439Z","steps":["trace[579693460] 'process raft request' (duration: 127.870864ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:46:51.594651Z","caller":"traceutil/trace.go:171","msg":"trace[253211033] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"120.800496ms","start":"2026-06-13T22:46:51.473792Z","end":"2026-06-13T22:46:51.594593Z","steps":["trace[253211033] 'process raft request' (duration: 120.560991ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:46:51.594695Z","caller":"traceutil/trace.go:171","msg":"trace[96896652] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"128.250083ms","start":"2026-06-13T22:46:51.466428Z","end":"2026-06-13T22:46:51.594678Z","steps":["trace[96896652] 'process raft request' (duration: 127.868164ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:46:51.594797Z","caller":"traceutil/trace.go:171","msg":"trace[1276645977] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"128.231894ms","start":"2026-06-13T22:46:51.466478Z","end":"2026-06-13T22:46:51.59471Z","steps":["trace[1276645977] 'process raft request' (duration: 127.845124ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:46:51.595054Z","caller":"traceutil/trace.go:171","msg":"trace[1138228919] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"118.135842ms","start":"2026-06-13T22:46:51.476327Z","end":"2026-06-13T22:46:51.594463Z","steps":["trace[1138228919] 'process raft request' (duration: 118.097081ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:47:27.870701Z","caller":"traceutil/trace.go:171","msg":"trace[603858472] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"415.888878ms","start":"2026-06-13T22:47:27.45477Z","end":"2026-06-13T22:47:27.870659Z","steps":["trace[603858472] 'process raft request' (duration: 319.16267ms)","trace[603858472] 'compare' (duration: 96.486683ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T22:47:27.871662Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:47:27.454744Z","time spent":"416.227846ms","remote":"127.0.0.1:50334","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":73770,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-13T22:47:27.871926Z","caller":"traceutil/trace.go:171","msg":"trace[602178242] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"369.097136ms","start":"2026-06-13T22:47:27.502767Z","end":"2026-06-13T22:47:27.871864Z","steps":["trace[602178242] 'process raft request' (duration: 368.561573ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:47:27.872334Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:47:27.502739Z","time spent":"369.274729ms","remote":"127.0.0.1:50334","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":98689,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-13T22:47:27.871786Z","caller":"traceutil/trace.go:171","msg":"trace[1669363892] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"332.59016ms","start":"2026-06-13T22:47:27.539156Z","end":"2026-06-13T22:47:27.871746Z","steps":["trace[1669363892] 'process raft request' (duration: 332.440797ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:47:27.872678Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:47:27.539117Z","time spent":"333.458083ms","remote":"127.0.0.1:50334","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":151221,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-13T22:47:28.794637Z","caller":"traceutil/trace.go:171","msg":"trace[829710184] transaction","detail":"{read_only:false; response_revision:560; number_of_response:1; }","duration":"101.035281ms","start":"2026-06-13T22:47:28.693557Z","end":"2026-06-13T22:47:28.794592Z","steps":["trace[829710184] 'process raft request' (duration: 100.60408ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:47:35.095096Z","caller":"traceutil/trace.go:171","msg":"trace[389023588] transaction","detail":"{read_only:false; response_revision:603; number_of_response:1; }","duration":"167.924444ms","start":"2026-06-13T22:47:34.927144Z","end":"2026-06-13T22:47:35.095069Z","steps":["trace[389023588] 'process raft request' (duration: 167.74855ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:47:35.568487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.076091ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T22:47:35.568581Z","caller":"traceutil/trace.go:171","msg":"trace[321728344] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:603; }","duration":"186.230464ms","start":"2026-06-13T22:47:35.382333Z","end":"2026-06-13T22:47:35.568563Z","steps":["trace[321728344] 'range keys from in-memory index tree' (duration: 185.971068ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:47:35.568913Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"416.086903ms","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-06-13T22:47:35.568956Z","caller":"traceutil/trace.go:171","msg":"trace[499854948] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:603; }","duration":"416.170676ms","start":"2026-06-13T22:47:35.152774Z","end":"2026-06-13T22:47:35.568944Z","steps":["trace[499854948] 'range keys from in-memory index tree' (duration: 415.896369ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:47:35.568985Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:47:35.152745Z","time spent":"416.232876ms","remote":"127.0.0.1:50542","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-06-13T22:47:35.569047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"347.387836ms","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-06-13T22:47:35.569164Z","caller":"traceutil/trace.go:171","msg":"trace[1733020248] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:603; }","duration":"347.54245ms","start":"2026-06-13T22:47:35.221591Z","end":"2026-06-13T22:47:35.569133Z","steps":["trace[1733020248] 'range keys from in-memory index tree' (duration: 347.14019ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:47:35.569223Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:47:35.221575Z","time spent":"347.632672ms","remote":"127.0.0.1:50542","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-13T22:48:24.073286Z","caller":"traceutil/trace.go:171","msg":"trace[1644748003] transaction","detail":"{read_only:false; response_revision:1168; number_of_response:1; }","duration":"224.798568ms","start":"2026-06-13T22:48:23.848457Z","end":"2026-06-13T22:48:24.073255Z","steps":["trace[1644748003] 'process raft request' (duration: 224.643334ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:48:24.0745Z","caller":"traceutil/trace.go:171","msg":"trace[292650463] transaction","detail":"{read_only:false; response_revision:1169; number_of_response:1; }","duration":"225.658138ms","start":"2026-06-13T22:48:23.848809Z","end":"2026-06-13T22:48:24.074467Z","steps":["trace[292650463] 'process raft request' (duration: 225.482634ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:48:24.345699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.228958ms","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-06-13T22:48:24.3458Z","caller":"traceutil/trace.go:171","msg":"trace[1045285092] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1169; }","duration":"124.376951ms","start":"2026-06-13T22:48:24.221397Z","end":"2026-06-13T22:48:24.345774Z","steps":["trace[1045285092] 'range keys from in-memory index tree' (duration: 124.061064ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:48:24.345947Z","caller":"traceutil/trace.go:171","msg":"trace[949559704] transaction","detail":"{read_only:false; response_revision:1170; number_of_response:1; }","duration":"115.351776ms","start":"2026-06-13T22:48:24.230482Z","end":"2026-06-13T22:48:24.345833Z","steps":["trace[949559704] 'process raft request' (duration: 112.746563ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:49:10.451911Z","caller":"traceutil/trace.go:171","msg":"trace[1358874091] transaction","detail":"{read_only:false; response_revision:1829; number_of_response:1; }","duration":"132.051421ms","start":"2026-06-13T22:49:10.319811Z","end":"2026-06-13T22:49:10.451862Z","steps":["trace[1358874091] 'process raft request' (duration: 117.047972ms)","trace[1358874091] 'compare' (duration: 14.62161ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T22:49:10.98333Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.942599ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-13T22:49:10.983437Z","caller":"traceutil/trace.go:171","msg":"trace[1000324186] linearizableReadLoop","detail":"{readStateIndex:1906; appliedIndex:1905; }","duration":"403.93917ms","start":"2026-06-13T22:49:10.579481Z","end":"2026-06-13T22:49:10.98342Z","steps":["trace[1000324186] 'read index received' (duration: 205.592061ms)","trace[1000324186] 'applied index is now lower than readState.Index' (duration: 198.345669ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T22:49:10.983522Z","caller":"traceutil/trace.go:171","msg":"trace[380252348] transaction","detail":"{read_only:false; response_revision:1833; number_of_response:1; }","duration":"431.701835ms","start":"2026-06-13T22:49:10.551775Z","end":"2026-06-13T22:49:10.983477Z","steps":["trace[380252348] 'process raft request' (duration: 233.379457ms)","trace[380252348] 'compare' (duration: 197.716664ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T22:49:10.983691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"398.342126ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-06-13T22:49:10.983728Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:49:10.551748Z","time spent":"431.872229ms","remote":"127.0.0.1:50542","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-13T22:49:10.983775Z","caller":"traceutil/trace.go:171","msg":"trace[1776900951] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1833; }","duration":"398.49593ms","start":"2026-06-13T22:49:10.585261Z","end":"2026-06-13T22:49:10.983757Z","steps":["trace[1776900951] 'agreement among raft nodes before linearized reading' (duration: 398.276645ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:49:10.983755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"404.271368ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-06-13T22:49:10.983824Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:49:10.585239Z","time spent":"398.575201ms","remote":"127.0.0.1:50542","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-06-13T22:49:10.983845Z","caller":"traceutil/trace.go:171","msg":"trace[1875578430] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1833; }","duration":"404.404921ms","start":"2026-06-13T22:49:10.579416Z","end":"2026-06-13T22:49:10.983821Z","steps":["trace[1875578430] 'agreement among raft nodes before linearized reading' (duration: 404.207827ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:49:10.983929Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:49:10.579391Z","time spent":"404.524373ms","remote":"127.0.0.1:50542","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":"info","ts":"2026-06-13T22:49:11.350409Z","caller":"traceutil/trace.go:171","msg":"trace[1545183745] transaction","detail":"{read_only:false; response_revision:1838; number_of_response:1; }","duration":"135.861533ms","start":"2026-06-13T22:49:11.214524Z","end":"2026-06-13T22:49:11.350386Z","steps":["trace[1545183745] 'process raft request' (duration: 89.729498ms)","trace[1545183745] 'compare' (duration: 46.017332ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T22:49:25.560283Z","caller":"traceutil/trace.go:171","msg":"trace[1084708271] transaction","detail":"{read_only:false; response_revision:1955; number_of_response:1; }","duration":"150.320458ms","start":"2026-06-13T22:49:25.409921Z","end":"2026-06-13T22:49:25.560242Z","steps":["trace[1084708271] 'process raft request' (duration: 150.128453ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:50:00.831922Z","caller":"traceutil/trace.go:171","msg":"trace[1200635975] transaction","detail":"{read_only:false; response_revision:2161; number_of_response:1; }","duration":"104.30198ms","start":"2026-06-13T22:50:00.727545Z","end":"2026-06-13T22:50:00.831847Z","steps":["trace[1200635975] 'process raft request' (duration: 73.583754ms)","trace[1200635975] 'compare' (duration: 30.216664ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T22:50:01.319104Z","caller":"traceutil/trace.go:171","msg":"trace[1550796694] transaction","detail":"{read_only:false; response_revision:2163; number_of_response:1; }","duration":"121.108343ms","start":"2026-06-13T22:50:01.197959Z","end":"2026-06-13T22:50:01.319067Z","steps":["trace[1550796694] 'process raft request' (duration: 120.838336ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:50:01.489656Z","caller":"traceutil/trace.go:171","msg":"trace[6786678] linearizableReadLoop","detail":"{readStateIndex:2249; appliedIndex:2248; }","duration":"170.60434ms","start":"2026-06-13T22:50:01.319014Z","end":"2026-06-13T22:50:01.489618Z","steps":["trace[6786678] 'read index received' (duration: 170.460036ms)","trace[6786678] 'applied index is now lower than readState.Index' (duration: 143.404µs)"],"step_count":2} {"level":"info","ts":"2026-06-13T22:50:01.489694Z","caller":"traceutil/trace.go:171","msg":"trace[1207376019] transaction","detail":"{read_only:false; response_revision:2164; number_of_response:1; }","duration":"177.922985ms","start":"2026-06-13T22:50:01.311739Z","end":"2026-06-13T22:50:01.489662Z","steps":["trace[1207376019] 'process raft request' (duration: 177.737ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:50:01.489873Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.035843ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-13T22:50:01.489952Z","caller":"traceutil/trace.go:171","msg":"trace[1220765488] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2164; }","duration":"177.175006ms","start":"2026-06-13T22:50:01.312751Z","end":"2026-06-13T22:50:01.489926Z","steps":["trace[1220765488] 'agreement among raft nodes before linearized reading' (duration: 176.974201ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:50:01.500679Z","caller":"traceutil/trace.go:171","msg":"trace[230691545] transaction","detail":"{read_only:false; response_revision:2165; number_of_response:1; }","duration":"176.824938ms","start":"2026-06-13T22:50:01.323831Z","end":"2026-06-13T22:50:01.500656Z","steps":["trace[230691545] 'process raft request' (duration: 176.665494ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:50:01.500707Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.230528ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-13T22:50:01.500707Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.252278ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T22:50:01.500762Z","caller":"traceutil/trace.go:171","msg":"trace[2024833048] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2165; }","duration":"119.33021ms","start":"2026-06-13T22:50:01.38142Z","end":"2026-06-13T22:50:01.50075Z","steps":["trace[2024833048] 'agreement among raft nodes before linearized reading' (duration: 119.252588ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:50:01.500772Z","caller":"traceutil/trace.go:171","msg":"trace[1611875703] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:2165; }","duration":"169.37466ms","start":"2026-06-13T22:50:01.331384Z","end":"2026-06-13T22:50:01.500759Z","steps":["trace[1611875703] 'agreement among raft nodes before linearized reading' (duration: 169.245207ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:50:02.113227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.386494ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-13T22:50:02.113349Z","caller":"traceutil/trace.go:171","msg":"trace[1775940950] linearizableReadLoop","detail":"{readStateIndex:2253; appliedIndex:2252; }","duration":"176.255634ms","start":"2026-06-13T22:50:01.937075Z","end":"2026-06-13T22:50:02.113331Z","steps":["trace[1775940950] 'read index received' (duration: 10.692875ms)","trace[1775940950] 'applied index is now lower than readState.Index' (duration: 165.561279ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T22:50:02.113441Z","caller":"traceutil/trace.go:171","msg":"trace[1141102141] transaction","detail":"{read_only:false; response_revision:2168; number_of_response:1; }","duration":"321.236639ms","start":"2026-06-13T22:50:01.792158Z","end":"2026-06-13T22:50:02.113395Z","steps":["trace[1141102141] 'process raft request' (duration: 155.578099ms)","trace[1141102141] 'compare' (duration: 165.134108ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T22:50:02.113581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.50287ms","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-06-13T22:50:02.11363Z","caller":"traceutil/trace.go:171","msg":"trace[1025056434] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2168; }","duration":"176.574222ms","start":"2026-06-13T22:50:01.93704Z","end":"2026-06-13T22:50:02.113614Z","steps":["trace[1025056434] 'agreement among raft nodes before linearized reading' (duration: 176.410037ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:50:02.113645Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:50:01.792132Z","time spent":"321.406154ms","remote":"127.0.0.1:50542","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-13T22:50:02.11389Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.825736ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-13T22:50:02.113929Z","caller":"traceutil/trace.go:171","msg":"trace[1603874239] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:2168; }","duration":"145.907918ms","start":"2026-06-13T22:50:01.968013Z","end":"2026-06-13T22:50:02.11392Z","steps":["trace[1603874239] 'agreement among raft nodes before linearized reading' (duration: 145.847706ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:54:03.089486Z","caller":"traceutil/trace.go:171","msg":"trace[2132419465] transaction","detail":"{read_only:false; response_revision:3844; number_of_response:1; }","duration":"263.970807ms","start":"2026-06-13T22:54:02.825483Z","end":"2026-06-13T22:54:03.089454Z","steps":["trace[2132419465] 'process raft request' (duration: 194.240872ms)","trace[2132419465] 'compare' (duration: 68.876644ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T22:55:26.894348Z","caller":"traceutil/trace.go:171","msg":"trace[7909142] transaction","detail":"{read_only:false; response_revision:4890; number_of_response:1; }","duration":"104.8198ms","start":"2026-06-13T22:55:26.789502Z","end":"2026-06-13T22:55:26.894321Z","steps":["trace[7909142] 'process raft request' (duration: 104.647896ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:55:26.907048Z","caller":"traceutil/trace.go:171","msg":"trace[254819207] transaction","detail":"{read_only:false; response_revision:4891; number_of_response:1; }","duration":"103.044367ms","start":"2026-06-13T22:55:26.803974Z","end":"2026-06-13T22:55:26.907018Z","steps":["trace[254819207] 'process raft request' (duration: 102.75497ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:55:30.774174Z","caller":"traceutil/trace.go:171","msg":"trace[562784864] transaction","detail":"{read_only:false; response_revision:5050; number_of_response:1; }","duration":"109.619624ms","start":"2026-06-13T22:55:30.664526Z","end":"2026-06-13T22:55:30.774145Z","steps":["trace[562784864] 'process raft request' (duration: 109.46527ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:55:32.726187Z","caller":"traceutil/trace.go:171","msg":"trace[1161499816] linearizableReadLoop","detail":"{readStateIndex:5282; appliedIndex:5281; }","duration":"114.803969ms","start":"2026-06-13T22:55:32.611347Z","end":"2026-06-13T22:55:32.726151Z","steps":["trace[1161499816] 'read index received' (duration: 86.13152ms)","trace[1161499816] 'applied index is now lower than readState.Index' (duration: 28.671309ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T22:55:32.726371Z","caller":"traceutil/trace.go:171","msg":"trace[860451081] transaction","detail":"{read_only:false; response_revision:5087; number_of_response:1; }","duration":"122.446933ms","start":"2026-06-13T22:55:32.603871Z","end":"2026-06-13T22:55:32.726318Z","steps":["trace[860451081] 'process raft request' (duration: 93.624319ms)","trace[860451081] 'compare' (duration: 28.510355ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T22:55:32.726522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.138618ms","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-06-13T22:55:32.72658Z","caller":"traceutil/trace.go:171","msg":"trace[1639377699] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5087; }","duration":"115.282391ms","start":"2026-06-13T22:55:32.611281Z","end":"2026-06-13T22:55:32.726564Z","steps":["trace[1639377699] 'agreement among raft nodes before linearized reading' (duration: 115.030206ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:55:32.726853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.13212ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-3bbdc0a6-e373-4048-8a8d-8ce19102b554\" ","response":"range_response_count:1 size:3890"} {"level":"info","ts":"2026-06-13T22:55:32.726973Z","caller":"traceutil/trace.go:171","msg":"trace[1544362028] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-3bbdc0a6-e373-4048-8a8d-8ce19102b554; range_end:; response_count:1; response_revision:5087; }","duration":"101.334445ms","start":"2026-06-13T22:55:32.625612Z","end":"2026-06-13T22:55:32.726947Z","steps":["trace[1544362028] 'agreement among raft nodes before linearized reading' (duration: 100.992016ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:55:45.103407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.580586ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-13T22:55:45.103632Z","caller":"traceutil/trace.go:171","msg":"trace[850095820] transaction","detail":"{read_only:false; response_revision:5319; number_of_response:1; }","duration":"195.947009ms","start":"2026-06-13T22:55:44.907628Z","end":"2026-06-13T22:55:45.103575Z","steps":["trace[850095820] 'process raft request' (duration: 93.124728ms)","trace[850095820] 'compare' (duration: 102.416321ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T22:55:45.501138Z","caller":"traceutil/trace.go:171","msg":"trace[636750970] linearizableReadLoop","detail":"{readStateIndex:5527; appliedIndex:5526; }","duration":"118.637101ms","start":"2026-06-13T22:55:45.382448Z","end":"2026-06-13T22:55:45.501085Z","steps":["trace[636750970] 'read index received' (duration: 118.304833ms)","trace[636750970] 'applied index is now lower than readState.Index' (duration: 331.248µs)"],"step_count":2} {"level":"warn","ts":"2026-06-13T22:55:45.501403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.898097ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T22:55:45.501449Z","caller":"traceutil/trace.go:171","msg":"trace[1739763213] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5323; }","duration":"119.013391ms","start":"2026-06-13T22:55:45.382425Z","end":"2026-06-13T22:55:45.501438Z","steps":["trace[1739763213] 'agreement among raft nodes before linearized reading' (duration: 118.831936ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:55:45.501602Z","caller":"traceutil/trace.go:171","msg":"trace[2061071752] transaction","detail":"{read_only:false; response_revision:5323; number_of_response:1; }","duration":"143.600951ms","start":"2026-06-13T22:55:45.357966Z","end":"2026-06-13T22:55:45.501567Z","steps":["trace[2061071752] 'process raft request' (duration: 142.900734ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:55:53.967619Z","caller":"traceutil/trace.go:171","msg":"trace[323732743] transaction","detail":"{read_only:false; response_revision:5517; number_of_response:1; }","duration":"126.271764ms","start":"2026-06-13T22:55:53.841317Z","end":"2026-06-13T22:55:53.967589Z","steps":["trace[323732743] 'process raft request' (duration: 97.099884ms)","trace[323732743] 'compare' (duration: 28.952495ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T22:55:53.968102Z","caller":"traceutil/trace.go:171","msg":"trace[1964575247] transaction","detail":"{read_only:false; response_revision:5518; number_of_response:1; }","duration":"120.894846ms","start":"2026-06-13T22:55:53.847045Z","end":"2026-06-13T22:55:53.96794Z","steps":["trace[1964575247] 'process raft request' (duration: 120.507356ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:56:50.075855Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2949} {"level":"info","ts":"2026-06-13T22:56:50.159964Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2949,"took":"79.752171ms","hash":1269361579,"current-db-size-bytes":56852480,"current-db-size":"57 MB","current-db-size-in-use-bytes":33505280,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-06-13T22:56:50.160072Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1269361579,"revision":2949,"compact-revision":-1} {"level":"info","ts":"2026-06-13T23:01:50.083365Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6022} {"level":"info","ts":"2026-06-13T23:01:50.180273Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6022,"took":"94.796558ms","hash":1611477116,"current-db-size-bytes":56852480,"current-db-size":"57 MB","current-db-size-in-use-bytes":21913600,"current-db-size-in-use":"22 MB"} {"level":"info","ts":"2026-06-13T23:01:50.180355Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1611477116,"revision":6022,"compact-revision":2949} {"level":"info","ts":"2026-06-13T23:02:03.626413Z","caller":"traceutil/trace.go:171","msg":"trace[2072474617] linearizableReadLoop","detail":"{readStateIndex:8641; appliedIndex:8640; }","duration":"149.321323ms","start":"2026-06-13T23:02:03.47706Z","end":"2026-06-13T23:02:03.626381Z","steps":["trace[2072474617] 'read index received' (duration: 149.112168ms)","trace[2072474617] 'applied index is now lower than readState.Index' (duration: 207.915µs)"],"step_count":2} {"level":"info","ts":"2026-06-13T23:02:03.626462Z","caller":"traceutil/trace.go:171","msg":"trace[28888503] transaction","detail":"{read_only:false; response_revision:8340; number_of_response:1; }","duration":"197.075755ms","start":"2026-06-13T23:02:03.429351Z","end":"2026-06-13T23:02:03.626426Z","steps":["trace[28888503] 'process raft request' (duration: 196.8443ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T23:02:03.626645Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.554598ms","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-06-13T23:02:03.626742Z","caller":"traceutil/trace.go:171","msg":"trace[824531665] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:8340; }","duration":"149.709872ms","start":"2026-06-13T23:02:03.476985Z","end":"2026-06-13T23:02:03.626695Z","steps":["trace[824531665] 'agreement among raft nodes before linearized reading' (duration: 149.524738ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T23:02:03.660715Z","caller":"traceutil/trace.go:171","msg":"trace[1649986714] transaction","detail":"{read_only:false; response_revision:8341; number_of_response:1; }","duration":"175.276483ms","start":"2026-06-13T23:02:03.485358Z","end":"2026-06-13T23:02:03.660634Z","steps":["trace[1649986714] 'process raft request' (duration: 163.044001ms)","trace[1649986714] 'compare' (duration: 11.983496ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T23:02:03.660875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.048493ms","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-06-13T23:02:03.661046Z","caller":"traceutil/trace.go:171","msg":"trace[1344827064] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8341; }","duration":"156.310999ms","start":"2026-06-13T23:02:03.504712Z","end":"2026-06-13T23:02:03.661023Z","steps":["trace[1344827064] 'agreement among raft nodes before linearized reading' (duration: 155.92708ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T23:02:15.92817Z","caller":"traceutil/trace.go:171","msg":"trace[356955029] transaction","detail":"{read_only:false; response_revision:8404; number_of_response:1; }","duration":"171.578305ms","start":"2026-06-13T23:02:15.756558Z","end":"2026-06-13T23:02:15.928136Z","steps":["trace[356955029] 'process raft request' (duration: 104.275265ms)","trace[356955029] 'compare' (duration: 66.747967ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T23:02:15.928151Z","caller":"traceutil/trace.go:171","msg":"trace[308903302] linearizableReadLoop","detail":"{readStateIndex:8708; appliedIndex:8707; }","duration":"136.456635ms","start":"2026-06-13T23:02:15.791646Z","end":"2026-06-13T23:02:15.928103Z","steps":["trace[308903302] 'read index received' (duration: 69.119373ms)","trace[308903302] 'applied index is now lower than readState.Index' (duration: 67.335672ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T23:02:15.928413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.746131ms","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-06-13T23:02:15.928472Z","caller":"traceutil/trace.go:171","msg":"trace[739862476] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8404; }","duration":"136.869945ms","start":"2026-06-13T23:02:15.791587Z","end":"2026-06-13T23:02:15.928457Z","steps":["trace[739862476] 'agreement among raft nodes before linearized reading' (duration: 136.641469ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T23:02:16.129784Z","caller":"traceutil/trace.go:171","msg":"trace[462858797] linearizableReadLoop","detail":"{readStateIndex:8709; appliedIndex:8708; }","duration":"196.342698ms","start":"2026-06-13T23:02:15.933378Z","end":"2026-06-13T23:02:16.12972Z","steps":["trace[462858797] 'read index received' (duration: 196.180594ms)","trace[462858797] 'applied index is now lower than readState.Index' (duration: 160.974µs)"],"step_count":2} {"level":"info","ts":"2026-06-13T23:02:16.129831Z","caller":"traceutil/trace.go:171","msg":"trace[311837656] transaction","detail":"{read_only:false; response_revision:8405; number_of_response:1; }","duration":"196.821859ms","start":"2026-06-13T23:02:15.932955Z","end":"2026-06-13T23:02:16.129777Z","steps":["trace[311837656] 'process raft request' (duration: 196.573014ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T23:02:16.130037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.547533ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T23:02:16.130087Z","caller":"traceutil/trace.go:171","msg":"trace[80782127] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:8405; }","duration":"196.750898ms","start":"2026-06-13T23:02:15.933324Z","end":"2026-06-13T23:02:16.130074Z","steps":["trace[80782127] 'agreement among raft nodes before linearized reading' (duration: 196.551964ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T23:02:16.989433Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.948064ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-13T23:02:16.989552Z","caller":"traceutil/trace.go:171","msg":"trace[59126211] linearizableReadLoop","detail":"{readStateIndex:8714; appliedIndex:8713; }","duration":"155.358257ms","start":"2026-06-13T23:02:16.834174Z","end":"2026-06-13T23:02:16.989533Z","steps":["trace[59126211] 'read index received' (duration: 68.282µs)","trace[59126211] 'applied index is now lower than readState.Index' (duration: 155.288185ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T23:02:16.989649Z","caller":"traceutil/trace.go:171","msg":"trace[216338111] transaction","detail":"{read_only:false; response_revision:8410; number_of_response:1; }","duration":"372.598056ms","start":"2026-06-13T23:02:16.617011Z","end":"2026-06-13T23:02:16.989609Z","steps":["trace[216338111] 'process raft request' (duration: 195.370236ms)","trace[216338111] 'compare' (duration: 176.719848ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T23:02:16.989777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.619604ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-06-13T23:02:16.989822Z","caller":"traceutil/trace.go:171","msg":"trace[1243206201] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8410; }","duration":"155.716456ms","start":"2026-06-13T23:02:16.834095Z","end":"2026-06-13T23:02:16.989812Z","steps":["trace[1243206201] 'agreement among raft nodes before linearized reading' (duration: 155.541952ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T23:02:16.989872Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T23:02:16.616978Z","time spent":"372.777339ms","remote":"127.0.0.1:50542","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-13T23:02:16.990182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.141853ms","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-06-13T23:02:16.990226Z","caller":"traceutil/trace.go:171","msg":"trace[828922120] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8410; }","duration":"155.251115ms","start":"2026-06-13T23:02:16.834965Z","end":"2026-06-13T23:02:16.990216Z","steps":["trace[828922120] 'agreement among raft nodes before linearized reading' (duration: 155.092321ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T23:02:16.990383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.026231ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/storage-loki-0\" ","response":"range_response_count:1 size:1781"} {"level":"info","ts":"2026-06-13T23:02:16.990513Z","caller":"traceutil/trace.go:171","msg":"trace[147304168] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/storage-loki-0; range_end:; response_count:1; response_revision:8410; }","duration":"145.208035ms","start":"2026-06-13T23:02:16.845273Z","end":"2026-06-13T23:02:16.990481Z","steps":["trace[147304168] 'agreement among raft nodes before linearized reading' (duration: 144.788984ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T23:02:18.321331Z","caller":"traceutil/trace.go:171","msg":"trace[1091848100] transaction","detail":"{read_only:false; response_revision:8415; number_of_response:1; }","duration":"181.161385ms","start":"2026-06-13T23:02:18.140127Z","end":"2026-06-13T23:02:18.321289Z","steps":["trace[1091848100] 'process raft request' (duration: 180.905089ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T23:02:45.383737Z","caller":"traceutil/trace.go:171","msg":"trace[1763513205] linearizableReadLoop","detail":"{readStateIndex:8927; appliedIndex:8926; }","duration":"215.037097ms","start":"2026-06-13T23:02:45.168676Z","end":"2026-06-13T23:02:45.383713Z","steps":["trace[1763513205] 'read index received' (duration: 214.843302ms)","trace[1763513205] 'applied index is now lower than readState.Index' (duration: 192.875µs)"],"step_count":2} {"level":"info","ts":"2026-06-13T23:02:45.383915Z","caller":"traceutil/trace.go:171","msg":"trace[704557486] transaction","detail":"{read_only:false; response_revision:8615; number_of_response:1; }","duration":"296.58009ms","start":"2026-06-13T23:02:45.087279Z","end":"2026-06-13T23:02:45.38386Z","steps":["trace[704557486] 'process raft request' (duration: 296.298423ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T23:02:45.384016Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.321913ms","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-06-13T23:02:45.384061Z","caller":"traceutil/trace.go:171","msg":"trace[1799721833] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8615; }","duration":"215.418345ms","start":"2026-06-13T23:02:45.168628Z","end":"2026-06-13T23:02:45.384046Z","steps":["trace[1799721833] 'agreement among raft nodes before linearized reading' (duration: 215.232161ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T23:02:45.384124Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.16447ms","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-06-13T23:02:45.384175Z","caller":"traceutil/trace.go:171","msg":"trace[575355152] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8615; }","duration":"215.240451ms","start":"2026-06-13T23:02:45.16892Z","end":"2026-06-13T23:02:45.384161Z","steps":["trace[575355152] 'agreement among raft nodes before linearized reading' (duration: 215.091988ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T23:02:45.55946Z","caller":"traceutil/trace.go:171","msg":"trace[1833635697] transaction","detail":"{read_only:false; response_revision:8617; number_of_response:1; }","duration":"171.047778ms","start":"2026-06-13T23:02:45.388368Z","end":"2026-06-13T23:02:45.559416Z","steps":["trace[1833635697] 'process raft request' (duration: 96.830278ms)","trace[1833635697] 'compare' (duration: 74.047026ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T23:02:49.754141Z","caller":"traceutil/trace.go:171","msg":"trace[1848703519] linearizableReadLoop","detail":"{readStateIndex:8950; appliedIndex:8949; }","duration":"120.3857ms","start":"2026-06-13T23:02:49.633723Z","end":"2026-06-13T23:02:49.754109Z","steps":["trace[1848703519] 'read index received' (duration: 120.158305ms)","trace[1848703519] 'applied index is now lower than readState.Index' (duration: 225.565µs)"],"step_count":2} {"level":"info","ts":"2026-06-13T23:02:49.754258Z","caller":"traceutil/trace.go:171","msg":"trace[543148101] transaction","detail":"{read_only:false; response_revision:8637; number_of_response:1; }","duration":"170.518716ms","start":"2026-06-13T23:02:49.5837Z","end":"2026-06-13T23:02:49.754218Z","steps":["trace[543148101] 'process raft request' (duration: 170.218719ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T23:02:49.75443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.676657ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12211"} {"level":"info","ts":"2026-06-13T23:02:49.754598Z","caller":"traceutil/trace.go:171","msg":"trace[1043806237] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:8637; }","duration":"120.892842ms","start":"2026-06-13T23:02:49.633681Z","end":"2026-06-13T23:02:49.754574Z","steps":["trace[1043806237] 'agreement among raft nodes before linearized reading' (duration: 120.559074ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T23:02:49.96795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.627541ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5651"} {"level":"info","ts":"2026-06-13T23:02:49.96848Z","caller":"traceutil/trace.go:171","msg":"trace[1378906273] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:8637; }","duration":"120.255467ms","start":"2026-06-13T23:02:49.8482Z","end":"2026-06-13T23:02:49.968455Z","steps":["trace[1378906273] 'range keys from in-memory index tree' (duration: 119.389026ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T23:02:58.441322Z","caller":"traceutil/trace.go:171","msg":"trace[424531543] transaction","detail":"{read_only:false; response_revision:8725; number_of_response:1; }","duration":"103.710032ms","start":"2026-06-13T23:02:58.337581Z","end":"2026-06-13T23:02:58.441291Z","steps":["trace[424531543] 'process raft request' (duration: 103.530818ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T23:02:58.69711Z","caller":"traceutil/trace.go:171","msg":"trace[857555014] transaction","detail":"{read_only:false; response_revision:8726; number_of_response:1; }","duration":"351.52801ms","start":"2026-06-13T23:02:58.345531Z","end":"2026-06-13T23:02:58.697059Z","steps":["trace[857555014] 'process raft request' (duration: 277.559746ms)","trace[857555014] 'compare' (duration: 73.737458ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T23:02:58.697177Z","caller":"traceutil/trace.go:171","msg":"trace[245254732] linearizableReadLoop","detail":"{readStateIndex:9042; appliedIndex:9040; }","duration":"314.5667ms","start":"2026-06-13T23:02:58.382554Z","end":"2026-06-13T23:02:58.697121Z","steps":["trace[245254732] 'read index received' (duration: 58.618728ms)","trace[245254732] 'applied index is now lower than readState.Index' (duration: 255.943502ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T23:02:58.697204Z","caller":"traceutil/trace.go:171","msg":"trace[736922831] transaction","detail":"{read_only:false; response_revision:8727; number_of_response:1; }","duration":"125.460021ms","start":"2026-06-13T23:02:58.5717Z","end":"2026-06-13T23:02:58.69716Z","steps":["trace[736922831] 'process raft request' (duration: 125.355958ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T23:02:58.697348Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T23:02:58.345496Z","time spent":"351.729875ms","remote":"127.0.0.1:50438","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4634,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-13T23:02:58.697969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.352658ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T23:02:58.698092Z","caller":"traceutil/trace.go:171","msg":"trace[1847897292] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8727; }","duration":"315.576213ms","start":"2026-06-13T23:02:58.382495Z","end":"2026-06-13T23:02:58.698072Z","steps":["trace[1847897292] 'agreement among raft nodes before linearized reading' (duration: 314.848096ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T23:02:58.698143Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T23:02:58.38247Z","time spent":"315.660156ms","remote":"127.0.0.1:50258","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-06-13T23:02:58.733798Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.967327ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-06-13T23:02:58.7339Z","caller":"traceutil/trace.go:171","msg":"trace[144867918] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8727; }","duration":"114.140761ms","start":"2026-06-13T23:02:58.619739Z","end":"2026-06-13T23:02:58.733879Z","steps":["trace[144867918] 'agreement among raft nodes before linearized reading' (duration: 113.795573ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T23:02:58.734208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.896511ms","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-06-13T23:02:58.73437Z","caller":"traceutil/trace.go:171","msg":"trace[2079805604] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8727; }","duration":"217.171928ms","start":"2026-06-13T23:02:58.517169Z","end":"2026-06-13T23:02:58.734341Z","steps":["trace[2079805604] 'agreement among raft nodes before linearized reading' (duration: 216.39639ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T23:03:34.326188Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000024b4.wal"} {"level":"warn","ts":"2026-06-13T23:04:18.915075Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.377543ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/superstreams/\" range_end:\"/registry/rabbitmq.com/superstreams0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T23:04:18.916068Z","caller":"traceutil/trace.go:171","msg":"trace[183826896] range","detail":"{range_begin:/registry/rabbitmq.com/superstreams/; range_end:/registry/rabbitmq.com/superstreams0; response_count:0; response_revision:9497; }","duration":"101.645299ms","start":"2026-06-13T23:04:18.813581Z","end":"2026-06-13T23:04:18.915226Z","steps":["trace[183826896] 'count revisions from in-memory index tree' (duration: 101.182558ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T23:04:38.399453Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"a847c2e9c7010db6","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-13T23:04:38.405533Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-06-13T23:04:38.405666Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-06-13T23:06:50.089296Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8131} {"level":"info","ts":"2026-06-13T23:06:50.154689Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8131,"took":"62.85619ms","hash":1961342411,"current-db-size-bytes":56852480,"current-db-size":"57 MB","current-db-size-in-use-bytes":28319744,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-06-13T23:06:50.154745Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1961342411,"revision":8131,"compact-revision":6022} {"level":"info","ts":"2026-06-13T23:09:56.493877Z","caller":"traceutil/trace.go:171","msg":"trace[1746239900] linearizableReadLoop","detail":"{readStateIndex:12336; appliedIndex:12335; }","duration":"132.742684ms","start":"2026-06-13T23:09:56.361104Z","end":"2026-06-13T23:09:56.493847Z","steps":["trace[1746239900] 'read index received' (duration: 132.616851ms)","trace[1746239900] 'applied index is now lower than readState.Index' (duration: 124.593µs)"],"step_count":2} {"level":"info","ts":"2026-06-13T23:09:56.493931Z","caller":"traceutil/trace.go:171","msg":"trace[1576479181] transaction","detail":"{read_only:false; response_revision:11920; number_of_response:1; }","duration":"141.280578ms","start":"2026-06-13T23:09:56.352614Z","end":"2026-06-13T23:09:56.493895Z","steps":["trace[1576479181] 'process raft request' (duration: 141.053623ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T23:09:56.494201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.026591ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-06-13T23:09:56.494296Z","caller":"traceutil/trace.go:171","msg":"trace[115619713] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:11920; }","duration":"133.247528ms","start":"2026-06-13T23:09:56.361036Z","end":"2026-06-13T23:09:56.494283Z","steps":["trace[115619713] 'agreement among raft nodes before linearized reading' (duration: 132.96052ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T23:09:56.514403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.025154ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T23:09:56.514487Z","caller":"traceutil/trace.go:171","msg":"trace[1326268520] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:11921; }","duration":"131.172007ms","start":"2026-06-13T23:09:56.383293Z","end":"2026-06-13T23:09:56.514465Z","steps":["trace[1326268520] 'agreement among raft nodes before linearized reading' (duration: 131.027064ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T23:09:57.768871Z","caller":"traceutil/trace.go:171","msg":"trace[1372483409] linearizableReadLoop","detail":"{readStateIndex:12347; appliedIndex:12346; }","duration":"103.884794ms","start":"2026-06-13T23:09:57.664921Z","end":"2026-06-13T23:09:57.768806Z","steps":["trace[1372483409] 'read index received' (duration: 103.689689ms)","trace[1372483409] 'applied index is now lower than readState.Index' (duration: 193.725µs)"],"step_count":2} {"level":"info","ts":"2026-06-13T23:09:57.76905Z","caller":"traceutil/trace.go:171","msg":"trace[676832872] transaction","detail":"{read_only:false; response_revision:11931; number_of_response:1; }","duration":"163.449589ms","start":"2026-06-13T23:09:57.605535Z","end":"2026-06-13T23:09:57.768984Z","steps":["trace[676832872] 'process raft request' (duration: 163.009128ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T23:09:57.769175Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.210493ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectstoreusers/\" range_end:\"/registry/ceph.rook.io/cephobjectstoreusers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T23:09:57.769247Z","caller":"traceutil/trace.go:171","msg":"trace[1572048011] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectstoreusers/; range_end:/registry/ceph.rook.io/cephobjectstoreusers0; response_count:0; response_revision:11931; }","duration":"104.386347ms","start":"2026-06-13T23:09:57.664841Z","end":"2026-06-13T23:09:57.769227Z","steps":["trace[1572048011] 'agreement among raft nodes before linearized reading' (duration: 104.191352ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T23:11:50.096842Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10496} {"level":"info","ts":"2026-06-13T23:11:50.176914Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10496,"took":"77.474287ms","hash":3530462888,"current-db-size-bytes":56852480,"current-db-size":"57 MB","current-db-size-in-use-bytes":26148864,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-06-13T23:11:50.176993Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3530462888,"revision":10496,"compact-revision":8131} {"level":"info","ts":"2026-06-13T23:16:01.943557Z","caller":"traceutil/trace.go:171","msg":"trace[842879553] transaction","detail":"{read_only:false; response_revision:14391; number_of_response:1; }","duration":"116.356331ms","start":"2026-06-13T23:16:01.827175Z","end":"2026-06-13T23:16:01.943532Z","steps":["trace[842879553] 'process raft request' (duration: 116.197757ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T23:16:41.021405Z","caller":"traceutil/trace.go:171","msg":"trace[1333952065] linearizableReadLoop","detail":"{readStateIndex:15125; appliedIndex:15124; }","duration":"154.695907ms","start":"2026-06-13T23:16:40.866683Z","end":"2026-06-13T23:16:41.021379Z","steps":["trace[1333952065] 'read index received' (duration: 154.514043ms)","trace[1333952065] 'applied index is now lower than readState.Index' (duration: 180.884µs)"],"step_count":2} {"level":"info","ts":"2026-06-13T23:16:41.021484Z","caller":"traceutil/trace.go:171","msg":"trace[701783551] transaction","detail":"{read_only:false; response_revision:14612; number_of_response:1; }","duration":"233.696766ms","start":"2026-06-13T23:16:40.787751Z","end":"2026-06-13T23:16:41.021448Z","steps":["trace[701783551] 'process raft request' (duration: 233.461439ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T23:16:41.021684Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.939994ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/policies/\" range_end:\"/registry/rabbitmq.com/policies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T23:16:41.021805Z","caller":"traceutil/trace.go:171","msg":"trace[2103866715] range","detail":"{range_begin:/registry/rabbitmq.com/policies/; range_end:/registry/rabbitmq.com/policies0; response_count:0; response_revision:14612; }","duration":"155.155439ms","start":"2026-06-13T23:16:40.866622Z","end":"2026-06-13T23:16:41.021777Z","steps":["trace[2103866715] 'agreement among raft nodes before linearized reading' (duration: 154.912703ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T23:16:50.103559Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12686} {"level":"info","ts":"2026-06-13T23:16:50.180733Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12686,"took":"74.253454ms","hash":2647464572,"current-db-size-bytes":56852480,"current-db-size":"57 MB","current-db-size-in-use-bytes":26955776,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-06-13T23:16:50.180795Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2647464572,"revision":12686,"compact-revision":10496} {"level":"info","ts":"2026-06-13T23:18:14.907834Z","caller":"traceutil/trace.go:171","msg":"trace[1671657123] transaction","detail":"{read_only:false; response_revision:15661; number_of_response:1; }","duration":"281.010073ms","start":"2026-06-13T23:18:14.626796Z","end":"2026-06-13T23:18:14.907806Z","steps":["trace[1671657123] 'process raft request' (duration: 280.814118ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T23:18:14.937116Z","caller":"traceutil/trace.go:171","msg":"trace[1188148097] linearizableReadLoop","detail":"{readStateIndex:16210; appliedIndex:16207; }","duration":"253.055561ms","start":"2026-06-13T23:18:14.68403Z","end":"2026-06-13T23:18:14.937086Z","steps":["trace[1188148097] 'read index received' (duration: 223.648705ms)","trace[1188148097] 'applied index is now lower than readState.Index' (duration: 29.405676ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T23:18:14.937196Z","caller":"traceutil/trace.go:171","msg":"trace[287508709] transaction","detail":"{read_only:false; response_revision:15663; number_of_response:1; }","duration":"307.749735ms","start":"2026-06-13T23:18:14.629424Z","end":"2026-06-13T23:18:14.937173Z","steps":["trace[287508709] 'process raft request' (duration: 307.622212ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T23:18:14.937155Z","caller":"traceutil/trace.go:171","msg":"trace[891032702] transaction","detail":"{read_only:false; response_revision:15662; number_of_response:1; }","duration":"308.3588ms","start":"2026-06-13T23:18:14.628776Z","end":"2026-06-13T23:18:14.937135Z","steps":["trace[891032702] 'process raft request' (duration: 308.106764ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T23:18:14.937353Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.256536ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-13T23:18:14.937356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.291836ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-endpoints\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-13T23:18:14.937466Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.272837ms","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-06-13T23:18:14.937476Z","caller":"traceutil/trace.go:171","msg":"trace[1003741159] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-endpoints; range_end:; response_count:0; response_revision:15663; }","duration":"253.486121ms","start":"2026-06-13T23:18:14.683962Z","end":"2026-06-13T23:18:14.937448Z","steps":["trace[1003741159] 'agreement among raft nodes before linearized reading' (duration: 253.259886ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T23:18:14.93751Z","caller":"traceutil/trace.go:171","msg":"trace[622936058] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:15663; }","duration":"251.346889ms","start":"2026-06-13T23:18:14.686152Z","end":"2026-06-13T23:18:14.937499Z","steps":["trace[622936058] 'agreement among raft nodes before linearized reading' (duration: 251.224637ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T23:18:14.937542Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.414741ms","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-06-13T23:18:14.937583Z","caller":"traceutil/trace.go:171","msg":"trace[1123940056] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:15663; }","duration":"251.478623ms","start":"2026-06-13T23:18:14.686096Z","end":"2026-06-13T23:18:14.937574Z","steps":["trace[1123940056] 'agreement among raft nodes before linearized reading' (duration: 251.338109ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T23:18:14.937657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.002719ms","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-06-13T23:18:14.937725Z","caller":"traceutil/trace.go:171","msg":"trace[1839314192] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:15663; }","duration":"151.118792ms","start":"2026-06-13T23:18:14.786594Z","end":"2026-06-13T23:18:14.937713Z","steps":["trace[1839314192] 'agreement among raft nodes before linearized reading' (duration: 150.987928ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T23:18:14.937747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.642235ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-endpoints\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-13T23:18:14.937778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.377439ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-user\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-13T23:18:14.937731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.621265ms","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-06-13T23:18:14.937806Z","caller":"traceutil/trace.go:171","msg":"trace[1462028317] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-user; range_end:; response_count:0; response_revision:15663; }","duration":"253.417191ms","start":"2026-06-13T23:18:14.684382Z","end":"2026-06-13T23:18:14.9378Z","steps":["trace[1462028317] 'agreement among raft nodes before linearized reading' (duration: 253.38547ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T23:18:14.937817Z","caller":"traceutil/trace.go:171","msg":"trace[644830319] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:15663; }","duration":"253.745798ms","start":"2026-06-13T23:18:14.684064Z","end":"2026-06-13T23:18:14.93781Z","steps":["trace[644830319] 'agreement among raft nodes before linearized reading' (duration: 253.651336ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T23:18:14.937409Z","caller":"traceutil/trace.go:171","msg":"trace[351068641] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:15663; }","duration":"253.346838ms","start":"2026-06-13T23:18:14.684049Z","end":"2026-06-13T23:18:14.937396Z","steps":["trace[351068641] 'agreement among raft nodes before linearized reading' (duration: 253.259416ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T23:18:14.937552Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.91325ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-cell-setup-znj8v\" ","response":"range_response_count:1 size:9790"} {"level":"warn","ts":"2026-06-13T23:18:14.937756Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.283668ms","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-06-13T23:18:14.937897Z","caller":"traceutil/trace.go:171","msg":"trace[1759814143] range","detail":"{range_begin:/registry/pods/openstack/nova-cell-setup-znj8v; range_end:; response_count:1; response_revision:15663; }","duration":"107.300819ms","start":"2026-06-13T23:18:14.830589Z","end":"2026-06-13T23:18:14.93789Z","steps":["trace[1759814143] 'agreement among raft nodes before linearized reading' (duration: 106.851957ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T23:18:14.937913Z","caller":"traceutil/trace.go:171","msg":"trace[988110139] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-user; range_end:; response_count:0; response_revision:15663; }","duration":"253.461441ms","start":"2026-06-13T23:18:14.684447Z","end":"2026-06-13T23:18:14.937908Z","steps":["trace[988110139] 'agreement among raft nodes before linearized reading' (duration: 253.295867ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T23:18:14.937675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.600256ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/\" range_end:\"/registry/cert-manager.io/certificates0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-13T23:18:14.937967Z","caller":"traceutil/trace.go:171","msg":"trace[411592852] range","detail":"{range_begin:/registry/cert-manager.io/certificates/; range_end:/registry/cert-manager.io/certificates0; response_count:0; response_revision:15663; }","duration":"189.940144ms","start":"2026-06-13T23:18:14.748021Z","end":"2026-06-13T23:18:14.937961Z","steps":["trace[411592852] 'agreement among raft nodes before linearized reading' (duration: 189.611847ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T23:18:14.937778Z","caller":"traceutil/trace.go:171","msg":"trace[307438622] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-endpoints; range_end:; response_count:0; response_revision:15663; }","duration":"253.710447ms","start":"2026-06-13T23:18:14.68406Z","end":"2026-06-13T23:18:14.937771Z","steps":["trace[307438622] 'agreement among raft nodes before linearized reading' (duration: 253.660536ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T23:18:14.937357Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T23:18:14.629406Z","time spent":"307.832096ms","remote":"127.0.0.1:50542","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-13T23:18:14.937407Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T23:18:14.628756Z","time spent":"308.507604ms","remote":"127.0.0.1:50542","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-13T23:18:15.934583Z","caller":"traceutil/trace.go:171","msg":"trace[1182265022] transaction","detail":"{read_only:false; response_revision:15667; number_of_response:1; }","duration":"147.205137ms","start":"2026-06-13T23:18:15.787342Z","end":"2026-06-13T23:18:15.934547Z","steps":["trace[1182265022] 'process raft request' (duration: 146.988802ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T23:18:15.935191Z","caller":"traceutil/trace.go:171","msg":"trace[2095963252] transaction","detail":"{read_only:false; response_revision:15668; number_of_response:1; }","duration":"146.950233ms","start":"2026-06-13T23:18:15.788221Z","end":"2026-06-13T23:18:15.935171Z","steps":["trace[2095963252] 'process raft request' (duration: 146.807799ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T23:18:46.755358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.81884ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-x5hlh\" ","response":"range_response_count:1 size:22095"} {"level":"info","ts":"2026-06-13T23:18:46.755489Z","caller":"traceutil/trace.go:171","msg":"trace[40319602] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-x5hlh; range_end:; response_count:1; response_revision:15825; }","duration":"110.060166ms","start":"2026-06-13T23:18:46.645404Z","end":"2026-06-13T23:18:46.755464Z","steps":["trace[40319602] 'range keys from in-memory index tree' (duration: 109.557494ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T23:21:34.602104Z","caller":"traceutil/trace.go:171","msg":"trace[1717308291] linearizableReadLoop","detail":"{readStateIndex:17812; appliedIndex:17811; }","duration":"324.93984ms","start":"2026-06-13T23:21:34.277138Z","end":"2026-06-13T23:21:34.602078Z","steps":["trace[1717308291] 'read index received' (duration: 324.380937ms)","trace[1717308291] 'applied index is now lower than readState.Index' (duration: 557.513µs)"],"step_count":2} {"level":"info","ts":"2026-06-13T23:21:34.602198Z","caller":"traceutil/trace.go:171","msg":"trace[664681677] transaction","detail":"{read_only:false; response_revision:17216; number_of_response:1; }","duration":"348.119068ms","start":"2026-06-13T23:21:34.254044Z","end":"2026-06-13T23:21:34.602163Z","steps":["trace[664681677] 'process raft request' (duration: 347.487883ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T23:21:34.60241Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T23:21:34.254012Z","time spent":"348.294152ms","remote":"127.0.0.1:45898","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":416771,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-13T23:21:34.602452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.281529ms","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-06-13T23:21:34.605175Z","caller":"traceutil/trace.go:171","msg":"trace[403263887] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:17216; }","duration":"328.057345ms","start":"2026-06-13T23:21:34.277069Z","end":"2026-06-13T23:21:34.605127Z","steps":["trace[403263887] 'agreement among raft nodes before linearized reading' (duration: 325.110134ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T23:21:34.605365Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T23:21:34.277028Z","time spent":"328.25775ms","remote":"127.0.0.1:50542","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":531,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-13T23:21:34.611562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.5308ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-13T23:21:34.611649Z","caller":"traceutil/trace.go:171","msg":"trace[829895492] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:17217; }","duration":"228.659024ms","start":"2026-06-13T23:21:34.382959Z","end":"2026-06-13T23:21:34.611618Z","steps":["trace[829895492] 'agreement among raft nodes before linearized reading' (duration: 228.533991ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T23:21:34.611558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.092577ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/objectbucket.io/objectbucketclaims/\" range_end:\"/registry/objectbucket.io/objectbucketclaims0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-06-13T23:21:34.611686Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.90555ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-x5hlh\" ","response":"range_response_count:1 size:22096"} {"level":"info","ts":"2026-06-13T23:21:34.611731Z","caller":"traceutil/trace.go:171","msg":"trace[1682990461] range","detail":"{range_begin:/registry/objectbucket.io/objectbucketclaims/; range_end:/registry/objectbucket.io/objectbucketclaims0; response_count:0; response_revision:17217; }","duration":"242.324962ms","start":"2026-06-13T23:21:34.369386Z","end":"2026-06-13T23:21:34.611711Z","steps":["trace[1682990461] 'agreement among raft nodes before linearized reading' (duration: 241.989084ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T23:21:34.611791Z","caller":"traceutil/trace.go:171","msg":"trace[570732888] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-x5hlh; range_end:; response_count:1; response_revision:17217; }","duration":"175.080404ms","start":"2026-06-13T23:21:34.436664Z","end":"2026-06-13T23:21:34.611744Z","steps":["trace[570732888] 'agreement among raft nodes before linearized reading' (duration: 174.797607ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T23:21:34.61158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.96394ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rook-ceph-pdbstatemap\" ","response":"range_response_count:1 size:357"} {"level":"warn","ts":"2026-06-13T23:21:34.61198Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.737628ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/neutron-server\" ","response":"range_response_count:1 size:702"} {"level":"info","ts":"2026-06-13T23:21:34.61195Z","caller":"traceutil/trace.go:171","msg":"trace[1878883457] range","detail":"{range_begin:/registry/configmaps/openstack/rook-ceph-pdbstatemap; range_end:; response_count:1; response_revision:17217; }","duration":"101.293948ms","start":"2026-06-13T23:21:34.510582Z","end":"2026-06-13T23:21:34.611876Z","steps":["trace[1878883457] 'agreement among raft nodes before linearized reading' (duration: 100.853347ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T23:21:34.612057Z","caller":"traceutil/trace.go:171","msg":"trace[560856750] range","detail":"{range_begin:/registry/services/endpoints/openstack/neutron-server; range_end:; response_count:1; response_revision:17217; }","duration":"133.81244ms","start":"2026-06-13T23:21:34.478212Z","end":"2026-06-13T23:21:34.612024Z","steps":["trace[560856750] 'agreement among raft nodes before linearized reading' (duration: 133.169795ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T23:21:50.109568Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14675} {"level":"info","ts":"2026-06-13T23:21:50.186489Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14675,"took":"73.428017ms","hash":831327540,"current-db-size-bytes":56852480,"current-db-size":"57 MB","current-db-size-in-use-bytes":34033664,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-06-13T23:21:50.186557Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":831327540,"revision":14675,"compact-revision":12686} {"level":"info","ts":"2026-06-13T23:26:50.119131Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17334} {"level":"info","ts":"2026-06-13T23:26:50.22553Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17334,"took":"102.484166ms","hash":3143545426,"current-db-size-bytes":56852480,"current-db-size":"57 MB","current-db-size-in-use-bytes":30175232,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-06-13T23:26:50.225687Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3143545426,"revision":17334,"compact-revision":14675} {"level":"info","ts":"2026-06-13T23:27:32.029987Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"a847c2e9c7010db6","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-13T23:27:32.035534Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-06-13T23:27:32.035678Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-06-13T23:31:50.167395Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19106} {"level":"info","ts":"2026-06-13T23:31:50.436982Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19106,"took":"266.298064ms","hash":3687737483,"current-db-size-bytes":56852480,"current-db-size":"57 MB","current-db-size-in-use-bytes":24141824,"current-db-size-in-use":"24 MB"} {"level":"info","ts":"2026-06-13T23:31:50.437085Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3687737483,"revision":19106,"compact-revision":17334}