{"level":"warn","ts":"2026-04-06T17:05:16.574163Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-06T17:05:16.574277Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.200:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://162.253.55.200:2380","--initial-cluster=instance=https://162.253.55.200:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.200:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.200: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-04-06T17:05:16.574401Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-06T17:05:16.574421Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.200:2380"]} {"level":"info","ts":"2026-04-06T17:05:16.574471Z","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-04-06T17:05:16.575359Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.200:2379"]} {"level":"info","ts":"2026-04-06T17:05:16.575525Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://162.253.55.200:2380"],"listen-peer-urls":["https://162.253.55.200:2380"],"advertise-client-urls":["https://162.253.55.200:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.200:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.200: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-04-06T17:05:16.579366Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.506669ms"} {"level":"info","ts":"2026-04-06T17:05:16.584862Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"e10bb51ed7578852","cluster-id":"aa14459abd2161c3"} {"level":"info","ts":"2026-04-06T17:05:16.585019Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e10bb51ed7578852 switched to configuration voters=()"} {"level":"info","ts":"2026-04-06T17:05:16.58506Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e10bb51ed7578852 became follower at term 0"} {"level":"info","ts":"2026-04-06T17:05:16.585081Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft e10bb51ed7578852 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-06T17:05:16.585103Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e10bb51ed7578852 became follower at term 1"} {"level":"info","ts":"2026-04-06T17:05:16.585159Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e10bb51ed7578852 switched to configuration voters=(16216254027344087122)"} {"level":"warn","ts":"2026-04-06T17:05:16.594683Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-06T17:05:16.596203Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-06T17:05:16.598054Z","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-04-06T17:05:16.600778Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"e10bb51ed7578852","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-06T17:05:16.601011Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"e10bb51ed7578852","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-06T17:05:16.601119Z","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-04-06T17:05:16.601182Z","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-04-06T17:05:16.601202Z","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-04-06T17:05:16.60224Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e10bb51ed7578852 switched to configuration voters=(16216254027344087122)"} {"level":"info","ts":"2026-04-06T17:05:16.602377Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"aa14459abd2161c3","local-member-id":"e10bb51ed7578852","added-peer-id":"e10bb51ed7578852","added-peer-peer-urls":["https://162.253.55.200:2380"]} {"level":"info","ts":"2026-04-06T17:05:16.604677Z","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-04-06T17:05:16.604795Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.200:2380"} {"level":"info","ts":"2026-04-06T17:05:16.604821Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.200:2380"} {"level":"info","ts":"2026-04-06T17:05:16.605051Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"e10bb51ed7578852","initial-advertise-peer-urls":["https://162.253.55.200:2380"],"listen-peer-urls":["https://162.253.55.200:2380"],"advertise-client-urls":["https://162.253.55.200:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.200:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-06T17:05:16.605112Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-06T17:05:16.685941Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e10bb51ed7578852 is starting a new election at term 1"} {"level":"info","ts":"2026-04-06T17:05:16.686051Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e10bb51ed7578852 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-06T17:05:16.686079Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e10bb51ed7578852 received MsgPreVoteResp from e10bb51ed7578852 at term 1"} {"level":"info","ts":"2026-04-06T17:05:16.686103Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e10bb51ed7578852 became candidate at term 2"} {"level":"info","ts":"2026-04-06T17:05:16.686116Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e10bb51ed7578852 received MsgVoteResp from e10bb51ed7578852 at term 2"} {"level":"info","ts":"2026-04-06T17:05:16.68614Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e10bb51ed7578852 became leader at term 2"} {"level":"info","ts":"2026-04-06T17:05:16.68616Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: e10bb51ed7578852 elected leader e10bb51ed7578852 at term 2"} {"level":"info","ts":"2026-04-06T17:05:16.688008Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"e10bb51ed7578852","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.200:2379]}","request-path":"/0/members/e10bb51ed7578852/attributes","cluster-id":"aa14459abd2161c3","publish-timeout":"7s"} {"level":"info","ts":"2026-04-06T17:05:16.688374Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-06T17:05:16.688716Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-06T17:05:16.688855Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-06T17:05:16.689063Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-06T17:05:16.688969Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-06T17:05:16.689326Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"aa14459abd2161c3","local-member-id":"e10bb51ed7578852","cluster-version":"3.5"} {"level":"info","ts":"2026-04-06T17:05:16.689451Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-06T17:05:16.689525Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-06T17:05:16.690828Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-06T17:05:16.693073Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.200:2379"} {"level":"info","ts":"2026-04-06T17:05:40.674708Z","caller":"traceutil/trace.go:171","msg":"trace[668708405] transaction","detail":"{read_only:false; response_revision:463; number_of_response:1; }","duration":"132.443512ms","start":"2026-04-06T17:05:40.542246Z","end":"2026-04-06T17:05:40.67469Z","steps":["trace[668708405] 'process raft request' (duration: 132.333049ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T17:05:54.129361Z","caller":"traceutil/trace.go:171","msg":"trace[494809045] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"155.475154ms","start":"2026-04-06T17:05:53.973841Z","end":"2026-04-06T17:05:54.129316Z","steps":["trace[494809045] 'process raft request' (duration: 152.724846ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T17:05:54.687987Z","caller":"traceutil/trace.go:171","msg":"trace[141186416] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"540.03359ms","start":"2026-04-06T17:05:54.147924Z","end":"2026-04-06T17:05:54.687957Z","steps":["trace[141186416] 'process raft request' (duration: 539.875105ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T17:05:54.688632Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T17:05:54.147895Z","time spent":"540.173344ms","remote":"127.0.0.1:59080","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-06T17:05:54.859288Z","caller":"traceutil/trace.go:171","msg":"trace[25262144] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"677.641379ms","start":"2026-04-06T17:05:54.181611Z","end":"2026-04-06T17:05:54.859252Z","steps":["trace[25262144] 'process raft request' (duration: 665.162395ms)","trace[25262144] 'compare' (duration: 12.215536ms)"],"step_count":2} {"level":"warn","ts":"2026-04-06T17:05:54.859456Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T17:05:54.181578Z","time spent":"677.794052ms","remote":"127.0.0.1:59380","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-06T17:05:54.859271Z","caller":"traceutil/trace.go:171","msg":"trace[279908861] linearizableReadLoop","detail":"{readStateIndex:644; appliedIndex:642; }","duration":"560.991905ms","start":"2026-04-06T17:05:54.298238Z","end":"2026-04-06T17:05:54.85923Z","steps":["trace[279908861] 'read index received' (duration: 389.557178ms)","trace[279908861] 'applied index is now lower than readState.Index' (duration: 171.432817ms)"],"step_count":2} {"level":"warn","ts":"2026-04-06T17:05:54.859802Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"561.54388ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-06T17:05:54.859819Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.298275ms","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-04-06T17:05:54.860058Z","caller":"traceutil/trace.go:171","msg":"trace[1700879507] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:623; }","duration":"561.821258ms","start":"2026-04-06T17:05:54.298216Z","end":"2026-04-06T17:05:54.860037Z","steps":["trace[1700879507] 'agreement among raft nodes before linearized reading' (duration: 561.140679ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T17:05:54.860168Z","caller":"traceutil/trace.go:171","msg":"trace[593855969] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:623; }","duration":"128.680306ms","start":"2026-04-06T17:05:54.731444Z","end":"2026-04-06T17:05:54.860124Z","steps":["trace[593855969] 'agreement among raft nodes before linearized reading' (duration: 128.230293ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T17:05:54.860216Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T17:05:54.298145Z","time spent":"562.005123ms","remote":"127.0.0.1:58924","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-06T17:05:55.344941Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.440827ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-06T17:05:55.345264Z","caller":"traceutil/trace.go:171","msg":"trace[393704752] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"481.12031ms","start":"2026-04-06T17:05:54.864118Z","end":"2026-04-06T17:05:55.345239Z","steps":["trace[393704752] 'process raft request' (duration: 243.162139ms)","trace[393704752] 'compare' (duration: 237.316953ms)"],"step_count":2} {"level":"warn","ts":"2026-04-06T17:05:55.345367Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T17:05:54.864097Z","time spent":"481.226044ms","remote":"127.0.0.1:59154","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-06T17:05:55.345387Z","caller":"traceutil/trace.go:171","msg":"trace[2139899926] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"477.879328ms","start":"2026-04-06T17:05:54.867464Z","end":"2026-04-06T17:05:55.345343Z","steps":["trace[2139899926] 'process raft request' (duration: 477.57606ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T17:05:55.34537Z","caller":"traceutil/trace.go:171","msg":"trace[1695135871] linearizableReadLoop","detail":"{readStateIndex:646; appliedIndex:644; }","duration":"474.811692ms","start":"2026-04-06T17:05:54.870506Z","end":"2026-04-06T17:05:55.345317Z","steps":["trace[1695135871] 'read index received' (duration: 236.782688ms)","trace[1695135871] 'applied index is now lower than readState.Index' (duration: 238.025343ms)"],"step_count":2} {"level":"warn","ts":"2026-04-06T17:05:55.345587Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T17:05:54.867435Z","time spent":"478.029122ms","remote":"127.0.0.1:59154","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-06T17:05:55.351623Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"481.092069ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-06T17:05:55.351722Z","caller":"traceutil/trace.go:171","msg":"trace[1820459991] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:625; }","duration":"481.243074ms","start":"2026-04-06T17:05:54.870456Z","end":"2026-04-06T17:05:55.351699Z","steps":["trace[1820459991] 'agreement among raft nodes before linearized reading' (duration: 474.986666ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T17:05:55.351926Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T17:05:54.870431Z","time spent":"481.328207ms","remote":"127.0.0.1:59124","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":29,"request content":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" "} {"level":"info","ts":"2026-04-06T17:06:11.325495Z","caller":"traceutil/trace.go:171","msg":"trace[283372286] transaction","detail":"{read_only:false; response_revision:788; number_of_response:1; }","duration":"144.660245ms","start":"2026-04-06T17:06:11.180807Z","end":"2026-04-06T17:06:11.325467Z","steps":["trace[283372286] 'process raft request' (duration: 144.462259ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T17:07:24.381547Z","caller":"traceutil/trace.go:171","msg":"trace[1085231112] transaction","detail":"{read_only:false; response_revision:1853; number_of_response:1; }","duration":"200.538493ms","start":"2026-04-06T17:07:24.180965Z","end":"2026-04-06T17:07:24.381504Z","steps":["trace[1085231112] 'process raft request' (duration: 200.310196ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T17:07:24.729918Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.409428ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-34e0f57e-9a8d-4e48-b269-75538e59e369\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-04-06T17:07:24.730008Z","caller":"traceutil/trace.go:171","msg":"trace[361547081] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-34e0f57e-9a8d-4e48-b269-75538e59e369; range_end:; response_count:1; response_revision:1853; }","duration":"215.532892ms","start":"2026-04-06T17:07:24.514437Z","end":"2026-04-06T17:07:24.72997Z","steps":["trace[361547081] 'range keys from in-memory index tree' (duration: 215.266154ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T17:07:24.730177Z","caller":"traceutil/trace.go:171","msg":"trace[682373321] transaction","detail":"{read_only:false; response_revision:1854; number_of_response:1; }","duration":"147.396384ms","start":"2026-04-06T17:07:24.582758Z","end":"2026-04-06T17:07:24.730154Z","steps":["trace[682373321] 'process raft request' (duration: 136.140053ms)","trace[682373321] 'compare' (duration: 10.833769ms)"],"step_count":2} {"level":"info","ts":"2026-04-06T17:07:24.741257Z","caller":"traceutil/trace.go:171","msg":"trace[1725635146] linearizableReadLoop","detail":"{readStateIndex:1925; appliedIndex:1923; }","duration":"119.416355ms","start":"2026-04-06T17:07:24.621827Z","end":"2026-04-06T17:07:24.741243Z","steps":["trace[1725635146] 'read index received' (duration: 97.127458ms)","trace[1725635146] 'applied index is now lower than readState.Index' (duration: 22.288297ms)"],"step_count":2} {"level":"warn","ts":"2026-04-06T17:07:24.741381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.555709ms","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-04-06T17:07:24.741408Z","caller":"traceutil/trace.go:171","msg":"trace[1084000180] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1855; }","duration":"119.633691ms","start":"2026-04-06T17:07:24.621765Z","end":"2026-04-06T17:07:24.741399Z","steps":["trace[1084000180] 'agreement among raft nodes before linearized reading' (duration: 119.523798ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T17:07:24.741405Z","caller":"traceutil/trace.go:171","msg":"trace[1329218162] transaction","detail":"{read_only:false; response_revision:1855; number_of_response:1; }","duration":"138.447829ms","start":"2026-04-06T17:07:24.602905Z","end":"2026-04-06T17:07:24.741353Z","steps":["trace[1329218162] 'process raft request' (duration: 138.270484ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T17:07:40.91721Z","caller":"traceutil/trace.go:171","msg":"trace[2054726522] transaction","detail":"{read_only:false; response_revision:1988; number_of_response:1; }","duration":"139.153369ms","start":"2026-04-06T17:07:40.778012Z","end":"2026-04-06T17:07:40.917166Z","steps":["trace[2054726522] 'process raft request' (duration: 138.244552ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T17:07:40.917489Z","caller":"traceutil/trace.go:171","msg":"trace[1664769413] transaction","detail":"{read_only:false; response_revision:1989; number_of_response:1; }","duration":"129.020759ms","start":"2026-04-06T17:07:40.788356Z","end":"2026-04-06T17:07:40.917377Z","steps":["trace[1664769413] 'process raft request' (duration: 128.743591ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T17:07:41.119015Z","caller":"traceutil/trace.go:171","msg":"trace[1676372810] transaction","detail":"{read_only:false; response_revision:1992; number_of_response:1; }","duration":"101.331627ms","start":"2026-04-06T17:07:41.017655Z","end":"2026-04-06T17:07:41.118987Z","steps":["trace[1676372810] 'process raft request' (duration: 99.719231ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T17:08:20.336149Z","caller":"traceutil/trace.go:171","msg":"trace[1400125732] transaction","detail":"{read_only:false; response_revision:2203; number_of_response:1; }","duration":"189.721539ms","start":"2026-04-06T17:08:20.146394Z","end":"2026-04-06T17:08:20.336116Z","steps":["trace[1400125732] 'process raft request' (duration: 120.651021ms)","trace[1400125732] 'compare' (duration: 68.822811ms)"],"step_count":2} {"level":"info","ts":"2026-04-06T17:08:20.336181Z","caller":"traceutil/trace.go:171","msg":"trace[2058246192] transaction","detail":"{read_only:false; response_revision:2204; number_of_response:1; }","duration":"186.751205ms","start":"2026-04-06T17:08:20.149408Z","end":"2026-04-06T17:08:20.336159Z","steps":["trace[2058246192] 'process raft request' (duration: 186.59508ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T17:08:20.336308Z","caller":"traceutil/trace.go:171","msg":"trace[1920375577] linearizableReadLoop","detail":"{readStateIndex:2287; appliedIndex:2284; }","duration":"176.340621ms","start":"2026-04-06T17:08:20.159943Z","end":"2026-04-06T17:08:20.336283Z","steps":["trace[1920375577] 'read index received' (duration: 107.119169ms)","trace[1920375577] 'applied index is now lower than readState.Index' (duration: 69.220302ms)"],"step_count":2} {"level":"info","ts":"2026-04-06T17:08:20.336565Z","caller":"traceutil/trace.go:171","msg":"trace[306746741] transaction","detail":"{read_only:false; response_revision:2205; number_of_response:1; }","duration":"187.031063ms","start":"2026-04-06T17:08:20.149474Z","end":"2026-04-06T17:08:20.336505Z","steps":["trace[306746741] 'process raft request' (duration: 186.626652ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T17:08:20.33677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.969572ms","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-04-06T17:08:20.336823Z","caller":"traceutil/trace.go:171","msg":"trace[1990046840] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2205; }","duration":"153.059184ms","start":"2026-04-06T17:08:20.183751Z","end":"2026-04-06T17:08:20.33681Z","steps":["trace[1990046840] 'agreement among raft nodes before linearized reading' (duration: 152.767916ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T17:08:20.33723Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.272618ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-04-06T17:08:20.337308Z","caller":"traceutil/trace.go:171","msg":"trace[1944108613] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2205; }","duration":"177.400101ms","start":"2026-04-06T17:08:20.159891Z","end":"2026-04-06T17:08:20.337291Z","steps":["trace[1944108613] 'agreement among raft nodes before linearized reading' (duration: 177.171885ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T17:08:20.622202Z","caller":"traceutil/trace.go:171","msg":"trace[812713095] transaction","detail":"{read_only:false; response_revision:2206; number_of_response:1; }","duration":"281.224868ms","start":"2026-04-06T17:08:20.34095Z","end":"2026-04-06T17:08:20.622175Z","steps":["trace[812713095] 'process raft request' (duration: 281.056623ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T17:08:20.627552Z","caller":"traceutil/trace.go:171","msg":"trace[1273044097] linearizableReadLoop","detail":"{readStateIndex:2289; appliedIndex:2287; }","duration":"285.92776ms","start":"2026-04-06T17:08:20.341607Z","end":"2026-04-06T17:08:20.627535Z","steps":["trace[1273044097] 'read index received' (duration: 280.423255ms)","trace[1273044097] 'applied index is now lower than readState.Index' (duration: 5.503735ms)"],"step_count":2} {"level":"info","ts":"2026-04-06T17:08:20.627645Z","caller":"traceutil/trace.go:171","msg":"trace[1465549049] transaction","detail":"{read_only:false; response_revision:2207; number_of_response:1; }","duration":"286.458125ms","start":"2026-04-06T17:08:20.341153Z","end":"2026-04-06T17:08:20.627611Z","steps":["trace[1465549049] 'process raft request' (duration: 286.297581ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T17:08:20.627679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.057044ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-04-06T17:08:20.627832Z","caller":"traceutil/trace.go:171","msg":"trace[216940860] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:2207; }","duration":"286.245099ms","start":"2026-04-06T17:08:20.341573Z","end":"2026-04-06T17:08:20.627818Z","steps":["trace[216940860] 'agreement among raft nodes before linearized reading' (duration: 286.035893ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T17:08:56.177904Z","caller":"traceutil/trace.go:171","msg":"trace[858927489] transaction","detail":"{read_only:false; response_revision:2575; number_of_response:1; }","duration":"142.96947ms","start":"2026-04-06T17:08:56.034907Z","end":"2026-04-06T17:08:56.177877Z","steps":["trace[858927489] 'process raft request' (duration: 142.470056ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T17:09:27.73063Z","caller":"traceutil/trace.go:171","msg":"trace[173992217] transaction","detail":"{read_only:false; response_revision:2768; number_of_response:1; }","duration":"102.06297ms","start":"2026-04-06T17:09:27.628529Z","end":"2026-04-06T17:09:27.730592Z","steps":["trace[173992217] 'process raft request' (duration: 101.853263ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T17:09:33.099478Z","caller":"traceutil/trace.go:171","msg":"trace[394793242] transaction","detail":"{read_only:false; response_revision:2796; number_of_response:1; }","duration":"140.076152ms","start":"2026-04-06T17:09:32.959371Z","end":"2026-04-06T17:09:33.099447Z","steps":["trace[394793242] 'process raft request' (duration: 139.904487ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T17:09:33.263815Z","caller":"traceutil/trace.go:171","msg":"trace[316855244] transaction","detail":"{read_only:false; response_revision:2797; number_of_response:1; }","duration":"303.766836ms","start":"2026-04-06T17:09:32.960023Z","end":"2026-04-06T17:09:33.26379Z","steps":["trace[316855244] 'process raft request' (duration: 220.705448ms)","trace[316855244] 'compare' (duration: 82.921063ms)"],"step_count":2} {"level":"warn","ts":"2026-04-06T17:09:33.263927Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T17:09:32.960001Z","time spent":"303.868239ms","remote":"127.0.0.1:59154","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-06T17:09:33.267017Z","caller":"traceutil/trace.go:171","msg":"trace[830084686] transaction","detail":"{read_only:false; response_revision:2798; number_of_response:1; }","duration":"125.739391ms","start":"2026-04-06T17:09:33.141265Z","end":"2026-04-06T17:09:33.267004Z","steps":["trace[830084686] 'process raft request' (duration: 125.650059ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T17:13:20.069791Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.614209ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-06T17:13:20.070181Z","caller":"traceutil/trace.go:171","msg":"trace[545601597] transaction","detail":"{read_only:false; response_revision:4941; number_of_response:1; }","duration":"150.157687ms","start":"2026-04-06T17:13:19.919995Z","end":"2026-04-06T17:13:20.070153Z","steps":["trace[545601597] 'compare' (duration: 142.447365ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T17:13:20.246125Z","caller":"traceutil/trace.go:171","msg":"trace[641509214] transaction","detail":"{read_only:false; response_revision:4942; number_of_response:1; }","duration":"128.955136ms","start":"2026-04-06T17:13:20.117138Z","end":"2026-04-06T17:13:20.246093Z","steps":["trace[641509214] 'process raft request' (duration: 83.200417ms)","trace[641509214] 'compare' (duration: 45.516401ms)"],"step_count":2} {"level":"info","ts":"2026-04-06T17:13:20.262129Z","caller":"traceutil/trace.go:171","msg":"trace[2037613141] transaction","detail":"{read_only:false; response_revision:4945; number_of_response:1; }","duration":"131.386885ms","start":"2026-04-06T17:13:20.130713Z","end":"2026-04-06T17:13:20.2621Z","steps":["trace[2037613141] 'process raft request' (duration: 131.262812ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T17:13:20.262456Z","caller":"traceutil/trace.go:171","msg":"trace[1303450069] transaction","detail":"{read_only:false; response_revision:4943; number_of_response:1; }","duration":"133.208568ms","start":"2026-04-06T17:13:20.129177Z","end":"2026-04-06T17:13:20.262386Z","steps":["trace[1303450069] 'process raft request' (duration: 132.629401ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T17:13:20.262226Z","caller":"traceutil/trace.go:171","msg":"trace[158128052] transaction","detail":"{read_only:false; response_revision:4944; number_of_response:1; }","duration":"132.891879ms","start":"2026-04-06T17:13:20.129256Z","end":"2026-04-06T17:13:20.262147Z","steps":["trace[158128052] 'process raft request' (duration: 132.682703ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T17:13:20.514341Z","caller":"traceutil/trace.go:171","msg":"trace[1405175514] transaction","detail":"{read_only:false; response_revision:4951; number_of_response:1; }","duration":"127.101582ms","start":"2026-04-06T17:13:20.387211Z","end":"2026-04-06T17:13:20.514312Z","steps":["trace[1405175514] 'process raft request' (duration: 104.027557ms)","trace[1405175514] 'compare' (duration: 22.273522ms)"],"step_count":2} {"level":"warn","ts":"2026-04-06T17:13:30.026224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.456798ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-06T17:13:30.026344Z","caller":"traceutil/trace.go:171","msg":"trace[507318321] linearizableReadLoop","detail":"{readStateIndex:5322; appliedIndex:5320; }","duration":"159.468385ms","start":"2026-04-06T17:13:29.866855Z","end":"2026-04-06T17:13:30.026323Z","steps":["trace[507318321] 'read index received' (duration: 5.275102ms)","trace[507318321] 'applied index is now lower than readState.Index' (duration: 154.191963ms)"],"step_count":2} {"level":"info","ts":"2026-04-06T17:13:30.026375Z","caller":"traceutil/trace.go:171","msg":"trace[1573154112] transaction","detail":"{read_only:false; response_revision:5132; number_of_response:1; }","duration":"190.692914ms","start":"2026-04-06T17:13:29.835649Z","end":"2026-04-06T17:13:30.026342Z","steps":["trace[1573154112] 'process raft request' (duration: 75.048941ms)","trace[1573154112] 'compare' (duration: 115.16294ms)"],"step_count":2} {"level":"warn","ts":"2026-04-06T17:13:30.026883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.023441ms","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-04-06T17:13:30.02693Z","caller":"traceutil/trace.go:171","msg":"trace[1182640685] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5132; }","duration":"160.139495ms","start":"2026-04-06T17:13:29.866778Z","end":"2026-04-06T17:13:30.026918Z","steps":["trace[1182640685] 'agreement among raft nodes before linearized reading' (duration: 159.957909ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T17:13:38.193734Z","caller":"traceutil/trace.go:171","msg":"trace[521923218] linearizableReadLoop","detail":"{readStateIndex:5461; appliedIndex:5459; }","duration":"111.632025ms","start":"2026-04-06T17:13:38.082083Z","end":"2026-04-06T17:13:38.193715Z","steps":["trace[521923218] 'read index received' (duration: 67.764574ms)","trace[521923218] 'applied index is now lower than readState.Index' (duration: 43.866571ms)"],"step_count":2} {"level":"info","ts":"2026-04-06T17:13:38.193775Z","caller":"traceutil/trace.go:171","msg":"trace[721571009] transaction","detail":"{read_only:false; response_revision:5269; number_of_response:1; }","duration":"116.642608ms","start":"2026-04-06T17:13:38.077096Z","end":"2026-04-06T17:13:38.193738Z","steps":["trace[721571009] 'process raft request' (duration: 116.516274ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T17:13:38.194014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.900203ms","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-04-06T17:13:38.194056Z","caller":"traceutil/trace.go:171","msg":"trace[2057974868] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5269; }","duration":"112.020876ms","start":"2026-04-06T17:13:38.082025Z","end":"2026-04-06T17:13:38.194046Z","steps":["trace[2057974868] 'agreement among raft nodes before linearized reading' (duration: 111.820701ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T17:13:38.194323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.738782ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-06T17:13:38.194375Z","caller":"traceutil/trace.go:171","msg":"trace[1055903501] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5269; }","duration":"108.843764ms","start":"2026-04-06T17:13:38.085518Z","end":"2026-04-06T17:13:38.194362Z","steps":["trace[1055903501] 'agreement among raft nodes before linearized reading' (duration: 108.658729ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T17:13:38.308772Z","caller":"traceutil/trace.go:171","msg":"trace[1777036132] transaction","detail":"{read_only:false; response_revision:5270; number_of_response:1; }","duration":"110.825501ms","start":"2026-04-06T17:13:38.197927Z","end":"2026-04-06T17:13:38.308752Z","steps":["trace[1777036132] 'process raft request' (duration: 48.872634ms)","trace[1777036132] 'compare' (duration: 61.840654ms)"],"step_count":2} {"level":"info","ts":"2026-04-06T17:13:38.312644Z","caller":"traceutil/trace.go:171","msg":"trace[1668533871] transaction","detail":"{read_only:false; response_revision:5271; number_of_response:1; }","duration":"114.086715ms","start":"2026-04-06T17:13:38.19846Z","end":"2026-04-06T17:13:38.312547Z","steps":["trace[1668533871] 'process raft request' (duration: 113.91252ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T17:13:54.645125Z","caller":"traceutil/trace.go:171","msg":"trace[1724816068] linearizableReadLoop","detail":"{readStateIndex:5687; appliedIndex:5686; }","duration":"265.466185ms","start":"2026-04-06T17:13:54.379632Z","end":"2026-04-06T17:13:54.645098Z","steps":["trace[1724816068] 'read index received' (duration: 265.215588ms)","trace[1724816068] 'applied index is now lower than readState.Index' (duration: 249.547µs)"],"step_count":2} {"level":"info","ts":"2026-04-06T17:13:54.645256Z","caller":"traceutil/trace.go:171","msg":"trace[1183077475] transaction","detail":"{read_only:false; response_revision:5489; number_of_response:1; }","duration":"313.796103ms","start":"2026-04-06T17:13:54.331426Z","end":"2026-04-06T17:13:54.645222Z","steps":["trace[1183077475] 'process raft request' (duration: 313.426943ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T17:13:54.645451Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T17:13:54.331405Z","time spent":"313.930377ms","remote":"127.0.0.1:59080","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4143,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-06T17:13:54.64558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.908517ms","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-04-06T17:13:54.645663Z","caller":"traceutil/trace.go:171","msg":"trace[822773587] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5489; }","duration":"266.046621ms","start":"2026-04-06T17:13:54.379604Z","end":"2026-04-06T17:13:54.64565Z","steps":["trace[822773587] 'agreement among raft nodes before linearized reading' (duration: 265.64307ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T17:13:54.69005Z","caller":"traceutil/trace.go:171","msg":"trace[1638469898] transaction","detail":"{read_only:false; response_revision:5491; number_of_response:1; }","duration":"303.310134ms","start":"2026-04-06T17:13:54.386713Z","end":"2026-04-06T17:13:54.690023Z","steps":["trace[1638469898] 'process raft request' (duration: 303.18481ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T17:13:54.690096Z","caller":"traceutil/trace.go:171","msg":"trace[1363483180] transaction","detail":"{read_only:false; response_revision:5490; number_of_response:1; }","duration":"310.365146ms","start":"2026-04-06T17:13:54.379679Z","end":"2026-04-06T17:13:54.690044Z","steps":["trace[1363483180] 'process raft request' (duration: 310.091098ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T17:13:54.690241Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T17:13:54.386699Z","time spent":"303.449588ms","remote":"127.0.0.1:59154","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-06T17:13:54.690405Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.514118ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-04-06T17:13:54.690311Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T17:13:54.379652Z","time spent":"310.54275ms","remote":"127.0.0.1:59154","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-06T17:13:54.690485Z","caller":"traceutil/trace.go:171","msg":"trace[1304174331] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5492; }","duration":"304.650863ms","start":"2026-04-06T17:13:54.385814Z","end":"2026-04-06T17:13:54.690465Z","steps":["trace[1304174331] 'agreement among raft nodes before linearized reading' (duration: 304.432487ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T17:13:54.690505Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.140804ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusterrestores/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusterrestores0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-06T17:13:54.690579Z","caller":"traceutil/trace.go:171","msg":"trace[1423978087] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusterrestores/; range_end:/registry/pxc.percona.com/perconaxtradbclusterrestores0; response_count:0; response_revision:5492; }","duration":"102.246987ms","start":"2026-04-06T17:13:54.588313Z","end":"2026-04-06T17:13:54.69056Z","steps":["trace[1423978087] 'agreement among raft nodes before linearized reading' (duration: 102.076472ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T17:13:54.690583Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.793193ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-06T17:13:54.690703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.444139ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-04-06T17:13:54.690759Z","caller":"traceutil/trace.go:171","msg":"trace[490003115] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5492; }","duration":"186.524202ms","start":"2026-04-06T17:13:54.504223Z","end":"2026-04-06T17:13:54.690747Z","steps":["trace[490003115] 'agreement among raft nodes before linearized reading' (duration: 186.374328ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T17:13:54.690669Z","caller":"traceutil/trace.go:171","msg":"trace[664133955] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:5492; }","duration":"129.902576ms","start":"2026-04-06T17:13:54.560754Z","end":"2026-04-06T17:13:54.690656Z","steps":["trace[664133955] 'agreement among raft nodes before linearized reading' (duration: 129.793803ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T17:13:54.690525Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T17:13:54.385793Z","time spent":"304.723404ms","remote":"127.0.0.1:59154","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-06T17:13:54.690831Z","caller":"traceutil/trace.go:171","msg":"trace[1507237257] transaction","detail":"{read_only:false; response_revision:5492; number_of_response:1; }","duration":"279.219657ms","start":"2026-04-06T17:13:54.411593Z","end":"2026-04-06T17:13:54.690812Z","steps":["trace[1507237257] 'process raft request' (duration: 278.344872ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T17:13:54.690856Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.683311ms","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-04-06T17:13:54.690922Z","caller":"traceutil/trace.go:171","msg":"trace[1615203216] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5492; }","duration":"258.770074ms","start":"2026-04-06T17:13:54.43214Z","end":"2026-04-06T17:13:54.69091Z","steps":["trace[1615203216] 'agreement among raft nodes before linearized reading' (duration: 258.603849ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T17:13:54.804693Z","caller":"traceutil/trace.go:171","msg":"trace[1577884695] transaction","detail":"{read_only:false; response_revision:5493; number_of_response:1; }","duration":"154.358674ms","start":"2026-04-06T17:13:54.650313Z","end":"2026-04-06T17:13:54.804672Z","steps":["trace[1577884695] 'process raft request' (duration: 154.170768ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T17:13:54.805047Z","caller":"traceutil/trace.go:171","msg":"trace[821670609] transaction","detail":"{read_only:false; response_revision:5494; number_of_response:1; }","duration":"154.018935ms","start":"2026-04-06T17:13:54.650984Z","end":"2026-04-06T17:13:54.805003Z","steps":["trace[821670609] 'process raft request' (duration: 153.634474ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T17:13:54.805087Z","caller":"traceutil/trace.go:171","msg":"trace[626631706] linearizableReadLoop","detail":"{readStateIndex:5694; appliedIndex:5690; }","duration":"111.289996ms","start":"2026-04-06T17:13:54.693768Z","end":"2026-04-06T17:13:54.805058Z","steps":["trace[626631706] 'read index received' (duration: 110.714289ms)","trace[626631706] 'applied index is now lower than readState.Index' (duration: 574.857µs)"],"step_count":2} {"level":"info","ts":"2026-04-06T17:13:54.805174Z","caller":"traceutil/trace.go:171","msg":"trace[2133343928] transaction","detail":"{read_only:false; response_revision:5495; number_of_response:1; }","duration":"154.000094ms","start":"2026-04-06T17:13:54.651145Z","end":"2026-04-06T17:13:54.805145Z","steps":["trace[2133343928] 'process raft request' (duration: 153.742677ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T17:13:54.805228Z","caller":"traceutil/trace.go:171","msg":"trace[1749626704] transaction","detail":"{read_only:false; response_revision:5496; number_of_response:1; }","duration":"152.035988ms","start":"2026-04-06T17:13:54.653149Z","end":"2026-04-06T17:13:54.805185Z","steps":["trace[1749626704] 'process raft request' (duration: 151.850583ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T17:13:54.805292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.512832ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-60a565c6-b7b0-49f5-9baa-9504558e869b\" ","response":"range_response_count:1 size:1322"} {"level":"info","ts":"2026-04-06T17:13:54.805333Z","caller":"traceutil/trace.go:171","msg":"trace[1825386252] range","detail":"{range_begin:/registry/persistentvolumes/pvc-60a565c6-b7b0-49f5-9baa-9504558e869b; range_end:; response_count:1; response_revision:5496; }","duration":"111.603745ms","start":"2026-04-06T17:13:54.693714Z","end":"2026-04-06T17:13:54.805318Z","steps":["trace[1825386252] 'agreement among raft nodes before linearized reading' (duration: 111.44043ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T17:13:54.822857Z","caller":"traceutil/trace.go:171","msg":"trace[567829989] transaction","detail":"{read_only:false; response_revision:5498; number_of_response:1; }","duration":"127.96204ms","start":"2026-04-06T17:13:54.694872Z","end":"2026-04-06T17:13:54.822834Z","steps":["trace[567829989] 'process raft request' (duration: 127.854857ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T17:13:54.822924Z","caller":"traceutil/trace.go:171","msg":"trace[2077516839] transaction","detail":"{read_only:false; response_revision:5497; number_of_response:1; }","duration":"128.021022ms","start":"2026-04-06T17:13:54.694864Z","end":"2026-04-06T17:13:54.822885Z","steps":["trace[2077516839] 'process raft request' (duration: 127.708023ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T17:13:54.823212Z","caller":"traceutil/trace.go:171","msg":"trace[1622741559] transaction","detail":"{read_only:false; response_revision:5499; number_of_response:1; }","duration":"128.228717ms","start":"2026-04-06T17:13:54.694963Z","end":"2026-04-06T17:13:54.823192Z","steps":["trace[1622741559] 'process raft request' (duration: 127.815966ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T17:14:39.151784Z","caller":"traceutil/trace.go:171","msg":"trace[1845697580] transaction","detail":"{read_only:false; response_revision:5861; number_of_response:1; }","duration":"130.694199ms","start":"2026-04-06T17:14:39.021062Z","end":"2026-04-06T17:14:39.151756Z","steps":["trace[1845697580] 'process raft request' (duration: 97.562623ms)","trace[1845697580] 'compare' (duration: 32.95018ms)"],"step_count":2} {"level":"info","ts":"2026-04-06T17:14:39.152293Z","caller":"traceutil/trace.go:171","msg":"trace[994844714] linearizableReadLoop","detail":"{readStateIndex:6070; appliedIndex:6068; }","duration":"131.10938ms","start":"2026-04-06T17:14:39.021163Z","end":"2026-04-06T17:14:39.152272Z","steps":["trace[994844714] 'read index received' (duration: 87.412124ms)","trace[994844714] 'applied index is now lower than readState.Index' (duration: 43.696226ms)"],"step_count":2} {"level":"warn","ts":"2026-04-06T17:14:39.152486Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.306945ms","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-04-06T17:14:39.152526Z","caller":"traceutil/trace.go:171","msg":"trace[1921663831] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5863; }","duration":"131.387238ms","start":"2026-04-06T17:14:39.02113Z","end":"2026-04-06T17:14:39.152518Z","steps":["trace[1921663831] 'agreement among raft nodes before linearized reading' (duration: 131.268045ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T17:14:39.152619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.725289ms","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-04-06T17:14:39.15269Z","caller":"traceutil/trace.go:171","msg":"trace[766020038] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5863; }","duration":"130.822102ms","start":"2026-04-06T17:14:39.021856Z","end":"2026-04-06T17:14:39.152678Z","steps":["trace[766020038] 'agreement among raft nodes before linearized reading' (duration: 130.610556ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T17:15:17.092807Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3035} {"level":"info","ts":"2026-04-06T17:15:17.178689Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3035,"took":"84.01418ms","hash":2163356359,"current-db-size-bytes":57806848,"current-db-size":"58 MB","current-db-size-in-use-bytes":31866880,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-04-06T17:15:17.178761Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2163356359,"revision":3035,"compact-revision":-1} {"level":"info","ts":"2026-04-06T17:19:54.833364Z","caller":"traceutil/trace.go:171","msg":"trace[1348352454] linearizableReadLoop","detail":"{readStateIndex:8480; appliedIndex:8479; }","duration":"180.530809ms","start":"2026-04-06T17:19:54.652811Z","end":"2026-04-06T17:19:54.833342Z","steps":["trace[1348352454] 'read index received' (duration: 180.394666ms)","trace[1348352454] 'applied index is now lower than readState.Index' (duration: 135.293µs)"],"step_count":2} {"level":"info","ts":"2026-04-06T17:19:54.833419Z","caller":"traceutil/trace.go:171","msg":"trace[1953216529] transaction","detail":"{read_only:false; response_revision:8197; number_of_response:1; }","duration":"186.870719ms","start":"2026-04-06T17:19:54.646516Z","end":"2026-04-06T17:19:54.833387Z","steps":["trace[1953216529] 'process raft request' (duration: 186.669783ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T17:19:54.833586Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.752446ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-04-06T17:19:54.833618Z","caller":"traceutil/trace.go:171","msg":"trace[1477490613] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8197; }","duration":"180.819748ms","start":"2026-04-06T17:19:54.65279Z","end":"2026-04-06T17:19:54.83361Z","steps":["trace[1477490613] 'agreement among raft nodes before linearized reading' (duration: 180.685054ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T17:19:54.833756Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.57993ms","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-04-06T17:19:54.83378Z","caller":"traceutil/trace.go:171","msg":"trace[284317971] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8197; }","duration":"174.639202ms","start":"2026-04-06T17:19:54.659135Z","end":"2026-04-06T17:19:54.833774Z","steps":["trace[284317971] 'agreement among raft nodes before linearized reading' (duration: 174.58166ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T17:19:54.833956Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.480869ms","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-04-06T17:19:54.834095Z","caller":"traceutil/trace.go:171","msg":"trace[461850038] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8197; }","duration":"179.638983ms","start":"2026-04-06T17:19:54.654435Z","end":"2026-04-06T17:19:54.834074Z","steps":["trace[461850038] 'agreement among raft nodes before linearized reading' (duration: 179.380766ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T17:19:55.014062Z","caller":"traceutil/trace.go:171","msg":"trace[211284404] transaction","detail":"{read_only:false; response_revision:8198; number_of_response:1; }","duration":"176.210427ms","start":"2026-04-06T17:19:54.837818Z","end":"2026-04-06T17:19:55.014029Z","steps":["trace[211284404] 'process raft request' (duration: 169.492687ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T17:19:55.024872Z","caller":"traceutil/trace.go:171","msg":"trace[1029445629] transaction","detail":"{read_only:false; response_revision:8199; number_of_response:1; }","duration":"186.630181ms","start":"2026-04-06T17:19:54.838217Z","end":"2026-04-06T17:19:55.024847Z","steps":["trace[1029445629] 'process raft request' (duration: 186.479437ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T17:19:55.025176Z","caller":"traceutil/trace.go:171","msg":"trace[433833983] transaction","detail":"{read_only:false; response_revision:8200; number_of_response:1; }","duration":"186.303672ms","start":"2026-04-06T17:19:54.838856Z","end":"2026-04-06T17:19:55.02516Z","steps":["trace[433833983] 'process raft request' (duration: 185.945332ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T17:19:55.025211Z","caller":"traceutil/trace.go:171","msg":"trace[410273226] transaction","detail":"{read_only:false; response_revision:8201; number_of_response:1; }","duration":"186.011764ms","start":"2026-04-06T17:19:54.839171Z","end":"2026-04-06T17:19:55.025183Z","steps":["trace[410273226] 'process raft request' (duration: 185.88688ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T17:20:08.638467Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.803514ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-06T17:20:08.638522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"517.3223ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-06T17:20:08.6386Z","caller":"traceutil/trace.go:171","msg":"trace[1423470285] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:8270; }","duration":"517.455123ms","start":"2026-04-06T17:20:08.121126Z","end":"2026-04-06T17:20:08.638581Z","steps":["trace[1423470285] 'count revisions from in-memory index tree' (duration: 517.197725ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T17:20:08.638737Z","caller":"traceutil/trace.go:171","msg":"trace[442553884] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8270; }","duration":"340.946628ms","start":"2026-04-06T17:20:08.2976Z","end":"2026-04-06T17:20:08.638546Z","steps":["trace[442553884] 'range keys from in-memory index tree' (duration: 340.672361ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T17:20:08.638773Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T17:20:08.121107Z","time spent":"517.651368ms","remote":"127.0.0.1:59306","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":13,"response size":31,"request content":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true "} {"level":"info","ts":"2026-04-06T17:20:08.638858Z","caller":"traceutil/trace.go:171","msg":"trace[38238469] linearizableReadLoop","detail":"{readStateIndex:8558; appliedIndex:8557; }","duration":"155.430019ms","start":"2026-04-06T17:20:08.483386Z","end":"2026-04-06T17:20:08.638816Z","steps":["trace[38238469] 'read index received' (duration: 82.66577ms)","trace[38238469] 'applied index is now lower than readState.Index' (duration: 72.762819ms)"],"step_count":2} {"level":"info","ts":"2026-04-06T17:20:08.638888Z","caller":"traceutil/trace.go:171","msg":"trace[765947831] transaction","detail":"{read_only:false; response_revision:8271; number_of_response:1; }","duration":"311.540735ms","start":"2026-04-06T17:20:08.327291Z","end":"2026-04-06T17:20:08.638832Z","steps":["trace[765947831] 'process raft request' (duration: 238.773146ms)","trace[765947831] 'compare' (duration: 72.483101ms)"],"step_count":2} {"level":"warn","ts":"2026-04-06T17:20:08.639082Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T17:20:08.29758Z","time spent":"341.372631ms","remote":"127.0.0.1:58914","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-06T17:20:08.639115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.714226ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-04-06T17:20:08.639158Z","caller":"traceutil/trace.go:171","msg":"trace[789116639] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:8271; }","duration":"155.809269ms","start":"2026-04-06T17:20:08.483334Z","end":"2026-04-06T17:20:08.639143Z","steps":["trace[789116639] 'agreement among raft nodes before linearized reading' (duration: 155.609753ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T17:20:08.639148Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T17:20:08.327271Z","time spent":"311.723801ms","remote":"127.0.0.1:59154","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-06T17:20:17.100764Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6149} {"level":"info","ts":"2026-04-06T17:20:17.195Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6149,"took":"92.199539ms","hash":3226924304,"current-db-size-bytes":57806848,"current-db-size":"58 MB","current-db-size-in-use-bytes":23560192,"current-db-size-in-use":"24 MB"} {"level":"info","ts":"2026-04-06T17:20:17.195053Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3226924304,"revision":6149,"compact-revision":3035} {"level":"info","ts":"2026-04-06T17:20:38.418177Z","caller":"traceutil/trace.go:171","msg":"trace[215142406] transaction","detail":"{read_only:false; response_revision:8485; number_of_response:1; }","duration":"185.801518ms","start":"2026-04-06T17:20:38.232349Z","end":"2026-04-06T17:20:38.41815Z","steps":["trace[215142406] 'process raft request' (duration: 185.612392ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T17:20:38.603744Z","caller":"traceutil/trace.go:171","msg":"trace[1281463209] transaction","detail":"{read_only:false; response_revision:8486; number_of_response:1; }","duration":"369.178107ms","start":"2026-04-06T17:20:38.234526Z","end":"2026-04-06T17:20:38.603704Z","steps":["trace[1281463209] 'process raft request' (duration: 271.603786ms)","trace[1281463209] 'compare' (duration: 96.980304ms)"],"step_count":2} {"level":"info","ts":"2026-04-06T17:20:38.603632Z","caller":"traceutil/trace.go:171","msg":"trace[1055333851] linearizableReadLoop","detail":"{readStateIndex:8783; appliedIndex:8781; }","duration":"368.396954ms","start":"2026-04-06T17:20:38.235172Z","end":"2026-04-06T17:20:38.603569Z","steps":["trace[1055333851] 'read index received' (duration: 182.886575ms)","trace[1055333851] 'applied index is now lower than readState.Index' (duration: 185.508789ms)"],"step_count":2} {"level":"warn","ts":"2026-04-06T17:20:38.603908Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T17:20:38.2345Z","time spent":"369.330752ms","remote":"127.0.0.1:59154","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-06T17:20:38.603898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"368.703033ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-06T17:20:38.603968Z","caller":"traceutil/trace.go:171","msg":"trace[198407841] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:8486; }","duration":"368.812206ms","start":"2026-04-06T17:20:38.235139Z","end":"2026-04-06T17:20:38.603951Z","steps":["trace[198407841] 'agreement among raft nodes before linearized reading' (duration: 368.677422ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T17:20:38.604006Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T17:20:38.235129Z","time spent":"368.869767ms","remote":"127.0.0.1:54966","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-06T17:20:51.056854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"397.008534ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-06T17:20:51.057203Z","caller":"traceutil/trace.go:171","msg":"trace[695906621] transaction","detail":"{read_only:false; response_revision:8589; number_of_response:1; }","duration":"510.952999ms","start":"2026-04-06T17:20:50.546212Z","end":"2026-04-06T17:20:51.057165Z","steps":["trace[695906621] 'process raft request' (duration: 113.535963ms)","trace[695906621] 'compare' (duration: 396.849999ms)"],"step_count":2} {"level":"info","ts":"2026-04-06T17:20:51.057298Z","caller":"traceutil/trace.go:171","msg":"trace[741669503] transaction","detail":"{read_only:false; response_revision:8591; number_of_response:1; }","duration":"415.202299ms","start":"2026-04-06T17:20:50.642085Z","end":"2026-04-06T17:20:51.057287Z","steps":["trace[741669503] 'process raft request' (duration: 415.012964ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T17:20:51.057391Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T17:20:50.642058Z","time spent":"415.287871ms","remote":"127.0.0.1:59154","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-06T17:20:51.057528Z","caller":"traceutil/trace.go:171","msg":"trace[1570967374] linearizableReadLoop","detail":"{readStateIndex:8893; appliedIndex:8891; }","duration":"503.091277ms","start":"2026-04-06T17:20:50.554422Z","end":"2026-04-06T17:20:51.057513Z","steps":["trace[1570967374] 'read index received' (duration: 105.338861ms)","trace[1570967374] 'applied index is now lower than readState.Index' (duration: 397.751196ms)"],"step_count":2} {"level":"info","ts":"2026-04-06T17:20:51.057715Z","caller":"traceutil/trace.go:171","msg":"trace[161684457] transaction","detail":"{read_only:false; number_of_response:1; response_revision:8590; }","duration":"511.32128ms","start":"2026-04-06T17:20:50.54637Z","end":"2026-04-06T17:20:51.057691Z","steps":["trace[161684457] 'process raft request' (duration: 510.62133ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T17:20:51.057249Z","caller":"traceutil/trace.go:171","msg":"trace[1101178688] transaction","detail":"{read_only:false; response_revision:8592; number_of_response:1; }","duration":"212.605987ms","start":"2026-04-06T17:20:50.844618Z","end":"2026-04-06T17:20:51.057224Z","steps":["trace[1101178688] 'process raft request' (duration: 212.551595ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T17:20:51.057896Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T17:20:50.546347Z","time spent":"511.438002ms","remote":"127.0.0.1:59004","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":59,"response count":0,"response size":42,"request content":"compare: success: > failure: >"} {"level":"warn","ts":"2026-04-06T17:20:51.057745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"503.317403ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rook-ceph-mon-endpoints\" ","response":"range_response_count:1 size:389"} {"level":"info","ts":"2026-04-06T17:20:51.058032Z","caller":"traceutil/trace.go:171","msg":"trace[1198022179] range","detail":"{range_begin:/registry/configmaps/openstack/rook-ceph-mon-endpoints; range_end:; response_count:1; response_revision:8592; }","duration":"503.692683ms","start":"2026-04-06T17:20:50.554316Z","end":"2026-04-06T17:20:51.058009Z","steps":["trace[1198022179] 'agreement among raft nodes before linearized reading' (duration: 503.320723ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T17:20:51.058116Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T17:20:50.554294Z","time spent":"503.803266ms","remote":"127.0.0.1:59004","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":413,"request content":"key:\"/registry/configmaps/openstack/rook-ceph-mon-endpoints\" "} {"level":"warn","ts":"2026-04-06T17:20:51.058322Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T17:20:50.546201Z","time spent":"511.104683ms","remote":"127.0.0.1:59080","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4653,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-06T17:20:51.695488Z","caller":"traceutil/trace.go:171","msg":"trace[965064277] transaction","detail":"{read_only:false; response_revision:8601; number_of_response:1; }","duration":"158.068104ms","start":"2026-04-06T17:20:51.53738Z","end":"2026-04-06T17:20:51.695448Z","steps":["trace[965064277] 'process raft request' (duration: 157.908258ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T17:20:52.777733Z","caller":"traceutil/trace.go:171","msg":"trace[124080688] transaction","detail":"{read_only:false; response_revision:8608; number_of_response:1; }","duration":"116.61867ms","start":"2026-04-06T17:20:52.661086Z","end":"2026-04-06T17:20:52.777704Z","steps":["trace[124080688] 'process raft request' (duration: 110.804656ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T17:21:05.605603Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002365.wal"} {"level":"info","ts":"2026-04-06T17:22:03.423581Z","caller":"traceutil/trace.go:171","msg":"trace[1295643101] transaction","detail":"{read_only:false; response_revision:9320; number_of_response:1; }","duration":"122.164817ms","start":"2026-04-06T17:22:03.301372Z","end":"2026-04-06T17:22:03.423537Z","steps":["trace[1295643101] 'process raft request' (duration: 80.995612ms)","trace[1295643101] 'compare' (duration: 40.958639ms)"],"step_count":2} {"level":"info","ts":"2026-04-06T17:22:51.699271Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"e10bb51ed7578852","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-06T17:22:51.704881Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-04-06T17:22:51.705001Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-04-06T17:24:25.351348Z","caller":"traceutil/trace.go:171","msg":"trace[435149635] transaction","detail":"{read_only:false; response_revision:10394; number_of_response:1; }","duration":"138.846713ms","start":"2026-04-06T17:24:25.212473Z","end":"2026-04-06T17:24:25.351319Z","steps":["trace[435149635] 'process raft request' (duration: 138.560935ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T17:25:17.107365Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8322} {"level":"info","ts":"2026-04-06T17:25:17.184456Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8322,"took":"74.763549ms","hash":3468804429,"current-db-size-bytes":57806848,"current-db-size":"58 MB","current-db-size-in-use-bytes":24911872,"current-db-size-in-use":"25 MB"} {"level":"info","ts":"2026-04-06T17:25:17.184523Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3468804429,"revision":8322,"compact-revision":6149} {"level":"info","ts":"2026-04-06T17:30:17.112778Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10712} {"level":"info","ts":"2026-04-06T17:30:17.186484Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10712,"took":"71.907632ms","hash":3223083881,"current-db-size-bytes":57806848,"current-db-size":"58 MB","current-db-size-in-use-bytes":20893696,"current-db-size-in-use":"21 MB"} {"level":"info","ts":"2026-04-06T17:30:17.186539Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3223083881,"revision":10712,"compact-revision":8322}