{"level":"warn","ts":"2026-03-07T05:35:07.704861Z","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-07T05:35:07.704973Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.74:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://162.253.55.74:2380","--initial-cluster=instance=https://162.253.55.74:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.74:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.74: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-07T05:35:07.705062Z","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-07T05:35:07.705077Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.74:2380"]} {"level":"info","ts":"2026-03-07T05:35:07.705103Z","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-07T05:35:07.705946Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.74:2379"]} {"level":"info","ts":"2026-03-07T05:35:07.70604Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://162.253.55.74:2380"],"listen-peer-urls":["https://162.253.55.74:2380"],"advertise-client-urls":["https://162.253.55.74:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.74:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.74: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-07T05:35:07.711235Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.884325ms"} {"level":"info","ts":"2026-03-07T05:35:07.71949Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"30aa8136fb61a722","cluster-id":"e7ea3889c4872560"} {"level":"info","ts":"2026-03-07T05:35:07.719658Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30aa8136fb61a722 switched to configuration voters=()"} {"level":"info","ts":"2026-03-07T05:35:07.7197Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30aa8136fb61a722 became follower at term 0"} {"level":"info","ts":"2026-03-07T05:35:07.719729Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 30aa8136fb61a722 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-03-07T05:35:07.71975Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30aa8136fb61a722 became follower at term 1"} {"level":"info","ts":"2026-03-07T05:35:07.719812Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30aa8136fb61a722 switched to configuration voters=(3506757333007050530)"} {"level":"warn","ts":"2026-03-07T05:35:07.731555Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-03-07T05:35:07.733155Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-03-07T05:35:07.734607Z","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-07T05:35:07.737876Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"30aa8136fb61a722","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-03-07T05:35:07.738083Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"30aa8136fb61a722","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-03-07T05:35:07.738282Z","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-07T05:35:07.738413Z","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-07T05:35:07.738426Z","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-07T05:35:07.739737Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30aa8136fb61a722 switched to configuration voters=(3506757333007050530)"} {"level":"info","ts":"2026-03-07T05:35:07.740638Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"e7ea3889c4872560","local-member-id":"30aa8136fb61a722","added-peer-id":"30aa8136fb61a722","added-peer-peer-urls":["https://162.253.55.74:2380"]} {"level":"info","ts":"2026-03-07T05:35:07.742726Z","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-07T05:35:07.742863Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.74:2380"} {"level":"info","ts":"2026-03-07T05:35:07.74292Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.74:2380"} {"level":"info","ts":"2026-03-07T05:35:07.743045Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"30aa8136fb61a722","initial-advertise-peer-urls":["https://162.253.55.74:2380"],"listen-peer-urls":["https://162.253.55.74:2380"],"advertise-client-urls":["https://162.253.55.74:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.74:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-03-07T05:35:07.74308Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-03-07T05:35:08.620295Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30aa8136fb61a722 is starting a new election at term 1"} {"level":"info","ts":"2026-03-07T05:35:08.620377Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30aa8136fb61a722 became pre-candidate at term 1"} {"level":"info","ts":"2026-03-07T05:35:08.620399Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30aa8136fb61a722 received MsgPreVoteResp from 30aa8136fb61a722 at term 1"} {"level":"info","ts":"2026-03-07T05:35:08.620417Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30aa8136fb61a722 became candidate at term 2"} {"level":"info","ts":"2026-03-07T05:35:08.620425Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30aa8136fb61a722 received MsgVoteResp from 30aa8136fb61a722 at term 2"} {"level":"info","ts":"2026-03-07T05:35:08.620437Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30aa8136fb61a722 became leader at term 2"} {"level":"info","ts":"2026-03-07T05:35:08.620448Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 30aa8136fb61a722 elected leader 30aa8136fb61a722 at term 2"} {"level":"info","ts":"2026-03-07T05:35:08.62118Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-03-07T05:35:08.62187Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-03-07T05:35:08.621874Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"30aa8136fb61a722","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.74:2379]}","request-path":"/0/members/30aa8136fb61a722/attributes","cluster-id":"e7ea3889c4872560","publish-timeout":"7s"} {"level":"info","ts":"2026-03-07T05:35:08.621922Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-03-07T05:35:08.622204Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"e7ea3889c4872560","local-member-id":"30aa8136fb61a722","cluster-version":"3.5"} {"level":"info","ts":"2026-03-07T05:35:08.622209Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-03-07T05:35:08.622278Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-03-07T05:35:08.622312Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-03-07T05:35:08.622356Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-03-07T05:35:08.624327Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-03-07T05:35:08.629395Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.74:2379"} {"level":"info","ts":"2026-03-07T05:35:20.97317Z","caller":"traceutil/trace.go:171","msg":"trace[1565362630] transaction","detail":"{read_only:false; response_revision:361; number_of_response:1; }","duration":"102.020018ms","start":"2026-03-07T05:35:20.871126Z","end":"2026-03-07T05:35:20.973146Z","steps":["trace[1565362630] 'process raft request' (duration: 101.891795ms)"],"step_count":1} {"level":"info","ts":"2026-03-07T05:35:47.915831Z","caller":"traceutil/trace.go:171","msg":"trace[731929605] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"108.470672ms","start":"2026-03-07T05:35:47.807293Z","end":"2026-03-07T05:35:47.915764Z","steps":["trace[731929605] 'process raft request' (duration: 85.545007ms)","trace[731929605] 'compare' (duration: 22.387713ms)"],"step_count":2} {"level":"info","ts":"2026-03-07T05:35:47.916008Z","caller":"traceutil/trace.go:171","msg":"trace[422020862] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"105.459107ms","start":"2026-03-07T05:35:47.810536Z","end":"2026-03-07T05:35:47.915995Z","steps":["trace[422020862] 'process raft request' (duration: 105.108109ms)"],"step_count":1} {"level":"info","ts":"2026-03-07T05:35:47.91607Z","caller":"traceutil/trace.go:171","msg":"trace[1696701843] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"108.463702ms","start":"2026-03-07T05:35:47.807302Z","end":"2026-03-07T05:35:47.915766Z","steps":["trace[1696701843] 'process raft request' (duration: 108.101504ms)"],"step_count":1} {"level":"info","ts":"2026-03-07T05:35:47.915881Z","caller":"traceutil/trace.go:171","msg":"trace[1460010085] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"108.468442ms","start":"2026-03-07T05:35:47.807335Z","end":"2026-03-07T05:35:47.915803Z","steps":["trace[1460010085] 'process raft request' (duration: 108.203466ms)"],"step_count":1} {"level":"info","ts":"2026-03-07T05:35:47.91595Z","caller":"traceutil/trace.go:171","msg":"trace[1230037334] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"108.579534ms","start":"2026-03-07T05:35:47.807335Z","end":"2026-03-07T05:35:47.915914Z","steps":["trace[1230037334] 'process raft request' (duration: 108.125814ms)"],"step_count":1} {"level":"info","ts":"2026-03-07T05:35:47.915924Z","caller":"traceutil/trace.go:171","msg":"trace[1306659367] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"106.729133ms","start":"2026-03-07T05:35:47.809158Z","end":"2026-03-07T05:35:47.915888Z","steps":["trace[1306659367] 'process raft request' (duration: 106.419717ms)"],"step_count":1} {"level":"info","ts":"2026-03-07T05:36:56.410269Z","caller":"traceutil/trace.go:171","msg":"trace[1668839881] linearizableReadLoop","detail":"{readStateIndex:1619; appliedIndex:1618; }","duration":"312.834571ms","start":"2026-03-07T05:36:56.097404Z","end":"2026-03-07T05:36:56.410238Z","steps":["trace[1668839881] 'read index received' (duration: 312.512734ms)","trace[1668839881] 'applied index is now lower than readState.Index' (duration: 320.547µs)"],"step_count":2} {"level":"info","ts":"2026-03-07T05:36:56.410421Z","caller":"traceutil/trace.go:171","msg":"trace[502744797] transaction","detail":"{read_only:false; response_revision:1557; number_of_response:1; }","duration":"338.582587ms","start":"2026-03-07T05:36:56.071803Z","end":"2026-03-07T05:36:56.410385Z","steps":["trace[502744797] 'process raft request' (duration: 338.194649ms)"],"step_count":1} {"level":"warn","ts":"2026-03-07T05:36:56.410616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"313.173209ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-47e2fde3-4e3d-40fc-aee8-e54e65cd3118\" ","response":"range_response_count:1 size:3626"} {"level":"info","ts":"2026-03-07T05:36:56.410759Z","caller":"traceutil/trace.go:171","msg":"trace[700071993] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-47e2fde3-4e3d-40fc-aee8-e54e65cd3118; range_end:; response_count:1; response_revision:1557; }","duration":"313.406263ms","start":"2026-03-07T05:36:56.097335Z","end":"2026-03-07T05:36:56.410741Z","steps":["trace[700071993] 'agreement among raft nodes before linearized reading' (duration: 313.091677ms)"],"step_count":1} {"level":"warn","ts":"2026-03-07T05:36:56.410766Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.569117ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"warn","ts":"2026-03-07T05:36:56.410818Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-07T05:36:56.097312Z","time spent":"313.491345ms","remote":"127.0.0.1:43038","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3649,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-47e2fde3-4e3d-40fc-aee8-e54e65cd3118\" "} {"level":"warn","ts":"2026-03-07T05:36:56.410671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.369214ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-07T05:36:56.410985Z","caller":"traceutil/trace.go:171","msg":"trace[648261533] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:1557; }","duration":"187.758562ms","start":"2026-03-07T05:36:56.223197Z","end":"2026-03-07T05:36:56.410956Z","steps":["trace[648261533] 'agreement among raft nodes before linearized reading' (duration: 187.347493ms)"],"step_count":1} {"level":"warn","ts":"2026-03-07T05:36:56.410746Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.5442ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-47e2fde3-4e3d-40fc-aee8-e54e65cd3118\" ","response":"range_response_count:1 size:3626"} {"level":"info","ts":"2026-03-07T05:36:56.410884Z","caller":"traceutil/trace.go:171","msg":"trace[1844363222] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1557; }","duration":"218.714051ms","start":"2026-03-07T05:36:56.192143Z","end":"2026-03-07T05:36:56.410857Z","steps":["trace[1844363222] 'agreement among raft nodes before linearized reading' (duration: 218.446195ms)"],"step_count":1} {"level":"info","ts":"2026-03-07T05:36:56.411097Z","caller":"traceutil/trace.go:171","msg":"trace[1154824733] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-47e2fde3-4e3d-40fc-aee8-e54e65cd3118; range_end:; response_count:1; response_revision:1557; }","duration":"252.96636ms","start":"2026-03-07T05:36:56.158112Z","end":"2026-03-07T05:36:56.411079Z","steps":["trace[1154824733] 'agreement among raft nodes before linearized reading' (duration: 252.376957ms)"],"step_count":1} {"level":"warn","ts":"2026-03-07T05:36:56.411525Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-07T05:36:56.071758Z","time spent":"338.854593ms","remote":"127.0.0.1:43132","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-07T05:36:56.851845Z","caller":"traceutil/trace.go:171","msg":"trace[594374425] transaction","detail":"{read_only:false; response_revision:1560; number_of_response:1; }","duration":"321.054559ms","start":"2026-03-07T05:36:56.530739Z","end":"2026-03-07T05:36:56.851794Z","steps":["trace[594374425] 'process raft request' (duration: 285.405399ms)","trace[594374425] 'compare' (duration: 35.137949ms)"],"step_count":2} {"level":"info","ts":"2026-03-07T05:36:56.851988Z","caller":"traceutil/trace.go:171","msg":"trace[665930952] transaction","detail":"{read_only:false; response_revision:1561; number_of_response:1; }","duration":"320.370304ms","start":"2026-03-07T05:36:56.531585Z","end":"2026-03-07T05:36:56.851955Z","steps":["trace[665930952] 'process raft request' (duration: 320.125499ms)"],"step_count":1} {"level":"warn","ts":"2026-03-07T05:36:56.852108Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-07T05:36:56.530724Z","time spent":"321.250733ms","remote":"127.0.0.1:43010","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":977,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-07T05:36:56.852231Z","caller":"traceutil/trace.go:171","msg":"trace[1650696887] transaction","detail":"{read_only:false; response_revision:1562; number_of_response:1; }","duration":"319.356252ms","start":"2026-03-07T05:36:56.532841Z","end":"2026-03-07T05:36:56.852197Z","steps":["trace[1650696887] 'process raft request' (duration: 318.995754ms)"],"step_count":1} {"level":"warn","ts":"2026-03-07T05:36:56.852265Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-07T05:36:56.53156Z","time spent":"320.567968ms","remote":"127.0.0.1:43010","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":893,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-07T05:36:56.852449Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-07T05:36:56.532812Z","time spent":"319.524726ms","remote":"127.0.0.1:43136","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1529,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-07T05:36:56.852825Z","caller":"traceutil/trace.go:171","msg":"trace[889885097] linearizableReadLoop","detail":"{readStateIndex:1625; appliedIndex:1621; }","duration":"142.291621ms","start":"2026-03-07T05:36:56.710512Z","end":"2026-03-07T05:36:56.852803Z","steps":["trace[889885097] 'read index received' (duration: 105.505007ms)","trace[889885097] 'applied index is now lower than readState.Index' (duration: 36.784904ms)"],"step_count":2} {"level":"warn","ts":"2026-03-07T05:36:56.853235Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.69322ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-03-07T05:36:56.853287Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.616338ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-03-07T05:36:56.853361Z","caller":"traceutil/trace.go:171","msg":"trace[1346025137] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1564; }","duration":"142.899344ms","start":"2026-03-07T05:36:56.710433Z","end":"2026-03-07T05:36:56.853332Z","steps":["trace[1346025137] 'agreement among raft nodes before linearized reading' (duration: 142.435344ms)"],"step_count":1} {"level":"info","ts":"2026-03-07T05:36:56.853404Z","caller":"traceutil/trace.go:171","msg":"trace[548317640] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1564; }","duration":"142.759621ms","start":"2026-03-07T05:36:56.710614Z","end":"2026-03-07T05:36:56.853374Z","steps":["trace[548317640] 'agreement among raft nodes before linearized reading' (duration: 142.356672ms)"],"step_count":1} {"level":"info","ts":"2026-03-07T05:36:56.85277Z","caller":"traceutil/trace.go:171","msg":"trace[1685194241] transaction","detail":"{read_only:false; response_revision:1563; number_of_response:1; }","duration":"318.975534ms","start":"2026-03-07T05:36:56.533752Z","end":"2026-03-07T05:36:56.852727Z","steps":["trace[1685194241] 'process raft request' (duration: 318.336051ms)"],"step_count":1} {"level":"warn","ts":"2026-03-07T05:36:56.853648Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-07T05:36:56.53372Z","time spent":"319.816452ms","remote":"127.0.0.1:43136","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1471,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-07T05:37:07.710353Z","caller":"traceutil/trace.go:171","msg":"trace[504609266] transaction","detail":"{read_only:false; response_revision:1653; number_of_response:1; }","duration":"139.556742ms","start":"2026-03-07T05:37:07.570769Z","end":"2026-03-07T05:37:07.710326Z","steps":["trace[504609266] 'process raft request' (duration: 139.363718ms)"],"step_count":1} {"level":"info","ts":"2026-03-07T05:37:07.712179Z","caller":"traceutil/trace.go:171","msg":"trace[1539772343] transaction","detail":"{read_only:false; response_revision:1654; number_of_response:1; }","duration":"123.638858ms","start":"2026-03-07T05:37:07.588498Z","end":"2026-03-07T05:37:07.712137Z","steps":["trace[1539772343] 'process raft request' (duration: 123.212009ms)"],"step_count":1} {"level":"warn","ts":"2026-03-07T05:37:40.255503Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.640709ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12380"} {"level":"info","ts":"2026-03-07T05:37:40.255604Z","caller":"traceutil/trace.go:171","msg":"trace[1684850441] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:1828; }","duration":"155.772763ms","start":"2026-03-07T05:37:40.099809Z","end":"2026-03-07T05:37:40.255581Z","steps":["trace[1684850441] 'range keys from in-memory index tree' (duration: 155.385554ms)"],"step_count":1} {"level":"warn","ts":"2026-03-07T05:37:40.255615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.7371ms","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-07T05:37:40.255673Z","caller":"traceutil/trace.go:171","msg":"trace[941855323] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1828; }","duration":"160.839242ms","start":"2026-03-07T05:37:40.09482Z","end":"2026-03-07T05:37:40.255659Z","steps":["trace[941855323] 'range keys from in-memory index tree' (duration: 160.442803ms)"],"step_count":1} {"level":"info","ts":"2026-03-07T05:37:46.04399Z","caller":"traceutil/trace.go:171","msg":"trace[65491340] transaction","detail":"{read_only:false; response_revision:1855; number_of_response:1; }","duration":"110.357953ms","start":"2026-03-07T05:37:45.933598Z","end":"2026-03-07T05:37:46.043956Z","steps":["trace[65491340] 'process raft request' (duration: 21.850621ms)","trace[65491340] 'compare' (duration: 88.287338ms)"],"step_count":2} {"level":"info","ts":"2026-03-07T05:37:46.667672Z","caller":"traceutil/trace.go:171","msg":"trace[447010276] transaction","detail":"{read_only:false; response_revision:1857; number_of_response:1; }","duration":"276.17408ms","start":"2026-03-07T05:37:46.391463Z","end":"2026-03-07T05:37:46.667637Z","steps":["trace[447010276] 'process raft request' (duration: 275.917074ms)"],"step_count":1} {"level":"info","ts":"2026-03-07T05:37:46.924717Z","caller":"traceutil/trace.go:171","msg":"trace[1270681403] linearizableReadLoop","detail":"{readStateIndex:1931; appliedIndex:1930; }","duration":"128.247041ms","start":"2026-03-07T05:37:46.796442Z","end":"2026-03-07T05:37:46.924689Z","steps":["trace[1270681403] 'read index received' (duration: 125.80541ms)","trace[1270681403] 'applied index is now lower than readState.Index' (duration: 2.440411ms)"],"step_count":2} {"level":"info","ts":"2026-03-07T05:37:46.924755Z","caller":"traceutil/trace.go:171","msg":"trace[485810678] transaction","detail":"{read_only:false; response_revision:1858; number_of_response:1; }","duration":"242.64023ms","start":"2026-03-07T05:37:46.682073Z","end":"2026-03-07T05:37:46.924713Z","steps":["trace[485810678] 'process raft request' (duration: 240.173708ms)"],"step_count":1} {"level":"warn","ts":"2026-03-07T05:37:46.924974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.514827ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-03-07T05:37:46.92503Z","caller":"traceutil/trace.go:171","msg":"trace[1703284341] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1858; }","duration":"128.61935ms","start":"2026-03-07T05:37:46.796394Z","end":"2026-03-07T05:37:46.925013Z","steps":["trace[1703284341] 'agreement among raft nodes before linearized reading' (duration: 128.408026ms)"],"step_count":1} {"level":"info","ts":"2026-03-07T05:38:35.540723Z","caller":"traceutil/trace.go:171","msg":"trace[482813328] linearizableReadLoop","detail":"{readStateIndex:2364; appliedIndex:2363; }","duration":"124.491963ms","start":"2026-03-07T05:38:35.416205Z","end":"2026-03-07T05:38:35.540697Z","steps":["trace[482813328] 'read index received' (duration: 124.281039ms)","trace[482813328] 'applied index is now lower than readState.Index' (duration: 209.854µs)"],"step_count":2} {"level":"info","ts":"2026-03-07T05:38:35.540921Z","caller":"traceutil/trace.go:171","msg":"trace[1643442449] transaction","detail":"{read_only:false; response_revision:2272; number_of_response:1; }","duration":"124.732378ms","start":"2026-03-07T05:38:35.416106Z","end":"2026-03-07T05:38:35.540838Z","steps":["trace[1643442449] 'process raft request' (duration: 124.431442ms)"],"step_count":1} {"level":"warn","ts":"2026-03-07T05:38:35.540985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.756858ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-03-07T05:38:35.541066Z","caller":"traceutil/trace.go:171","msg":"trace[256124838] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2272; }","duration":"124.901221ms","start":"2026-03-07T05:38:35.416143Z","end":"2026-03-07T05:38:35.541044Z","steps":["trace[256124838] 'agreement among raft nodes before linearized reading' (duration: 124.712517ms)"],"step_count":1} {"level":"warn","ts":"2026-03-07T05:38:35.541158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.862345ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-03-07T05:38:35.541267Z","caller":"traceutil/trace.go:171","msg":"trace[1905160211] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2272; }","duration":"119.019917ms","start":"2026-03-07T05:38:35.422222Z","end":"2026-03-07T05:38:35.541242Z","steps":["trace[1905160211] 'agreement among raft nodes before linearized reading' (duration: 118.69001ms)"],"step_count":1} {"level":"info","ts":"2026-03-07T05:43:06.296828Z","caller":"traceutil/trace.go:171","msg":"trace[793900887] transaction","detail":"{read_only:false; number_of_response:1; response_revision:4333; }","duration":"138.023696ms","start":"2026-03-07T05:43:06.158779Z","end":"2026-03-07T05:43:06.296803Z","steps":["trace[793900887] 'process raft request' (duration: 133.650333ms)"],"step_count":1} {"level":"info","ts":"2026-03-07T05:43:08.549935Z","caller":"traceutil/trace.go:171","msg":"trace[1975708531] transaction","detail":"{read_only:false; response_revision:4383; number_of_response:1; }","duration":"111.578794ms","start":"2026-03-07T05:43:08.438324Z","end":"2026-03-07T05:43:08.549903Z","steps":["trace[1975708531] 'process raft request' (duration: 111.38457ms)"],"step_count":1} {"level":"info","ts":"2026-03-07T05:43:08.555693Z","caller":"traceutil/trace.go:171","msg":"trace[1973953460] linearizableReadLoop","detail":"{readStateIndex:4563; appliedIndex:4561; }","duration":"116.113509ms","start":"2026-03-07T05:43:08.439543Z","end":"2026-03-07T05:43:08.555657Z","steps":["trace[1973953460] 'read index received' (duration: 110.134943ms)","trace[1973953460] 'applied index is now lower than readState.Index' (duration: 5.977046ms)"],"step_count":2} {"level":"warn","ts":"2026-03-07T05:43:08.555965Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.374725ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-1\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-07T05:43:08.555815Z","caller":"traceutil/trace.go:171","msg":"trace[224636181] transaction","detail":"{read_only:false; response_revision:4384; number_of_response:1; }","duration":"116.57958ms","start":"2026-03-07T05:43:08.4392Z","end":"2026-03-07T05:43:08.55578Z","steps":["trace[224636181] 'process raft request' (duration: 116.212802ms)"],"step_count":1} {"level":"info","ts":"2026-03-07T05:43:08.556049Z","caller":"traceutil/trace.go:171","msg":"trace[1772597484] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-1; range_end:; response_count:0; response_revision:4384; }","duration":"116.495599ms","start":"2026-03-07T05:43:08.439528Z","end":"2026-03-07T05:43:08.556024Z","steps":["trace[1772597484] 'agreement among raft nodes before linearized reading' (duration: 116.310534ms)"],"step_count":1} {"level":"info","ts":"2026-03-07T05:43:12.530368Z","caller":"traceutil/trace.go:171","msg":"trace[1294122811] linearizableReadLoop","detail":"{readStateIndex:4724; appliedIndex:4723; }","duration":"113.197548ms","start":"2026-03-07T05:43:12.417125Z","end":"2026-03-07T05:43:12.530323Z","steps":["trace[1294122811] 'read index received' (duration: 63.224793ms)","trace[1294122811] 'applied index is now lower than readState.Index' (duration: 49.971335ms)"],"step_count":2} {"level":"info","ts":"2026-03-07T05:43:12.530409Z","caller":"traceutil/trace.go:171","msg":"trace[614991632] transaction","detail":"{read_only:false; response_revision:4541; number_of_response:1; }","duration":"276.713929ms","start":"2026-03-07T05:43:12.253655Z","end":"2026-03-07T05:43:12.530369Z","steps":["trace[614991632] 'process raft request' (duration: 227.781077ms)","trace[614991632] 'compare' (duration: 48.660837ms)"],"step_count":2} {"level":"warn","ts":"2026-03-07T05:43:12.531145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.996776ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:24 size:719265"} {"level":"info","ts":"2026-03-07T05:43:12.531259Z","caller":"traceutil/trace.go:171","msg":"trace[120049668] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:24; response_revision:4541; }","duration":"114.175339ms","start":"2026-03-07T05:43:12.417057Z","end":"2026-03-07T05:43:12.531232Z","steps":["trace[120049668] 'agreement among raft nodes before linearized reading' (duration: 113.406392ms)"],"step_count":1} {"level":"info","ts":"2026-03-07T05:43:25.065273Z","caller":"traceutil/trace.go:171","msg":"trace[304367916] transaction","detail":"{read_only:false; response_revision:4780; number_of_response:1; }","duration":"112.871791ms","start":"2026-03-07T05:43:24.952374Z","end":"2026-03-07T05:43:25.065246Z","steps":["trace[304367916] 'process raft request' (duration: 112.668207ms)"],"step_count":1} {"level":"warn","ts":"2026-03-07T05:43:32.322858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.374127ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/persistence-rabbitmq-keystone-server-0.189a78c9c601d854\" ","response":"range_response_count:1 size:1012"} {"level":"info","ts":"2026-03-07T05:43:32.322965Z","caller":"traceutil/trace.go:171","msg":"trace[943812904] range","detail":"{range_begin:/registry/events/openstack/persistence-rabbitmq-keystone-server-0.189a78c9c601d854; range_end:; response_count:1; response_revision:4940; }","duration":"108.538681ms","start":"2026-03-07T05:43:32.214404Z","end":"2026-03-07T05:43:32.322943Z","steps":["trace[943812904] 'range keys from in-memory index tree' (duration: 108.185842ms)"],"step_count":1} {"level":"info","ts":"2026-03-07T05:43:32.590826Z","caller":"traceutil/trace.go:171","msg":"trace[554284425] linearizableReadLoop","detail":"{readStateIndex:5137; appliedIndex:5136; }","duration":"125.366735ms","start":"2026-03-07T05:43:32.465432Z","end":"2026-03-07T05:43:32.590798Z","steps":["trace[554284425] 'read index received' (duration: 125.203322ms)","trace[554284425] 'applied index is now lower than readState.Index' (duration: 161.973µs)"],"step_count":2} {"level":"info","ts":"2026-03-07T05:43:32.590915Z","caller":"traceutil/trace.go:171","msg":"trace[1266865421] transaction","detail":"{read_only:false; response_revision:4942; number_of_response:1; }","duration":"169.426464ms","start":"2026-03-07T05:43:32.421441Z","end":"2026-03-07T05:43:32.590867Z","steps":["trace[1266865421] 'process raft request' (duration: 169.19333ms)"],"step_count":1} {"level":"warn","ts":"2026-03-07T05:43:32.590974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.523599ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-03-07T05:43:32.591026Z","caller":"traceutil/trace.go:171","msg":"trace[1806322310] range","detail":"{range_begin:/registry/validatingwebhookconfigurations/; range_end:/registry/validatingwebhookconfigurations0; response_count:0; response_revision:4942; }","duration":"125.644891ms","start":"2026-03-07T05:43:32.465365Z","end":"2026-03-07T05:43:32.591009Z","steps":["trace[1806322310] 'agreement among raft nodes before linearized reading' (duration: 125.544509ms)"],"step_count":1} {"level":"info","ts":"2026-03-07T05:43:32.727538Z","caller":"traceutil/trace.go:171","msg":"trace[1711417487] transaction","detail":"{read_only:false; response_revision:4943; number_of_response:1; }","duration":"128.945831ms","start":"2026-03-07T05:43:32.598544Z","end":"2026-03-07T05:43:32.72749Z","steps":["trace[1711417487] 'process raft request' (duration: 64.426419ms)","trace[1711417487] 'compare' (duration: 64.240586ms)"],"step_count":2} {"level":"info","ts":"2026-03-07T05:43:32.727772Z","caller":"traceutil/trace.go:171","msg":"trace[1098572187] transaction","detail":"{read_only:false; response_revision:4944; number_of_response:1; }","duration":"129.098014ms","start":"2026-03-07T05:43:32.598607Z","end":"2026-03-07T05:43:32.727705Z","steps":["trace[1098572187] 'process raft request' (duration: 128.745427ms)"],"step_count":1} {"level":"info","ts":"2026-03-07T05:43:32.727931Z","caller":"traceutil/trace.go:171","msg":"trace[267234047] transaction","detail":"{read_only:false; response_revision:4946; number_of_response:1; }","duration":"128.824938ms","start":"2026-03-07T05:43:32.599082Z","end":"2026-03-07T05:43:32.727907Z","steps":["trace[267234047] 'process raft request' (duration: 128.611664ms)"],"step_count":1} {"level":"info","ts":"2026-03-07T05:43:32.728103Z","caller":"traceutil/trace.go:171","msg":"trace[456296077] transaction","detail":"{read_only:false; response_revision:4945; number_of_response:1; }","duration":"129.063583ms","start":"2026-03-07T05:43:32.599025Z","end":"2026-03-07T05:43:32.728089Z","steps":["trace[456296077] 'process raft request' (duration: 128.603914ms)"],"step_count":1} {"level":"info","ts":"2026-03-07T05:43:32.728121Z","caller":"traceutil/trace.go:171","msg":"trace[1896878449] transaction","detail":"{read_only:false; response_revision:4947; number_of_response:1; }","duration":"128.917241ms","start":"2026-03-07T05:43:32.599162Z","end":"2026-03-07T05:43:32.728079Z","steps":["trace[1896878449] 'process raft request' (duration: 128.575544ms)"],"step_count":1} {"level":"info","ts":"2026-03-07T05:43:32.728204Z","caller":"traceutil/trace.go:171","msg":"trace[990458324] transaction","detail":"{read_only:false; response_revision:4948; number_of_response:1; }","duration":"128.90269ms","start":"2026-03-07T05:43:32.599292Z","end":"2026-03-07T05:43:32.728194Z","steps":["trace[990458324] 'process raft request' (duration: 128.495652ms)"],"step_count":1} {"level":"info","ts":"2026-03-07T05:43:32.72815Z","caller":"traceutil/trace.go:171","msg":"trace[584380458] transaction","detail":"{read_only:false; response_revision:4949; number_of_response:1; }","duration":"124.192261ms","start":"2026-03-07T05:43:32.603926Z","end":"2026-03-07T05:43:32.728119Z","steps":["trace[584380458] 'process raft request' (duration: 123.908255ms)"],"step_count":1} {"level":"info","ts":"2026-03-07T05:43:44.728214Z","caller":"traceutil/trace.go:171","msg":"trace[166954562] transaction","detail":"{read_only:false; response_revision:5093; number_of_response:1; }","duration":"123.19748ms","start":"2026-03-07T05:43:44.604982Z","end":"2026-03-07T05:43:44.72818Z","steps":["trace[166954562] 'process raft request' (duration: 29.876981ms)","trace[166954562] 'compare' (duration: 93.134535ms)"],"step_count":2} {"level":"info","ts":"2026-03-07T05:43:44.733134Z","caller":"traceutil/trace.go:171","msg":"trace[914257631] transaction","detail":"{read_only:false; response_revision:5094; number_of_response:1; }","duration":"127.950251ms","start":"2026-03-07T05:43:44.605165Z","end":"2026-03-07T05:43:44.733115Z","steps":["trace[914257631] 'process raft request' (duration: 127.794687ms)"],"step_count":1} {"level":"info","ts":"2026-03-07T05:43:44.733318Z","caller":"traceutil/trace.go:171","msg":"trace[91907831] transaction","detail":"{read_only:false; response_revision:5095; number_of_response:1; }","duration":"127.632834ms","start":"2026-03-07T05:43:44.605676Z","end":"2026-03-07T05:43:44.733309Z","steps":["trace[91907831] 'process raft request' (duration: 127.375398ms)"],"step_count":1} {"level":"info","ts":"2026-03-07T05:43:44.733427Z","caller":"traceutil/trace.go:171","msg":"trace[1783885339] transaction","detail":"{read_only:false; response_revision:5096; number_of_response:1; }","duration":"127.524562ms","start":"2026-03-07T05:43:44.605894Z","end":"2026-03-07T05:43:44.733418Z","steps":["trace[1783885339] 'process raft request' (duration: 127.370579ms)"],"step_count":1} {"level":"info","ts":"2026-03-07T05:45:08.653187Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2754} {"level":"info","ts":"2026-03-07T05:45:08.717476Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2754,"took":"62.731731ms","hash":1973237213,"current-db-size-bytes":41246720,"current-db-size":"41 MB","current-db-size-in-use-bytes":30871552,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-03-07T05:45:08.717544Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1973237213,"revision":2754,"compact-revision":-1} {"level":"info","ts":"2026-03-07T05:49:39.520092Z","caller":"traceutil/trace.go:171","msg":"trace[396467311] transaction","detail":"{read_only:false; response_revision:7590; number_of_response:1; }","duration":"128.447224ms","start":"2026-03-07T05:49:39.391609Z","end":"2026-03-07T05:49:39.520056Z","steps":["trace[396467311] 'process raft request' (duration: 128.21269ms)"],"step_count":1} {"level":"info","ts":"2026-03-07T05:49:39.83294Z","caller":"traceutil/trace.go:171","msg":"trace[480908984] linearizableReadLoop","detail":"{readStateIndex:7873; appliedIndex:7871; }","duration":"264.406797ms","start":"2026-03-07T05:49:39.568503Z","end":"2026-03-07T05:49:39.832909Z","steps":["trace[480908984] 'read index received' (duration: 264.10941ms)","trace[480908984] 'applied index is now lower than readState.Index' (duration: 296.367µs)"],"step_count":2} {"level":"info","ts":"2026-03-07T05:49:39.833326Z","caller":"traceutil/trace.go:171","msg":"trace[2054531527] transaction","detail":"{read_only:false; response_revision:7591; number_of_response:1; }","duration":"441.468204ms","start":"2026-03-07T05:49:39.391818Z","end":"2026-03-07T05:49:39.833287Z","steps":["trace[2054531527] 'process raft request' (duration: 440.875672ms)"],"step_count":1} {"level":"warn","ts":"2026-03-07T05:49:39.833386Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.841295ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/probes/\" range_end:\"/registry/monitoring.coreos.com/probes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-07T05:49:39.833513Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-07T05:49:39.391812Z","time spent":"441.602887ms","remote":"127.0.0.1:43132","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-07T05:49:39.833528Z","caller":"traceutil/trace.go:171","msg":"trace[1275588740] range","detail":"{range_begin:/registry/monitoring.coreos.com/probes/; range_end:/registry/monitoring.coreos.com/probes0; response_count:0; response_revision:7592; }","duration":"265.04386ms","start":"2026-03-07T05:49:39.568452Z","end":"2026-03-07T05:49:39.833496Z","steps":["trace[1275588740] 'agreement among raft nodes before linearized reading' (duration: 264.799565ms)"],"step_count":1} {"level":"warn","ts":"2026-03-07T05:49:39.833583Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.733287ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-gv4v7\" ","response":"range_response_count:1 size:6520"} {"level":"info","ts":"2026-03-07T05:49:39.833636Z","caller":"traceutil/trace.go:171","msg":"trace[1370004368] range","detail":"{range_begin:/registry/pods/openstack/keepalived-gv4v7; range_end:; response_count:1; response_revision:7592; }","duration":"153.830899ms","start":"2026-03-07T05:49:39.67979Z","end":"2026-03-07T05:49:39.833621Z","steps":["trace[1370004368] 'agreement among raft nodes before linearized reading' (duration: 153.640545ms)"],"step_count":1} {"level":"info","ts":"2026-03-07T05:49:39.833849Z","caller":"traceutil/trace.go:171","msg":"trace[1349332037] transaction","detail":"{read_only:false; response_revision:7592; number_of_response:1; }","duration":"440.121346ms","start":"2026-03-07T05:49:39.393691Z","end":"2026-03-07T05:49:39.833812Z","steps":["trace[1349332037] 'process raft request' (duration: 439.177827ms)"],"step_count":1} {"level":"warn","ts":"2026-03-07T05:49:39.833979Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.227199ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-03-07T05:49:39.833974Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-07T05:49:39.393686Z","time spent":"440.200198ms","remote":"127.0.0.1:43132","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-07T05:49:39.834027Z","caller":"traceutil/trace.go:171","msg":"trace[260000348] range","detail":"{range_begin:/registry/controllerrevisions/; range_end:/registry/controllerrevisions0; response_count:0; response_revision:7592; }","duration":"128.327931ms","start":"2026-03-07T05:49:39.705685Z","end":"2026-03-07T05:49:39.834013Z","steps":["trace[260000348] 'agreement among raft nodes before linearized reading' (duration: 128.222829ms)"],"step_count":1} {"level":"warn","ts":"2026-03-07T05:49:50.169336Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.691146ms","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-07T05:49:50.16944Z","caller":"traceutil/trace.go:171","msg":"trace[1702196377] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:7638; }","duration":"105.851609ms","start":"2026-03-07T05:49:50.06357Z","end":"2026-03-07T05:49:50.169422Z","steps":["trace[1702196377] 'range keys from in-memory index tree' (duration: 105.532312ms)"],"step_count":1} {"level":"info","ts":"2026-03-07T05:49:52.691664Z","caller":"traceutil/trace.go:171","msg":"trace[851899350] transaction","detail":"{read_only:false; response_revision:7653; number_of_response:1; }","duration":"104.466969ms","start":"2026-03-07T05:49:52.587158Z","end":"2026-03-07T05:49:52.691625Z","steps":["trace[851899350] 'process raft request' (duration: 104.235105ms)"],"step_count":1} {"level":"info","ts":"2026-03-07T05:50:08.661831Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5710} {"level":"info","ts":"2026-03-07T05:50:08.75283Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5710,"took":"88.968114ms","hash":1170904016,"current-db-size-bytes":42627072,"current-db-size":"43 MB","current-db-size-in-use-bytes":23228416,"current-db-size-in-use":"23 MB"} {"level":"info","ts":"2026-03-07T05:50:08.752893Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1170904016,"revision":5710,"compact-revision":2754} {"level":"info","ts":"2026-03-07T05:50:19.339036Z","caller":"traceutil/trace.go:171","msg":"trace[191421413] transaction","detail":"{read_only:false; response_revision:7837; number_of_response:1; }","duration":"161.939989ms","start":"2026-03-07T05:50:19.177067Z","end":"2026-03-07T05:50:19.339007Z","steps":["trace[191421413] 'process raft request' (duration: 161.752035ms)"],"step_count":1} {"level":"info","ts":"2026-03-07T05:50:22.241238Z","caller":"traceutil/trace.go:171","msg":"trace[1312505861] transaction","detail":"{read_only:false; response_revision:7852; number_of_response:1; }","duration":"101.398884ms","start":"2026-03-07T05:50:22.139807Z","end":"2026-03-07T05:50:22.241206Z","steps":["trace[1312505861] 'process raft request' (duration: 101.240271ms)"],"step_count":1} {"level":"info","ts":"2026-03-07T05:50:22.991458Z","caller":"traceutil/trace.go:171","msg":"trace[368138112] transaction","detail":"{read_only:false; response_revision:7857; number_of_response:1; }","duration":"124.091772ms","start":"2026-03-07T05:50:22.867341Z","end":"2026-03-07T05:50:22.991433Z","steps":["trace[368138112] 'process raft request' (duration: 123.890088ms)"],"step_count":1} {"level":"warn","ts":"2026-03-07T05:50:32.232396Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.144268ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-07T05:50:32.232586Z","caller":"traceutil/trace.go:171","msg":"trace[1296713945] transaction","detail":"{read_only:false; response_revision:7939; number_of_response:1; }","duration":"175.322801ms","start":"2026-03-07T05:50:32.057228Z","end":"2026-03-07T05:50:32.232551Z","steps":["trace[1296713945] 'process raft request' (duration: 66.712564ms)","trace[1296713945] 'compare' (duration: 107.942524ms)"],"step_count":2} {"level":"info","ts":"2026-03-07T05:50:32.472724Z","caller":"traceutil/trace.go:171","msg":"trace[1452239250] linearizableReadLoop","detail":"{readStateIndex:8239; appliedIndex:8238; }","duration":"183.149537ms","start":"2026-03-07T05:50:32.28955Z","end":"2026-03-07T05:50:32.472699Z","steps":["trace[1452239250] 'read index received' (duration: 107.254389ms)","trace[1452239250] 'applied index is now lower than readState.Index' (duration: 75.894068ms)"],"step_count":2} {"level":"info","ts":"2026-03-07T05:50:32.47287Z","caller":"traceutil/trace.go:171","msg":"trace[21089462] transaction","detail":"{read_only:false; response_revision:7940; number_of_response:1; }","duration":"200.466451ms","start":"2026-03-07T05:50:32.272389Z","end":"2026-03-07T05:50:32.472856Z","steps":["trace[21089462] 'process raft request' (duration: 124.42034ms)","trace[21089462] 'compare' (duration: 75.781235ms)"],"step_count":2} {"level":"warn","ts":"2026-03-07T05:50:32.473019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.825068ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-gv4v7\" ","response":"range_response_count:1 size:6520"} {"level":"info","ts":"2026-03-07T05:50:32.473086Z","caller":"traceutil/trace.go:171","msg":"trace[464267707] range","detail":"{range_begin:/registry/pods/openstack/keepalived-gv4v7; range_end:; response_count:1; response_revision:7940; }","duration":"171.926629ms","start":"2026-03-07T05:50:32.301142Z","end":"2026-03-07T05:50:32.473068Z","steps":["trace[464267707] 'agreement among raft nodes before linearized reading' (duration: 171.741435ms)"],"step_count":1} {"level":"warn","ts":"2026-03-07T05:50:32.473276Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.718198ms","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-07T05:50:32.47332Z","caller":"traceutil/trace.go:171","msg":"trace[1623777331] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:7940; }","duration":"183.77967ms","start":"2026-03-07T05:50:32.289528Z","end":"2026-03-07T05:50:32.473308Z","steps":["trace[1623777331] 'agreement among raft nodes before linearized reading' (duration: 183.670898ms)"],"step_count":1} {"level":"info","ts":"2026-03-07T05:50:33.105619Z","caller":"traceutil/trace.go:171","msg":"trace[499738646] transaction","detail":"{read_only:false; response_revision:7948; number_of_response:1; }","duration":"139.093399ms","start":"2026-03-07T05:50:32.966503Z","end":"2026-03-07T05:50:33.105596Z","steps":["trace[499738646] 'process raft request' (duration: 65.07216ms)","trace[499738646] 'compare' (duration: 73.56788ms)"],"step_count":2} {"level":"info","ts":"2026-03-07T05:50:33.105605Z","caller":"traceutil/trace.go:171","msg":"trace[989994649] linearizableReadLoop","detail":"{readStateIndex:8247; appliedIndex:8246; }","duration":"135.353111ms","start":"2026-03-07T05:50:32.970228Z","end":"2026-03-07T05:50:33.105581Z","steps":["trace[989994649] 'read index received' (duration: 61.303361ms)","trace[989994649] 'applied index is now lower than readState.Index' (duration: 74.04842ms)"],"step_count":2} {"level":"warn","ts":"2026-03-07T05:50:33.106251Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.987544ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/alertmanagers/monitoring/kube-prometheus-stack-alertmanager\" ","response":"range_response_count:1 size:4725"} {"level":"info","ts":"2026-03-07T05:50:33.106396Z","caller":"traceutil/trace.go:171","msg":"trace[708625189] range","detail":"{range_begin:/registry/monitoring.coreos.com/alertmanagers/monitoring/kube-prometheus-stack-alertmanager; range_end:; response_count:1; response_revision:7949; }","duration":"136.163597ms","start":"2026-03-07T05:50:32.970208Z","end":"2026-03-07T05:50:33.106371Z","steps":["trace[708625189] 'agreement among raft nodes before linearized reading' (duration: 135.450742ms)"],"step_count":1} {"level":"info","ts":"2026-03-07T05:50:33.500314Z","caller":"traceutil/trace.go:171","msg":"trace[1913454089] transaction","detail":"{read_only:false; response_revision:7953; number_of_response:1; }","duration":"149.261643ms","start":"2026-03-07T05:50:33.351021Z","end":"2026-03-07T05:50:33.500283Z","steps":["trace[1913454089] 'process raft request' (duration: 149.057228ms)"],"step_count":1} {"level":"info","ts":"2026-03-07T05:51:35.810398Z","caller":"traceutil/trace.go:171","msg":"trace[1279057389] transaction","detail":"{read_only:false; response_revision:8588; number_of_response:1; }","duration":"127.572576ms","start":"2026-03-07T05:51:35.682795Z","end":"2026-03-07T05:51:35.810367Z","steps":["trace[1279057389] 'process raft request' (duration: 127.32237ms)"],"step_count":1} {"level":"info","ts":"2026-03-07T05:54:07.802334Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"30aa8136fb61a722","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-03-07T05:54:07.808384Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-03-07T05:54:07.808667Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-03-07T05:55:08.669112Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":7734} {"level":"info","ts":"2026-03-07T05:55:08.735945Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":7734,"took":"64.266765ms","hash":4080532886,"current-db-size-bytes":42627072,"current-db-size":"43 MB","current-db-size-in-use-bytes":26263552,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-03-07T05:55:08.735998Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4080532886,"revision":7734,"compact-revision":5710} {"level":"info","ts":"2026-03-07T06:00:08.675185Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":9983} {"level":"info","ts":"2026-03-07T06:00:08.752334Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":9983,"took":"74.788929ms","hash":809423611,"current-db-size-bytes":42627072,"current-db-size":"43 MB","current-db-size-in-use-bytes":16359424,"current-db-size-in-use":"16 MB"} {"level":"info","ts":"2026-03-07T06:00:08.752428Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":809423611,"revision":9983,"compact-revision":7734}