{"level":"warn","ts":"2026-10-20T14:12:31.140797Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-20T14:12:31.14097Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.3: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.3:2380","--initial-cluster=instance=https://162.253.55.3:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.3:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.3:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-10-20T14:12:31.141103Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-20T14:12:31.141136Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.3:2380"]} {"level":"info","ts":"2026-10-20T14:12:31.141188Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-10-20T14:12:31.142684Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.3:2379"]} {"level":"info","ts":"2026-10-20T14:12:31.142894Z","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.3:2380"],"listen-peer-urls":["https://162.253.55.3:2380"],"advertise-client-urls":["https://162.253.55.3:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.3:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.3:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-10-20T14:12:31.145863Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.530301ms"} {"level":"info","ts":"2026-10-20T14:12:31.153499Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"a99b527d1e65fdd9","cluster-id":"9bd8b4a41eaf5d40"} {"level":"info","ts":"2026-10-20T14:12:31.153618Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a99b527d1e65fdd9 switched to configuration voters=()"} {"level":"info","ts":"2026-10-20T14:12:31.153658Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a99b527d1e65fdd9 became follower at term 0"} {"level":"info","ts":"2026-10-20T14:12:31.15368Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft a99b527d1e65fdd9 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-10-20T14:12:31.153693Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a99b527d1e65fdd9 became follower at term 1"} {"level":"info","ts":"2026-10-20T14:12:31.153785Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a99b527d1e65fdd9 switched to configuration voters=(12221452711134363097)"} {"level":"warn","ts":"2026-10-20T14:12:31.160062Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-10-20T14:12:31.162376Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-10-20T14:12:31.164531Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-10-20T14:12:31.168424Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"a99b527d1e65fdd9","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-10-20T14:12:31.16858Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"a99b527d1e65fdd9","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-10-20T14:12:31.16892Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-10-20T14:12:31.16903Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-10-20T14:12:31.169074Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-10-20T14:12:31.169709Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a99b527d1e65fdd9 switched to configuration voters=(12221452711134363097)"} {"level":"info","ts":"2026-10-20T14:12:31.170493Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"9bd8b4a41eaf5d40","local-member-id":"a99b527d1e65fdd9","added-peer-id":"a99b527d1e65fdd9","added-peer-peer-urls":["https://162.253.55.3:2380"]} {"level":"info","ts":"2026-10-20T14:12:31.173759Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-10-20T14:12:31.173908Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.3:2380"} {"level":"info","ts":"2026-10-20T14:12:31.173997Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.3:2380"} {"level":"info","ts":"2026-10-20T14:12:31.174129Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"a99b527d1e65fdd9","initial-advertise-peer-urls":["https://162.253.55.3:2380"],"listen-peer-urls":["https://162.253.55.3:2380"],"advertise-client-urls":["https://162.253.55.3:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.3:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-10-20T14:12:31.174191Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-10-20T14:12:31.954681Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a99b527d1e65fdd9 is starting a new election at term 1"} {"level":"info","ts":"2026-10-20T14:12:31.954759Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a99b527d1e65fdd9 became pre-candidate at term 1"} {"level":"info","ts":"2026-10-20T14:12:31.954824Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a99b527d1e65fdd9 received MsgPreVoteResp from a99b527d1e65fdd9 at term 1"} {"level":"info","ts":"2026-10-20T14:12:31.954855Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a99b527d1e65fdd9 became candidate at term 2"} {"level":"info","ts":"2026-10-20T14:12:31.954882Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a99b527d1e65fdd9 received MsgVoteResp from a99b527d1e65fdd9 at term 2"} {"level":"info","ts":"2026-10-20T14:12:31.954902Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a99b527d1e65fdd9 became leader at term 2"} {"level":"info","ts":"2026-10-20T14:12:31.954923Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: a99b527d1e65fdd9 elected leader a99b527d1e65fdd9 at term 2"} {"level":"info","ts":"2026-10-20T14:12:31.956692Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-10-20T14:12:31.957916Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"a99b527d1e65fdd9","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.3:2379]}","request-path":"/0/members/a99b527d1e65fdd9/attributes","cluster-id":"9bd8b4a41eaf5d40","publish-timeout":"7s"} {"level":"info","ts":"2026-10-20T14:12:31.957947Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-20T14:12:31.957966Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-20T14:12:31.958228Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-10-20T14:12:31.958251Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-10-20T14:12:31.958826Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"9bd8b4a41eaf5d40","local-member-id":"a99b527d1e65fdd9","cluster-version":"3.5"} {"level":"info","ts":"2026-10-20T14:12:31.958955Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-10-20T14:12:31.958996Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-10-20T14:12:31.96138Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.3:2379"} {"level":"info","ts":"2026-10-20T14:12:31.961463Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-10-20T14:12:43.920952Z","caller":"traceutil/trace.go:171","msg":"trace[44703778] transaction","detail":"{read_only:false; response_revision:396; number_of_response:1; }","duration":"287.25626ms","start":"2026-10-20T14:12:43.633668Z","end":"2026-10-20T14:12:43.920924Z","steps":["trace[44703778] 'process raft request' (duration: 286.964016ms)"],"step_count":1} {"level":"warn","ts":"2026-10-20T14:12:43.921106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.995779ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-10-20T14:12:43.921267Z","caller":"traceutil/trace.go:171","msg":"trace[1627366754] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:396; }","duration":"237.166561ms","start":"2026-10-20T14:12:43.684085Z","end":"2026-10-20T14:12:43.921251Z","steps":["trace[1627366754] 'agreement among raft nodes before linearized reading' (duration: 236.951098ms)"],"step_count":1} {"level":"info","ts":"2026-10-20T14:12:43.92088Z","caller":"traceutil/trace.go:171","msg":"trace[605986546] linearizableReadLoop","detail":"{readStateIndex:407; appliedIndex:406; }","duration":"236.762845ms","start":"2026-10-20T14:12:43.684097Z","end":"2026-10-20T14:12:43.92086Z","steps":["trace[605986546] 'read index received' (duration: 236.495221ms)","trace[605986546] 'applied index is now lower than readState.Index' (duration: 266.704µs)"],"step_count":2} {"level":"info","ts":"2026-10-20T14:12:43.935373Z","caller":"traceutil/trace.go:171","msg":"trace[765598108] transaction","detail":"{read_only:false; response_revision:397; number_of_response:1; }","duration":"115.638124ms","start":"2026-10-20T14:12:43.819694Z","end":"2026-10-20T14:12:43.935332Z","steps":["trace[765598108] 'process raft request' (duration: 115.440491ms)"],"step_count":1} {"level":"warn","ts":"2026-10-20T14:12:44.23524Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.948001ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-20T14:12:44.23542Z","caller":"traceutil/trace.go:171","msg":"trace[790458949] transaction","detail":"{read_only:false; response_revision:399; number_of_response:1; }","duration":"296.814302ms","start":"2026-10-20T14:12:43.938593Z","end":"2026-10-20T14:12:44.235408Z","steps":["trace[790458949] 'process raft request' (duration: 296.72117ms)"],"step_count":1} {"level":"info","ts":"2026-10-20T14:12:44.235517Z","caller":"traceutil/trace.go:171","msg":"trace[1669464468] transaction","detail":"{read_only:false; response_revision:398; number_of_response:1; }","duration":"310.667973ms","start":"2026-10-20T14:12:43.924842Z","end":"2026-10-20T14:12:44.23551Z","steps":["trace[1669464468] 'process raft request' (duration: 122.997981ms)","trace[1669464468] 'compare' (duration: 186.822229ms)"],"step_count":2} {"level":"warn","ts":"2026-10-20T14:12:44.235552Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-20T14:12:43.924818Z","time spent":"310.714474ms","remote":"127.0.0.1:57080","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-20T14:13:15.732265Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.715317ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-10-20T14:13:15.732758Z","caller":"traceutil/trace.go:171","msg":"trace[2123307081] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"395.982646ms","start":"2026-10-20T14:13:15.336742Z","end":"2026-10-20T14:13:15.732725Z","steps":["trace[2123307081] 'process raft request' (duration: 247.709908ms)","trace[2123307081] 'compare' (duration: 147.473023ms)"],"step_count":2} {"level":"info","ts":"2026-10-20T14:13:15.732811Z","caller":"traceutil/trace.go:171","msg":"trace[275311282] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"395.067398ms","start":"2026-10-20T14:13:15.337722Z","end":"2026-10-20T14:13:15.732789Z","steps":["trace[275311282] 'process raft request' (duration: 394.64587ms)"],"step_count":1} {"level":"warn","ts":"2026-10-20T14:13:15.732896Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-20T14:13:15.336716Z","time spent":"396.116908ms","remote":"127.0.0.1:57322","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":995,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-20T14:13:15.732732Z","caller":"traceutil/trace.go:171","msg":"trace[2061662141] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"391.679594ms","start":"2026-10-20T14:13:15.341032Z","end":"2026-10-20T14:13:15.732711Z","steps":["trace[2061662141] 'process raft request' (duration: 391.484941ms)"],"step_count":1} {"level":"warn","ts":"2026-10-20T14:13:15.732922Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-20T14:13:15.3377Z","time spent":"395.157929ms","remote":"127.0.0.1:56890","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6888,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-20T14:13:15.733074Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-20T14:13:15.341015Z","time spent":"391.943109ms","remote":"127.0.0.1:56890","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-20T14:13:15.733102Z","caller":"traceutil/trace.go:171","msg":"trace[1468533351] transaction","detail":"{read_only:false; number_of_response:1; response_revision:551; }","duration":"391.549852ms","start":"2026-10-20T14:13:15.341446Z","end":"2026-10-20T14:13:15.732995Z","steps":["trace[1468533351] 'process raft request' (duration: 391.193755ms)"],"step_count":1} {"level":"warn","ts":"2026-10-20T14:13:15.733382Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-20T14:13:15.341433Z","time spent":"391.790966ms","remote":"127.0.0.1:56890","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":102,"response count":0,"response size":6938,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-20T14:13:15.733504Z","caller":"traceutil/trace.go:171","msg":"trace[1990863948] transaction","detail":"{read_only:false; response_revision:553; number_of_response:1; }","duration":"362.692739ms","start":"2026-10-20T14:13:15.370758Z","end":"2026-10-20T14:13:15.733451Z","steps":["trace[1990863948] 'process raft request' (duration: 362.544196ms)"],"step_count":1} {"level":"info","ts":"2026-10-20T14:13:15.733586Z","caller":"traceutil/trace.go:171","msg":"trace[1985700547] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"384.400406ms","start":"2026-10-20T14:13:15.349123Z","end":"2026-10-20T14:13:15.733523Z","steps":["trace[1985700547] 'process raft request' (duration: 383.801225ms)"],"step_count":1} {"level":"warn","ts":"2026-10-20T14:13:15.733602Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-20T14:13:15.37073Z","time spent":"362.828771ms","remote":"127.0.0.1:56890","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-20T14:13:15.733742Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-20T14:13:15.349096Z","time spent":"384.54512ms","remote":"127.0.0.1:56890","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-20T14:13:15.734537Z","caller":"traceutil/trace.go:171","msg":"trace[991500056] transaction","detail":"{read_only:false; response_revision:554; number_of_response:1; }","duration":"348.109594ms","start":"2026-10-20T14:13:15.386394Z","end":"2026-10-20T14:13:15.734504Z","steps":["trace[991500056] 'process raft request' (duration: 347.985092ms)"],"step_count":1} {"level":"warn","ts":"2026-10-20T14:13:15.73461Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-20T14:13:15.386378Z","time spent":"348.199886ms","remote":"127.0.0.1:57322","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":980,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-20T14:13:15.734797Z","caller":"traceutil/trace.go:171","msg":"trace[1633153200] transaction","detail":"{read_only:false; response_revision:556; number_of_response:1; }","duration":"346.177938ms","start":"2026-10-20T14:13:15.388596Z","end":"2026-10-20T14:13:15.734774Z","steps":["trace[1633153200] 'process raft request' (duration: 345.859732ms)"],"step_count":1} {"level":"info","ts":"2026-10-20T14:13:15.734805Z","caller":"traceutil/trace.go:171","msg":"trace[788715852] transaction","detail":"{read_only:false; response_revision:557; number_of_response:1; }","duration":"340.36918ms","start":"2026-10-20T14:13:15.394416Z","end":"2026-10-20T14:13:15.734785Z","steps":["trace[788715852] 'process raft request' (duration: 340.073513ms)"],"step_count":1} {"level":"info","ts":"2026-10-20T14:13:15.73487Z","caller":"traceutil/trace.go:171","msg":"trace[1469117705] transaction","detail":"{read_only:false; response_revision:558; number_of_response:1; }","duration":"339.991163ms","start":"2026-10-20T14:13:15.394853Z","end":"2026-10-20T14:13:15.734844Z","steps":["trace[1469117705] 'process raft request' (duration: 339.677946ms)"],"step_count":1} {"level":"warn","ts":"2026-10-20T14:13:15.73491Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-20T14:13:15.394402Z","time spent":"340.454441ms","remote":"127.0.0.1:56890","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10063,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-20T14:13:15.734978Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-20T14:13:15.394842Z","time spent":"340.083314ms","remote":"127.0.0.1:57322","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":998,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-20T14:13:15.734992Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-20T14:13:15.38858Z","time spent":"346.265791ms","remote":"127.0.0.1:57322","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":998,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-20T14:13:15.735056Z","caller":"traceutil/trace.go:171","msg":"trace[1302275259] transaction","detail":"{read_only:false; response_revision:555; number_of_response:1; }","duration":"348.507993ms","start":"2026-10-20T14:13:15.386533Z","end":"2026-10-20T14:13:15.735041Z","steps":["trace[1302275259] 'process raft request' (duration: 347.897251ms)"],"step_count":1} {"level":"warn","ts":"2026-10-20T14:13:15.73514Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-20T14:13:15.386525Z","time spent":"348.578835ms","remote":"127.0.0.1:57322","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1004,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-20T14:13:15.735203Z","caller":"traceutil/trace.go:171","msg":"trace[969830072] transaction","detail":"{read_only:false; response_revision:559; number_of_response:1; }","duration":"340.059544ms","start":"2026-10-20T14:13:15.395126Z","end":"2026-10-20T14:13:15.735185Z","steps":["trace[969830072] 'process raft request' (duration: 339.437862ms)"],"step_count":1} {"level":"warn","ts":"2026-10-20T14:13:15.735324Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-20T14:13:15.395117Z","time spent":"340.130305ms","remote":"127.0.0.1:56890","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28739,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-20T14:13:15.735497Z","caller":"traceutil/trace.go:171","msg":"trace[615301232] transaction","detail":"{read_only:false; response_revision:560; number_of_response:1; }","duration":"334.660783ms","start":"2026-10-20T14:13:15.400822Z","end":"2026-10-20T14:13:15.735483Z","steps":["trace[615301232] 'process raft request' (duration: 333.787905ms)"],"step_count":1} {"level":"warn","ts":"2026-10-20T14:13:15.735585Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-20T14:13:15.400808Z","time spent":"334.734534ms","remote":"127.0.0.1:56890","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30374,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-20T14:13:15.735773Z","caller":"traceutil/trace.go:171","msg":"trace[603284989] transaction","detail":"{read_only:false; response_revision:561; number_of_response:1; }","duration":"333.958339ms","start":"2026-10-20T14:13:15.401803Z","end":"2026-10-20T14:13:15.735761Z","steps":["trace[603284989] 'process raft request' (duration: 333.624693ms)"],"step_count":1} {"level":"info","ts":"2026-10-20T14:13:15.735788Z","caller":"traceutil/trace.go:171","msg":"trace[191009281] linearizableReadLoop","detail":"{readStateIndex:579; appliedIndex:566; }","duration":"334.370857ms","start":"2026-10-20T14:13:15.401389Z","end":"2026-10-20T14:13:15.735759Z","steps":["trace[191009281] 'read index received' (duration: 183.159954ms)","trace[191009281] 'applied index is now lower than readState.Index' (duration: 151.209933ms)"],"step_count":2} {"level":"warn","ts":"2026-10-20T14:13:15.735834Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-20T14:13:15.40179Z","time spent":"334.01324ms","remote":"127.0.0.1:56890","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30393,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-20T14:13:15.735895Z","caller":"traceutil/trace.go:171","msg":"trace[1734808303] transaction","detail":"{read_only:false; response_revision:562; number_of_response:1; }","duration":"260.239673ms","start":"2026-10-20T14:13:15.4756Z","end":"2026-10-20T14:13:15.73584Z","steps":["trace[1734808303] 'process raft request' (duration: 260.006129ms)"],"step_count":1} {"level":"warn","ts":"2026-10-20T14:13:15.735934Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"334.55426ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.3\" ","response":"range_response_count:1 size:131"} {"level":"info","ts":"2026-10-20T14:13:15.735974Z","caller":"traceutil/trace.go:171","msg":"trace[166919285] range","detail":"{range_begin:/registry/masterleases/162.253.55.3; range_end:; response_count:1; response_revision:562; }","duration":"334.620521ms","start":"2026-10-20T14:13:15.401345Z","end":"2026-10-20T14:13:15.735965Z","steps":["trace[166919285] 'agreement among raft nodes before linearized reading' (duration: 334.529489ms)"],"step_count":1} {"level":"warn","ts":"2026-10-20T14:13:15.736008Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-20T14:13:15.401334Z","time spent":"334.668382ms","remote":"127.0.0.1:56876","response type":"/etcdserverpb.KV/Range","request count":0,"request size":37,"response count":1,"response size":155,"request content":"key:\"/registry/masterleases/162.253.55.3\" "} {"level":"warn","ts":"2026-10-20T14:13:15.736193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.739943ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-10-20T14:13:15.736283Z","caller":"traceutil/trace.go:171","msg":"trace[1910488544] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:562; }","duration":"276.839325ms","start":"2026-10-20T14:13:15.459396Z","end":"2026-10-20T14:13:15.736235Z","steps":["trace[1910488544] 'agreement among raft nodes before linearized reading' (duration: 276.598201ms)"],"step_count":1} {"level":"info","ts":"2026-10-20T14:13:21.918186Z","caller":"traceutil/trace.go:171","msg":"trace[1985301991] transaction","detail":"{read_only:false; response_revision:647; number_of_response:1; }","duration":"125.123384ms","start":"2026-10-20T14:13:21.793041Z","end":"2026-10-20T14:13:21.918164Z","steps":["trace[1985301991] 'process raft request' (duration: 125.001482ms)"],"step_count":1} {"level":"info","ts":"2026-10-20T14:13:22.397599Z","caller":"traceutil/trace.go:171","msg":"trace[334106784] transaction","detail":"{read_only:false; response_revision:648; number_of_response:1; }","duration":"284.688062ms","start":"2026-10-20T14:13:22.11288Z","end":"2026-10-20T14:13:22.397568Z","steps":["trace[334106784] 'process raft request' (duration: 284.536769ms)"],"step_count":1} {"level":"info","ts":"2026-10-20T14:13:22.471755Z","caller":"traceutil/trace.go:171","msg":"trace[814524412] transaction","detail":"{read_only:false; response_revision:649; number_of_response:1; }","duration":"316.791534ms","start":"2026-10-20T14:13:22.154928Z","end":"2026-10-20T14:13:22.471719Z","steps":["trace[814524412] 'process raft request' (duration: 316.0132ms)"],"step_count":1} {"level":"warn","ts":"2026-10-20T14:13:22.471967Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-20T14:13:22.154904Z","time spent":"316.948156ms","remote":"127.0.0.1:56930","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036285,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-20T14:13:38.73113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.775414ms","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-10-20T14:13:38.731162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.745326ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-10-20T14:13:38.731229Z","caller":"traceutil/trace.go:171","msg":"trace[1849479912] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:815; }","duration":"180.840307ms","start":"2026-10-20T14:13:38.550374Z","end":"2026-10-20T14:13:38.731214Z","steps":["trace[1849479912] 'range keys from in-memory index tree' (duration: 180.637084ms)"],"step_count":1} {"level":"info","ts":"2026-10-20T14:13:38.731225Z","caller":"traceutil/trace.go:171","msg":"trace[1805980127] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:815; }","duration":"142.917007ms","start":"2026-10-20T14:13:38.58829Z","end":"2026-10-20T14:13:38.731207Z","steps":["trace[1805980127] 'range keys from in-memory index tree' (duration: 142.61693ms)"],"step_count":1} {"level":"warn","ts":"2026-10-20T14:13:38.731207Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.345413ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-d9fsf\" ","response":"range_response_count:1 size:3963"} {"level":"info","ts":"2026-10-20T14:13:38.731288Z","caller":"traceutil/trace.go:171","msg":"trace[1569581701] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-d9fsf; range_end:; response_count:1; response_revision:815; }","duration":"207.485946ms","start":"2026-10-20T14:13:38.523783Z","end":"2026-10-20T14:13:38.731269Z","steps":["trace[1569581701] 'range keys from in-memory index tree' (duration: 207.16552ms)"],"step_count":1} {"level":"warn","ts":"2026-10-20T14:13:38.73134Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.491796ms","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-10-20T14:13:38.731427Z","caller":"traceutil/trace.go:171","msg":"trace[548930339] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:815; }","duration":"255.621879ms","start":"2026-10-20T14:13:38.475786Z","end":"2026-10-20T14:13:38.731408Z","steps":["trace[548930339] 'range keys from in-memory index tree' (duration: 255.299183ms)"],"step_count":1} {"level":"info","ts":"2026-10-20T14:13:38.739078Z","caller":"traceutil/trace.go:171","msg":"trace[1740265047] transaction","detail":"{read_only:false; response_revision:816; number_of_response:1; }","duration":"124.816777ms","start":"2026-10-20T14:13:38.614243Z","end":"2026-10-20T14:13:38.73906Z","steps":["trace[1740265047] 'process raft request' (duration: 124.672405ms)"],"step_count":1} {"level":"warn","ts":"2026-10-20T14:14:30.969501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.707171ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-10-20T14:14:30.969903Z","caller":"traceutil/trace.go:171","msg":"trace[646272004] transaction","detail":"{read_only:false; response_revision:1473; number_of_response:1; }","duration":"130.034733ms","start":"2026-10-20T14:14:30.839837Z","end":"2026-10-20T14:14:30.969872Z","steps":["trace[646272004] 'process raft request' (duration: 129.770538ms)"],"step_count":1} {"level":"info","ts":"2026-10-20T14:14:57.044263Z","caller":"traceutil/trace.go:171","msg":"trace[2100996566] linearizableReadLoop","detail":"{readStateIndex:1969; appliedIndex:1968; }","duration":"147.698584ms","start":"2026-10-20T14:14:56.896536Z","end":"2026-10-20T14:14:57.044235Z","steps":["trace[2100996566] 'read index received' (duration: 147.534621ms)","trace[2100996566] 'applied index is now lower than readState.Index' (duration: 162.743µs)"],"step_count":2} {"level":"info","ts":"2026-10-20T14:14:57.044309Z","caller":"traceutil/trace.go:171","msg":"trace[1827055091] transaction","detail":"{read_only:false; response_revision:1895; number_of_response:1; }","duration":"168.285711ms","start":"2026-10-20T14:14:56.875989Z","end":"2026-10-20T14:14:57.044274Z","steps":["trace[1827055091] 'process raft request' (duration: 168.068887ms)"],"step_count":1} {"level":"warn","ts":"2026-10-20T14:14:57.044475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.076075ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-20T14:14:57.044534Z","caller":"traceutil/trace.go:171","msg":"trace[359128458] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1895; }","duration":"112.184297ms","start":"2026-10-20T14:14:56.932336Z","end":"2026-10-20T14:14:57.04452Z","steps":["trace[359128458] 'agreement among raft nodes before linearized reading' (duration: 112.078075ms)"],"step_count":1} {"level":"warn","ts":"2026-10-20T14:14:57.044557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.99394ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-550e2cce-a2b2-4b92-8990-722dbf398001\" ","response":"range_response_count:1 size:3625"} {"level":"info","ts":"2026-10-20T14:14:57.044675Z","caller":"traceutil/trace.go:171","msg":"trace[932410921] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-550e2cce-a2b2-4b92-8990-722dbf398001; range_end:; response_count:1; response_revision:1895; }","duration":"148.168563ms","start":"2026-10-20T14:14:56.896483Z","end":"2026-10-20T14:14:57.044651Z","steps":["trace[932410921] 'agreement among raft nodes before linearized reading' (duration: 147.899968ms)"],"step_count":1} {"level":"info","ts":"2026-10-20T14:14:57.353831Z","caller":"traceutil/trace.go:171","msg":"trace[327267864] transaction","detail":"{read_only:false; response_revision:1896; number_of_response:1; }","duration":"301.497663ms","start":"2026-10-20T14:14:57.052314Z","end":"2026-10-20T14:14:57.353811Z","steps":["trace[327267864] 'process raft request' (duration: 301.36849ms)"],"step_count":1} {"level":"warn","ts":"2026-10-20T14:14:57.353958Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-20T14:14:57.052291Z","time spent":"301.600174ms","remote":"127.0.0.1:57006","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3730,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-20T14:14:57.355267Z","caller":"traceutil/trace.go:171","msg":"trace[1813169201] linearizableReadLoop","detail":"{readStateIndex:1972; appliedIndex:1969; }","duration":"164.745355ms","start":"2026-10-20T14:14:57.1905Z","end":"2026-10-20T14:14:57.355246Z","steps":["trace[1813169201] 'read index received' (duration: 163.244466ms)","trace[1813169201] 'applied index is now lower than readState.Index' (duration: 1.499959ms)"],"step_count":2} {"level":"warn","ts":"2026-10-20T14:14:57.355659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.129852ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-10-20T14:14:57.355603Z","caller":"traceutil/trace.go:171","msg":"trace[27731982] transaction","detail":"{read_only:false; response_revision:1897; number_of_response:1; }","duration":"251.416303ms","start":"2026-10-20T14:14:57.104152Z","end":"2026-10-20T14:14:57.355568Z","steps":["trace[27731982] 'process raft request' (duration: 250.903933ms)"],"step_count":1} {"level":"info","ts":"2026-10-20T14:14:57.355701Z","caller":"traceutil/trace.go:171","msg":"trace[723686600] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1899; }","duration":"165.242044ms","start":"2026-10-20T14:14:57.190449Z","end":"2026-10-20T14:14:57.355691Z","steps":["trace[723686600] 'agreement among raft nodes before linearized reading' (duration: 165.083701ms)"],"step_count":1} {"level":"info","ts":"2026-10-20T14:14:57.355746Z","caller":"traceutil/trace.go:171","msg":"trace[1326591235] transaction","detail":"{read_only:false; response_revision:1898; number_of_response:1; }","duration":"213.621892ms","start":"2026-10-20T14:14:57.142097Z","end":"2026-10-20T14:14:57.355719Z","steps":["trace[1326591235] 'process raft request' (duration: 213.074322ms)"],"step_count":1} {"level":"warn","ts":"2026-10-20T14:14:57.355811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.433281ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-10-20T14:14:57.355862Z","caller":"traceutil/trace.go:171","msg":"trace[813329932] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1899; }","duration":"161.502283ms","start":"2026-10-20T14:14:57.194348Z","end":"2026-10-20T14:14:57.355851Z","steps":["trace[813329932] 'agreement among raft nodes before linearized reading' (duration: 161.361751ms)"],"step_count":1} {"level":"warn","ts":"2026-10-20T14:14:57.356027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.179587ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-10-20T14:14:57.356099Z","caller":"traceutil/trace.go:171","msg":"trace[849167371] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1899; }","duration":"161.301189ms","start":"2026-10-20T14:14:57.194777Z","end":"2026-10-20T14:14:57.356078Z","steps":["trace[849167371] 'agreement among raft nodes before linearized reading' (duration: 161.095206ms)"],"step_count":1} {"level":"info","ts":"2026-10-20T14:15:13.861094Z","caller":"traceutil/trace.go:171","msg":"trace[1839235646] transaction","detail":"{read_only:false; response_revision:2036; number_of_response:1; }","duration":"111.723088ms","start":"2026-10-20T14:15:13.749334Z","end":"2026-10-20T14:15:13.861057Z","steps":["trace[1839235646] 'process raft request' (duration: 111.478654ms)"],"step_count":1} {"level":"warn","ts":"2026-10-20T14:15:46.79465Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.773301ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-10-20T14:15:46.79473Z","caller":"traceutil/trace.go:171","msg":"trace[1651760267] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2217; }","duration":"106.904984ms","start":"2026-10-20T14:15:46.687803Z","end":"2026-10-20T14:15:46.794708Z","steps":["trace[1651760267] 'range keys from in-memory index tree' (duration: 106.635648ms)"],"step_count":1} {"level":"info","ts":"2026-10-20T14:15:53.129775Z","caller":"traceutil/trace.go:171","msg":"trace[313562333] linearizableReadLoop","detail":"{readStateIndex:2336; appliedIndex:2335; }","duration":"263.714338ms","start":"2026-10-20T14:15:52.866041Z","end":"2026-10-20T14:15:53.129755Z","steps":["trace[313562333] 'read index received' (duration: 263.509345ms)","trace[313562333] 'applied index is now lower than readState.Index' (duration: 204.093µs)"],"step_count":2} {"level":"info","ts":"2026-10-20T14:15:53.129815Z","caller":"traceutil/trace.go:171","msg":"trace[427343521] transaction","detail":"{read_only:false; response_revision:2249; number_of_response:1; }","duration":"284.089312ms","start":"2026-10-20T14:15:52.845708Z","end":"2026-10-20T14:15:53.129797Z","steps":["trace[427343521] 'process raft request' (duration: 283.881408ms)"],"step_count":1} {"level":"warn","ts":"2026-10-20T14:15:53.129917Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.852721ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-20T14:15:53.130411Z","caller":"traceutil/trace.go:171","msg":"trace[378943837] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:2249; }","duration":"264.37396ms","start":"2026-10-20T14:15:52.866007Z","end":"2026-10-20T14:15:53.130381Z","steps":["trace[378943837] 'agreement among raft nodes before linearized reading' (duration: 263.85785ms)"],"step_count":1} {"level":"warn","ts":"2026-10-20T14:15:53.130074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.94386ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-20T14:15:53.130517Z","caller":"traceutil/trace.go:171","msg":"trace[1614419328] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2249; }","duration":"198.443568ms","start":"2026-10-20T14:15:52.932063Z","end":"2026-10-20T14:15:53.130506Z","steps":["trace[1614419328] 'agreement among raft nodes before linearized reading' (duration: 197.892008ms)"],"step_count":1} {"level":"info","ts":"2026-10-20T14:17:09.990059Z","caller":"traceutil/trace.go:171","msg":"trace[262198461] transaction","detail":"{read_only:false; response_revision:2859; number_of_response:1; }","duration":"111.050029ms","start":"2026-10-20T14:17:09.878967Z","end":"2026-10-20T14:17:09.990017Z","steps":["trace[262198461] 'process raft request' (duration: 110.890477ms)"],"step_count":1} {"level":"info","ts":"2026-10-20T14:17:10.40769Z","caller":"traceutil/trace.go:171","msg":"trace[1741059024] transaction","detail":"{read_only:false; response_revision:2863; number_of_response:1; }","duration":"144.095299ms","start":"2026-10-20T14:17:10.263563Z","end":"2026-10-20T14:17:10.407658Z","steps":["trace[1741059024] 'process raft request' (duration: 143.847584ms)"],"step_count":1} {"level":"info","ts":"2026-10-20T14:17:15.718192Z","caller":"traceutil/trace.go:171","msg":"trace[814857895] transaction","detail":"{read_only:false; response_revision:2892; number_of_response:1; }","duration":"100.96698ms","start":"2026-10-20T14:17:15.617192Z","end":"2026-10-20T14:17:15.718159Z","steps":["trace[814857895] 'process raft request' (duration: 100.562873ms)"],"step_count":1} {"level":"info","ts":"2026-10-20T14:21:48.232361Z","caller":"traceutil/trace.go:171","msg":"trace[816336142] linearizableReadLoop","detail":"{readStateIndex:5447; appliedIndex:5446; }","duration":"178.860437ms","start":"2026-10-20T14:21:48.053477Z","end":"2026-10-20T14:21:48.232338Z","steps":["trace[816336142] 'read index received' (duration: 178.777295ms)","trace[816336142] 'applied index is now lower than readState.Index' (duration: 82.312µs)"],"step_count":2} {"level":"info","ts":"2026-10-20T14:21:48.232407Z","caller":"traceutil/trace.go:171","msg":"trace[1954750205] transaction","detail":"{read_only:false; response_revision:5247; number_of_response:1; }","duration":"182.644298ms","start":"2026-10-20T14:21:48.049741Z","end":"2026-10-20T14:21:48.232385Z","steps":["trace[1954750205] 'process raft request' (duration: 182.431124ms)"],"step_count":1} {"level":"warn","ts":"2026-10-20T14:21:48.232571Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.072141ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-1e2fc9b8-5ebe-430d-bbbd-3d79b3444533\" ","response":"range_response_count:1 size:3719"} {"level":"info","ts":"2026-10-20T14:21:48.232628Z","caller":"traceutil/trace.go:171","msg":"trace[1408006722] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-1e2fc9b8-5ebe-430d-bbbd-3d79b3444533; range_end:; response_count:1; response_revision:5247; }","duration":"179.180254ms","start":"2026-10-20T14:21:48.053431Z","end":"2026-10-20T14:21:48.232611Z","steps":["trace[1408006722] 'agreement among raft nodes before linearized reading' (duration: 179.076082ms)"],"step_count":1} {"level":"info","ts":"2026-10-20T14:21:48.38662Z","caller":"traceutil/trace.go:171","msg":"trace[838101048] linearizableReadLoop","detail":"{readStateIndex:5448; appliedIndex:5447; }","duration":"154.144127ms","start":"2026-10-20T14:21:48.232449Z","end":"2026-10-20T14:21:48.386593Z","steps":["trace[838101048] 'read index received' (duration: 88.18646ms)","trace[838101048] 'applied index is now lower than readState.Index' (duration: 65.955977ms)"],"step_count":2} {"level":"info","ts":"2026-10-20T14:21:48.386735Z","caller":"traceutil/trace.go:171","msg":"trace[2068060889] transaction","detail":"{read_only:false; response_revision:5248; number_of_response:1; }","duration":"217.984995ms","start":"2026-10-20T14:21:48.168716Z","end":"2026-10-20T14:21:48.386701Z","steps":["trace[2068060889] 'process raft request' (duration: 151.858644ms)","trace[2068060889] 'compare' (duration: 65.793464ms)"],"step_count":2} {"level":"warn","ts":"2026-10-20T14:21:48.386829Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.796075ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/\" range_end:\"/registry/rabbitmq.com/rabbitmqclusters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-20T14:21:48.386864Z","caller":"traceutil/trace.go:171","msg":"trace[506765559] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/; range_end:/registry/rabbitmq.com/rabbitmqclusters0; response_count:0; response_revision:5248; }","duration":"308.856237ms","start":"2026-10-20T14:21:48.077998Z","end":"2026-10-20T14:21:48.386854Z","steps":["trace[506765559] 'agreement among raft nodes before linearized reading' (duration: 308.806486ms)"],"step_count":1} {"level":"warn","ts":"2026-10-20T14:21:48.386901Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-20T14:21:48.077984Z","time spent":"308.908537ms","remote":"127.0.0.1:33770","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":0,"response size":29,"request content":"key:\"/registry/rabbitmq.com/rabbitmqclusters/\" range_end:\"/registry/rabbitmq.com/rabbitmqclusters0\" count_only:true "} {"level":"warn","ts":"2026-10-20T14:21:48.386781Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.167669ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/monitoring/vector\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-20T14:21:48.387009Z","caller":"traceutil/trace.go:171","msg":"trace[1421269700] range","detail":"{range_begin:/registry/serviceaccounts/monitoring/vector; range_end:; response_count:0; response_revision:5248; }","duration":"325.437365ms","start":"2026-10-20T14:21:48.061545Z","end":"2026-10-20T14:21:48.386983Z","steps":["trace[1421269700] 'agreement among raft nodes before linearized reading' (duration: 325.14265ms)"],"step_count":1} {"level":"warn","ts":"2026-10-20T14:21:48.387099Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-20T14:21:48.061532Z","time spent":"325.543427ms","remote":"127.0.0.1:57014","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":29,"request content":"key:\"/registry/serviceaccounts/monitoring/vector\" "} {"level":"info","ts":"2026-10-20T14:21:48.415972Z","caller":"traceutil/trace.go:171","msg":"trace[641319468] transaction","detail":"{read_only:false; response_revision:5249; number_of_response:1; }","duration":"166.752903ms","start":"2026-10-20T14:21:48.249188Z","end":"2026-10-20T14:21:48.415941Z","steps":["trace[641319468] 'process raft request' (duration: 166.378016ms)"],"step_count":1} {"level":"info","ts":"2026-10-20T14:22:03.237842Z","caller":"traceutil/trace.go:171","msg":"trace[66140128] transaction","detail":"{read_only:false; response_revision:5526; number_of_response:1; }","duration":"209.293697ms","start":"2026-10-20T14:22:03.028527Z","end":"2026-10-20T14:22:03.237821Z","steps":["trace[66140128] 'process raft request' (duration: 209.152724ms)"],"step_count":1} {"level":"info","ts":"2026-10-20T14:22:03.242343Z","caller":"traceutil/trace.go:171","msg":"trace[1048405517] linearizableReadLoop","detail":"{readStateIndex:5736; appliedIndex:5734; }","duration":"202.045943ms","start":"2026-10-20T14:22:03.04026Z","end":"2026-10-20T14:22:03.242306Z","steps":["trace[1048405517] 'read index received' (duration: 197.479527ms)","trace[1048405517] 'applied index is now lower than readState.Index' (duration: 4.565566ms)"],"step_count":2} {"level":"info","ts":"2026-10-20T14:22:03.242693Z","caller":"traceutil/trace.go:171","msg":"trace[1456410442] transaction","detail":"{read_only:false; response_revision:5527; number_of_response:1; }","duration":"212.314733ms","start":"2026-10-20T14:22:03.030351Z","end":"2026-10-20T14:22:03.242666Z","steps":["trace[1456410442] 'process raft request' (duration: 211.825714ms)"],"step_count":1} {"level":"warn","ts":"2026-10-20T14:22:03.242743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.43434ms","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-10-20T14:22:03.242878Z","caller":"traceutil/trace.go:171","msg":"trace[1268685935] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:5527; }","duration":"202.640074ms","start":"2026-10-20T14:22:03.040208Z","end":"2026-10-20T14:22:03.242849Z","steps":["trace[1268685935] 'agreement among raft nodes before linearized reading' (duration: 202.348258ms)"],"step_count":1} {"level":"info","ts":"2026-10-20T14:22:05.368031Z","caller":"traceutil/trace.go:171","msg":"trace[752461896] transaction","detail":"{read_only:false; response_revision:5553; number_of_response:1; }","duration":"141.361282ms","start":"2026-10-20T14:22:05.226638Z","end":"2026-10-20T14:22:05.368Z","steps":["trace[752461896] 'process raft request' (duration: 141.22268ms)"],"step_count":1} {"level":"info","ts":"2026-10-20T14:22:05.370221Z","caller":"traceutil/trace.go:171","msg":"trace[1467910991] transaction","detail":"{read_only:false; response_revision:5554; number_of_response:1; }","duration":"126.997834ms","start":"2026-10-20T14:22:05.243199Z","end":"2026-10-20T14:22:05.370197Z","steps":["trace[1467910991] 'process raft request' (duration: 126.829801ms)"],"step_count":1} {"level":"info","ts":"2026-10-20T14:22:05.370531Z","caller":"traceutil/trace.go:171","msg":"trace[53603093] transaction","detail":"{read_only:false; response_revision:5555; number_of_response:1; }","duration":"123.088352ms","start":"2026-10-20T14:22:05.247422Z","end":"2026-10-20T14:22:05.370511Z","steps":["trace[53603093] 'process raft request' (duration: 122.731355ms)"],"step_count":1} {"level":"info","ts":"2026-10-20T14:22:11.475555Z","caller":"traceutil/trace.go:171","msg":"trace[1415100726] linearizableReadLoop","detail":"{readStateIndex:5909; appliedIndex:5908; }","duration":"107.725346ms","start":"2026-10-20T14:22:11.367808Z","end":"2026-10-20T14:22:11.475533Z","steps":["trace[1415100726] 'read index received' (duration: 107.592514ms)","trace[1415100726] 'applied index is now lower than readState.Index' (duration: 131.882µs)"],"step_count":2} {"level":"info","ts":"2026-10-20T14:22:11.475732Z","caller":"traceutil/trace.go:171","msg":"trace[767720936] transaction","detail":"{read_only:false; response_revision:5696; number_of_response:1; }","duration":"178.909621ms","start":"2026-10-20T14:22:11.296767Z","end":"2026-10-20T14:22:11.475676Z","steps":["trace[767720936] 'process raft request' (duration: 178.573274ms)"],"step_count":1} {"level":"warn","ts":"2026-10-20T14:22:11.475787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.96412ms","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-10-20T14:22:11.475825Z","caller":"traceutil/trace.go:171","msg":"trace[225474996] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/storage-loki-0; range_end:; response_count:1; response_revision:5696; }","duration":"108.060652ms","start":"2026-10-20T14:22:11.367754Z","end":"2026-10-20T14:22:11.475815Z","steps":["trace[225474996] 'agreement among raft nodes before linearized reading' (duration: 107.913379ms)"],"step_count":1} {"level":"info","ts":"2026-10-20T14:22:11.506737Z","caller":"traceutil/trace.go:171","msg":"trace[811002997] transaction","detail":"{read_only:false; response_revision:5697; number_of_response:1; }","duration":"117.296855ms","start":"2026-10-20T14:22:11.389407Z","end":"2026-10-20T14:22:11.506704Z","steps":["trace[811002997] 'process raft request' (duration: 98.540235ms)","trace[811002997] 'compare' (duration: 18.570236ms)"],"step_count":2} {"level":"warn","ts":"2026-10-20T14:22:11.507004Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.444341ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-20T14:22:11.507061Z","caller":"traceutil/trace.go:171","msg":"trace[370956264] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:5698; }","duration":"136.542053ms","start":"2026-10-20T14:22:11.370504Z","end":"2026-10-20T14:22:11.507046Z","steps":["trace[370956264] 'agreement among raft nodes before linearized reading' (duration: 136.40467ms)"],"step_count":1} {"level":"info","ts":"2026-10-20T14:22:11.507058Z","caller":"traceutil/trace.go:171","msg":"trace[1546198058] transaction","detail":"{read_only:false; response_revision:5698; number_of_response:1; }","duration":"116.461219ms","start":"2026-10-20T14:22:11.390563Z","end":"2026-10-20T14:22:11.507024Z","steps":["trace[1546198058] 'process raft request' (duration: 116.098913ms)"],"step_count":1} {"level":"info","ts":"2026-10-20T14:22:11.649821Z","caller":"traceutil/trace.go:171","msg":"trace[1699897756] transaction","detail":"{read_only:false; response_revision:5705; number_of_response:1; }","duration":"137.696103ms","start":"2026-10-20T14:22:11.512089Z","end":"2026-10-20T14:22:11.649785Z","steps":["trace[1699897756] 'process raft request' (duration: 133.087947ms)"],"step_count":1} {"level":"info","ts":"2026-10-20T14:22:11.649841Z","caller":"traceutil/trace.go:171","msg":"trace[1496345185] transaction","detail":"{read_only:false; response_revision:5707; number_of_response:1; }","duration":"103.404975ms","start":"2026-10-20T14:22:11.546404Z","end":"2026-10-20T14:22:11.649809Z","steps":["trace[1496345185] 'process raft request' (duration: 103.347464ms)"],"step_count":1} {"level":"info","ts":"2026-10-20T14:22:11.649957Z","caller":"traceutil/trace.go:171","msg":"trace[808233867] transaction","detail":"{read_only:false; response_revision:5706; number_of_response:1; }","duration":"124.445758ms","start":"2026-10-20T14:22:11.525469Z","end":"2026-10-20T14:22:11.649915Z","steps":["trace[808233867] 'process raft request' (duration: 124.209544ms)"],"step_count":1} {"level":"info","ts":"2026-10-20T14:22:31.99639Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2981} {"level":"info","ts":"2026-10-20T14:22:32.078932Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2981,"took":"81.213532ms","hash":512649606,"current-db-size-bytes":56619008,"current-db-size":"57 MB","current-db-size-in-use-bytes":32681984,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-10-20T14:22:32.079071Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":512649606,"revision":2981,"compact-revision":-1} {"level":"info","ts":"2026-10-20T14:27:32.004265Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5912} {"level":"info","ts":"2026-10-20T14:27:32.096213Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5912,"took":"89.916244ms","hash":654733013,"current-db-size-bytes":56619008,"current-db-size":"57 MB","current-db-size-in-use-bytes":26411008,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-10-20T14:27:32.096294Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":654733013,"revision":5912,"compact-revision":2981} {"level":"info","ts":"2026-10-20T14:28:48.181342Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-000000000000231f.wal"} {"level":"info","ts":"2026-10-20T14:28:49.235072Z","caller":"traceutil/trace.go:171","msg":"trace[1916752921] transaction","detail":"{read_only:false; response_revision:8686; number_of_response:1; }","duration":"164.4723ms","start":"2026-10-20T14:28:49.070573Z","end":"2026-10-20T14:28:49.235045Z","steps":["trace[1916752921] 'process raft request' (duration: 164.432159ms)"],"step_count":1} {"level":"info","ts":"2026-10-20T14:28:49.235252Z","caller":"traceutil/trace.go:171","msg":"trace[1318447091] transaction","detail":"{read_only:false; response_revision:8684; number_of_response:1; }","duration":"191.654426ms","start":"2026-10-20T14:28:49.043461Z","end":"2026-10-20T14:28:49.235116Z","steps":["trace[1318447091] 'process raft request' (duration: 116.336944ms)","trace[1318447091] 'compare' (duration: 75.005285ms)"],"step_count":2} {"level":"info","ts":"2026-10-20T14:28:49.235278Z","caller":"traceutil/trace.go:171","msg":"trace[1848555431] transaction","detail":"{read_only:false; response_revision:8685; number_of_response:1; }","duration":"181.632509ms","start":"2026-10-20T14:28:49.053611Z","end":"2026-10-20T14:28:49.235244Z","steps":["trace[1848555431] 'process raft request' (duration: 181.336742ms)"],"step_count":1} {"level":"info","ts":"2026-10-20T14:28:49.92974Z","caller":"traceutil/trace.go:171","msg":"trace[1978777890] linearizableReadLoop","detail":"{readStateIndex:8996; appliedIndex:8995; }","duration":"190.741808ms","start":"2026-10-20T14:28:49.738973Z","end":"2026-10-20T14:28:49.929714Z","steps":["trace[1978777890] 'read index received' (duration: 190.558755ms)","trace[1978777890] 'applied index is now lower than readState.Index' (duration: 182.173µs)"],"step_count":2} {"level":"info","ts":"2026-10-20T14:28:49.929799Z","caller":"traceutil/trace.go:171","msg":"trace[617600851] transaction","detail":"{read_only:false; response_revision:8688; number_of_response:1; }","duration":"232.804221ms","start":"2026-10-20T14:28:49.696971Z","end":"2026-10-20T14:28:49.929775Z","steps":["trace[617600851] 'process raft request' (duration: 232.555376ms)"],"step_count":1} {"level":"warn","ts":"2026-10-20T14:28:49.929949Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.966204ms","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-10-20T14:28:49.92998Z","caller":"traceutil/trace.go:171","msg":"trace[1694037099] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8688; }","duration":"191.053435ms","start":"2026-10-20T14:28:49.738917Z","end":"2026-10-20T14:28:49.92997Z","steps":["trace[1694037099] 'agreement among raft nodes before linearized reading' (duration: 190.923852ms)"],"step_count":1} {"level":"warn","ts":"2026-10-20T14:28:49.930061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.066446ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-10-20T14:28:49.930095Z","caller":"traceutil/trace.go:171","msg":"trace[1173353201] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8688; }","duration":"147.138788ms","start":"2026-10-20T14:28:49.782946Z","end":"2026-10-20T14:28:49.930085Z","steps":["trace[1173353201] 'agreement among raft nodes before linearized reading' (duration: 147.034416ms)"],"step_count":1} {"level":"warn","ts":"2026-10-20T14:28:49.930098Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.101371ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusterbackups/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusterbackups0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-20T14:28:49.930125Z","caller":"traceutil/trace.go:171","msg":"trace[615199900] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusterbackups/; range_end:/registry/pxc.percona.com/perconaxtradbclusterbackups0; response_count:0; response_revision:8688; }","duration":"130.189502ms","start":"2026-10-20T14:28:49.799927Z","end":"2026-10-20T14:28:49.930116Z","steps":["trace[615199900] 'agreement among raft nodes before linearized reading' (duration: 130.140031ms)"],"step_count":1} {"level":"warn","ts":"2026-10-20T14:28:49.930213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.362994ms","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-10-20T14:28:49.930242Z","caller":"traceutil/trace.go:171","msg":"trace[1594755396] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8688; }","duration":"131.389914ms","start":"2026-10-20T14:28:49.798842Z","end":"2026-10-20T14:28:49.930232Z","steps":["trace[1594755396] 'agreement among raft nodes before linearized reading' (duration: 131.321283ms)"],"step_count":1} {"level":"info","ts":"2026-10-20T14:29:30.45822Z","caller":"traceutil/trace.go:171","msg":"trace[1480211299] linearizableReadLoop","detail":"{readStateIndex:9273; appliedIndex:9272; }","duration":"141.399761ms","start":"2026-10-20T14:29:30.316787Z","end":"2026-10-20T14:29:30.458187Z","steps":["trace[1480211299] 'read index received' (duration: 141.160757ms)","trace[1480211299] 'applied index is now lower than readState.Index' (duration: 237.334µs)"],"step_count":2} {"level":"info","ts":"2026-10-20T14:29:30.458338Z","caller":"traceutil/trace.go:171","msg":"trace[476793399] transaction","detail":"{read_only:false; response_revision:8954; number_of_response:1; }","duration":"241.182956ms","start":"2026-10-20T14:29:30.217111Z","end":"2026-10-20T14:29:30.458294Z","steps":["trace[476793399] 'process raft request' (duration: 240.87154ms)"],"step_count":1} {"level":"warn","ts":"2026-10-20T14:29:30.458506Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.673836ms","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-10-20T14:29:30.458551Z","caller":"traceutil/trace.go:171","msg":"trace[1583469046] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8954; }","duration":"141.794398ms","start":"2026-10-20T14:29:30.316745Z","end":"2026-10-20T14:29:30.458539Z","steps":["trace[1583469046] 'agreement among raft nodes before linearized reading' (duration: 141.588975ms)"],"step_count":1} {"level":"warn","ts":"2026-10-20T14:29:30.479031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.898681ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-10-20T14:29:30.479108Z","caller":"traceutil/trace.go:171","msg":"trace[1458807136] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8955; }","duration":"162.000043ms","start":"2026-10-20T14:29:30.31709Z","end":"2026-10-20T14:29:30.47909Z","steps":["trace[1458807136] 'agreement among raft nodes before linearized reading' (duration: 161.800239ms)"],"step_count":1} {"level":"warn","ts":"2026-10-20T14:29:30.479183Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.168651ms","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-10-20T14:29:30.479264Z","caller":"traceutil/trace.go:171","msg":"trace[600979058] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8955; }","duration":"159.277562ms","start":"2026-10-20T14:29:30.319966Z","end":"2026-10-20T14:29:30.479243Z","steps":["trace[600979058] 'agreement among raft nodes before linearized reading' (duration: 159.071489ms)"],"step_count":1} {"level":"warn","ts":"2026-10-20T14:29:31.019099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.304ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-10-20T14:30:36.628221Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"a99b527d1e65fdd9","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-20T14:30:36.635815Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-10-20T14:30:36.635938Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-10-20T14:31:00.77217Z","caller":"traceutil/trace.go:171","msg":"trace[1186928520] linearizableReadLoop","detail":"{readStateIndex:10164; appliedIndex:10163; }","duration":"124.500546ms","start":"2026-10-20T14:31:00.647651Z","end":"2026-10-20T14:31:00.772151Z","steps":["trace[1186928520] 'read index received' (duration: 124.381683ms)","trace[1186928520] 'applied index is now lower than readState.Index' (duration: 117.923µs)"],"step_count":2} {"level":"info","ts":"2026-10-20T14:31:00.772219Z","caller":"traceutil/trace.go:171","msg":"trace[95841229] transaction","detail":"{read_only:false; response_revision:9815; number_of_response:1; }","duration":"189.134108ms","start":"2026-10-20T14:31:00.583054Z","end":"2026-10-20T14:31:00.772188Z","steps":["trace[95841229] 'process raft request' (duration: 188.936055ms)"],"step_count":1} {"level":"warn","ts":"2026-10-20T14:31:00.772372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.716599ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12430"} {"level":"info","ts":"2026-10-20T14:31:00.772413Z","caller":"traceutil/trace.go:171","msg":"trace[1822352522] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:9815; }","duration":"124.804291ms","start":"2026-10-20T14:31:00.647598Z","end":"2026-10-20T14:31:00.772403Z","steps":["trace[1822352522] 'agreement among raft nodes before linearized reading' (duration: 124.668339ms)"],"step_count":1} {"level":"info","ts":"2026-10-20T14:32:32.011512Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8065} {"level":"info","ts":"2026-10-20T14:32:32.080099Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8065,"took":"66.503597ms","hash":2923002468,"current-db-size-bytes":56619008,"current-db-size":"57 MB","current-db-size-in-use-bytes":28123136,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-10-20T14:32:32.080175Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2923002468,"revision":8065,"compact-revision":5912} {"level":"info","ts":"2026-10-20T14:36:36.941664Z","caller":"traceutil/trace.go:171","msg":"trace[1262887295] linearizableReadLoop","detail":"{readStateIndex:12664; appliedIndex:12662; }","duration":"138.8399ms","start":"2026-10-20T14:36:36.802796Z","end":"2026-10-20T14:36:36.941636Z","steps":["trace[1262887295] 'read index received' (duration: 11.397979ms)","trace[1262887295] 'applied index is now lower than readState.Index' (duration: 127.437621ms)"],"step_count":2} {"level":"info","ts":"2026-10-20T14:36:36.941753Z","caller":"traceutil/trace.go:171","msg":"trace[14576758] transaction","detail":"{read_only:false; response_revision:12238; number_of_response:1; }","duration":"142.437756ms","start":"2026-10-20T14:36:36.799288Z","end":"2026-10-20T14:36:36.941726Z","steps":["trace[14576758] 'process raft request' (duration: 106.856213ms)","trace[14576758] 'compare' (duration: 35.374199ms)"],"step_count":2} {"level":"warn","ts":"2026-10-20T14:36:36.941922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.102115ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-10-20T14:36:36.941976Z","caller":"traceutil/trace.go:171","msg":"trace[1196636229] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:12238; }","duration":"139.208618ms","start":"2026-10-20T14:36:36.802752Z","end":"2026-10-20T14:36:36.94196Z","steps":["trace[1196636229] 'agreement among raft nodes before linearized reading' (duration: 139.030524ms)"],"step_count":1} {"level":"warn","ts":"2026-10-20T14:36:36.94201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.669458ms","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-10-20T14:36:36.942045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.972895ms","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:5"} {"level":"info","ts":"2026-10-20T14:36:36.942083Z","caller":"traceutil/trace.go:171","msg":"trace[1910775915] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:12238; }","duration":"138.031607ms","start":"2026-10-20T14:36:36.804037Z","end":"2026-10-20T14:36:36.942069Z","steps":["trace[1910775915] 'agreement among raft nodes before linearized reading' (duration: 137.968256ms)"],"step_count":1} {"level":"info","ts":"2026-10-20T14:36:36.94208Z","caller":"traceutil/trace.go:171","msg":"trace[1936428801] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:12238; }","duration":"138.76874ms","start":"2026-10-20T14:36:36.803294Z","end":"2026-10-20T14:36:36.942062Z","steps":["trace[1936428801] 'agreement among raft nodes before linearized reading' (duration: 138.604897ms)"],"step_count":1} {"level":"info","ts":"2026-10-20T14:37:32.02274Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10433} {"level":"info","ts":"2026-10-20T14:37:32.125578Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10433,"took":"100.654651ms","hash":2146399595,"current-db-size-bytes":56619008,"current-db-size":"57 MB","current-db-size-in-use-bytes":26329088,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-10-20T14:37:32.12565Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2146399595,"revision":10433,"compact-revision":8065} {"level":"info","ts":"2026-10-20T14:42:32.029211Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12615} {"level":"info","ts":"2026-10-20T14:42:32.106505Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12615,"took":"75.352751ms","hash":3437155593,"current-db-size-bytes":56619008,"current-db-size":"57 MB","current-db-size-in-use-bytes":27496448,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-10-20T14:42:32.106569Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3437155593,"revision":12615,"compact-revision":10433} {"level":"info","ts":"2026-10-20T14:43:29.676986Z","caller":"traceutil/trace.go:171","msg":"trace[226513585] transaction","detail":"{read_only:false; response_revision:14972; number_of_response:1; }","duration":"151.843772ms","start":"2026-10-20T14:43:29.525118Z","end":"2026-10-20T14:43:29.676962Z","steps":["trace[226513585] 'process raft request' (duration: 151.685329ms)"],"step_count":1} {"level":"info","ts":"2026-10-20T14:45:05.490005Z","caller":"traceutil/trace.go:171","msg":"trace[596761767] transaction","detail":"{read_only:false; response_revision:16032; number_of_response:1; }","duration":"110.746438ms","start":"2026-10-20T14:45:05.379238Z","end":"2026-10-20T14:45:05.489985Z","steps":["trace[596761767] 'process raft request' (duration: 110.602886ms)"],"step_count":1} {"level":"info","ts":"2026-10-20T14:45:12.009959Z","caller":"traceutil/trace.go:171","msg":"trace[1743233616] transaction","detail":"{read_only:false; response_revision:16064; number_of_response:1; }","duration":"261.678783ms","start":"2026-10-20T14:45:11.748243Z","end":"2026-10-20T14:45:12.009922Z","steps":["trace[1743233616] 'process raft request' (duration: 261.358347ms)"],"step_count":1} {"level":"info","ts":"2026-10-20T14:45:12.010646Z","caller":"traceutil/trace.go:171","msg":"trace[1935998791] linearizableReadLoop","detail":"{readStateIndex:16628; appliedIndex:16626; }","duration":"222.730789ms","start":"2026-10-20T14:45:11.787898Z","end":"2026-10-20T14:45:12.010629Z","steps":["trace[1935998791] 'read index received' (duration: 221.854743ms)","trace[1935998791] 'applied index is now lower than readState.Index' (duration: 874.986µs)"],"step_count":2} {"level":"info","ts":"2026-10-20T14:45:12.010672Z","caller":"traceutil/trace.go:171","msg":"trace[990525486] transaction","detail":"{read_only:false; response_revision:16065; number_of_response:1; }","duration":"254.641273ms","start":"2026-10-20T14:45:11.756014Z","end":"2026-10-20T14:45:12.010655Z","steps":["trace[990525486] 'process raft request' (duration: 254.48598ms)"],"step_count":1} {"level":"warn","ts":"2026-10-20T14:45:12.010854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.945243ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-cell-setup-q2mb5\" ","response":"range_response_count:1 size:9789"} {"level":"info","ts":"2026-10-20T14:45:12.010894Z","caller":"traceutil/trace.go:171","msg":"trace[735747525] range","detail":"{range_begin:/registry/pods/openstack/nova-cell-setup-q2mb5; range_end:; response_count:1; response_revision:16065; }","duration":"223.040035ms","start":"2026-10-20T14:45:11.787844Z","end":"2026-10-20T14:45:12.010884Z","steps":["trace[735747525] 'agreement among raft nodes before linearized reading' (duration: 222.877012ms)"],"step_count":1} {"level":"info","ts":"2026-10-20T14:47:32.03945Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14613} {"level":"info","ts":"2026-10-20T14:47:32.126887Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14613,"took":"84.865407ms","hash":3429682177,"current-db-size-bytes":56619008,"current-db-size":"57 MB","current-db-size-in-use-bytes":30810112,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-10-20T14:47:32.127043Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3429682177,"revision":14613,"compact-revision":12615} {"level":"info","ts":"2026-10-20T14:51:26.406478Z","caller":"traceutil/trace.go:171","msg":"trace[876489218] linearizableReadLoop","detail":"{readStateIndex:19461; appliedIndex:19460; }","duration":"417.244623ms","start":"2026-10-20T14:51:25.989213Z","end":"2026-10-20T14:51:26.406458Z","steps":["trace[876489218] 'read index received' (duration: 417.005928ms)","trace[876489218] 'applied index is now lower than readState.Index' (duration: 237.735µs)"],"step_count":2} {"level":"warn","ts":"2026-10-20T14:51:26.406934Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"417.702461ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-10-20T14:51:26.407036Z","caller":"traceutil/trace.go:171","msg":"trace[956795821] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:18809; }","duration":"417.854084ms","start":"2026-10-20T14:51:25.989166Z","end":"2026-10-20T14:51:26.40702Z","steps":["trace[956795821] 'agreement among raft nodes before linearized reading' (duration: 417.62997ms)"],"step_count":1} {"level":"warn","ts":"2026-10-20T14:51:26.407077Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-20T14:51:25.989142Z","time spent":"417.927065ms","remote":"127.0.0.1:57080","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":506,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-10-20T14:51:26.407132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"414.213216ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"} {"level":"info","ts":"2026-10-20T14:51:26.407195Z","caller":"traceutil/trace.go:171","msg":"trace[492636401] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:18809; }","duration":"414.339119ms","start":"2026-10-20T14:51:25.992843Z","end":"2026-10-20T14:51:26.407182Z","steps":["trace[492636401] 'agreement among raft nodes before linearized reading' (duration: 414.059194ms)"],"step_count":1} {"level":"warn","ts":"2026-10-20T14:51:26.407242Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-20T14:51:25.992785Z","time spent":"414.447861ms","remote":"127.0.0.1:57080","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":464,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-10-20T14:51:26.407296Z","caller":"traceutil/trace.go:171","msg":"trace[1947635673] transaction","detail":"{read_only:false; response_revision:18809; number_of_response:1; }","duration":"501.101159ms","start":"2026-10-20T14:51:25.906182Z","end":"2026-10-20T14:51:26.407284Z","steps":["trace[1947635673] 'process raft request' (duration: 500.125301ms)"],"step_count":1} {"level":"warn","ts":"2026-10-20T14:51:26.407389Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-20T14:51:25.906153Z","time spent":"501.17622ms","remote":"127.0.0.1:57006","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":21003,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-20T14:51:26.407544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.095364ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rook-ceph-pdbstatemap\" ","response":"range_response_count:1 size:357"} {"level":"info","ts":"2026-10-20T14:51:26.407604Z","caller":"traceutil/trace.go:171","msg":"trace[1161044322] range","detail":"{range_begin:/registry/configmaps/openstack/rook-ceph-pdbstatemap; range_end:; response_count:1; response_revision:18809; }","duration":"178.191486ms","start":"2026-10-20T14:51:26.229404Z","end":"2026-10-20T14:51:26.407595Z","steps":["trace[1161044322] 'agreement among raft nodes before linearized reading' (duration: 178.079074ms)"],"step_count":1} {"level":"info","ts":"2026-10-20T14:52:04.724834Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"a99b527d1e65fdd9","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-20T14:52:04.730771Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-10-20T14:52:04.730891Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-10-20T14:52:32.046373Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":16994} {"level":"info","ts":"2026-10-20T14:52:32.150693Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":16994,"took":"100.861105ms","hash":1393403839,"current-db-size-bytes":56619008,"current-db-size":"57 MB","current-db-size-in-use-bytes":33247232,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-10-20T14:52:32.150765Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1393403839,"revision":16994,"compact-revision":14613} {"level":"info","ts":"2026-10-20T14:57:32.053154Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19541} {"level":"info","ts":"2026-10-20T14:57:32.17324Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19541,"took":"116.200151ms","hash":923641448,"current-db-size-bytes":56619008,"current-db-size":"57 MB","current-db-size-in-use-bytes":29839360,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-10-20T14:57:32.173372Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":923641448,"revision":19541,"compact-revision":16994} {"level":"info","ts":"2026-10-20T14:57:41.479221Z","caller":"traceutil/trace.go:171","msg":"trace[402781760] linearizableReadLoop","detail":"{readStateIndex:22396; appliedIndex:22395; }","duration":"123.20247ms","start":"2026-10-20T14:57:41.355993Z","end":"2026-10-20T14:57:41.479195Z","steps":["trace[402781760] 'read index received' (duration: 123.023376ms)","trace[402781760] 'applied index is now lower than readState.Index' (duration: 177.894µs)"],"step_count":2} {"level":"info","ts":"2026-10-20T14:57:41.479272Z","caller":"traceutil/trace.go:171","msg":"trace[358181601] transaction","detail":"{read_only:false; response_revision:21648; number_of_response:1; }","duration":"133.869449ms","start":"2026-10-20T14:57:41.345373Z","end":"2026-10-20T14:57:41.479242Z","steps":["trace[358181601] 'process raft request' (duration: 133.617064ms)"],"step_count":1} {"level":"warn","ts":"2026-10-20T14:57:41.479438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.436315ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/storage-loki-0\" ","response":"range_response_count:1 size:1782"} {"level":"info","ts":"2026-10-20T14:57:41.479477Z","caller":"traceutil/trace.go:171","msg":"trace[283736614] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/storage-loki-0; range_end:; response_count:1; response_revision:21648; }","duration":"123.517566ms","start":"2026-10-20T14:57:41.355945Z","end":"2026-10-20T14:57:41.479462Z","steps":["trace[283736614] 'agreement among raft nodes before linearized reading' (duration: 123.342973ms)"],"step_count":1} {"level":"warn","ts":"2026-10-20T14:57:41.667137Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.004951ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-1e2fc9b8-5ebe-430d-bbbd-3d79b3444533\" ","response":"range_response_count:1 size:1276"} {"level":"info","ts":"2026-10-20T14:57:41.667214Z","caller":"traceutil/trace.go:171","msg":"trace[670319432] range","detail":"{range_begin:/registry/persistentvolumes/pvc-1e2fc9b8-5ebe-430d-bbbd-3d79b3444533; range_end:; response_count:1; response_revision:21648; }","duration":"184.089803ms","start":"2026-10-20T14:57:41.483106Z","end":"2026-10-20T14:57:41.667196Z","steps":["trace[670319432] 'range keys from in-memory index tree' (duration: 183.853678ms)"],"step_count":1} {"level":"info","ts":"2026-10-20T14:57:42.019486Z","caller":"traceutil/trace.go:171","msg":"trace[379896284] linearizableReadLoop","detail":"{readStateIndex:22397; appliedIndex:22396; }","duration":"143.720562ms","start":"2026-10-20T14:57:41.875734Z","end":"2026-10-20T14:57:42.019455Z","steps":["trace[379896284] 'read index received' (duration: 143.513738ms)","trace[379896284] 'applied index is now lower than readState.Index' (duration: 205.414µs)"],"step_count":2} {"level":"info","ts":"2026-10-20T14:57:42.019542Z","caller":"traceutil/trace.go:171","msg":"trace[671141413] transaction","detail":"{read_only:false; response_revision:21649; number_of_response:1; }","duration":"176.868308ms","start":"2026-10-20T14:57:41.842644Z","end":"2026-10-20T14:57:42.019512Z","steps":["trace[671141413] 'process raft request' (duration: 176.635484ms)"],"step_count":1} {"level":"warn","ts":"2026-10-20T14:57:42.019655Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.908275ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-20T14:57:42.019728Z","caller":"traceutil/trace.go:171","msg":"trace[1724150726] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:21649; }","duration":"144.041028ms","start":"2026-10-20T14:57:41.875672Z","end":"2026-10-20T14:57:42.019713Z","steps":["trace[1724150726] 'agreement among raft nodes before linearized reading' (duration: 143.922956ms)"],"step_count":1} {"level":"info","ts":"2026-10-20T14:57:42.285968Z","caller":"traceutil/trace.go:171","msg":"trace[532511294] linearizableReadLoop","detail":"{readStateIndex:22398; appliedIndex:22397; }","duration":"266.368022ms","start":"2026-10-20T14:57:42.01957Z","end":"2026-10-20T14:57:42.285938Z","steps":["trace[532511294] 'read index received' (duration: 266.172479ms)","trace[532511294] 'applied index is now lower than readState.Index' (duration: 193.973µs)"],"step_count":2} {"level":"info","ts":"2026-10-20T14:57:42.286104Z","caller":"traceutil/trace.go:171","msg":"trace[772474414] transaction","detail":"{read_only:false; response_revision:21650; number_of_response:1; }","duration":"378.371655ms","start":"2026-10-20T14:57:41.907719Z","end":"2026-10-20T14:57:42.28609Z","steps":["trace[772474414] 'process raft request' (duration: 378.002087ms)"],"step_count":1} {"level":"warn","ts":"2026-10-20T14:57:42.286211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"354.43379ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-10-20T14:57:42.286251Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-20T14:57:41.9077Z","time spent":"378.436507ms","remote":"127.0.0.1:57080","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-20T14:57:42.286284Z","caller":"traceutil/trace.go:171","msg":"trace[396572254] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:21650; }","duration":"354.567952ms","start":"2026-10-20T14:57:41.931699Z","end":"2026-10-20T14:57:42.286267Z","steps":["trace[396572254] 'agreement among raft nodes before linearized reading' (duration: 354.44256ms)"],"step_count":1} {"level":"warn","ts":"2026-10-20T14:57:42.286323Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-20T14:57:41.931678Z","time spent":"354.638093ms","remote":"127.0.0.1:56846","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":30,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-10-20T14:57:42.311241Z","caller":"traceutil/trace.go:171","msg":"trace[143966749] transaction","detail":"{read_only:false; response_revision:21651; number_of_response:1; }","duration":"111.34728ms","start":"2026-10-20T14:57:42.199872Z","end":"2026-10-20T14:57:42.311219Z","steps":["trace[143966749] 'process raft request' (duration: 111.201967ms)"],"step_count":1} {"level":"info","ts":"2026-10-20T14:57:42.311426Z","caller":"traceutil/trace.go:171","msg":"trace[323148596] transaction","detail":"{read_only:false; response_revision:21652; number_of_response:1; }","duration":"109.2166ms","start":"2026-10-20T14:57:42.202204Z","end":"2026-10-20T14:57:42.311421Z","steps":["trace[323148596] 'process raft request' (duration: 108.985766ms)"],"step_count":1} {"level":"warn","ts":"2026-10-20T14:57:42.311774Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.752018ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-20T14:57:42.311798Z","caller":"traceutil/trace.go:171","msg":"trace[993195744] range","detail":"{range_begin:/registry/services/specs/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:21653; }","duration":"288.81922ms","start":"2026-10-20T14:57:42.022973Z","end":"2026-10-20T14:57:42.311792Z","steps":["trace[993195744] 'agreement among raft nodes before linearized reading' (duration: 288.766139ms)"],"step_count":1} {"level":"info","ts":"2026-10-20T14:57:42.311895Z","caller":"traceutil/trace.go:171","msg":"trace[866080414] transaction","detail":"{read_only:false; response_revision:21653; number_of_response:1; }","duration":"109.629868ms","start":"2026-10-20T14:57:42.202259Z","end":"2026-10-20T14:57:42.311889Z","steps":["trace[866080414] 'process raft request' (duration: 109.138939ms)"],"step_count":1} {"level":"info","ts":"2026-10-20T14:57:42.624396Z","caller":"traceutil/trace.go:171","msg":"trace[990335858] transaction","detail":"{read_only:false; response_revision:21654; number_of_response:1; }","duration":"127.038472ms","start":"2026-10-20T14:57:42.497321Z","end":"2026-10-20T14:57:42.624359Z","steps":["trace[990335858] 'process raft request' (duration: 126.840608ms)"],"step_count":1} {"level":"warn","ts":"2026-10-20T14:57:42.887944Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.441481ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-20T14:57:42.888208Z","caller":"traceutil/trace.go:171","msg":"trace[54996127] transaction","detail":"{read_only:false; response_revision:21656; number_of_response:1; }","duration":"390.329657ms","start":"2026-10-20T14:57:42.49786Z","end":"2026-10-20T14:57:42.888189Z","steps":["trace[54996127] 'process raft request' (duration: 390.207134ms)"],"step_count":1} {"level":"info","ts":"2026-10-20T14:57:42.888245Z","caller":"traceutil/trace.go:171","msg":"trace[2143503669] transaction","detail":"{read_only:false; response_revision:21655; number_of_response:1; }","duration":"390.444959ms","start":"2026-10-20T14:57:42.497769Z","end":"2026-10-20T14:57:42.888214Z","steps":["trace[2143503669] 'process raft request' (duration: 214.610451ms)","trace[2143503669] 'compare' (duration: 175.124155ms)"],"step_count":2} {"level":"warn","ts":"2026-10-20T14:57:42.888281Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-20T14:57:42.497848Z","time spent":"390.402008ms","remote":"127.0.0.1:57080","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-20T14:57:42.888396Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-20T14:57:42.497748Z","time spent":"390.563112ms","remote":"127.0.0.1:57080","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-20T15:02:32.060351Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":21600} {"level":"info","ts":"2026-10-20T15:02:32.188123Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":21600,"took":"123.955093ms","hash":2486990620,"current-db-size-bytes":57470976,"current-db-size":"58 MB","current-db-size-in-use-bytes":42827776,"current-db-size-in-use":"43 MB"} {"level":"info","ts":"2026-10-20T15:02:32.188218Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2486990620,"revision":21600,"compact-revision":19541} {"level":"info","ts":"2026-10-20T15:04:16.370817Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-00000000000067c6.wal"} {"level":"info","ts":"2026-10-20T15:05:29.545214Z","caller":"traceutil/trace.go:171","msg":"trace[658747455] transaction","detail":"{read_only:false; response_revision:26433; number_of_response:1; }","duration":"146.891431ms","start":"2026-10-20T15:05:29.398289Z","end":"2026-10-20T15:05:29.545181Z","steps":["trace[658747455] 'process raft request' (duration: 146.34254ms)"],"step_count":1} {"level":"warn","ts":"2026-10-20T15:05:29.792424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.511224ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-20T15:05:29.792708Z","caller":"traceutil/trace.go:171","msg":"trace[2111768968] transaction","detail":"{read_only:false; response_revision:26435; number_of_response:1; }","duration":"238.248355ms","start":"2026-10-20T15:05:29.554434Z","end":"2026-10-20T15:05:29.792683Z","steps":["trace[2111768968] 'process raft request' (duration: 238.120002ms)"],"step_count":1} {"level":"info","ts":"2026-10-20T15:05:29.792708Z","caller":"traceutil/trace.go:171","msg":"trace[323035803] transaction","detail":"{read_only:false; response_revision:26434; number_of_response:1; }","duration":"238.745064ms","start":"2026-10-20T15:05:29.553927Z","end":"2026-10-20T15:05:29.792672Z","steps":["trace[323035803] 'process raft request' (duration: 121.875273ms)","trace[323035803] 'compare' (duration: 116.28846ms)"],"step_count":2} {"level":"warn","ts":"2026-10-20T15:05:30.047624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.376232ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-20T15:05:30.047695Z","caller":"traceutil/trace.go:171","msg":"trace[1363628730] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26435; }","duration":"115.492954ms","start":"2026-10-20T15:05:29.932186Z","end":"2026-10-20T15:05:30.047679Z","steps":["trace[1363628730] 'range keys from in-memory index tree' (duration: 115.244399ms)"],"step_count":1} {"level":"info","ts":"2026-10-20T15:06:39.264915Z","caller":"traceutil/trace.go:171","msg":"trace[1560054779] linearizableReadLoop","detail":"{readStateIndex:27937; appliedIndex:27936; }","duration":"296.008352ms","start":"2026-10-20T15:06:38.968877Z","end":"2026-10-20T15:06:39.264885Z","steps":["trace[1560054779] 'read index received' (duration: 295.737407ms)","trace[1560054779] 'applied index is now lower than readState.Index' (duration: 269.375µs)"],"step_count":2} {"level":"info","ts":"2026-10-20T15:06:39.265032Z","caller":"traceutil/trace.go:171","msg":"trace[799954231] transaction","detail":"{read_only:false; response_revision:27048; number_of_response:1; }","duration":"338.654587ms","start":"2026-10-20T15:06:38.926367Z","end":"2026-10-20T15:06:39.265021Z","steps":["trace[799954231] 'process raft request' (duration: 338.273849ms)"],"step_count":1} {"level":"warn","ts":"2026-10-20T15:06:39.265137Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-20T15:06:38.926348Z","time spent":"338.708399ms","remote":"127.0.0.1:57080","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-20T15:06:39.265362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.467661ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-10-20T15:06:39.265467Z","caller":"traceutil/trace.go:171","msg":"trace[1298411957] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:27048; }","duration":"296.604793ms","start":"2026-10-20T15:06:38.968838Z","end":"2026-10-20T15:06:39.265442Z","steps":["trace[1298411957] 'agreement among raft nodes before linearized reading' (duration: 296.340808ms)"],"step_count":1} {"level":"warn","ts":"2026-10-20T15:06:40.098607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"471.464815ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-20T15:06:40.098783Z","caller":"traceutil/trace.go:171","msg":"trace[1099249674] linearizableReadLoop","detail":"{readStateIndex:27938; appliedIndex:27937; }","duration":"833.769674ms","start":"2026-10-20T15:06:39.264991Z","end":"2026-10-20T15:06:40.09876Z","steps":["trace[1099249674] 'read index received' (duration: 362.025754ms)","trace[1099249674] 'applied index is now lower than readState.Index' (duration: 471.7425ms)"],"step_count":2} {"level":"warn","ts":"2026-10-20T15:06:40.098899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.073762861s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-20T15:06:40.098933Z","caller":"traceutil/trace.go:171","msg":"trace[1082718807] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:27049; }","duration":"1.073840533s","start":"2026-10-20T15:06:39.025078Z","end":"2026-10-20T15:06:40.098918Z","steps":["trace[1082718807] 'agreement among raft nodes before linearized reading' (duration: 1.073769471s)"],"step_count":1} {"level":"info","ts":"2026-10-20T15:06:40.098902Z","caller":"traceutil/trace.go:171","msg":"trace[491693558] transaction","detail":"{read_only:false; response_revision:27049; number_of_response:1; }","duration":"1.080221872s","start":"2026-10-20T15:06:39.018634Z","end":"2026-10-20T15:06:40.098855Z","steps":["trace[491693558] 'process raft request' (duration: 608.375669ms)","trace[491693558] 'compare' (duration: 471.276962ms)"],"step_count":2} {"level":"warn","ts":"2026-10-20T15:06:40.098972Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-20T15:06:39.025052Z","time spent":"1.073909875s","remote":"127.0.0.1:48284","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":30,"request content":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true "} {"level":"warn","ts":"2026-10-20T15:06:40.099097Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-20T15:06:39.018589Z","time spent":"1.080398395s","remote":"127.0.0.1:57080","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-20T15:06:40.403068Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.504647ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-20T15:06:40.403302Z","caller":"traceutil/trace.go:171","msg":"trace[146106940] linearizableReadLoop","detail":"{readStateIndex:27941; appliedIndex:27938; }","duration":"304.47318ms","start":"2026-10-20T15:06:40.098811Z","end":"2026-10-20T15:06:40.403284Z","steps":["trace[146106940] 'read index received' (duration: 138.755319ms)","trace[146106940] 'applied index is now lower than readState.Index' (duration: 165.716971ms)"],"step_count":2} {"level":"warn","ts":"2026-10-20T15:06:40.403423Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"470.085089ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-20T15:06:40.403447Z","caller":"traceutil/trace.go:171","msg":"trace[306067314] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:27052; }","duration":"470.187872ms","start":"2026-10-20T15:06:39.93325Z","end":"2026-10-20T15:06:40.403438Z","steps":["trace[306067314] 'agreement among raft nodes before linearized reading' (duration: 470.114311ms)"],"step_count":1} {"level":"warn","ts":"2026-10-20T15:06:40.403474Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-20T15:06:39.933232Z","time spent":"470.235472ms","remote":"127.0.0.1:56846","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":30,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-10-20T15:06:40.403509Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"429.990862ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates/\" range_end:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-20T15:06:40.403584Z","caller":"traceutil/trace.go:171","msg":"trace[25255926] range","detail":"{range_begin:/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates/; range_end:/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates0; response_count:0; response_revision:27052; }","duration":"430.132474ms","start":"2026-10-20T15:06:39.973432Z","end":"2026-10-20T15:06:40.403565Z","steps":["trace[25255926] 'agreement among raft nodes before linearized reading' (duration: 429.88065ms)"],"step_count":1} {"level":"warn","ts":"2026-10-20T15:06:40.403643Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-20T15:06:39.973387Z","time spent":"430.229226ms","remote":"127.0.0.1:56224","response type":"/etcdserverpb.KV/Range","request count":0,"request size":126,"response count":0,"response size":30,"request content":"key:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates/\" range_end:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates0\" count_only:true "} {"level":"warn","ts":"2026-10-20T15:06:40.40367Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"800.645437ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-10-20T15:06:40.403738Z","caller":"traceutil/trace.go:171","msg":"trace[1541845164] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:27052; }","duration":"800.723988ms","start":"2026-10-20T15:06:39.602979Z","end":"2026-10-20T15:06:40.403703Z","steps":["trace[1541845164] 'agreement among raft nodes before linearized reading' (duration: 800.571435ms)"],"step_count":1} {"level":"warn","ts":"2026-10-20T15:06:40.40375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.063672274s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1866"} {"level":"info","ts":"2026-10-20T15:06:40.403784Z","caller":"traceutil/trace.go:171","msg":"trace[280728941] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:27052; }","duration":"1.063742495s","start":"2026-10-20T15:06:39.340031Z","end":"2026-10-20T15:06:40.403774Z","steps":["trace[280728941] 'agreement among raft nodes before linearized reading' (duration: 1.063620683s)"],"step_count":1} {"level":"warn","ts":"2026-10-20T15:06:40.403786Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-20T15:06:39.602968Z","time spent":"800.797889ms","remote":"127.0.0.1:57080","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":506,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-10-20T15:06:40.403807Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-20T15:06:39.340013Z","time spent":"1.063788676s","remote":"127.0.0.1:56986","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":1,"response size":1890,"request content":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" "} {"level":"warn","ts":"2026-10-20T15:06:40.403879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"485.812802ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12431"} {"level":"info","ts":"2026-10-20T15:06:40.403957Z","caller":"traceutil/trace.go:171","msg":"trace[565092892] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:27052; }","duration":"485.958596ms","start":"2026-10-20T15:06:39.917976Z","end":"2026-10-20T15:06:40.403934Z","steps":["trace[565092892] 'agreement among raft nodes before linearized reading' (duration: 485.668931ms)"],"step_count":1} {"level":"warn","ts":"2026-10-20T15:06:40.403979Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.539666ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigs/\" range_end:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigs0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-10-20T15:06:40.403996Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-20T15:06:39.917941Z","time spent":"486.046877ms","remote":"127.0.0.1:57006","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12455,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"info","ts":"2026-10-20T15:06:40.404011Z","caller":"traceutil/trace.go:171","msg":"trace[172259336] range","detail":"{range_begin:/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigs/; range_end:/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigs0; response_count:0; response_revision:27052; }","duration":"204.604247ms","start":"2026-10-20T15:06:40.199396Z","end":"2026-10-20T15:06:40.404Z","steps":["trace[172259336] 'agreement among raft nodes before linearized reading' (duration: 204.550116ms)"],"step_count":1} {"level":"info","ts":"2026-10-20T15:06:40.404009Z","caller":"traceutil/trace.go:171","msg":"trace[2143594992] transaction","detail":"{read_only:false; response_revision:27050; number_of_response:1; }","duration":"1.133792562s","start":"2026-10-20T15:06:39.270201Z","end":"2026-10-20T15:06:40.403993Z","steps":["trace[2143594992] 'process raft request' (duration: 967.271526ms)","trace[2143594992] 'compare' (duration: 165.147101ms)"],"step_count":2} {"level":"warn","ts":"2026-10-20T15:06:40.404061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"689.445842ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-10-20T15:06:40.404092Z","caller":"traceutil/trace.go:171","msg":"trace[1127352940] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:27052; }","duration":"689.518773ms","start":"2026-10-20T15:06:39.714564Z","end":"2026-10-20T15:06:40.404083Z","steps":["trace[1127352940] 'agreement among raft nodes before linearized reading' (duration: 689.35422ms)"],"step_count":1} {"level":"warn","ts":"2026-10-20T15:06:40.404103Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-20T15:06:39.270179Z","time spent":"1.133863013s","remote":"127.0.0.1:57080","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-20T15:06:40.404117Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-20T15:06:39.714539Z","time spent":"689.570864ms","remote":"127.0.0.1:57154","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":126,"response size":32,"request content":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true "} {"level":"warn","ts":"2026-10-20T15:06:40.404239Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.13786ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/clusterclasses/\" range_end:\"/registry/cluster.x-k8s.io/clusterclasses0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-20T15:06:40.404241Z","caller":"traceutil/trace.go:171","msg":"trace[211131399] transaction","detail":"{read_only:false; response_revision:27051; number_of_response:1; }","duration":"804.704371ms","start":"2026-10-20T15:06:39.599526Z","end":"2026-10-20T15:06:40.404231Z","steps":["trace[211131399] 'process raft request' (duration: 803.634372ms)"],"step_count":1} {"level":"info","ts":"2026-10-20T15:06:40.404267Z","caller":"traceutil/trace.go:171","msg":"trace[1590754927] range","detail":"{range_begin:/registry/cluster.x-k8s.io/clusterclasses/; range_end:/registry/cluster.x-k8s.io/clusterclasses0; response_count:0; response_revision:27052; }","duration":"150.188871ms","start":"2026-10-20T15:06:40.254069Z","end":"2026-10-20T15:06:40.404258Z","steps":["trace[1590754927] 'agreement among raft nodes before linearized reading' (duration: 150.13736ms)"],"step_count":1} {"level":"warn","ts":"2026-10-20T15:06:40.404298Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-20T15:06:39.599502Z","time spent":"804.764953ms","remote":"127.0.0.1:57080","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":498,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-20T15:06:40.404507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.950302ms","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-10-20T15:06:40.404543Z","caller":"traceutil/trace.go:171","msg":"trace[1898146801] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:27052; }","duration":"198.011803ms","start":"2026-10-20T15:06:40.206521Z","end":"2026-10-20T15:06:40.404533Z","steps":["trace[1898146801] 'agreement among raft nodes before linearized reading' (duration: 197.909141ms)"],"step_count":1} {"level":"info","ts":"2026-10-20T15:06:40.404509Z","caller":"traceutil/trace.go:171","msg":"trace[831237270] transaction","detail":"{read_only:false; response_revision:27052; number_of_response:1; }","duration":"589.630539ms","start":"2026-10-20T15:06:39.814867Z","end":"2026-10-20T15:06:40.404498Z","steps":["trace[831237270] 'process raft request' (duration: 588.374426ms)"],"step_count":1} {"level":"warn","ts":"2026-10-20T15:06:40.404692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.595175ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"} {"level":"info","ts":"2026-10-20T15:06:40.404739Z","caller":"traceutil/trace.go:171","msg":"trace[923135015] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:27052; }","duration":"198.642966ms","start":"2026-10-20T15:06:40.206065Z","end":"2026-10-20T15:06:40.404708Z","steps":["trace[923135015] 'agreement among raft nodes before linearized reading' (duration: 198.565225ms)"],"step_count":1} {"level":"warn","ts":"2026-10-20T15:06:40.40476Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-20T15:06:39.814825Z","time spent":"589.867074ms","remote":"127.0.0.1:57080","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":608,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-20T15:07:01.099504Z","caller":"traceutil/trace.go:171","msg":"trace[1538189304] linearizableReadLoop","detail":"{readStateIndex:28102; appliedIndex:28101; }","duration":"167.721989ms","start":"2026-10-20T15:07:00.931758Z","end":"2026-10-20T15:07:01.09948Z","steps":["trace[1538189304] 'read index received' (duration: 167.487784ms)","trace[1538189304] 'applied index is now lower than readState.Index' (duration: 233.425µs)"],"step_count":2} {"level":"info","ts":"2026-10-20T15:07:01.099938Z","caller":"traceutil/trace.go:171","msg":"trace[385813698] transaction","detail":"{read_only:false; response_revision:27208; number_of_response:1; }","duration":"216.343096ms","start":"2026-10-20T15:07:00.883581Z","end":"2026-10-20T15:07:01.099924Z","steps":["trace[385813698] 'process raft request' (duration: 215.740715ms)"],"step_count":1} {"level":"warn","ts":"2026-10-20T15:07:01.100177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.405872ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-20T15:07:01.100229Z","caller":"traceutil/trace.go:171","msg":"trace[332096390] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:27208; }","duration":"168.512703ms","start":"2026-10-20T15:07:00.931704Z","end":"2026-10-20T15:07:01.100217Z","steps":["trace[332096390] 'agreement among raft nodes before linearized reading' (duration: 168.408201ms)"],"step_count":1} {"level":"warn","ts":"2026-10-20T15:07:01.100494Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.990705ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12431"} {"level":"info","ts":"2026-10-20T15:07:01.100531Z","caller":"traceutil/trace.go:171","msg":"trace[1812863233] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:27208; }","duration":"122.071127ms","start":"2026-10-20T15:07:00.97845Z","end":"2026-10-20T15:07:01.100521Z","steps":["trace[1812863233] 'agreement among raft nodes before linearized reading' (duration: 121.930674ms)"],"step_count":1} {"level":"info","ts":"2026-10-20T15:07:32.06718Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":24658} {"level":"info","ts":"2026-10-20T15:07:32.218535Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":24658,"took":"147.098323ms","hash":2397382151,"current-db-size-bytes":58736640,"current-db-size":"59 MB","current-db-size-in-use-bytes":37318656,"current-db-size-in-use":"37 MB"} {"level":"info","ts":"2026-10-20T15:07:32.21861Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2397382151,"revision":24658,"compact-revision":21600} {"level":"info","ts":"2026-10-20T15:10:07.1936Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"a99b527d1e65fdd9","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-20T15:10:07.199616Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003} {"level":"info","ts":"2026-10-20T15:10:07.199742Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003} {"level":"info","ts":"2026-10-20T15:12:32.074791Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":27608} {"level":"info","ts":"2026-10-20T15:12:32.232446Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":27608,"took":"153.343424ms","hash":2144033207,"current-db-size-bytes":59158528,"current-db-size":"59 MB","current-db-size-in-use-bytes":35426304,"current-db-size-in-use":"35 MB"} {"level":"info","ts":"2026-10-20T15:12:32.23252Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2144033207,"revision":27608,"compact-revision":24658} {"level":"info","ts":"2026-10-20T15:17:32.086488Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":30315} {"level":"info","ts":"2026-10-20T15:17:32.245841Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":30315,"took":"155.194219ms","hash":765079626,"current-db-size-bytes":59158528,"current-db-size":"59 MB","current-db-size-in-use-bytes":31211520,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-10-20T15:17:32.245897Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":765079626,"revision":30315,"compact-revision":27608} {"level":"info","ts":"2026-10-20T15:22:32.093729Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":32567} {"level":"info","ts":"2026-10-20T15:22:32.26106Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":32567,"took":"160.277473ms","hash":4077487173,"current-db-size-bytes":59158528,"current-db-size":"59 MB","current-db-size-in-use-bytes":30388224,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-10-20T15:22:32.261168Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4077487173,"revision":32567,"compact-revision":30315} {"level":"info","ts":"2026-10-20T15:27:32.105235Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":34800} {"level":"info","ts":"2026-10-20T15:27:32.240697Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":34800,"took":"131.072279ms","hash":3078783011,"current-db-size-bytes":59158528,"current-db-size":"59 MB","current-db-size-in-use-bytes":31293440,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-10-20T15:27:32.240753Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3078783011,"revision":34800,"compact-revision":32567} {"level":"info","ts":"2026-10-20T15:31:12.547195Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"a99b527d1e65fdd9","local-member-applied-index":40004,"local-member-snapshot-index":30003,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-20T15:31:12.554056Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40004} {"level":"info","ts":"2026-10-20T15:31:12.554156Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35004} {"level":"info","ts":"2026-10-20T15:32:32.112578Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":37097} {"level":"info","ts":"2026-10-20T15:32:32.26597Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":37097,"took":"150.274346ms","hash":1114185963,"current-db-size-bytes":61300736,"current-db-size":"61 MB","current-db-size-in-use-bytes":33107968,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-10-20T15:32:32.266033Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1114185963,"revision":37097,"compact-revision":34800} {"level":"info","ts":"2026-10-20T15:37:32.120959Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":39369} {"level":"info","ts":"2026-10-20T15:37:32.255944Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":39369,"took":"130.932248ms","hash":1982167758,"current-db-size-bytes":61726720,"current-db-size":"62 MB","current-db-size-in-use-bytes":31371264,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-10-20T15:37:32.256016Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1982167758,"revision":39369,"compact-revision":37097}