{"level":"warn","ts":"2026-04-02T01:05:49.717152Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-02T01:05:49.717262Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.138: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.138:2380","--initial-cluster=instance=https://199.204.45.138:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.138:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.138:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-04-02T01:05:49.717328Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-02T01:05:49.717338Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.138:2380"]} {"level":"info","ts":"2026-04-02T01:05:49.717359Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-02T01:05:49.718081Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.138:2379"]} {"level":"info","ts":"2026-04-02T01:05:49.718163Z","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.138:2380"],"listen-peer-urls":["https://199.204.45.138:2380"],"advertise-client-urls":["https://199.204.45.138:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.138:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.138:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-04-02T01:05:49.722245Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.858921ms"} {"level":"info","ts":"2026-04-02T01:05:49.727825Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"f3d52791b64f7591","cluster-id":"90076b89649fe294"} {"level":"info","ts":"2026-04-02T01:05:49.727897Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 switched to configuration voters=()"} {"level":"info","ts":"2026-04-02T01:05:49.727925Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 became follower at term 0"} {"level":"info","ts":"2026-04-02T01:05:49.727937Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft f3d52791b64f7591 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-02T01:05:49.72795Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 became follower at term 1"} {"level":"info","ts":"2026-04-02T01:05:49.727994Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 switched to configuration voters=(17569993028038260113)"} {"level":"warn","ts":"2026-04-02T01:05:49.733691Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-02T01:05:49.735199Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-02T01:05:49.736486Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-04-02T01:05:49.740086Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"f3d52791b64f7591","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-02T01:05:49.741899Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"f3d52791b64f7591","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-02T01:05:49.746114Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-02T01:05:49.746247Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-02T01:05:49.746268Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-02T01:05:49.747623Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 switched to configuration voters=(17569993028038260113)"} {"level":"info","ts":"2026-04-02T01:05:49.753626Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"90076b89649fe294","local-member-id":"f3d52791b64f7591","added-peer-id":"f3d52791b64f7591","added-peer-peer-urls":["https://199.204.45.138:2380"]} {"level":"info","ts":"2026-04-02T01:05:49.754647Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-02T01:05:49.754754Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.138:2380"} {"level":"info","ts":"2026-04-02T01:05:49.754837Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.138:2380"} {"level":"info","ts":"2026-04-02T01:05:49.755008Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"f3d52791b64f7591","initial-advertise-peer-urls":["https://199.204.45.138:2380"],"listen-peer-urls":["https://199.204.45.138:2380"],"advertise-client-urls":["https://199.204.45.138:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.138:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-02T01:05:49.755073Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-02T01:05:50.128954Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 is starting a new election at term 1"} {"level":"info","ts":"2026-04-02T01:05:50.129026Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-02T01:05:50.129063Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 received MsgPreVoteResp from f3d52791b64f7591 at term 1"} {"level":"info","ts":"2026-04-02T01:05:50.129082Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 became candidate at term 2"} {"level":"info","ts":"2026-04-02T01:05:50.12909Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 received MsgVoteResp from f3d52791b64f7591 at term 2"} {"level":"info","ts":"2026-04-02T01:05:50.129104Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 became leader at term 2"} {"level":"info","ts":"2026-04-02T01:05:50.129237Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: f3d52791b64f7591 elected leader f3d52791b64f7591 at term 2"} {"level":"info","ts":"2026-04-02T01:05:50.131586Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"f3d52791b64f7591","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.138:2379]}","request-path":"/0/members/f3d52791b64f7591/attributes","cluster-id":"90076b89649fe294","publish-timeout":"7s"} {"level":"info","ts":"2026-04-02T01:05:50.131589Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-02T01:05:50.131665Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-02T01:05:50.131962Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-02T01:05:50.132002Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-02T01:05:50.13321Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-02T01:05:50.133571Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.138:2379"} {"level":"info","ts":"2026-04-02T01:05:50.135378Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-02T01:05:50.136267Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"90076b89649fe294","local-member-id":"f3d52791b64f7591","cluster-version":"3.5"} {"level":"info","ts":"2026-04-02T01:05:50.136356Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-02T01:05:50.136382Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-02T01:05:53.285271Z","caller":"traceutil/trace.go:171","msg":"trace[1284254014] transaction","detail":"{read_only:false; response_revision:232; number_of_response:1; }","duration":"142.161704ms","start":"2026-04-02T01:05:53.14307Z","end":"2026-04-02T01:05:53.285231Z","steps":["trace[1284254014] 'process raft request' (duration: 52.275694ms)","trace[1284254014] 'compare' (duration: 89.704596ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T01:06:04.916984Z","caller":"traceutil/trace.go:171","msg":"trace[825551036] transaction","detail":"{read_only:false; response_revision:410; number_of_response:1; }","duration":"156.308573ms","start":"2026-04-02T01:06:04.760651Z","end":"2026-04-02T01:06:04.916959Z","steps":["trace[825551036] 'process raft request' (duration: 156.13116ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T01:06:26.384525Z","caller":"traceutil/trace.go:171","msg":"trace[1719207004] transaction","detail":"{read_only:false; response_revision:574; number_of_response:1; }","duration":"117.356765ms","start":"2026-04-02T01:06:26.267124Z","end":"2026-04-02T01:06:26.384481Z","steps":["trace[1719207004] 'process raft request' (duration: 101.705323ms)","trace[1719207004] 'compare' (duration: 15.324545ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T01:06:29.150568Z","caller":"traceutil/trace.go:171","msg":"trace[1922514468] transaction","detail":"{read_only:false; response_revision:607; number_of_response:1; }","duration":"104.931332ms","start":"2026-04-02T01:06:29.045612Z","end":"2026-04-02T01:06:29.150543Z","steps":["trace[1922514468] 'process raft request' (duration: 104.599615ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T01:06:32.844193Z","caller":"traceutil/trace.go:171","msg":"trace[900654667] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"180.434322ms","start":"2026-04-02T01:06:32.663706Z","end":"2026-04-02T01:06:32.84414Z","steps":["trace[900654667] 'process raft request' (duration: 133.928296ms)","trace[900654667] 'compare' (duration: 46.137427ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T01:06:33.300455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.441618ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T01:06:33.30075Z","caller":"traceutil/trace.go:171","msg":"trace[867804949] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:634; }","duration":"102.819587ms","start":"2026-04-02T01:06:33.197901Z","end":"2026-04-02T01:06:33.30072Z","steps":["trace[867804949] 'range keys from in-memory index tree' (duration: 102.421958ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T01:06:33.317522Z","caller":"traceutil/trace.go:171","msg":"trace[2015402949] linearizableReadLoop","detail":"{readStateIndex:656; appliedIndex:655; }","duration":"277.481806ms","start":"2026-04-02T01:06:33.040012Z","end":"2026-04-02T01:06:33.317494Z","steps":["trace[2015402949] 'read index received' (duration: 276.556156ms)","trace[2015402949] 'applied index is now lower than readState.Index' (duration: 924.64µs)"],"step_count":2} {"level":"info","ts":"2026-04-02T01:06:33.317667Z","caller":"traceutil/trace.go:171","msg":"trace[1735171693] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"291.982513ms","start":"2026-04-02T01:06:33.025617Z","end":"2026-04-02T01:06:33.317599Z","steps":["trace[1735171693] 'process raft request' (duration: 291.275518ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T01:06:33.317969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.937996ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-xp6tz\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-04-02T01:06:33.318025Z","caller":"traceutil/trace.go:171","msg":"trace[1530509172] range","detail":"{range_begin:/registry/pods/kube-system/cilium-xp6tz; range_end:; response_count:1; response_revision:635; }","duration":"278.064069ms","start":"2026-04-02T01:06:33.039946Z","end":"2026-04-02T01:06:33.31801Z","steps":["trace[1530509172] 'agreement among raft nodes before linearized reading' (duration: 277.673081ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T01:08:02.847389Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.996785ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-02T01:08:02.847588Z","caller":"traceutil/trace.go:171","msg":"trace[394400913] transaction","detail":"{read_only:false; response_revision:1851; number_of_response:1; }","duration":"163.87521ms","start":"2026-04-02T01:08:02.683642Z","end":"2026-04-02T01:08:02.847517Z","steps":["trace[394400913] 'process raft request' (duration: 23.049037ms)","trace[394400913] 'compare' (duration: 139.838312ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T01:08:03.307337Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.645386ms","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-04-02T01:08:03.307432Z","caller":"traceutil/trace.go:171","msg":"trace[1550747252] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1852; }","duration":"138.783819ms","start":"2026-04-02T01:08:03.168626Z","end":"2026-04-02T01:08:03.30741Z","steps":["trace[1550747252] 'range keys from in-memory index tree' (duration: 138.463132ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T01:08:03.307264Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.378366ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T01:08:03.307612Z","caller":"traceutil/trace.go:171","msg":"trace[33581693] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1852; }","duration":"109.713783ms","start":"2026-04-02T01:08:03.197844Z","end":"2026-04-02T01:08:03.307558Z","steps":["trace[33581693] 'range keys from in-memory index tree' (duration: 109.356006ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T01:08:53.55719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.361558ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:41"} {"level":"info","ts":"2026-04-02T01:10:16.093563Z","caller":"traceutil/trace.go:171","msg":"trace[2006915357] transaction","detail":"{read_only:false; response_revision:2821; number_of_response:1; }","duration":"220.666364ms","start":"2026-04-02T01:10:15.872819Z","end":"2026-04-02T01:10:16.093485Z","steps":["trace[2006915357] 'process raft request' (duration: 220.381207ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T01:14:12.678309Z","caller":"traceutil/trace.go:171","msg":"trace[1330188437] transaction","detail":"{read_only:false; response_revision:4760; number_of_response:1; }","duration":"101.895034ms","start":"2026-04-02T01:14:12.576379Z","end":"2026-04-02T01:14:12.678274Z","steps":["trace[1330188437] 'process raft request' (duration: 85.3403ms)","trace[1330188437] 'compare' (duration: 16.37511ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T01:14:12.683573Z","caller":"traceutil/trace.go:171","msg":"trace[187780603] transaction","detail":"{read_only:false; response_revision:4761; number_of_response:1; }","duration":"101.71621ms","start":"2026-04-02T01:14:12.581827Z","end":"2026-04-02T01:14:12.683543Z","steps":["trace[187780603] 'process raft request' (duration: 101.157578ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T01:14:20.910446Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.173984ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-cqf7s.18a2652f73a212f2\" ","response":"range_response_count:1 size:962"} {"level":"info","ts":"2026-04-02T01:14:20.910588Z","caller":"traceutil/trace.go:171","msg":"trace[819297930] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-cqf7s.18a2652f73a212f2; range_end:; response_count:1; response_revision:5049; }","duration":"257.358639ms","start":"2026-04-02T01:14:20.653201Z","end":"2026-04-02T01:14:20.910559Z","steps":["trace[819297930] 'range keys from in-memory index tree' (duration: 256.974241ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T01:14:20.910773Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.228868ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T01:14:20.910903Z","caller":"traceutil/trace.go:171","msg":"trace[751283368] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5049; }","duration":"259.392922ms","start":"2026-04-02T01:14:20.65148Z","end":"2026-04-02T01:14:20.910873Z","steps":["trace[751283368] 'range keys from in-memory index tree' (duration: 259.159776ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T01:14:20.911051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.464403ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-9f40653d-0954-4160-aca0-f211eb3e0e09\" ","response":"range_response_count:1 size:3601"} {"level":"info","ts":"2026-04-02T01:14:20.911102Z","caller":"traceutil/trace.go:171","msg":"trace[412492021] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-9f40653d-0954-4160-aca0-f211eb3e0e09; range_end:; response_count:1; response_revision:5049; }","duration":"259.568545ms","start":"2026-04-02T01:14:20.65152Z","end":"2026-04-02T01:14:20.911089Z","steps":["trace[412492021] 'range keys from in-memory index tree' (duration: 259.31529ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T01:14:33.326733Z","caller":"traceutil/trace.go:171","msg":"trace[1352477383] transaction","detail":"{read_only:false; response_revision:5281; number_of_response:1; }","duration":"102.15886ms","start":"2026-04-02T01:14:33.224546Z","end":"2026-04-02T01:14:33.326705Z","steps":["trace[1352477383] 'process raft request' (duration: 101.948476ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T01:14:33.541699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.938369ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-02T01:14:33.542411Z","caller":"traceutil/trace.go:171","msg":"trace[1155013739] transaction","detail":"{read_only:false; response_revision:5286; number_of_response:1; }","duration":"124.291059ms","start":"2026-04-02T01:14:33.41753Z","end":"2026-04-02T01:14:33.541822Z","steps":["trace[1155013739] 'process raft request' (duration: 17.130646ms)","trace[1155013739] 'compare' (duration: 106.765305ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T01:14:34.124912Z","caller":"traceutil/trace.go:171","msg":"trace[1703912014] linearizableReadLoop","detail":"{readStateIndex:5490; appliedIndex:5488; }","duration":"312.360801ms","start":"2026-04-02T01:14:33.812514Z","end":"2026-04-02T01:14:34.124874Z","steps":["trace[1703912014] 'read index received' (duration: 4.246279ms)","trace[1703912014] 'applied index is now lower than readState.Index' (duration: 308.113342ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T01:14:34.124966Z","caller":"traceutil/trace.go:171","msg":"trace[1083035397] transaction","detail":"{read_only:false; response_revision:5291; number_of_response:1; }","duration":"329.729561ms","start":"2026-04-02T01:14:33.795198Z","end":"2026-04-02T01:14:34.124928Z","steps":["trace[1083035397] 'process raft request' (duration: 320.989599ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T01:14:34.125112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.577126ms","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":"warn","ts":"2026-04-02T01:14:34.125117Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T01:14:33.795168Z","time spent":"329.865824ms","remote":"127.0.0.1:46500","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1409,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T01:14:34.125167Z","caller":"traceutil/trace.go:171","msg":"trace[477452873] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:5291; }","duration":"312.713849ms","start":"2026-04-02T01:14:33.812439Z","end":"2026-04-02T01:14:34.125153Z","steps":["trace[477452873] 'agreement among raft nodes before linearized reading' (duration: 312.595836ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T01:14:34.125213Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T01:14:33.812411Z","time spent":"312.79076ms","remote":"127.0.0.1:42226","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":31,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "} {"level":"info","ts":"2026-04-02T01:14:34.125435Z","caller":"traceutil/trace.go:171","msg":"trace[1671267160] transaction","detail":"{read_only:false; response_revision:5293; number_of_response:1; }","duration":"302.654029ms","start":"2026-04-02T01:14:33.822771Z","end":"2026-04-02T01:14:34.125425Z","steps":["trace[1671267160] 'process raft request' (duration: 302.436515ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T01:14:34.125483Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T01:14:33.822752Z","time spent":"302.70524ms","remote":"127.0.0.1:46500","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1193,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T01:14:34.125594Z","caller":"traceutil/trace.go:171","msg":"trace[1352541219] transaction","detail":"{read_only:false; response_revision:5292; number_of_response:1; }","duration":"302.937894ms","start":"2026-04-02T01:14:33.8226Z","end":"2026-04-02T01:14:34.125538Z","steps":["trace[1352541219] 'process raft request' (duration: 302.509766ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T01:14:34.125662Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T01:14:33.822582Z","time spent":"303.050907ms","remote":"127.0.0.1:46404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":529,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T01:14:34.125753Z","caller":"traceutil/trace.go:171","msg":"trace[1690272592] transaction","detail":"{read_only:false; response_revision:5294; number_of_response:1; }","duration":"302.178209ms","start":"2026-04-02T01:14:33.823529Z","end":"2026-04-02T01:14:34.125707Z","steps":["trace[1690272592] 'process raft request' (duration: 301.72269ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T01:14:34.12547Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.421255ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-cqf7s.18a2652f37439f40\" ","response":"range_response_count:1 size:906"} {"level":"info","ts":"2026-04-02T01:14:34.125897Z","caller":"traceutil/trace.go:171","msg":"trace[1618519423] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-cqf7s.18a2652f37439f40; range_end:; response_count:1; response_revision:5296; }","duration":"195.847853ms","start":"2026-04-02T01:14:33.930036Z","end":"2026-04-02T01:14:34.125884Z","steps":["trace[1618519423] 'agreement among raft nodes before linearized reading' (duration: 195.326453ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T01:14:34.125942Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T01:14:33.823513Z","time spent":"302.320872ms","remote":"127.0.0.1:46500","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1067,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T01:14:34.126322Z","caller":"traceutil/trace.go:171","msg":"trace[1643963572] transaction","detail":"{read_only:false; response_revision:5295; number_of_response:1; }","duration":"302.311272ms","start":"2026-04-02T01:14:33.823994Z","end":"2026-04-02T01:14:34.126306Z","steps":["trace[1643963572] 'process raft request' (duration: 301.283371ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T01:14:34.126405Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T01:14:33.823971Z","time spent":"302.389963ms","remote":"127.0.0.1:46404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":681,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T01:14:42.092535Z","caller":"traceutil/trace.go:171","msg":"trace[1085523678] linearizableReadLoop","detail":"{readStateIndex:5664; appliedIndex:5663; }","duration":"138.080735ms","start":"2026-04-02T01:14:41.954428Z","end":"2026-04-02T01:14:42.092509Z","steps":["trace[1085523678] 'read index received' (duration: 137.861221ms)","trace[1085523678] 'applied index is now lower than readState.Index' (duration: 218.454µs)"],"step_count":2} {"level":"info","ts":"2026-04-02T01:14:42.09265Z","caller":"traceutil/trace.go:171","msg":"trace[86879500] transaction","detail":"{read_only:false; response_revision:5460; number_of_response:1; }","duration":"183.420705ms","start":"2026-04-02T01:14:41.909198Z","end":"2026-04-02T01:14:42.092619Z","steps":["trace[86879500] 'process raft request' (duration: 183.14413ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T01:14:42.09284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.225527ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/storage-loki-0\" ","response":"range_response_count:1 size:1781"} {"level":"info","ts":"2026-04-02T01:14:42.09289Z","caller":"traceutil/trace.go:171","msg":"trace[1858015466] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/storage-loki-0; range_end:; response_count:1; response_revision:5460; }","duration":"136.34467ms","start":"2026-04-02T01:14:41.956534Z","end":"2026-04-02T01:14:42.092878Z","steps":["trace[1858015466] 'agreement among raft nodes before linearized reading' (duration: 136.163966ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T01:14:42.092983Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.352851ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-68051796-be26-41db-aef2-00b610af1603\" ","response":"range_response_count:1 size:3766"} {"level":"info","ts":"2026-04-02T01:14:42.093108Z","caller":"traceutil/trace.go:171","msg":"trace[2079527617] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-68051796-be26-41db-aef2-00b610af1603; range_end:; response_count:1; response_revision:5460; }","duration":"138.742739ms","start":"2026-04-02T01:14:41.954337Z","end":"2026-04-02T01:14:42.09308Z","steps":["trace[2079527617] 'agreement among raft nodes before linearized reading' (duration: 138.30712ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T01:14:42.207915Z","caller":"traceutil/trace.go:171","msg":"trace[269606184] linearizableReadLoop","detail":"{readStateIndex:5665; appliedIndex:5664; }","duration":"110.656557ms","start":"2026-04-02T01:14:42.097229Z","end":"2026-04-02T01:14:42.207886Z","steps":["trace[269606184] 'read index received' (duration: 92.06136ms)","trace[269606184] 'applied index is now lower than readState.Index' (duration: 18.593406ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T01:14:42.207964Z","caller":"traceutil/trace.go:171","msg":"trace[959966268] transaction","detail":"{read_only:false; response_revision:5461; number_of_response:1; }","duration":"110.823949ms","start":"2026-04-02T01:14:42.097106Z","end":"2026-04-02T01:14:42.20793Z","steps":["trace[959966268] 'process raft request' (duration: 92.182342ms)","trace[959966268] 'compare' (duration: 18.458144ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T01:14:42.208502Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.246198ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/loki-0\" ","response":"range_response_count:1 size:5588"} {"level":"info","ts":"2026-04-02T01:14:42.208574Z","caller":"traceutil/trace.go:171","msg":"trace[2031751608] range","detail":"{range_begin:/registry/pods/monitoring/loki-0; range_end:; response_count:1; response_revision:5461; }","duration":"111.34096ms","start":"2026-04-02T01:14:42.097215Z","end":"2026-04-02T01:14:42.208556Z","steps":["trace[2031751608] 'agreement among raft nodes before linearized reading' (duration: 110.82417ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T01:14:42.435304Z","caller":"traceutil/trace.go:171","msg":"trace[45980571] transaction","detail":"{read_only:false; response_revision:5468; number_of_response:1; }","duration":"153.333691ms","start":"2026-04-02T01:14:42.281944Z","end":"2026-04-02T01:14:42.435278Z","steps":["trace[45980571] 'process raft request' (duration: 153.236669ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T01:14:42.435361Z","caller":"traceutil/trace.go:171","msg":"trace[140142618] transaction","detail":"{read_only:false; response_revision:5466; number_of_response:1; }","duration":"154.019115ms","start":"2026-04-02T01:14:42.281318Z","end":"2026-04-02T01:14:42.435337Z","steps":["trace[140142618] 'process raft request' (duration: 153.709269ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T01:14:42.435459Z","caller":"traceutil/trace.go:171","msg":"trace[1478209364] transaction","detail":"{read_only:false; response_revision:5465; number_of_response:1; }","duration":"154.475545ms","start":"2026-04-02T01:14:42.28094Z","end":"2026-04-02T01:14:42.435415Z","steps":["trace[1478209364] 'process raft request' (duration: 118.387286ms)","trace[1478209364] 'compare' (duration: 35.400545ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T01:14:42.435569Z","caller":"traceutil/trace.go:171","msg":"trace[204194751] transaction","detail":"{read_only:false; response_revision:5469; number_of_response:1; }","duration":"153.495084ms","start":"2026-04-02T01:14:42.28206Z","end":"2026-04-02T01:14:42.435555Z","steps":["trace[204194751] 'process raft request' (duration: 153.170138ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T01:14:42.435448Z","caller":"traceutil/trace.go:171","msg":"trace[1557078398] transaction","detail":"{read_only:false; response_revision:5467; number_of_response:1; }","duration":"153.475474ms","start":"2026-04-02T01:14:42.281937Z","end":"2026-04-02T01:14:42.435412Z","steps":["trace[1557078398] 'process raft request' (duration: 153.194569ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T01:14:42.4359Z","caller":"traceutil/trace.go:171","msg":"trace[977063095] transaction","detail":"{read_only:false; response_revision:5470; number_of_response:1; }","duration":"153.7994ms","start":"2026-04-02T01:14:42.282092Z","end":"2026-04-02T01:14:42.435892Z","steps":["trace[977063095] 'process raft request' (duration: 153.366941ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T01:14:42.435921Z","caller":"traceutil/trace.go:171","msg":"trace[312691134] transaction","detail":"{read_only:false; response_revision:5471; number_of_response:1; }","duration":"153.387111ms","start":"2026-04-02T01:14:42.282512Z","end":"2026-04-02T01:14:42.435899Z","steps":["trace[312691134] 'process raft request' (duration: 153.228428ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T01:15:34.781041Z","caller":"traceutil/trace.go:171","msg":"trace[736466475] transaction","detail":"{read_only:false; response_revision:5972; number_of_response:1; }","duration":"108.139116ms","start":"2026-04-02T01:15:34.672866Z","end":"2026-04-02T01:15:34.781005Z","steps":["trace[736466475] 'process raft request' (duration: 51.065045ms)","trace[736466475] 'compare' (duration: 56.813636ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T01:15:50.215505Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3008} {"level":"info","ts":"2026-04-02T01:15:50.299953Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3008,"took":"82.216527ms","hash":461480565,"current-db-size-bytes":58114048,"current-db-size":"58 MB","current-db-size-in-use-bytes":31436800,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-04-02T01:15:50.300088Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":461480565,"revision":3008,"compact-revision":-1} {"level":"info","ts":"2026-04-02T01:20:29.600876Z","caller":"traceutil/trace.go:171","msg":"trace[930125161] transaction","detail":"{read_only:false; response_revision:8201; number_of_response:1; }","duration":"100.667624ms","start":"2026-04-02T01:20:29.500181Z","end":"2026-04-02T01:20:29.600848Z","steps":["trace[930125161] 'process raft request' (duration: 93.302558ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T01:20:40.44701Z","caller":"traceutil/trace.go:171","msg":"trace[1969072730] transaction","detail":"{read_only:false; response_revision:8255; number_of_response:1; }","duration":"101.41307ms","start":"2026-04-02T01:20:40.34557Z","end":"2026-04-02T01:20:40.446983Z","steps":["trace[1969072730] 'process raft request' (duration: 101.216416ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T01:20:40.528244Z","caller":"traceutil/trace.go:171","msg":"trace[1910926603] linearizableReadLoop","detail":"{readStateIndex:8549; appliedIndex:8547; }","duration":"179.956343ms","start":"2026-04-02T01:20:40.348252Z","end":"2026-04-02T01:20:40.528208Z","steps":["trace[1910926603] 'read index received' (duration: 98.638531ms)","trace[1910926603] 'applied index is now lower than readState.Index' (duration: 81.316222ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T01:20:40.528303Z","caller":"traceutil/trace.go:171","msg":"trace[1748978071] transaction","detail":"{read_only:false; response_revision:8256; number_of_response:1; }","duration":"180.054444ms","start":"2026-04-02T01:20:40.348213Z","end":"2026-04-02T01:20:40.528268Z","steps":["trace[1748978071] 'process raft request' (duration: 152.292502ms)","trace[1748978071] 'compare' (duration: 27.533957ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T01:20:40.528477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.196338ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"warn","ts":"2026-04-02T01:20:40.528541Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.188652ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-04-02T01:20:40.528562Z","caller":"traceutil/trace.go:171","msg":"trace[1303544496] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8256; }","duration":"180.31566ms","start":"2026-04-02T01:20:40.348225Z","end":"2026-04-02T01:20:40.52854Z","steps":["trace[1303544496] 'agreement among raft nodes before linearized reading' (duration: 180.112635ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T01:20:40.528564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.792138ms","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-04-02T01:20:40.528603Z","caller":"traceutil/trace.go:171","msg":"trace[1133378056] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8256; }","duration":"138.251744ms","start":"2026-04-02T01:20:40.390337Z","end":"2026-04-02T01:20:40.528589Z","steps":["trace[1133378056] 'agreement among raft nodes before linearized reading' (duration: 138.120961ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T01:20:40.528616Z","caller":"traceutil/trace.go:171","msg":"trace[491558389] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8256; }","duration":"170.879329ms","start":"2026-04-02T01:20:40.357723Z","end":"2026-04-02T01:20:40.528602Z","steps":["trace[491558389] 'agreement among raft nodes before linearized reading' (duration: 170.694655ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T01:20:42.535658Z","caller":"traceutil/trace.go:171","msg":"trace[1042577679] transaction","detail":"{read_only:false; response_revision:8265; number_of_response:1; }","duration":"122.455758ms","start":"2026-04-02T01:20:42.413168Z","end":"2026-04-02T01:20:42.535624Z","steps":["trace[1042577679] 'process raft request' (duration: 122.176531ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T01:20:50.22179Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6091} {"level":"info","ts":"2026-04-02T01:20:50.329963Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6091,"took":"104.793122ms","hash":1744496322,"current-db-size-bytes":58114048,"current-db-size":"58 MB","current-db-size-in-use-bytes":23343104,"current-db-size-in-use":"23 MB"} {"level":"info","ts":"2026-04-02T01:20:50.330055Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1744496322,"revision":6091,"compact-revision":3008} {"level":"info","ts":"2026-04-02T01:21:22.007948Z","caller":"traceutil/trace.go:171","msg":"trace[969991018] transaction","detail":"{read_only:false; response_revision:8572; number_of_response:1; }","duration":"239.44622ms","start":"2026-04-02T01:21:21.768468Z","end":"2026-04-02T01:21:22.007914Z","steps":["trace[969991018] 'process raft request' (duration: 189.870244ms)","trace[969991018] 'compare' (duration: 49.187728ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T01:21:22.026262Z","caller":"traceutil/trace.go:171","msg":"trace[1617499633] transaction","detail":"{read_only:false; number_of_response:1; response_revision:8573; }","duration":"257.669108ms","start":"2026-04-02T01:21:21.768565Z","end":"2026-04-02T01:21:22.026234Z","steps":["trace[1617499633] 'process raft request' (duration: 257.488684ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T01:21:22.026666Z","caller":"traceutil/trace.go:171","msg":"trace[945586649] transaction","detail":"{read_only:false; response_revision:8574; number_of_response:1; }","duration":"215.52696ms","start":"2026-04-02T01:21:21.811122Z","end":"2026-04-02T01:21:22.026649Z","steps":["trace[945586649] 'process raft request' (duration: 215.042669ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T01:21:22.026582Z","caller":"traceutil/trace.go:171","msg":"trace[27787951] linearizableReadLoop","detail":"{readStateIndex:8879; appliedIndex:8877; }","duration":"232.291997ms","start":"2026-04-02T01:21:21.79421Z","end":"2026-04-02T01:21:22.026502Z","steps":["trace[27787951] 'read index received' (duration: 164.143945ms)","trace[27787951] 'applied index is now lower than readState.Index' (duration: 68.145372ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T01:21:22.026916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.692845ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-04-02T01:21:22.026993Z","caller":"traceutil/trace.go:171","msg":"trace[1357991818] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8574; }","duration":"232.826718ms","start":"2026-04-02T01:21:21.794149Z","end":"2026-04-02T01:21:22.026976Z","steps":["trace[1357991818] 'agreement among raft nodes before linearized reading' (duration: 232.573813ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T01:21:22.084829Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.261698ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T01:21:22.084922Z","caller":"traceutil/trace.go:171","msg":"trace[1027154354] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:8575; }","duration":"272.384911ms","start":"2026-04-02T01:21:21.812516Z","end":"2026-04-02T01:21:22.084901Z","steps":["trace[1027154354] 'agreement among raft nodes before linearized reading' (duration: 272.240508ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T01:21:22.085187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.604664ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-02T01:21:22.085224Z","caller":"traceutil/trace.go:171","msg":"trace[1915422868] range","detail":"{range_begin:/registry/ingress/; range_end:/registry/ingress0; response_count:0; response_revision:8575; }","duration":"210.701626ms","start":"2026-04-02T01:21:21.874514Z","end":"2026-04-02T01:21:22.085215Z","steps":["trace[1915422868] 'agreement among raft nodes before linearized reading' (duration: 210.632595ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T01:21:22.085209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.872207ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-v99gk\" ","response":"range_response_count:1 size:6524"} {"level":"info","ts":"2026-04-02T01:21:22.085311Z","caller":"traceutil/trace.go:171","msg":"trace[8186764] range","detail":"{range_begin:/registry/pods/openstack/keepalived-v99gk; range_end:; response_count:1; response_revision:8575; }","duration":"123.998352ms","start":"2026-04-02T01:21:21.961276Z","end":"2026-04-02T01:21:22.085275Z","steps":["trace[8186764] 'agreement among raft nodes before linearized reading' (duration: 123.795486ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T01:21:22.085612Z","caller":"traceutil/trace.go:171","msg":"trace[775658883] transaction","detail":"{read_only:false; response_revision:8575; number_of_response:1; }","duration":"117.017612ms","start":"2026-04-02T01:21:21.968581Z","end":"2026-04-02T01:21:22.085599Z","steps":["trace[775658883] 'process raft request' (duration: 115.835747ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T01:21:22.864364Z","caller":"traceutil/trace.go:171","msg":"trace[1396205014] transaction","detail":"{read_only:false; response_revision:8579; number_of_response:1; }","duration":"115.698054ms","start":"2026-04-02T01:21:22.748368Z","end":"2026-04-02T01:21:22.864066Z","steps":["trace[1396205014] 'process raft request' (duration: 115.492249ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T01:22:11.133369Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-000000000000249c.wal"} {"level":"info","ts":"2026-04-02T01:22:23.062186Z","caller":"traceutil/trace.go:171","msg":"trace[168169501] transaction","detail":"{read_only:false; response_revision:9232; number_of_response:1; }","duration":"112.227056ms","start":"2026-04-02T01:22:22.949936Z","end":"2026-04-02T01:22:23.062163Z","steps":["trace[168169501] 'process raft request' (duration: 111.308647ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T01:23:22.160045Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"f3d52791b64f7591","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-02T01:23:22.166868Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-04-02T01:23:22.166982Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-04-02T01:25:50.228626Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8316} {"level":"info","ts":"2026-04-02T01:25:50.315393Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8316,"took":"84.117281ms","hash":399519106,"current-db-size-bytes":58114048,"current-db-size":"58 MB","current-db-size-in-use-bytes":24485888,"current-db-size-in-use":"24 MB"} {"level":"info","ts":"2026-04-02T01:25:50.315526Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":399519106,"revision":8316,"compact-revision":6091} {"level":"info","ts":"2026-04-02T01:30:50.233429Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10702} {"level":"info","ts":"2026-04-02T01:30:50.312743Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10702,"took":"76.862684ms","hash":2996199242,"current-db-size-bytes":58114048,"current-db-size":"58 MB","current-db-size-in-use-bytes":20443136,"current-db-size-in-use":"20 MB"} {"level":"info","ts":"2026-04-02T01:30:50.312796Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2996199242,"revision":10702,"compact-revision":8316}