{"level":"warn","ts":"2026-03-18T01:38:44.265949Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-03-18T01:38:44.266072Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.200:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://162.253.55.200:2380","--initial-cluster=instance=https://162.253.55.200:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.200:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.200:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-03-18T01:38:44.266185Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-03-18T01:38:44.266199Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.200:2380"]} {"level":"info","ts":"2026-03-18T01:38:44.266251Z","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-03-18T01:38:44.267119Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.200:2379"]} {"level":"info","ts":"2026-03-18T01:38:44.267234Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://162.253.55.200:2380"],"listen-peer-urls":["https://162.253.55.200:2380"],"advertise-client-urls":["https://162.253.55.200:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.200:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.200:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-03-18T01:38:44.272154Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.621846ms"} {"level":"info","ts":"2026-03-18T01:38:44.281106Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"e10bb51ed7578852","cluster-id":"aa14459abd2161c3"} {"level":"info","ts":"2026-03-18T01:38:44.281234Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e10bb51ed7578852 switched to configuration voters=()"} {"level":"info","ts":"2026-03-18T01:38:44.281295Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e10bb51ed7578852 became follower at term 0"} {"level":"info","ts":"2026-03-18T01:38:44.281314Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft e10bb51ed7578852 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-03-18T01:38:44.281327Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e10bb51ed7578852 became follower at term 1"} {"level":"info","ts":"2026-03-18T01:38:44.281371Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e10bb51ed7578852 switched to configuration voters=(16216254027344087122)"} {"level":"warn","ts":"2026-03-18T01:38:44.291045Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-03-18T01:38:44.292823Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-03-18T01:38:44.294232Z","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-03-18T01:38:44.298234Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"e10bb51ed7578852","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-03-18T01:38:44.298851Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"e10bb51ed7578852","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-03-18T01:38:44.299039Z","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-03-18T01:38:44.299137Z","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-03-18T01:38:44.299151Z","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-03-18T01:38:44.301248Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e10bb51ed7578852 switched to configuration voters=(16216254027344087122)"} {"level":"info","ts":"2026-03-18T01:38:44.302374Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"aa14459abd2161c3","local-member-id":"e10bb51ed7578852","added-peer-id":"e10bb51ed7578852","added-peer-peer-urls":["https://162.253.55.200:2380"]} {"level":"info","ts":"2026-03-18T01:38:44.305162Z","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-03-18T01:38:44.305305Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.200:2380"} {"level":"info","ts":"2026-03-18T01:38:44.30534Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.200:2380"} {"level":"info","ts":"2026-03-18T01:38:44.305549Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"e10bb51ed7578852","initial-advertise-peer-urls":["https://162.253.55.200:2380"],"listen-peer-urls":["https://162.253.55.200:2380"],"advertise-client-urls":["https://162.253.55.200:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.200:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-03-18T01:38:44.305624Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-03-18T01:38:44.582344Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e10bb51ed7578852 is starting a new election at term 1"} {"level":"info","ts":"2026-03-18T01:38:44.582406Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e10bb51ed7578852 became pre-candidate at term 1"} {"level":"info","ts":"2026-03-18T01:38:44.582453Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e10bb51ed7578852 received MsgPreVoteResp from e10bb51ed7578852 at term 1"} {"level":"info","ts":"2026-03-18T01:38:44.582523Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e10bb51ed7578852 became candidate at term 2"} {"level":"info","ts":"2026-03-18T01:38:44.582536Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e10bb51ed7578852 received MsgVoteResp from e10bb51ed7578852 at term 2"} {"level":"info","ts":"2026-03-18T01:38:44.582582Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e10bb51ed7578852 became leader at term 2"} {"level":"info","ts":"2026-03-18T01:38:44.582605Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: e10bb51ed7578852 elected leader e10bb51ed7578852 at term 2"} {"level":"info","ts":"2026-03-18T01:38:44.583766Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"e10bb51ed7578852","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.200:2379]}","request-path":"/0/members/e10bb51ed7578852/attributes","cluster-id":"aa14459abd2161c3","publish-timeout":"7s"} {"level":"info","ts":"2026-03-18T01:38:44.583914Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-03-18T01:38:44.584128Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-03-18T01:38:44.584572Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-03-18T01:38:44.5853Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-03-18T01:38:44.585349Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-03-18T01:38:44.587317Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.200:2379"} {"level":"info","ts":"2026-03-18T01:38:44.588077Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-03-18T01:38:44.58813Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"aa14459abd2161c3","local-member-id":"e10bb51ed7578852","cluster-version":"3.5"} {"level":"info","ts":"2026-03-18T01:38:44.588235Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-03-18T01:38:44.588272Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-03-18T01:38:48.400566Z","caller":"traceutil/trace.go:171","msg":"trace[47078665] transaction","detail":"{read_only:false; response_revision:196; number_of_response:1; }","duration":"103.62289ms","start":"2026-03-18T01:38:48.296919Z","end":"2026-03-18T01:38:48.400542Z","steps":["trace[47078665] 'process raft request' (duration: 103.483036ms)"],"step_count":1} {"level":"info","ts":"2026-03-18T01:39:02.059245Z","caller":"traceutil/trace.go:171","msg":"trace[538111770] transaction","detail":"{read_only:false; response_revision:376; number_of_response:1; }","duration":"301.452472ms","start":"2026-03-18T01:39:01.757766Z","end":"2026-03-18T01:39:02.059218Z","steps":["trace[538111770] 'process raft request' (duration: 301.292958ms)"],"step_count":1} {"level":"warn","ts":"2026-03-18T01:39:02.065186Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T01:39:01.757741Z","time spent":"301.933245ms","remote":"127.0.0.1:36346","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4180,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-18T01:39:23.450549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.652426ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-03-18T01:39:23.450899Z","caller":"traceutil/trace.go:171","msg":"trace[713116536] linearizableReadLoop","detail":"{readStateIndex:651; appliedIndex:650; }","duration":"107.468426ms","start":"2026-03-18T01:39:23.343345Z","end":"2026-03-18T01:39:23.450813Z","steps":["trace[713116536] 'read index received' (duration: 280.117µs)","trace[713116536] 'applied index is now lower than readState.Index' (duration: 107.185379ms)"],"step_count":2} {"level":"warn","ts":"2026-03-18T01:39:23.451061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.516988ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/cert-manager/cert-manager-cainjector-64b59ddb75\" ","response":"range_response_count:1 size:3566"} {"level":"info","ts":"2026-03-18T01:39:23.451192Z","caller":"traceutil/trace.go:171","msg":"trace[1584106458] range","detail":"{range_begin:/registry/replicasets/cert-manager/cert-manager-cainjector-64b59ddb75; range_end:; response_count:1; response_revision:633; }","duration":"111.646661ms","start":"2026-03-18T01:39:23.339524Z","end":"2026-03-18T01:39:23.451171Z","steps":["trace[1584106458] 'agreement among raft nodes before linearized reading' (duration: 111.418055ms)"],"step_count":1} {"level":"info","ts":"2026-03-18T01:39:23.450839Z","caller":"traceutil/trace.go:171","msg":"trace[1105671691] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"104.46523ms","start":"2026-03-18T01:39:23.346353Z","end":"2026-03-18T01:39:23.450818Z","steps":["trace[1105671691] 'process raft request' (duration: 104.327657ms)"],"step_count":1} {"level":"info","ts":"2026-03-18T01:39:23.451422Z","caller":"traceutil/trace.go:171","msg":"trace[1548225860] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"101.755543ms","start":"2026-03-18T01:39:23.349655Z","end":"2026-03-18T01:39:23.45141Z","steps":["trace[1548225860] 'process raft request' (duration: 101.585588ms)"],"step_count":1} {"level":"info","ts":"2026-03-18T01:39:23.451392Z","caller":"traceutil/trace.go:171","msg":"trace[151324035] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"104.113372ms","start":"2026-03-18T01:39:23.347242Z","end":"2026-03-18T01:39:23.451355Z","steps":["trace[151324035] 'process raft request' (duration: 103.808515ms)"],"step_count":1} {"level":"info","ts":"2026-03-18T01:39:39.718665Z","caller":"traceutil/trace.go:171","msg":"trace[166224761] transaction","detail":"{read_only:false; response_revision:877; number_of_response:1; }","duration":"149.678063ms","start":"2026-03-18T01:39:39.568966Z","end":"2026-03-18T01:39:39.718644Z","steps":["trace[166224761] 'process raft request' (duration: 149.55746ms)"],"step_count":1} {"level":"info","ts":"2026-03-18T01:39:39.72426Z","caller":"traceutil/trace.go:171","msg":"trace[1312791504] transaction","detail":"{read_only:false; response_revision:878; number_of_response:1; }","duration":"155.186814ms","start":"2026-03-18T01:39:39.569059Z","end":"2026-03-18T01:39:39.724245Z","steps":["trace[1312791504] 'process raft request' (duration: 154.926708ms)"],"step_count":1} {"level":"warn","ts":"2026-03-18T01:40:32.552604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.057899ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-18T01:40:32.552919Z","caller":"traceutil/trace.go:171","msg":"trace[1757628942] transaction","detail":"{read_only:false; response_revision:1558; number_of_response:1; }","duration":"387.676046ms","start":"2026-03-18T01:40:32.165214Z","end":"2026-03-18T01:40:32.55289Z","steps":["trace[1757628942] 'process raft request' (duration: 268.759006ms)","trace[1757628942] 'compare' (duration: 117.759543ms)"],"step_count":2} {"level":"warn","ts":"2026-03-18T01:40:32.553016Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T01:40:32.165186Z","time spent":"387.778979ms","remote":"127.0.0.1:36190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":508,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-18T01:40:32.752108Z","caller":"traceutil/trace.go:171","msg":"trace[1219067428] transaction","detail":"{read_only:false; response_revision:1559; number_of_response:1; }","duration":"112.213069ms","start":"2026-03-18T01:40:32.639848Z","end":"2026-03-18T01:40:32.752061Z","steps":["trace[1219067428] 'process raft request' (duration: 111.972143ms)"],"step_count":1} {"level":"warn","ts":"2026-03-18T01:40:33.009797Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.835563ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-9228e72f-0ff6-4d86-b7d2-8dab63ff03ea\" ","response":"range_response_count:1 size:3747"} {"level":"info","ts":"2026-03-18T01:40:33.009901Z","caller":"traceutil/trace.go:171","msg":"trace[1381437055] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-9228e72f-0ff6-4d86-b7d2-8dab63ff03ea; range_end:; response_count:1; response_revision:1559; }","duration":"136.017487ms","start":"2026-03-18T01:40:32.87386Z","end":"2026-03-18T01:40:33.009878Z","steps":["trace[1381437055] 'range keys from in-memory index tree' (duration: 135.694539ms)"],"step_count":1} {"level":"info","ts":"2026-03-18T01:40:48.310608Z","caller":"traceutil/trace.go:171","msg":"trace[2083751500] transaction","detail":"{read_only:false; response_revision:1682; number_of_response:1; }","duration":"164.113619ms","start":"2026-03-18T01:40:48.146442Z","end":"2026-03-18T01:40:48.310555Z","steps":["trace[2083751500] 'process raft request' (duration: 163.910504ms)"],"step_count":1} {"level":"info","ts":"2026-03-18T01:41:26.941037Z","caller":"traceutil/trace.go:171","msg":"trace[2099211788] transaction","detail":"{read_only:false; response_revision:1875; number_of_response:1; }","duration":"143.184126ms","start":"2026-03-18T01:41:26.797825Z","end":"2026-03-18T01:41:26.941009Z","steps":["trace[2099211788] 'process raft request' (duration: 142.999512ms)"],"step_count":1} {"level":"warn","ts":"2026-03-18T01:41:27.200794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.361534ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-03-18T01:41:27.200892Z","caller":"traceutil/trace.go:171","msg":"trace[1698369973] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1875; }","duration":"211.510276ms","start":"2026-03-18T01:41:26.989359Z","end":"2026-03-18T01:41:27.200869Z","steps":["trace[1698369973] 'range keys from in-memory index tree' (duration: 211.163959ms)"],"step_count":1} {"level":"info","ts":"2026-03-18T01:42:01.89044Z","caller":"traceutil/trace.go:171","msg":"trace[294336377] transaction","detail":"{read_only:false; response_revision:2221; number_of_response:1; }","duration":"159.212476ms","start":"2026-03-18T01:42:01.7312Z","end":"2026-03-18T01:42:01.890412Z","steps":["trace[294336377] 'process raft request' (duration: 159.066453ms)"],"step_count":1} {"level":"info","ts":"2026-03-18T01:42:01.89187Z","caller":"traceutil/trace.go:171","msg":"trace[226814719] transaction","detail":"{read_only:false; response_revision:2222; number_of_response:1; }","duration":"158.52455ms","start":"2026-03-18T01:42:01.733326Z","end":"2026-03-18T01:42:01.89185Z","steps":["trace[226814719] 'process raft request' (duration: 158.261564ms)"],"step_count":1} {"level":"info","ts":"2026-03-18T01:42:36.231616Z","caller":"traceutil/trace.go:171","msg":"trace[271144505] transaction","detail":"{read_only:false; response_revision:2410; number_of_response:1; }","duration":"165.231963ms","start":"2026-03-18T01:42:36.066351Z","end":"2026-03-18T01:42:36.231583Z","steps":["trace[271144505] 'process raft request' (duration: 165.07279ms)"],"step_count":1} {"level":"info","ts":"2026-03-18T01:42:36.233649Z","caller":"traceutil/trace.go:171","msg":"trace[630819562] transaction","detail":"{read_only:false; response_revision:2411; number_of_response:1; }","duration":"166.243326ms","start":"2026-03-18T01:42:36.067391Z","end":"2026-03-18T01:42:36.233634Z","steps":["trace[630819562] 'process raft request' (duration: 166.122134ms)"],"step_count":1} {"level":"info","ts":"2026-03-18T01:42:36.233811Z","caller":"traceutil/trace.go:171","msg":"trace[469178313] linearizableReadLoop","detail":"{readStateIndex:2507; appliedIndex:2505; }","duration":"162.4372ms","start":"2026-03-18T01:42:36.071362Z","end":"2026-03-18T01:42:36.2338Z","steps":["trace[469178313] 'read index received' (duration: 160.133348ms)","trace[469178313] 'applied index is now lower than readState.Index' (duration: 2.302752ms)"],"step_count":2} {"level":"warn","ts":"2026-03-18T01:42:36.234164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.788078ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"} {"level":"info","ts":"2026-03-18T01:42:36.234206Z","caller":"traceutil/trace.go:171","msg":"trace[1348253382] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2412; }","duration":"162.87334ms","start":"2026-03-18T01:42:36.071322Z","end":"2026-03-18T01:42:36.234195Z","steps":["trace[1348253382] 'agreement among raft nodes before linearized reading' (duration: 162.718696ms)"],"step_count":1} {"level":"warn","ts":"2026-03-18T01:42:36.234448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.489406ms","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-03-18T01:42:36.234604Z","caller":"traceutil/trace.go:171","msg":"trace[1765614326] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2412; }","duration":"160.64838ms","start":"2026-03-18T01:42:36.073888Z","end":"2026-03-18T01:42:36.234536Z","steps":["trace[1765614326] 'agreement among raft nodes before linearized reading' (duration: 160.319421ms)"],"step_count":1} {"level":"warn","ts":"2026-03-18T01:45:01.221178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.200179ms","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-03-18T01:45:01.22128Z","caller":"traceutil/trace.go:171","msg":"trace[1079760271] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:3302; }","duration":"205.353133ms","start":"2026-03-18T01:45:01.015908Z","end":"2026-03-18T01:45:01.221261Z","steps":["trace[1079760271] 'count revisions from in-memory index tree' (duration: 205.118037ms)"],"step_count":1} {"level":"warn","ts":"2026-03-18T01:45:01.221768Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.861265ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-03-18T01:45:01.221814Z","caller":"traceutil/trace.go:171","msg":"trace[200052198] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:3302; }","duration":"312.947747ms","start":"2026-03-18T01:45:00.908855Z","end":"2026-03-18T01:45:01.221803Z","steps":["trace[200052198] 'range keys from in-memory index tree' (duration: 312.696061ms)"],"step_count":1} {"level":"warn","ts":"2026-03-18T01:45:01.221846Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T01:45:00.908829Z","time spent":"313.007198ms","remote":"127.0.0.1:36088","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12240,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-03-18T01:45:01.221948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.534686ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-03-18T01:45:01.22204Z","caller":"traceutil/trace.go:171","msg":"trace[794250717] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:3302; }","duration":"288.653078ms","start":"2026-03-18T01:45:00.933366Z","end":"2026-03-18T01:45:01.222019Z","steps":["trace[794250717] 'range keys from in-memory index tree' (duration: 288.381502ms)"],"step_count":1} {"level":"warn","ts":"2026-03-18T01:45:01.222147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.301177ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-18T01:45:01.222187Z","caller":"traceutil/trace.go:171","msg":"trace[992718941] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:3302; }","duration":"235.380879ms","start":"2026-03-18T01:45:00.986796Z","end":"2026-03-18T01:45:01.222177Z","steps":["trace[992718941] 'range keys from in-memory index tree' (duration: 235.232406ms)"],"step_count":1} {"level":"warn","ts":"2026-03-18T01:45:01.222362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.090906ms","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-03-18T01:45:01.222534Z","caller":"traceutil/trace.go:171","msg":"trace[600410013] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:3302; }","duration":"296.303701ms","start":"2026-03-18T01:45:00.926212Z","end":"2026-03-18T01:45:01.222516Z","steps":["trace[600410013] 'range keys from in-memory index tree' (duration: 295.959502ms)"],"step_count":1} {"level":"warn","ts":"2026-03-18T01:45:01.222785Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.927424ms","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-03-18T01:45:01.222829Z","caller":"traceutil/trace.go:171","msg":"trace[143734235] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:3302; }","duration":"294.003336ms","start":"2026-03-18T01:45:00.928812Z","end":"2026-03-18T01:45:01.222815Z","steps":["trace[143734235] 'range keys from in-memory index tree' (duration: 293.765751ms)"],"step_count":1} {"level":"warn","ts":"2026-03-18T01:45:01.223163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.405394ms","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-03-18T01:45:01.223216Z","caller":"traceutil/trace.go:171","msg":"trace[95200137] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:3302; }","duration":"291.481916ms","start":"2026-03-18T01:45:00.931722Z","end":"2026-03-18T01:45:01.223204Z","steps":["trace[95200137] 'range keys from in-memory index tree' (duration: 291.284891ms)"],"step_count":1} {"level":"warn","ts":"2026-03-18T01:45:01.223275Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.700339ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-03-18T01:45:01.223389Z","caller":"traceutil/trace.go:171","msg":"trace[796621894] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:3302; }","duration":"293.866323ms","start":"2026-03-18T01:45:00.929494Z","end":"2026-03-18T01:45:01.223361Z","steps":["trace[796621894] 'range keys from in-memory index tree' (duration: 293.503504ms)"],"step_count":1} {"level":"info","ts":"2026-03-18T01:46:20.496633Z","caller":"traceutil/trace.go:171","msg":"trace[142360378] linearizableReadLoop","detail":"{readStateIndex:4403; appliedIndex:4402; }","duration":"145.284349ms","start":"2026-03-18T01:46:20.351322Z","end":"2026-03-18T01:46:20.496607Z","steps":["trace[142360378] 'read index received' (duration: 145.149476ms)","trace[142360378] 'applied index is now lower than readState.Index' (duration: 133.053µs)"],"step_count":2} {"level":"info","ts":"2026-03-18T01:46:20.496692Z","caller":"traceutil/trace.go:171","msg":"trace[984312565] transaction","detail":"{read_only:false; response_revision:4232; number_of_response:1; }","duration":"159.564493ms","start":"2026-03-18T01:46:20.337093Z","end":"2026-03-18T01:46:20.496657Z","steps":["trace[984312565] 'process raft request' (duration: 159.325567ms)"],"step_count":1} {"level":"warn","ts":"2026-03-18T01:46:20.49682Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.475875ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-7cc84169-4ce7-41ef-8048-1a654669a6af\" ","response":"range_response_count:1 size:3894"} {"level":"info","ts":"2026-03-18T01:46:20.496864Z","caller":"traceutil/trace.go:171","msg":"trace[640039441] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-7cc84169-4ce7-41ef-8048-1a654669a6af; range_end:; response_count:1; response_revision:4232; }","duration":"145.566686ms","start":"2026-03-18T01:46:20.351285Z","end":"2026-03-18T01:46:20.496851Z","steps":["trace[640039441] 'agreement among raft nodes before linearized reading' (duration: 145.472004ms)"],"step_count":1} {"level":"info","ts":"2026-03-18T01:46:26.02427Z","caller":"traceutil/trace.go:171","msg":"trace[647057761] transaction","detail":"{read_only:false; response_revision:4434; number_of_response:1; }","duration":"219.238056ms","start":"2026-03-18T01:46:25.805002Z","end":"2026-03-18T01:46:26.02424Z","steps":["trace[647057761] 'process raft request' (duration: 219.093273ms)"],"step_count":1} {"level":"info","ts":"2026-03-18T01:46:47.301973Z","caller":"traceutil/trace.go:171","msg":"trace[1717976914] transaction","detail":"{read_only:false; response_revision:4829; number_of_response:1; }","duration":"172.061143ms","start":"2026-03-18T01:46:47.129886Z","end":"2026-03-18T01:46:47.301947Z","steps":["trace[1717976914] 'process raft request' (duration: 171.886618ms)"],"step_count":1} {"level":"info","ts":"2026-03-18T01:46:47.374542Z","caller":"traceutil/trace.go:171","msg":"trace[2128028484] transaction","detail":"{read_only:false; response_revision:4830; number_of_response:1; }","duration":"243.445117ms","start":"2026-03-18T01:46:47.131064Z","end":"2026-03-18T01:46:47.374509Z","steps":["trace[2128028484] 'process raft request' (duration: 243.273283ms)"],"step_count":1} {"level":"warn","ts":"2026-03-18T01:46:48.906478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.959045ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-03-18T01:46:48.906561Z","caller":"traceutil/trace.go:171","msg":"trace[365954347] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:4849; }","duration":"106.085439ms","start":"2026-03-18T01:46:48.800459Z","end":"2026-03-18T01:46:48.906545Z","steps":["trace[365954347] 'count revisions from in-memory index tree' (duration: 105.901994ms)"],"step_count":1} {"level":"warn","ts":"2026-03-18T01:46:48.906642Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.975893ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-18T01:46:48.906687Z","caller":"traceutil/trace.go:171","msg":"trace[417340871] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4849; }","duration":"160.061885ms","start":"2026-03-18T01:46:48.746606Z","end":"2026-03-18T01:46:48.906668Z","steps":["trace[417340871] 'range keys from in-memory index tree' (duration: 159.806028ms)"],"step_count":1} {"level":"warn","ts":"2026-03-18T01:46:58.058397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.523758ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-18T01:46:58.058691Z","caller":"traceutil/trace.go:171","msg":"trace[2087359051] transaction","detail":"{read_only:false; response_revision:4980; number_of_response:1; }","duration":"230.725872ms","start":"2026-03-18T01:46:57.827909Z","end":"2026-03-18T01:46:58.058635Z","steps":["trace[2087359051] 'process raft request' (duration: 88.826524ms)","trace[2087359051] 'compare' (duration: 141.339694ms)"],"step_count":2} {"level":"info","ts":"2026-03-18T01:46:58.058926Z","caller":"traceutil/trace.go:171","msg":"trace[1793910498] transaction","detail":"{read_only:false; response_revision:4981; number_of_response:1; }","duration":"230.897996ms","start":"2026-03-18T01:46:57.827964Z","end":"2026-03-18T01:46:58.058862Z","steps":["trace[1793910498] 'process raft request' (duration: 230.579398ms)"],"step_count":1} {"level":"info","ts":"2026-03-18T01:46:58.059019Z","caller":"traceutil/trace.go:171","msg":"trace[1686610684] linearizableReadLoop","detail":"{readStateIndex:5175; appliedIndex:5172; }","duration":"172.169845ms","start":"2026-03-18T01:46:57.886839Z","end":"2026-03-18T01:46:58.059009Z","steps":["trace[1686610684] 'read index received' (duration: 29.815677ms)","trace[1686610684] 'applied index is now lower than readState.Index' (duration: 142.353318ms)"],"step_count":2} {"level":"info","ts":"2026-03-18T01:46:58.05914Z","caller":"traceutil/trace.go:171","msg":"trace[737056350] transaction","detail":"{read_only:false; response_revision:4982; number_of_response:1; }","duration":"230.797805ms","start":"2026-03-18T01:46:57.828315Z","end":"2026-03-18T01:46:58.059113Z","steps":["trace[737056350] 'process raft request' (duration: 230.433975ms)"],"step_count":1} {"level":"warn","ts":"2026-03-18T01:46:58.059395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.475682ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-03-18T01:46:58.05949Z","caller":"traceutil/trace.go:171","msg":"trace[197535741] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4982; }","duration":"107.595845ms","start":"2026-03-18T01:46:57.951876Z","end":"2026-03-18T01:46:58.059472Z","steps":["trace[197535741] 'agreement among raft nodes before linearized reading' (duration: 107.37402ms)"],"step_count":1} {"level":"warn","ts":"2026-03-18T01:46:58.059558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.954568ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-03-18T01:46:58.059673Z","caller":"traceutil/trace.go:171","msg":"trace[831335321] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4982; }","duration":"134.130352ms","start":"2026-03-18T01:46:57.925519Z","end":"2026-03-18T01:46:58.059649Z","steps":["trace[831335321] 'agreement among raft nodes before linearized reading' (duration: 133.720332ms)"],"step_count":1} {"level":"warn","ts":"2026-03-18T01:46:58.059701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.818202ms","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-03-18T01:46:58.059861Z","caller":"traceutil/trace.go:171","msg":"trace[1802803566] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4982; }","duration":"173.037527ms","start":"2026-03-18T01:46:57.886799Z","end":"2026-03-18T01:46:58.059837Z","steps":["trace[1802803566] 'agreement among raft nodes before linearized reading' (duration: 172.605937ms)"],"step_count":1} {"level":"warn","ts":"2026-03-18T01:46:58.059871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.563185ms","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-03-18T01:46:58.060026Z","caller":"traceutil/trace.go:171","msg":"trace[88868887] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4982; }","duration":"132.796701ms","start":"2026-03-18T01:46:57.927199Z","end":"2026-03-18T01:46:58.059996Z","steps":["trace[88868887] 'agreement among raft nodes before linearized reading' (duration: 132.195407ms)"],"step_count":1} {"level":"warn","ts":"2026-03-18T01:46:58.060389Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.58948ms","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-03-18T01:46:58.060607Z","caller":"traceutil/trace.go:171","msg":"trace[520582788] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4982; }","duration":"121.839066ms","start":"2026-03-18T01:46:57.938753Z","end":"2026-03-18T01:46:58.060592Z","steps":["trace[520582788] 'agreement among raft nodes before linearized reading' (duration: 120.505064ms)"],"step_count":1} {"level":"info","ts":"2026-03-18T01:48:45.186118Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2752} {"level":"info","ts":"2026-03-18T01:48:45.242223Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2752,"took":"54.952064ms","hash":3689874040,"current-db-size-bytes":41697280,"current-db-size":"42 MB","current-db-size-in-use-bytes":31584256,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-03-18T01:48:45.242351Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3689874040,"revision":2752,"compact-revision":-1} {"level":"info","ts":"2026-03-18T01:53:00.082116Z","caller":"traceutil/trace.go:171","msg":"trace[1377063245] transaction","detail":"{read_only:false; response_revision:7512; number_of_response:1; }","duration":"143.89478ms","start":"2026-03-18T01:52:59.938183Z","end":"2026-03-18T01:53:00.082077Z","steps":["trace[1377063245] 'process raft request' (duration: 62.706689ms)","trace[1377063245] 'compare' (duration: 80.882994ms)"],"step_count":2} {"level":"info","ts":"2026-03-18T01:53:00.082202Z","caller":"traceutil/trace.go:171","msg":"trace[40493997] transaction","detail":"{read_only:false; response_revision:7513; number_of_response:1; }","duration":"143.154342ms","start":"2026-03-18T01:52:59.939004Z","end":"2026-03-18T01:53:00.082158Z","steps":["trace[40493997] 'process raft request' (duration: 142.976468ms)"],"step_count":1} {"level":"info","ts":"2026-03-18T01:53:00.082701Z","caller":"traceutil/trace.go:171","msg":"trace[2006606341] transaction","detail":"{read_only:false; response_revision:7514; number_of_response:1; }","duration":"142.420485ms","start":"2026-03-18T01:52:59.940263Z","end":"2026-03-18T01:53:00.082684Z","steps":["trace[2006606341] 'process raft request' (duration: 142.347854ms)"],"step_count":1} {"level":"info","ts":"2026-03-18T01:53:04.273185Z","caller":"traceutil/trace.go:171","msg":"trace[380898045] linearizableReadLoop","detail":"{readStateIndex:7809; appliedIndex:7808; }","duration":"177.682847ms","start":"2026-03-18T01:53:04.095463Z","end":"2026-03-18T01:53:04.273146Z","steps":["trace[380898045] 'read index received' (duration: 162.406903ms)","trace[380898045] 'applied index is now lower than readState.Index' (duration: 15.274714ms)"],"step_count":2} {"level":"info","ts":"2026-03-18T01:53:04.273272Z","caller":"traceutil/trace.go:171","msg":"trace[1425364208] transaction","detail":"{read_only:false; response_revision:7529; number_of_response:1; }","duration":"195.655028ms","start":"2026-03-18T01:53:04.077585Z","end":"2026-03-18T01:53:04.27324Z","steps":["trace[1425364208] 'process raft request' (duration: 180.298221ms)","trace[1425364208] 'compare' (duration: 14.964257ms)"],"step_count":2} {"level":"warn","ts":"2026-03-18T01:53:04.27342Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.951703ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-03-18T01:53:04.273483Z","caller":"traceutil/trace.go:171","msg":"trace[1034667549] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:7529; }","duration":"178.054606ms","start":"2026-03-18T01:53:04.095414Z","end":"2026-03-18T01:53:04.273469Z","steps":["trace[1034667549] 'agreement among raft nodes before linearized reading' (duration: 177.899262ms)"],"step_count":1} {"level":"warn","ts":"2026-03-18T01:53:04.273532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.454885ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-03-18T01:53:04.273619Z","caller":"traceutil/trace.go:171","msg":"trace[1059044454] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:7529; }","duration":"175.601718ms","start":"2026-03-18T01:53:04.097995Z","end":"2026-03-18T01:53:04.273597Z","steps":["trace[1059044454] 'agreement among raft nodes before linearized reading' (duration: 175.344922ms)"],"step_count":1} {"level":"warn","ts":"2026-03-18T01:53:04.273925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.560375ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-03-18T01:53:04.273977Z","caller":"traceutil/trace.go:171","msg":"trace[1525975047] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:7529; }","duration":"175.633978ms","start":"2026-03-18T01:53:04.098331Z","end":"2026-03-18T01:53:04.273965Z","steps":["trace[1525975047] 'agreement among raft nodes before linearized reading' (duration: 175.502454ms)"],"step_count":1} {"level":"info","ts":"2026-03-18T01:53:31.855751Z","caller":"traceutil/trace.go:171","msg":"trace[924501843] transaction","detail":"{read_only:false; response_revision:7721; number_of_response:1; }","duration":"107.86505ms","start":"2026-03-18T01:53:31.747857Z","end":"2026-03-18T01:53:31.855722Z","steps":["trace[924501843] 'process raft request' (duration: 107.695926ms)"],"step_count":1} {"level":"info","ts":"2026-03-18T01:53:44.420073Z","caller":"traceutil/trace.go:171","msg":"trace[765401333] transaction","detail":"{read_only:false; response_revision:7823; number_of_response:1; }","duration":"218.897246ms","start":"2026-03-18T01:53:44.201143Z","end":"2026-03-18T01:53:44.420041Z","steps":["trace[765401333] 'process raft request' (duration: 218.473296ms)"],"step_count":1} {"level":"info","ts":"2026-03-18T01:53:44.420088Z","caller":"traceutil/trace.go:171","msg":"trace[326287517] linearizableReadLoop","detail":"{readStateIndex:8115; appliedIndex:8114; }","duration":"204.471641ms","start":"2026-03-18T01:53:44.215581Z","end":"2026-03-18T01:53:44.420052Z","steps":["trace[326287517] 'read index received' (duration: 203.955889ms)","trace[326287517] 'applied index is now lower than readState.Index' (duration: 512.542µs)"],"step_count":2} {"level":"warn","ts":"2026-03-18T01:53:44.545074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.459521ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-03-18T01:53:44.545153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.941508ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-03-18T01:53:44.545199Z","caller":"traceutil/trace.go:171","msg":"trace[799780350] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:7823; }","duration":"117.05264ms","start":"2026-03-18T01:53:44.428133Z","end":"2026-03-18T01:53:44.545185Z","steps":["trace[799780350] 'count revisions from in-memory index tree' (duration: 116.884666ms)"],"step_count":1} {"level":"info","ts":"2026-03-18T01:53:44.545199Z","caller":"traceutil/trace.go:171","msg":"trace[784410625] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:7823; }","duration":"329.595264ms","start":"2026-03-18T01:53:44.215573Z","end":"2026-03-18T01:53:44.545169Z","steps":["trace[784410625] 'agreement among raft nodes before linearized reading' (duration: 204.567044ms)","trace[784410625] 'range keys from in-memory index tree' (duration: 124.757554ms)"],"step_count":2} {"level":"warn","ts":"2026-03-18T01:53:44.545249Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T01:53:44.215514Z","time spent":"329.721747ms","remote":"127.0.0.1:36190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-03-18T01:53:45.17937Z","caller":"traceutil/trace.go:171","msg":"trace[1129171697] transaction","detail":"{read_only:false; response_revision:7832; number_of_response:1; }","duration":"200.052664ms","start":"2026-03-18T01:53:44.979268Z","end":"2026-03-18T01:53:45.17932Z","steps":["trace[1129171697] 'process raft request' (duration: 178.764366ms)","trace[1129171697] 'compare' (duration: 21.062623ms)"],"step_count":2} {"level":"info","ts":"2026-03-18T01:53:45.292579Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5759} {"level":"info","ts":"2026-03-18T01:53:45.608184Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5759,"took":"313.051728ms","hash":2684619678,"current-db-size-bytes":42823680,"current-db-size":"43 MB","current-db-size-in-use-bytes":23347200,"current-db-size-in-use":"23 MB"} {"level":"info","ts":"2026-03-18T01:53:45.608264Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2684619678,"revision":5759,"compact-revision":2752} {"level":"info","ts":"2026-03-18T01:58:12.91348Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"e10bb51ed7578852","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-03-18T01:58:12.918674Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-03-18T01:58:12.918779Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-03-18T01:58:45.305441Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":7833} {"level":"info","ts":"2026-03-18T01:58:45.386454Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":7833,"took":"78.69062ms","hash":2003799217,"current-db-size-bytes":42823680,"current-db-size":"43 MB","current-db-size-in-use-bytes":24604672,"current-db-size-in-use":"25 MB"} {"level":"info","ts":"2026-03-18T01:58:45.386566Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2003799217,"revision":7833,"compact-revision":5759} {"level":"info","ts":"2026-03-18T02:03:45.311577Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":9809} {"level":"info","ts":"2026-03-18T02:03:45.384424Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":9809,"took":"70.453714ms","hash":3827795689,"current-db-size-bytes":42823680,"current-db-size":"43 MB","current-db-size-in-use-bytes":22716416,"current-db-size-in-use":"23 MB"} {"level":"info","ts":"2026-03-18T02:03:45.384491Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3827795689,"revision":9809,"compact-revision":7833} {"level":"info","ts":"2026-03-18T02:06:03.393896Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-000000000000341e.wal"} {"level":"info","ts":"2026-03-18T02:07:12.670842Z","caller":"traceutil/trace.go:171","msg":"trace[597721156] transaction","detail":"{read_only:false; response_revision:13398; number_of_response:1; }","duration":"340.863319ms","start":"2026-03-18T02:07:12.329944Z","end":"2026-03-18T02:07:12.670808Z","steps":["trace[597721156] 'process raft request' (duration: 340.674705ms)"],"step_count":1} {"level":"warn","ts":"2026-03-18T02:07:12.67105Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T02:07:12.329917Z","time spent":"341.014503ms","remote":"127.0.0.1:36088","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":14446,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-18T02:07:12.689542Z","caller":"traceutil/trace.go:171","msg":"trace[1057766850] transaction","detail":"{read_only:false; response_revision:13399; number_of_response:1; }","duration":"284.632376ms","start":"2026-03-18T02:07:12.404878Z","end":"2026-03-18T02:07:12.68951Z","steps":["trace[1057766850] 'process raft request' (duration: 284.472732ms)"],"step_count":1} {"level":"warn","ts":"2026-03-18T02:07:12.860724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.41595ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-18T02:07:12.860809Z","caller":"traceutil/trace.go:171","msg":"trace[1465774836] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:13400; }","duration":"120.557643ms","start":"2026-03-18T02:07:12.740233Z","end":"2026-03-18T02:07:12.860791Z","steps":["trace[1465774836] 'range keys from in-memory index tree' (duration: 120.258295ms)"],"step_count":1} {"level":"info","ts":"2026-03-18T02:08:45.316677Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":11925} {"level":"info","ts":"2026-03-18T02:08:45.394642Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":11925,"took":"75.176107ms","hash":465472553,"current-db-size-bytes":42823680,"current-db-size":"43 MB","current-db-size-in-use-bytes":27951104,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-03-18T02:08:45.394737Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":465472553,"revision":11925,"compact-revision":9809} {"level":"info","ts":"2026-03-18T02:13:45.323312Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14409} {"level":"info","ts":"2026-03-18T02:13:45.421018Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14409,"took":"93.923615ms","hash":4169497088,"current-db-size-bytes":42823680,"current-db-size":"43 MB","current-db-size-in-use-bytes":28516352,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-03-18T02:13:45.421085Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4169497088,"revision":14409,"compact-revision":11925} {"level":"info","ts":"2026-03-18T02:18:45.331366Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":16469} {"level":"info","ts":"2026-03-18T02:18:45.430921Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":16469,"took":"95.025959ms","hash":2760340504,"current-db-size-bytes":42823680,"current-db-size":"43 MB","current-db-size-in-use-bytes":22966272,"current-db-size-in-use":"23 MB"} {"level":"info","ts":"2026-03-18T02:18:45.431073Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2760340504,"revision":16469,"compact-revision":14409}