{"level":"warn","ts":"2026-03-31T20:27:35.580579Z","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-31T20:27:35.580674Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.22:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.22:2380","--initial-cluster=instance=https://199.204.45.22:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.22:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.22: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-31T20:27:35.580737Z","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-31T20:27:35.580778Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.22:2380"]} {"level":"info","ts":"2026-03-31T20:27:35.5808Z","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-31T20:27:35.581429Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.22:2379"]} {"level":"info","ts":"2026-03-31T20:27:35.581501Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.22:2380"],"listen-peer-urls":["https://199.204.45.22:2380"],"advertise-client-urls":["https://199.204.45.22:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.22:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.22: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-31T20:27:35.58846Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.762565ms"} {"level":"info","ts":"2026-03-31T20:27:35.595112Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"fed19d9291630e09","cluster-id":"6ebf1e01320cc017"} {"level":"info","ts":"2026-03-31T20:27:35.595205Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 switched to configuration voters=()"} {"level":"info","ts":"2026-03-31T20:27:35.595227Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 became follower at term 0"} {"level":"info","ts":"2026-03-31T20:27:35.595246Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft fed19d9291630e09 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-03-31T20:27:35.595255Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 became follower at term 1"} {"level":"info","ts":"2026-03-31T20:27:35.595303Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 switched to configuration voters=(18361630408596196873)"} {"level":"warn","ts":"2026-03-31T20:27:35.602065Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-03-31T20:27:35.603383Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-03-31T20:27:35.606184Z","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-31T20:27:35.608767Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"fed19d9291630e09","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-03-31T20:27:35.608986Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"fed19d9291630e09","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-03-31T20:27:35.609058Z","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-31T20:27:35.609176Z","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-31T20:27:35.609225Z","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-31T20:27:35.610858Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 switched to configuration voters=(18361630408596196873)"} {"level":"info","ts":"2026-03-31T20:27:35.611225Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"6ebf1e01320cc017","local-member-id":"fed19d9291630e09","added-peer-id":"fed19d9291630e09","added-peer-peer-urls":["https://199.204.45.22:2380"]} {"level":"info","ts":"2026-03-31T20:27:35.616045Z","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-31T20:27:35.616133Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.22:2380"} {"level":"info","ts":"2026-03-31T20:27:35.616207Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.22:2380"} {"level":"info","ts":"2026-03-31T20:27:35.616384Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"fed19d9291630e09","initial-advertise-peer-urls":["https://199.204.45.22:2380"],"listen-peer-urls":["https://199.204.45.22:2380"],"advertise-client-urls":["https://199.204.45.22:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.22:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-03-31T20:27:35.616446Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-03-31T20:27:36.596388Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 is starting a new election at term 1"} {"level":"info","ts":"2026-03-31T20:27:36.596472Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 became pre-candidate at term 1"} {"level":"info","ts":"2026-03-31T20:27:36.596501Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 received MsgPreVoteResp from fed19d9291630e09 at term 1"} {"level":"info","ts":"2026-03-31T20:27:36.596525Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 became candidate at term 2"} {"level":"info","ts":"2026-03-31T20:27:36.596537Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 received MsgVoteResp from fed19d9291630e09 at term 2"} {"level":"info","ts":"2026-03-31T20:27:36.596557Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 became leader at term 2"} {"level":"info","ts":"2026-03-31T20:27:36.596579Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: fed19d9291630e09 elected leader fed19d9291630e09 at term 2"} {"level":"info","ts":"2026-03-31T20:27:36.597817Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-03-31T20:27:36.598011Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-03-31T20:27:36.598017Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"fed19d9291630e09","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.22:2379]}","request-path":"/0/members/fed19d9291630e09/attributes","cluster-id":"6ebf1e01320cc017","publish-timeout":"7s"} {"level":"info","ts":"2026-03-31T20:27:36.598065Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-03-31T20:27:36.598561Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-03-31T20:27:36.598624Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-03-31T20:27:36.600174Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"6ebf1e01320cc017","local-member-id":"fed19d9291630e09","cluster-version":"3.5"} {"level":"info","ts":"2026-03-31T20:27:36.60032Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-03-31T20:27:36.600376Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-03-31T20:27:36.601895Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-03-31T20:27:36.602005Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.22:2379"} {"level":"info","ts":"2026-03-31T20:28:27.099071Z","caller":"traceutil/trace.go:171","msg":"trace[991629003] transaction","detail":"{read_only:false; response_revision:651; number_of_response:1; }","duration":"199.801644ms","start":"2026-03-31T20:28:26.899137Z","end":"2026-03-31T20:28:27.098939Z","steps":["trace[991629003] 'process raft request' (duration: 194.504998ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T20:28:27.439729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.661259ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-31T20:28:27.439896Z","caller":"traceutil/trace.go:171","msg":"trace[1387219712] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:652; }","duration":"118.925195ms","start":"2026-03-31T20:28:27.320948Z","end":"2026-03-31T20:28:27.439873Z","steps":["trace[1387219712] 'range keys from in-memory index tree' (duration: 118.527387ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T20:28:27.889678Z","caller":"traceutil/trace.go:171","msg":"trace[1846573829] linearizableReadLoop","detail":"{readStateIndex:677; appliedIndex:676; }","duration":"200.182211ms","start":"2026-03-31T20:28:27.689463Z","end":"2026-03-31T20:28:27.889645Z","steps":["trace[1846573829] 'read index received' (duration: 199.114229ms)","trace[1846573829] 'applied index is now lower than readState.Index' (duration: 1.066832ms)"],"step_count":2} {"level":"info","ts":"2026-03-31T20:28:27.889777Z","caller":"traceutil/trace.go:171","msg":"trace[335951795] transaction","detail":"{read_only:false; response_revision:653; number_of_response:1; }","duration":"283.091761ms","start":"2026-03-31T20:28:27.606635Z","end":"2026-03-31T20:28:27.889727Z","steps":["trace[335951795] 'process raft request' (duration: 282.260305ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T20:28:27.890232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.485268ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-k5p6j\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-03-31T20:28:27.890433Z","caller":"traceutil/trace.go:171","msg":"trace[1535626284] range","detail":"{range_begin:/registry/pods/kube-system/cilium-k5p6j; range_end:; response_count:1; response_revision:653; }","duration":"200.945567ms","start":"2026-03-31T20:28:27.689402Z","end":"2026-03-31T20:28:27.890348Z","steps":["trace[1535626284] 'agreement among raft nodes before linearized reading' (duration: 200.344645ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T20:29:16.996409Z","caller":"traceutil/trace.go:171","msg":"trace[1063205741] transaction","detail":"{read_only:false; response_revision:1231; number_of_response:1; }","duration":"123.348126ms","start":"2026-03-31T20:29:16.873035Z","end":"2026-03-31T20:29:16.996383Z","steps":["trace[1063205741] 'process raft request' (duration: 123.201093ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T20:30:03.069179Z","caller":"traceutil/trace.go:171","msg":"trace[1287358460] transaction","detail":"{read_only:false; response_revision:1883; number_of_response:1; }","duration":"165.497995ms","start":"2026-03-31T20:30:02.903625Z","end":"2026-03-31T20:30:03.069123Z","steps":["trace[1287358460] 'process raft request' (duration: 165.322082ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T20:30:03.089403Z","caller":"traceutil/trace.go:171","msg":"trace[1548672138] transaction","detail":"{read_only:false; response_revision:1885; number_of_response:1; }","duration":"183.021304ms","start":"2026-03-31T20:30:02.906346Z","end":"2026-03-31T20:30:03.089367Z","steps":["trace[1548672138] 'process raft request' (duration: 182.957462ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T20:30:03.089708Z","caller":"traceutil/trace.go:171","msg":"trace[1718665255] transaction","detail":"{read_only:false; response_revision:1884; number_of_response:1; }","duration":"183.431022ms","start":"2026-03-31T20:30:02.906232Z","end":"2026-03-31T20:30:03.089663Z","steps":["trace[1718665255] 'process raft request' (duration: 182.859131ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T20:30:03.38806Z","caller":"traceutil/trace.go:171","msg":"trace[82166780] linearizableReadLoop","detail":"{readStateIndex:1961; appliedIndex:1960; }","duration":"141.759083ms","start":"2026-03-31T20:30:03.246272Z","end":"2026-03-31T20:30:03.388031Z","steps":["trace[82166780] 'read index received' (duration: 140.930286ms)","trace[82166780] 'applied index is now lower than readState.Index' (duration: 827.147µs)"],"step_count":2} {"level":"info","ts":"2026-03-31T20:30:03.388199Z","caller":"traceutil/trace.go:171","msg":"trace[159588483] transaction","detail":"{read_only:false; response_revision:1886; number_of_response:1; }","duration":"145.622499ms","start":"2026-03-31T20:30:03.242533Z","end":"2026-03-31T20:30:03.388156Z","steps":["trace[159588483] 'process raft request' (duration: 144.629279ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T20:30:03.388356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.056598ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-03-31T20:30:03.388432Z","caller":"traceutil/trace.go:171","msg":"trace[824216315] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1886; }","duration":"142.217741ms","start":"2026-03-31T20:30:03.246201Z","end":"2026-03-31T20:30:03.388419Z","steps":["trace[824216315] 'agreement among raft nodes before linearized reading' (duration: 141.966827ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T20:30:03.462355Z","caller":"traceutil/trace.go:171","msg":"trace[1821095258] transaction","detail":"{read_only:false; response_revision:1887; number_of_response:1; }","duration":"213.622864ms","start":"2026-03-31T20:30:03.248699Z","end":"2026-03-31T20:30:03.462322Z","steps":["trace[1821095258] 'process raft request' (duration: 213.380489ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T20:30:03.462412Z","caller":"traceutil/trace.go:171","msg":"trace[668271971] transaction","detail":"{read_only:false; response_revision:1888; number_of_response:1; }","duration":"210.973221ms","start":"2026-03-31T20:30:03.251409Z","end":"2026-03-31T20:30:03.462382Z","steps":["trace[668271971] 'process raft request' (duration: 210.825928ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T20:30:03.462405Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.022328ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-31T20:30:03.462577Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.146241ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"info","ts":"2026-03-31T20:30:03.462609Z","caller":"traceutil/trace.go:171","msg":"trace[1097270084] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1888; }","duration":"141.259672ms","start":"2026-03-31T20:30:03.321324Z","end":"2026-03-31T20:30:03.462584Z","steps":["trace[1097270084] 'agreement among raft nodes before linearized reading' (duration: 140.969636ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T20:30:03.462659Z","caller":"traceutil/trace.go:171","msg":"trace[1040890906] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1888; }","duration":"126.252834ms","start":"2026-03-31T20:30:03.336383Z","end":"2026-03-31T20:30:03.462636Z","steps":["trace[1040890906] 'agreement among raft nodes before linearized reading' (duration: 125.989599ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T20:32:16.371516Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.048104ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/\" range_end:\"/registry/cert-manager.io/certificates0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-03-31T20:32:16.371726Z","caller":"traceutil/trace.go:171","msg":"trace[1598187848] range","detail":"{range_begin:/registry/cert-manager.io/certificates/; range_end:/registry/cert-manager.io/certificates0; response_count:0; response_revision:2856; }","duration":"215.335559ms","start":"2026-03-31T20:32:16.156358Z","end":"2026-03-31T20:32:16.371693Z","steps":["trace[1598187848] 'count revisions from in-memory index tree' (duration: 214.912821ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T20:32:16.85737Z","caller":"traceutil/trace.go:171","msg":"trace[1247151180] transaction","detail":"{read_only:false; response_revision:2859; number_of_response:1; }","duration":"118.470365ms","start":"2026-03-31T20:32:16.738861Z","end":"2026-03-31T20:32:16.857331Z","steps":["trace[1247151180] 'process raft request' (duration: 118.266071ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T20:34:46.820577Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.416369ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-31T20:34:46.820815Z","caller":"traceutil/trace.go:171","msg":"trace[1862807554] transaction","detail":"{read_only:false; response_revision:3849; number_of_response:1; }","duration":"264.692563ms","start":"2026-03-31T20:34:46.556088Z","end":"2026-03-31T20:34:46.820781Z","steps":["trace[1862807554] 'process raft request' (duration: 107.699893ms)","trace[1862807554] 'compare' (duration: 154.93761ms)"],"step_count":2} {"level":"info","ts":"2026-03-31T20:34:46.820753Z","caller":"traceutil/trace.go:171","msg":"trace[1170410127] linearizableReadLoop","detail":"{readStateIndex:3998; appliedIndex:3996; }","duration":"254.332316ms","start":"2026-03-31T20:34:46.566398Z","end":"2026-03-31T20:34:46.82073Z","steps":["trace[1170410127] 'read index received' (duration: 46.586742ms)","trace[1170410127] 'applied index is now lower than readState.Index' (duration: 207.743604ms)"],"step_count":2} {"level":"warn","ts":"2026-03-31T20:34:46.82111Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.688453ms","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-03-31T20:34:46.821215Z","caller":"traceutil/trace.go:171","msg":"trace[1176423355] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:3849; }","duration":"254.861287ms","start":"2026-03-31T20:34:46.566331Z","end":"2026-03-31T20:34:46.821192Z","steps":["trace[1176423355] 'agreement among raft nodes before linearized reading' (duration: 254.54572ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T20:34:46.821379Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.052411ms","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-03-31T20:34:46.821458Z","caller":"traceutil/trace.go:171","msg":"trace[149559396] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:3849; }","duration":"223.180864ms","start":"2026-03-31T20:34:46.598259Z","end":"2026-03-31T20:34:46.821439Z","steps":["trace[149559396] 'agreement among raft nodes before linearized reading' (duration: 222.910188ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T20:34:46.821726Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.141913ms","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-03-31T20:34:46.821878Z","caller":"traceutil/trace.go:171","msg":"trace[732461211] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:3849; }","duration":"224.270125ms","start":"2026-03-31T20:34:46.59753Z","end":"2026-03-31T20:34:46.8218Z","steps":["trace[732461211] 'agreement among raft nodes before linearized reading' (duration: 223.583331ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T20:36:19.478242Z","caller":"traceutil/trace.go:171","msg":"trace[1476897299] transaction","detail":"{read_only:false; response_revision:5226; number_of_response:1; }","duration":"110.883987ms","start":"2026-03-31T20:36:19.367322Z","end":"2026-03-31T20:36:19.478206Z","steps":["trace[1476897299] 'process raft request' (duration: 110.794685ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T20:36:19.47822Z","caller":"traceutil/trace.go:171","msg":"trace[435594487] transaction","detail":"{read_only:false; response_revision:5225; number_of_response:1; }","duration":"111.084772ms","start":"2026-03-31T20:36:19.36707Z","end":"2026-03-31T20:36:19.478154Z","steps":["trace[435594487] 'process raft request' (duration: 22.303016ms)","trace[435594487] 'compare' (duration: 88.534301ms)"],"step_count":2} {"level":"info","ts":"2026-03-31T20:36:19.478259Z","caller":"traceutil/trace.go:171","msg":"trace[881274096] linearizableReadLoop","detail":"{readStateIndex:5423; appliedIndex:5421; }","duration":"104.859506ms","start":"2026-03-31T20:36:19.373332Z","end":"2026-03-31T20:36:19.478191Z","steps":["trace[881274096] 'read index received' (duration: 16.03012ms)","trace[881274096] 'applied index is now lower than readState.Index' (duration: 88.828086ms)"],"step_count":2} {"level":"warn","ts":"2026-03-31T20:36:19.47851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.151102ms","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-03-31T20:36:19.478587Z","caller":"traceutil/trace.go:171","msg":"trace[123621192] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5226; }","duration":"105.276265ms","start":"2026-03-31T20:36:19.373293Z","end":"2026-03-31T20:36:19.478569Z","steps":["trace[123621192] 'agreement among raft nodes before linearized reading' (duration: 105.02363ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T20:36:27.728669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.395887ms","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-03-31T20:36:27.728797Z","caller":"traceutil/trace.go:171","msg":"trace[2097623860] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5394; }","duration":"132.603962ms","start":"2026-03-31T20:36:27.596172Z","end":"2026-03-31T20:36:27.728776Z","steps":["trace[2097623860] 'range keys from in-memory index tree' (duration: 132.151443ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T20:36:27.728912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.928158ms","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-31T20:36:27.728934Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.362627ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-b9bfb476-1cc7-455b-b421-daeee00a0f9f\" ","response":"range_response_count:1 size:3762"} {"level":"warn","ts":"2026-03-31T20:36:27.728899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.679443ms","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-03-31T20:36:27.729012Z","caller":"traceutil/trace.go:171","msg":"trace[2146217283] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5394; }","duration":"201.05976ms","start":"2026-03-31T20:36:27.527929Z","end":"2026-03-31T20:36:27.728989Z","steps":["trace[2146217283] 'range keys from in-memory index tree' (duration: 200.717034ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T20:36:27.729043Z","caller":"traceutil/trace.go:171","msg":"trace[644141138] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-b9bfb476-1cc7-455b-b421-daeee00a0f9f; range_end:; response_count:1; response_revision:5394; }","duration":"192.507209ms","start":"2026-03-31T20:36:27.536509Z","end":"2026-03-31T20:36:27.729016Z","steps":["trace[644141138] 'range keys from in-memory index tree' (duration: 192.121441ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T20:36:27.729102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.154042ms","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-03-31T20:36:27.729105Z","caller":"traceutil/trace.go:171","msg":"trace[631289975] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5394; }","duration":"201.001819ms","start":"2026-03-31T20:36:27.52807Z","end":"2026-03-31T20:36:27.729072Z","steps":["trace[631289975] 'range keys from in-memory index tree' (duration: 200.288735ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T20:36:27.729202Z","caller":"traceutil/trace.go:171","msg":"trace[575530672] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5394; }","duration":"204.318846ms","start":"2026-03-31T20:36:27.524861Z","end":"2026-03-31T20:36:27.72918Z","steps":["trace[575530672] 'range keys from in-memory index tree' (duration: 203.589001ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T20:36:27.890902Z","caller":"traceutil/trace.go:171","msg":"trace[1486205788] transaction","detail":"{read_only:false; response_revision:5395; number_of_response:1; }","duration":"157.157153ms","start":"2026-03-31T20:36:27.73372Z","end":"2026-03-31T20:36:27.890877Z","steps":["trace[1486205788] 'process raft request' (duration: 157.0123ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T20:36:27.976595Z","caller":"traceutil/trace.go:171","msg":"trace[2085456247] transaction","detail":"{read_only:false; response_revision:5397; number_of_response:1; }","duration":"241.893158ms","start":"2026-03-31T20:36:27.734679Z","end":"2026-03-31T20:36:27.976572Z","steps":["trace[2085456247] 'process raft request' (duration: 241.792186ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T20:36:27.97664Z","caller":"traceutil/trace.go:171","msg":"trace[1783140778] transaction","detail":"{read_only:false; response_revision:5396; number_of_response:1; }","duration":"242.597792ms","start":"2026-03-31T20:36:27.734009Z","end":"2026-03-31T20:36:27.976607Z","steps":["trace[1783140778] 'process raft request' (duration: 205.954769ms)","trace[1783140778] 'compare' (duration: 36.369127ms)"],"step_count":2} {"level":"info","ts":"2026-03-31T20:36:27.976712Z","caller":"traceutil/trace.go:171","msg":"trace[1935015891] transaction","detail":"{read_only:false; response_revision:5398; number_of_response:1; }","duration":"241.253845ms","start":"2026-03-31T20:36:27.735415Z","end":"2026-03-31T20:36:27.976669Z","steps":["trace[1935015891] 'process raft request' (duration: 241.099612ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T20:36:27.976581Z","caller":"traceutil/trace.go:171","msg":"trace[1147382166] linearizableReadLoop","detail":"{readStateIndex:5600; appliedIndex:5597; }","duration":"199.385677ms","start":"2026-03-31T20:36:27.777169Z","end":"2026-03-31T20:36:27.976554Z","steps":["trace[1147382166] 'read index received' (duration: 113.845826ms)","trace[1147382166] 'applied index is now lower than readState.Index' (duration: 85.538541ms)"],"step_count":2} {"level":"warn","ts":"2026-03-31T20:36:27.976778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.592271ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:557"} {"level":"info","ts":"2026-03-31T20:36:27.976822Z","caller":"traceutil/trace.go:171","msg":"trace[2082155059] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5398; }","duration":"199.715774ms","start":"2026-03-31T20:36:27.777094Z","end":"2026-03-31T20:36:27.97681Z","steps":["trace[2082155059] 'agreement among raft nodes before linearized reading' (duration: 199.54425ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T20:36:27.97691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.830316ms","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-31T20:36:27.976937Z","caller":"traceutil/trace.go:171","msg":"trace[1039567185] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5398; }","duration":"185.909607ms","start":"2026-03-31T20:36:27.79102Z","end":"2026-03-31T20:36:27.976929Z","steps":["trace[1039567185] 'agreement among raft nodes before linearized reading' (duration: 185.806635ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T20:37:36.625728Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2971} {"level":"info","ts":"2026-03-31T20:37:36.698945Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2971,"took":"71.482046ms","hash":1023968761,"current-db-size-bytes":57638912,"current-db-size":"58 MB","current-db-size-in-use-bytes":33349632,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-03-31T20:37:36.69902Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1023968761,"revision":2971,"compact-revision":-1} {"level":"info","ts":"2026-03-31T20:42:21.118022Z","caller":"traceutil/trace.go:171","msg":"trace[2008368248] linearizableReadLoop","detail":"{readStateIndex:8454; appliedIndex:8453; }","duration":"192.245746ms","start":"2026-03-31T20:42:20.925748Z","end":"2026-03-31T20:42:21.117994Z","steps":["trace[2008368248] 'read index received' (duration: 192.047162ms)","trace[2008368248] 'applied index is now lower than readState.Index' (duration: 197.234µs)"],"step_count":2} {"level":"info","ts":"2026-03-31T20:42:21.118088Z","caller":"traceutil/trace.go:171","msg":"trace[1902212470] transaction","detail":"{read_only:false; response_revision:8167; number_of_response:1; }","duration":"392.093795ms","start":"2026-03-31T20:42:20.725978Z","end":"2026-03-31T20:42:21.118072Z","steps":["trace[1902212470] 'process raft request' (duration: 391.82873ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T20:42:21.118246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.49226ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-zjjd8\" ","response":"range_response_count:1 size:6527"} {"level":"warn","ts":"2026-03-31T20:42:21.118236Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T20:42:20.725954Z","time spent":"392.187068ms","remote":"127.0.0.1:46690","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-31T20:42:21.118286Z","caller":"traceutil/trace.go:171","msg":"trace[1603658722] range","detail":"{range_begin:/registry/pods/openstack/keepalived-zjjd8; range_end:; response_count:1; response_revision:8167; }","duration":"192.567412ms","start":"2026-03-31T20:42:20.925713Z","end":"2026-03-31T20:42:21.118281Z","steps":["trace[1603658722] 'agreement among raft nodes before linearized reading' (duration: 192.406899ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T20:42:32.74398Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.033432ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-31T20:42:32.744078Z","caller":"traceutil/trace.go:171","msg":"trace[1716895274] range","detail":"{range_begin:/registry/csidrivers/; range_end:/registry/csidrivers0; response_count:0; response_revision:8225; }","duration":"110.210314ms","start":"2026-03-31T20:42:32.63385Z","end":"2026-03-31T20:42:32.74406Z","steps":["trace[1716895274] 'count revisions from in-memory index tree' (duration: 109.936149ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T20:42:33.508523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.239286ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-31T20:42:33.508602Z","caller":"traceutil/trace.go:171","msg":"trace[128824885] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8226; }","duration":"187.369189ms","start":"2026-03-31T20:42:33.321214Z","end":"2026-03-31T20:42:33.508583Z","steps":["trace[128824885] 'range keys from in-memory index tree' (duration: 187.107823ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T20:42:33.508781Z","caller":"traceutil/trace.go:171","msg":"trace[1831739791] transaction","detail":"{read_only:false; response_revision:8227; number_of_response:1; }","duration":"131.382918ms","start":"2026-03-31T20:42:33.377362Z","end":"2026-03-31T20:42:33.508745Z","steps":["trace[1831739791] 'process raft request' (duration: 110.902559ms)","trace[1831739791] 'compare' (duration: 20.338136ms)"],"step_count":2} {"level":"info","ts":"2026-03-31T20:42:36.63156Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6057} {"level":"info","ts":"2026-03-31T20:42:36.734279Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6057,"took":"101.087822ms","hash":1262867048,"current-db-size-bytes":57638912,"current-db-size":"58 MB","current-db-size-in-use-bytes":23076864,"current-db-size-in-use":"23 MB"} {"level":"info","ts":"2026-03-31T20:42:36.73439Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1262867048,"revision":6057,"compact-revision":2971} {"level":"warn","ts":"2026-03-31T20:43:12.789161Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.97939ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-31T20:43:12.789441Z","caller":"traceutil/trace.go:171","msg":"trace[1043239642] transaction","detail":"{read_only:false; response_revision:8532; number_of_response:1; }","duration":"217.199276ms","start":"2026-03-31T20:43:12.57219Z","end":"2026-03-31T20:43:12.78939Z","steps":["trace[1043239642] 'process raft request' (duration: 67.849728ms)","trace[1043239642] 'compare' (duration: 148.824227ms)"],"step_count":2} {"level":"info","ts":"2026-03-31T20:43:12.789486Z","caller":"traceutil/trace.go:171","msg":"trace[2147011619] transaction","detail":"{read_only:false; number_of_response:1; response_revision:8533; }","duration":"217.069573ms","start":"2026-03-31T20:43:12.572394Z","end":"2026-03-31T20:43:12.789464Z","steps":["trace[2147011619] 'process raft request' (duration: 216.91529ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T20:43:12.789769Z","caller":"traceutil/trace.go:171","msg":"trace[650033995] linearizableReadLoop","detail":"{readStateIndex:8837; appliedIndex:8835; }","duration":"165.865849ms","start":"2026-03-31T20:43:12.623877Z","end":"2026-03-31T20:43:12.789743Z","steps":["trace[650033995] 'read index received' (duration: 16.165144ms)","trace[650033995] 'applied index is now lower than readState.Index' (duration: 149.699675ms)"],"step_count":2} {"level":"warn","ts":"2026-03-31T20:43:12.789975Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.090574ms","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-31T20:43:12.79001Z","caller":"traceutil/trace.go:171","msg":"trace[813605581] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:8534; }","duration":"166.146276ms","start":"2026-03-31T20:43:12.623853Z","end":"2026-03-31T20:43:12.789999Z","steps":["trace[813605581] 'agreement among raft nodes before linearized reading' (duration: 165.983112ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T20:43:12.79002Z","caller":"traceutil/trace.go:171","msg":"trace[1117581635] transaction","detail":"{read_only:false; response_revision:8534; number_of_response:1; }","duration":"156.719226ms","start":"2026-03-31T20:43:12.63328Z","end":"2026-03-31T20:43:12.789999Z","steps":["trace[1117581635] 'process raft request' (duration: 156.111173ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T20:43:13.457701Z","caller":"traceutil/trace.go:171","msg":"trace[468834659] transaction","detail":"{read_only:false; response_revision:8539; number_of_response:1; }","duration":"128.621273ms","start":"2026-03-31T20:43:13.329049Z","end":"2026-03-31T20:43:13.45767Z","steps":["trace[468834659] 'process raft request' (duration: 128.413449ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T20:43:13.457955Z","caller":"traceutil/trace.go:171","msg":"trace[1754978003] linearizableReadLoop","detail":"{readStateIndex:8843; appliedIndex:8842; }","duration":"122.671725ms","start":"2026-03-31T20:43:13.335262Z","end":"2026-03-31T20:43:13.457934Z","steps":["trace[1754978003] 'read index received' (duration: 122.083454ms)","trace[1754978003] 'applied index is now lower than readState.Index' (duration: 586.411µs)"],"step_count":2} {"level":"warn","ts":"2026-03-31T20:43:13.45838Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.088223ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/nfd.k8s-sigs.io/nodefeatures/monitoring/instance\" ","response":"range_response_count:1 size:414394"} {"level":"info","ts":"2026-03-31T20:43:13.45848Z","caller":"traceutil/trace.go:171","msg":"trace[202644821] range","detail":"{range_begin:/registry/nfd.k8s-sigs.io/nodefeatures/monitoring/instance; range_end:; response_count:1; response_revision:8539; }","duration":"123.230646ms","start":"2026-03-31T20:43:13.335228Z","end":"2026-03-31T20:43:13.458459Z","steps":["trace[202644821] 'agreement among raft nodes before linearized reading' (duration: 122.811977ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T20:43:13.710969Z","caller":"traceutil/trace.go:171","msg":"trace[1408833562] transaction","detail":"{read_only:false; response_revision:8540; number_of_response:1; }","duration":"148.327118ms","start":"2026-03-31T20:43:13.562617Z","end":"2026-03-31T20:43:13.710944Z","steps":["trace[1408833562] 'process raft request' (duration: 148.173065ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T20:43:14.2614Z","caller":"traceutil/trace.go:171","msg":"trace[410524505] transaction","detail":"{read_only:false; response_revision:8546; number_of_response:1; }","duration":"103.917559ms","start":"2026-03-31T20:43:14.157458Z","end":"2026-03-31T20:43:14.261376Z","steps":["trace[410524505] 'process raft request' (duration: 103.757816ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T20:43:14.280979Z","caller":"traceutil/trace.go:171","msg":"trace[2109731922] linearizableReadLoop","detail":"{readStateIndex:8851; appliedIndex:8849; }","duration":"112.047182ms","start":"2026-03-31T20:43:14.168906Z","end":"2026-03-31T20:43:14.280953Z","steps":["trace[2109731922] 'read index received' (duration: 92.426049ms)","trace[2109731922] 'applied index is now lower than readState.Index' (duration: 19.619993ms)"],"step_count":2} {"level":"info","ts":"2026-03-31T20:43:14.2811Z","caller":"traceutil/trace.go:171","msg":"trace[246167173] transaction","detail":"{read_only:false; response_revision:8547; number_of_response:1; }","duration":"120.052752ms","start":"2026-03-31T20:43:14.161021Z","end":"2026-03-31T20:43:14.281074Z","steps":["trace[246167173] 'process raft request' (duration: 119.803087ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T20:43:14.281401Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.543122ms","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-31T20:43:14.281458Z","caller":"traceutil/trace.go:171","msg":"trace[1059750861] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8547; }","duration":"111.627114ms","start":"2026-03-31T20:43:14.169818Z","end":"2026-03-31T20:43:14.281445Z","steps":["trace[1059750861] 'agreement among raft nodes before linearized reading' (duration: 111.44581ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T20:43:14.281472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.340328ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1821"} {"level":"info","ts":"2026-03-31T20:43:14.281523Z","caller":"traceutil/trace.go:171","msg":"trace[632142524] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:8547; }","duration":"112.612013ms","start":"2026-03-31T20:43:14.168895Z","end":"2026-03-31T20:43:14.281507Z","steps":["trace[632142524] 'agreement among raft nodes before linearized reading' (duration: 112.183344ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T20:43:14.387478Z","caller":"traceutil/trace.go:171","msg":"trace[479262010] transaction","detail":"{read_only:false; response_revision:8550; number_of_response:1; }","duration":"100.072603ms","start":"2026-03-31T20:43:14.287372Z","end":"2026-03-31T20:43:14.387445Z","steps":["trace[479262010] 'process raft request' (duration: 99.764757ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T20:44:13.730593Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000024f2.wal"} {"level":"info","ts":"2026-03-31T20:45:14.532159Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"fed19d9291630e09","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-03-31T20:45:14.5379Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-03-31T20:45:14.537976Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-03-31T20:47:36.639415Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8256} {"level":"info","ts":"2026-03-31T20:47:36.723377Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8256,"took":"81.411776ms","hash":1482533046,"current-db-size-bytes":57638912,"current-db-size":"58 MB","current-db-size-in-use-bytes":25120768,"current-db-size-in-use":"25 MB"} {"level":"info","ts":"2026-03-31T20:47:36.723482Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1482533046,"revision":8256,"compact-revision":6057} {"level":"info","ts":"2026-03-31T20:52:36.677127Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10684} {"level":"info","ts":"2026-03-31T20:52:36.754283Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10684,"took":"75.112946ms","hash":4258793955,"current-db-size-bytes":57638912,"current-db-size":"58 MB","current-db-size-in-use-bytes":20885504,"current-db-size-in-use":"21 MB"} {"level":"info","ts":"2026-03-31T20:52:36.754364Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4258793955,"revision":10684,"compact-revision":8256}