{"level":"warn","ts":"2026-04-16T22:48:59.672522Z","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-16T22:48:59.672646Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.140: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.140:2380","--initial-cluster=instance=https://199.204.45.140:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.140:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.140: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-16T22:48:59.672746Z","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-16T22:48:59.672758Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.140:2380"]} {"level":"info","ts":"2026-04-16T22:48:59.672777Z","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-16T22:48:59.673534Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.140:2379"]} {"level":"info","ts":"2026-04-16T22:48:59.67362Z","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.140:2380"],"listen-peer-urls":["https://199.204.45.140:2380"],"advertise-client-urls":["https://199.204.45.140:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.140:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.140: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-16T22:48:59.679872Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.972578ms"} {"level":"info","ts":"2026-04-16T22:48:59.69041Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"35b2766da46a76bb","cluster-id":"f5fd3aeb8d9f53dc"} {"level":"info","ts":"2026-04-16T22:48:59.690531Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"35b2766da46a76bb switched to configuration voters=()"} {"level":"info","ts":"2026-04-16T22:48:59.690555Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"35b2766da46a76bb became follower at term 0"} {"level":"info","ts":"2026-04-16T22:48:59.69057Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 35b2766da46a76bb [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-16T22:48:59.690584Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"35b2766da46a76bb became follower at term 1"} {"level":"info","ts":"2026-04-16T22:48:59.690654Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"35b2766da46a76bb switched to configuration voters=(3869285243146630843)"} {"level":"warn","ts":"2026-04-16T22:48:59.699927Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-16T22:48:59.701958Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-16T22:48:59.703479Z","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-16T22:48:59.706645Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"35b2766da46a76bb","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-16T22:48:59.706833Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"35b2766da46a76bb","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-16T22:48:59.706919Z","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-16T22:48:59.707068Z","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-16T22:48:59.707094Z","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-16T22:48:59.707807Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"35b2766da46a76bb switched to configuration voters=(3869285243146630843)"} {"level":"info","ts":"2026-04-16T22:48:59.707997Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"f5fd3aeb8d9f53dc","local-member-id":"35b2766da46a76bb","added-peer-id":"35b2766da46a76bb","added-peer-peer-urls":["https://199.204.45.140:2380"]} {"level":"info","ts":"2026-04-16T22:48:59.711988Z","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-16T22:48:59.712127Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.140:2380"} {"level":"info","ts":"2026-04-16T22:48:59.71217Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.140:2380"} {"level":"info","ts":"2026-04-16T22:48:59.712286Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"35b2766da46a76bb","initial-advertise-peer-urls":["https://199.204.45.140:2380"],"listen-peer-urls":["https://199.204.45.140:2380"],"advertise-client-urls":["https://199.204.45.140:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.140:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-16T22:48:59.712338Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-16T22:49:00.090968Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"35b2766da46a76bb is starting a new election at term 1"} {"level":"info","ts":"2026-04-16T22:49:00.091054Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"35b2766da46a76bb became pre-candidate at term 1"} {"level":"info","ts":"2026-04-16T22:49:00.091079Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"35b2766da46a76bb received MsgPreVoteResp from 35b2766da46a76bb at term 1"} {"level":"info","ts":"2026-04-16T22:49:00.091099Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"35b2766da46a76bb became candidate at term 2"} {"level":"info","ts":"2026-04-16T22:49:00.09111Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"35b2766da46a76bb received MsgVoteResp from 35b2766da46a76bb at term 2"} {"level":"info","ts":"2026-04-16T22:49:00.091127Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"35b2766da46a76bb became leader at term 2"} {"level":"info","ts":"2026-04-16T22:49:00.091142Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 35b2766da46a76bb elected leader 35b2766da46a76bb at term 2"} {"level":"info","ts":"2026-04-16T22:49:00.092213Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"35b2766da46a76bb","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.140:2379]}","request-path":"/0/members/35b2766da46a76bb/attributes","cluster-id":"f5fd3aeb8d9f53dc","publish-timeout":"7s"} {"level":"info","ts":"2026-04-16T22:49:00.092226Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-16T22:49:00.092254Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-16T22:49:00.092286Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-16T22:49:00.092598Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-16T22:49:00.092701Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-16T22:49:00.093185Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"f5fd3aeb8d9f53dc","local-member-id":"35b2766da46a76bb","cluster-version":"3.5"} {"level":"info","ts":"2026-04-16T22:49:00.093325Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-16T22:49:00.093379Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-16T22:49:00.096137Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.140:2379"} {"level":"info","ts":"2026-04-16T22:49:00.096207Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-16T22:49:04.281495Z","caller":"traceutil/trace.go:171","msg":"trace[1264010231] transaction","detail":"{read_only:false; response_revision:213; number_of_response:1; }","duration":"186.196761ms","start":"2026-04-16T22:49:04.095264Z","end":"2026-04-16T22:49:04.28146Z","steps":["trace[1264010231] 'process raft request' (duration: 186.008785ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T22:49:11.716042Z","caller":"traceutil/trace.go:171","msg":"trace[1042372163] transaction","detail":"{read_only:false; response_revision:357; number_of_response:1; }","duration":"260.706406ms","start":"2026-04-16T22:49:11.455304Z","end":"2026-04-16T22:49:11.71601Z","steps":["trace[1042372163] 'process raft request' (duration: 260.443569ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T22:49:11.989272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.974918ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-16T22:49:11.990239Z","caller":"traceutil/trace.go:171","msg":"trace[849168673] transaction","detail":"{read_only:false; response_revision:359; number_of_response:1; }","duration":"198.456568ms","start":"2026-04-16T22:49:11.791705Z","end":"2026-04-16T22:49:11.990162Z","steps":["trace[849168673] 'process raft request' (duration: 198.110518ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T22:49:11.990318Z","caller":"traceutil/trace.go:171","msg":"trace[426229755] transaction","detail":"{read_only:false; response_revision:358; number_of_response:1; }","duration":"243.084819ms","start":"2026-04-16T22:49:11.747136Z","end":"2026-04-16T22:49:11.990221Z","steps":["trace[426229755] 'process raft request' (duration: 67.767644ms)","trace[426229755] 'compare' (duration: 172.838375ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T22:49:11.993208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.916759ms","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-04-16T22:49:11.993362Z","caller":"traceutil/trace.go:171","msg":"trace[157097169] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:359; }","duration":"103.135564ms","start":"2026-04-16T22:49:11.890189Z","end":"2026-04-16T22:49:11.993325Z","steps":["trace[157097169] 'agreement among raft nodes before linearized reading' (duration: 99.79759ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T22:49:38.347157Z","caller":"traceutil/trace.go:171","msg":"trace[1750303200] transaction","detail":"{read_only:false; response_revision:490; number_of_response:1; }","duration":"106.894211ms","start":"2026-04-16T22:49:38.240237Z","end":"2026-04-16T22:49:38.347131Z","steps":["trace[1750303200] 'process raft request' (duration: 106.751977ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T22:49:38.396586Z","caller":"traceutil/trace.go:171","msg":"trace[1104635291] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"152.611304ms","start":"2026-04-16T22:49:38.243923Z","end":"2026-04-16T22:49:38.396534Z","steps":["trace[1104635291] 'process raft request' (duration: 152.265295ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T22:49:38.396612Z","caller":"traceutil/trace.go:171","msg":"trace[1828037960] transaction","detail":"{read_only:false; response_revision:492; number_of_response:1; }","duration":"152.621174ms","start":"2026-04-16T22:49:38.243953Z","end":"2026-04-16T22:49:38.396574Z","steps":["trace[1828037960] 'process raft request' (duration: 152.45046ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T22:49:38.452112Z","caller":"traceutil/trace.go:171","msg":"trace[1525340826] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"200.256239ms","start":"2026-04-16T22:49:38.251827Z","end":"2026-04-16T22:49:38.452083Z","steps":["trace[1525340826] 'process raft request' (duration: 199.956111ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T22:49:38.452202Z","caller":"traceutil/trace.go:171","msg":"trace[68759870] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"198.764408ms","start":"2026-04-16T22:49:38.253382Z","end":"2026-04-16T22:49:38.452147Z","steps":["trace[68759870] 'process raft request' (duration: 198.540082ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T22:49:38.452432Z","caller":"traceutil/trace.go:171","msg":"trace[269429667] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"197.477773ms","start":"2026-04-16T22:49:38.254924Z","end":"2026-04-16T22:49:38.452401Z","steps":["trace[269429667] 'process raft request' (duration: 197.219686ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T22:49:38.452624Z","caller":"traceutil/trace.go:171","msg":"trace[469740550] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"166.126916ms","start":"2026-04-16T22:49:38.286477Z","end":"2026-04-16T22:49:38.452604Z","steps":["trace[469740550] 'process raft request' (duration: 165.918081ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T22:49:38.452477Z","caller":"traceutil/trace.go:171","msg":"trace[532793169] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"197.75136ms","start":"2026-04-16T22:49:38.25471Z","end":"2026-04-16T22:49:38.452462Z","steps":["trace[532793169] 'process raft request' (duration: 197.280988ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T22:49:38.452778Z","caller":"traceutil/trace.go:171","msg":"trace[1096620531] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"197.420351ms","start":"2026-04-16T22:49:38.255345Z","end":"2026-04-16T22:49:38.452765Z","steps":["trace[1096620531] 'process raft request' (duration: 196.866346ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T22:49:38.452798Z","caller":"traceutil/trace.go:171","msg":"trace[1439961111] transaction","detail":"{read_only:false; response_revision:500; number_of_response:1; }","duration":"134.803031ms","start":"2026-04-16T22:49:38.31798Z","end":"2026-04-16T22:49:38.452783Z","steps":["trace[1439961111] 'process raft request' (duration: 134.561885ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T22:49:38.452902Z","caller":"traceutil/trace.go:171","msg":"trace[1636841820] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"179.65008ms","start":"2026-04-16T22:49:38.273237Z","end":"2026-04-16T22:49:38.452887Z","steps":["trace[1636841820] 'process raft request' (duration: 179.041463ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T22:49:38.462255Z","caller":"traceutil/trace.go:171","msg":"trace[949597245] transaction","detail":"{read_only:false; response_revision:501; number_of_response:1; }","duration":"102.848469ms","start":"2026-04-16T22:49:38.359392Z","end":"2026-04-16T22:49:38.462241Z","steps":["trace[949597245] 'process raft request' (duration: 102.404657ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T22:49:38.462521Z","caller":"traceutil/trace.go:171","msg":"trace[1728230678] transaction","detail":"{read_only:false; response_revision:502; number_of_response:1; }","duration":"100.597407ms","start":"2026-04-16T22:49:38.361914Z","end":"2026-04-16T22:49:38.462512Z","steps":["trace[1728230678] 'process raft request' (duration: 99.99002ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T22:49:44.696665Z","caller":"traceutil/trace.go:171","msg":"trace[395178355] transaction","detail":"{read_only:false; response_revision:586; number_of_response:1; }","duration":"143.902303ms","start":"2026-04-16T22:49:44.552731Z","end":"2026-04-16T22:49:44.696633Z","steps":["trace[395178355] 'process raft request' (duration: 142.679359ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T22:49:44.952502Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.294002ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-16T22:49:44.952606Z","caller":"traceutil/trace.go:171","msg":"trace[846945735] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"197.333747ms","start":"2026-04-16T22:49:44.755254Z","end":"2026-04-16T22:49:44.952588Z","steps":["trace[846945735] 'process raft request' (duration: 47.883901ms)","trace[846945735] 'compare' (duration: 149.166388ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T22:49:45.384804Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.1429ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-16T22:49:45.38513Z","caller":"traceutil/trace.go:171","msg":"trace[1144724294] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"329.23049ms","start":"2026-04-16T22:49:45.055847Z","end":"2026-04-16T22:49:45.385078Z","steps":["trace[1144724294] 'process raft request' (duration: 34.717718ms)","trace[1144724294] 'compare' (duration: 293.875203ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T22:49:45.385235Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T22:49:45.055821Z","time spent":"329.366194ms","remote":"127.0.0.1:38722","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-16T22:49:45.578029Z","caller":"traceutil/trace.go:171","msg":"trace[1783317067] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"187.673341ms","start":"2026-04-16T22:49:45.390331Z","end":"2026-04-16T22:49:45.578004Z","steps":["trace[1783317067] 'process raft request' (duration: 170.034965ms)","trace[1783317067] 'compare' (duration: 17.553674ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T22:49:45.584895Z","caller":"traceutil/trace.go:171","msg":"trace[89304312] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"147.107752ms","start":"2026-04-16T22:49:45.437766Z","end":"2026-04-16T22:49:45.584874Z","steps":["trace[89304312] 'process raft request' (duration: 146.486485ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T22:50:01.103353Z","caller":"traceutil/trace.go:171","msg":"trace[616684707] transaction","detail":"{read_only:false; response_revision:765; number_of_response:1; }","duration":"150.695169ms","start":"2026-04-16T22:50:00.952597Z","end":"2026-04-16T22:50:01.103292Z","steps":["trace[616684707] 'process raft request' (duration: 145.944409ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T22:51:17.770116Z","caller":"traceutil/trace.go:171","msg":"trace[369939821] linearizableReadLoop","detail":"{readStateIndex:1905; appliedIndex:1904; }","duration":"203.843504ms","start":"2026-04-16T22:51:17.56624Z","end":"2026-04-16T22:51:17.770084Z","steps":["trace[369939821] 'read index received' (duration: 203.654729ms)","trace[369939821] 'applied index is now lower than readState.Index' (duration: 187.625µs)"],"step_count":2} {"level":"info","ts":"2026-04-16T22:51:17.770216Z","caller":"traceutil/trace.go:171","msg":"trace[1700339694] transaction","detail":"{read_only:false; response_revision:1827; number_of_response:1; }","duration":"207.550988ms","start":"2026-04-16T22:51:17.562602Z","end":"2026-04-16T22:51:17.770153Z","steps":["trace[1700339694] 'process raft request' (duration: 207.312331ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T22:51:17.770469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.198624ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-6cec790a-fd6b-4da1-b09c-160a57885d4a\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-04-16T22:51:17.770585Z","caller":"traceutil/trace.go:171","msg":"trace[1242226831] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-6cec790a-fd6b-4da1-b09c-160a57885d4a; range_end:; response_count:1; response_revision:1827; }","duration":"204.40382ms","start":"2026-04-16T22:51:17.566156Z","end":"2026-04-16T22:51:17.77056Z","steps":["trace[1242226831] 'agreement among raft nodes before linearized reading' (duration: 204.104072ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T22:51:17.780968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.212921ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-16T22:51:17.780976Z","caller":"traceutil/trace.go:171","msg":"trace[60230663] transaction","detail":"{read_only:false; response_revision:1828; number_of_response:1; }","duration":"150.431444ms","start":"2026-04-16T22:51:17.630525Z","end":"2026-04-16T22:51:17.780956Z","steps":["trace[60230663] 'process raft request' (duration: 150.154317ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T22:51:17.781034Z","caller":"traceutil/trace.go:171","msg":"trace[1389747331] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:1828; }","duration":"175.325143ms","start":"2026-04-16T22:51:17.605695Z","end":"2026-04-16T22:51:17.78102Z","steps":["trace[1389747331] 'agreement among raft nodes before linearized reading' (duration: 175.134188ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T22:51:17.975587Z","caller":"traceutil/trace.go:171","msg":"trace[1709970655] transaction","detail":"{read_only:false; response_revision:1831; number_of_response:1; }","duration":"147.161002ms","start":"2026-04-16T22:51:17.828392Z","end":"2026-04-16T22:51:17.975553Z","steps":["trace[1709970655] 'process raft request' (duration: 57.865714ms)","trace[1709970655] 'compare' (duration: 88.99726ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T22:51:18.180953Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.647122ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-04-16T22:51:18.181082Z","caller":"traceutil/trace.go:171","msg":"trace[889130623] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1836; }","duration":"102.857618ms","start":"2026-04-16T22:51:18.078199Z","end":"2026-04-16T22:51:18.181057Z","steps":["trace[889130623] 'range keys from in-memory index tree' (duration: 102.317322ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T22:52:03.633485Z","caller":"traceutil/trace.go:171","msg":"trace[96956995] transaction","detail":"{read_only:false; response_revision:2131; number_of_response:1; }","duration":"192.68914ms","start":"2026-04-16T22:52:03.440755Z","end":"2026-04-16T22:52:03.633444Z","steps":["trace[96956995] 'process raft request' (duration: 192.470913ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T22:52:56.867299Z","caller":"traceutil/trace.go:171","msg":"trace[638828368] transaction","detail":"{read_only:false; response_revision:2592; number_of_response:1; }","duration":"123.910225ms","start":"2026-04-16T22:52:56.743363Z","end":"2026-04-16T22:52:56.867274Z","steps":["trace[638828368] 'process raft request' (duration: 123.760561ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T22:53:30.719048Z","caller":"traceutil/trace.go:171","msg":"trace[1693950671] transaction","detail":"{read_only:false; response_revision:2795; number_of_response:1; }","duration":"161.164672ms","start":"2026-04-16T22:53:30.557861Z","end":"2026-04-16T22:53:30.719026Z","steps":["trace[1693950671] 'process raft request' (duration: 141.105418ms)","trace[1693950671] 'compare' (duration: 19.630802ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T22:53:30.71951Z","caller":"traceutil/trace.go:171","msg":"trace[1279077435] transaction","detail":"{read_only:false; response_revision:2796; number_of_response:1; }","duration":"161.408268ms","start":"2026-04-16T22:53:30.558022Z","end":"2026-04-16T22:53:30.71943Z","steps":["trace[1279077435] 'process raft request' (duration: 160.936705ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T22:55:25.462327Z","caller":"traceutil/trace.go:171","msg":"trace[2046888159] transaction","detail":"{read_only:false; response_revision:3401; number_of_response:1; }","duration":"231.159654ms","start":"2026-04-16T22:55:25.231129Z","end":"2026-04-16T22:55:25.462289Z","steps":["trace[2046888159] 'process raft request' (duration: 230.861105ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T22:56:11.220254Z","caller":"traceutil/trace.go:171","msg":"trace[428512138] transaction","detail":"{read_only:false; response_revision:3839; number_of_response:1; }","duration":"125.517338ms","start":"2026-04-16T22:56:11.09469Z","end":"2026-04-16T22:56:11.220207Z","steps":["trace[428512138] 'process raft request' (duration: 125.198448ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T22:58:10.812237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.291545ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T22:58:10.812382Z","caller":"traceutil/trace.go:171","msg":"trace[1188424576] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5356; }","duration":"120.5048ms","start":"2026-04-16T22:58:10.691838Z","end":"2026-04-16T22:58:10.812343Z","steps":["trace[1188424576] 'range keys from in-memory index tree' (duration: 120.177971ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T22:58:13.052269Z","caller":"traceutil/trace.go:171","msg":"trace[1941323452] transaction","detail":"{read_only:false; response_revision:5380; number_of_response:1; }","duration":"102.780719ms","start":"2026-04-16T22:58:12.949436Z","end":"2026-04-16T22:58:13.052217Z","steps":["trace[1941323452] 'process raft request' (duration: 63.287315ms)","trace[1941323452] 'compare' (duration: 39.198196ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T22:58:24.655087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.805935ms","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-16T22:58:24.655221Z","caller":"traceutil/trace.go:171","msg":"trace[1714569853] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5528; }","duration":"185.042632ms","start":"2026-04-16T22:58:24.470149Z","end":"2026-04-16T22:58:24.655192Z","steps":["trace[1714569853] 'range keys from in-memory index tree' (duration: 184.532237ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T22:58:24.655221Z","caller":"traceutil/trace.go:171","msg":"trace[1651223020] transaction","detail":"{read_only:false; response_revision:5529; number_of_response:1; }","duration":"184.567179ms","start":"2026-04-16T22:58:24.47063Z","end":"2026-04-16T22:58:24.655198Z","steps":["trace[1651223020] 'process raft request' (duration: 128.683762ms)","trace[1651223020] 'compare' (duration: 55.752403ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T22:58:24.702053Z","caller":"traceutil/trace.go:171","msg":"trace[2130892925] transaction","detail":"{read_only:false; response_revision:5531; number_of_response:1; }","duration":"114.445379ms","start":"2026-04-16T22:58:24.587573Z","end":"2026-04-16T22:58:24.702018Z","steps":["trace[2130892925] 'process raft request' (duration: 114.398628ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T22:58:24.702081Z","caller":"traceutil/trace.go:171","msg":"trace[1259364484] transaction","detail":"{read_only:false; response_revision:5530; number_of_response:1; }","duration":"116.356433ms","start":"2026-04-16T22:58:24.585702Z","end":"2026-04-16T22:58:24.702058Z","steps":["trace[1259364484] 'process raft request' (duration: 116.095906ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T22:58:24.802132Z","caller":"traceutil/trace.go:171","msg":"trace[782576371] transaction","detail":"{read_only:false; response_revision:5532; number_of_response:1; }","duration":"142.309086ms","start":"2026-04-16T22:58:24.659778Z","end":"2026-04-16T22:58:24.802087Z","steps":["trace[782576371] 'process raft request' (duration: 132.011066ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T22:58:25.262819Z","caller":"traceutil/trace.go:171","msg":"trace[1309899490] transaction","detail":"{read_only:false; response_revision:5539; number_of_response:1; }","duration":"106.195217ms","start":"2026-04-16T22:58:25.156587Z","end":"2026-04-16T22:58:25.262782Z","steps":["trace[1309899490] 'process raft request' (duration: 95.285789ms)","trace[1309899490] 'compare' (duration: 10.276701ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T22:58:25.263023Z","caller":"traceutil/trace.go:171","msg":"trace[1685847142] linearizableReadLoop","detail":"{readStateIndex:5751; appliedIndex:5750; }","duration":"104.92648ms","start":"2026-04-16T22:58:25.158068Z","end":"2026-04-16T22:58:25.262994Z","steps":["trace[1685847142] 'read index received' (duration: 29.914103ms)","trace[1685847142] 'applied index is now lower than readState.Index' (duration: 75.011547ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T22:58:25.263123Z","caller":"traceutil/trace.go:171","msg":"trace[1594718104] transaction","detail":"{read_only:false; response_revision:5541; number_of_response:1; }","duration":"104.568051ms","start":"2026-04-16T22:58:25.158527Z","end":"2026-04-16T22:58:25.263095Z","steps":["trace[1594718104] 'process raft request' (duration: 104.299043ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T22:58:25.263191Z","caller":"traceutil/trace.go:171","msg":"trace[2048086099] transaction","detail":"{read_only:false; response_revision:5540; number_of_response:1; }","duration":"105.013383ms","start":"2026-04-16T22:58:25.158124Z","end":"2026-04-16T22:58:25.263137Z","steps":["trace[2048086099] 'process raft request' (duration: 104.568371ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T22:58:25.263373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.27858ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2082"} {"level":"info","ts":"2026-04-16T22:58:25.263424Z","caller":"traceutil/trace.go:171","msg":"trace[1462272199] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:5542; }","duration":"105.415334ms","start":"2026-04-16T22:58:25.157992Z","end":"2026-04-16T22:58:25.263407Z","steps":["trace[1462272199] 'agreement among raft nodes before linearized reading' (duration: 105.195778ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T22:59:00.139719Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2958} {"level":"info","ts":"2026-04-16T22:59:00.207789Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2958,"took":"66.125015ms","hash":177216324,"current-db-size-bytes":58052608,"current-db-size":"58 MB","current-db-size-in-use-bytes":33230848,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-04-16T22:59:00.207873Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":177216324,"revision":2958,"compact-revision":-1} {"level":"info","ts":"2026-04-16T22:59:01.091823Z","caller":"traceutil/trace.go:171","msg":"trace[511259681] transaction","detail":"{read_only:false; response_revision:5968; number_of_response:1; }","duration":"261.644613ms","start":"2026-04-16T22:59:00.830141Z","end":"2026-04-16T22:59:01.091785Z","steps":["trace[511259681] 'process raft request' (duration: 261.441368ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T22:59:01.103735Z","caller":"traceutil/trace.go:171","msg":"trace[164773317] linearizableReadLoop","detail":"{readStateIndex:6194; appliedIndex:6192; }","duration":"257.98018ms","start":"2026-04-16T22:59:00.84572Z","end":"2026-04-16T22:59:01.103701Z","steps":["trace[164773317] 'read index received' (duration: 245.887319ms)","trace[164773317] 'applied index is now lower than readState.Index' (duration: 12.091471ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T22:59:01.103838Z","caller":"traceutil/trace.go:171","msg":"trace[1832946126] transaction","detail":"{read_only:false; response_revision:5969; number_of_response:1; }","duration":"270.201804ms","start":"2026-04-16T22:59:00.833579Z","end":"2026-04-16T22:59:01.10378Z","steps":["trace[1832946126] 'process raft request' (duration: 269.959588ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T22:59:01.104036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.290068ms","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-16T22:59:01.104089Z","caller":"traceutil/trace.go:171","msg":"trace[1261832779] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5969; }","duration":"258.432042ms","start":"2026-04-16T22:59:00.845639Z","end":"2026-04-16T22:59:01.104071Z","steps":["trace[1261832779] 'agreement among raft nodes before linearized reading' (duration: 258.218467ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T22:59:01.104278Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.644062ms","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-16T22:59:01.104385Z","caller":"traceutil/trace.go:171","msg":"trace[2064880686] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5969; }","duration":"110.814777ms","start":"2026-04-16T22:59:00.993544Z","end":"2026-04-16T22:59:01.104359Z","steps":["trace[2064880686] 'agreement among raft nodes before linearized reading' (duration: 110.549419ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T22:59:01.104351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.342584ms","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-04-16T22:59:01.104666Z","caller":"traceutil/trace.go:171","msg":"trace[1271093532] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5969; }","duration":"115.723766ms","start":"2026-04-16T22:59:00.988913Z","end":"2026-04-16T22:59:01.104637Z","steps":["trace[1271093532] 'agreement among raft nodes before linearized reading' (duration: 115.130299ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T23:04:00.146012Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5956} {"level":"info","ts":"2026-04-16T23:04:00.230606Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5956,"took":"81.936082ms","hash":2972398759,"current-db-size-bytes":58052608,"current-db-size":"58 MB","current-db-size-in-use-bytes":25239552,"current-db-size-in-use":"25 MB"} {"level":"info","ts":"2026-04-16T23:04:00.230701Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2972398759,"revision":5956,"compact-revision":2958} {"level":"info","ts":"2026-04-16T23:04:21.191225Z","caller":"traceutil/trace.go:171","msg":"trace[1835125224] linearizableReadLoop","detail":"{readStateIndex:8636; appliedIndex:8635; }","duration":"227.140617ms","start":"2026-04-16T23:04:20.964044Z","end":"2026-04-16T23:04:21.191185Z","steps":["trace[1835125224] 'read index received' (duration: 226.855879ms)","trace[1835125224] 'applied index is now lower than readState.Index' (duration: 283.268µs)"],"step_count":2} {"level":"info","ts":"2026-04-16T23:04:21.191313Z","caller":"traceutil/trace.go:171","msg":"trace[147471874] transaction","detail":"{read_only:false; response_revision:8335; number_of_response:1; }","duration":"228.26235ms","start":"2026-04-16T23:04:20.963002Z","end":"2026-04-16T23:04:21.191265Z","steps":["trace[147471874] 'process raft request' (duration: 227.929379ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T23:04:21.19161Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.532969ms","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-16T23:04:21.191676Z","caller":"traceutil/trace.go:171","msg":"trace[385715659] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8335; }","duration":"227.664203ms","start":"2026-04-16T23:04:20.963997Z","end":"2026-04-16T23:04:21.191661Z","steps":["trace[385715659] 'agreement among raft nodes before linearized reading' (duration: 227.378365ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T23:04:21.205406Z","caller":"traceutil/trace.go:171","msg":"trace[1230132526] transaction","detail":"{read_only:false; response_revision:8336; number_of_response:1; }","duration":"237.894763ms","start":"2026-04-16T23:04:20.967481Z","end":"2026-04-16T23:04:21.205376Z","steps":["trace[1230132526] 'process raft request' (duration: 237.621764ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T23:04:21.205483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.564828ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-04-16T23:04:21.205582Z","caller":"traceutil/trace.go:171","msg":"trace[2079389956] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8336; }","duration":"240.703012ms","start":"2026-04-16T23:04:20.964859Z","end":"2026-04-16T23:04:21.205562Z","steps":["trace[2079389956] 'agreement among raft nodes before linearized reading' (duration: 240.420864ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T23:04:33.409098Z","caller":"traceutil/trace.go:171","msg":"trace[1922489029] linearizableReadLoop","detail":"{readStateIndex:8699; appliedIndex:8698; }","duration":"154.675504ms","start":"2026-04-16T23:04:33.254387Z","end":"2026-04-16T23:04:33.409062Z","steps":["trace[1922489029] 'read index received' (duration: 154.614912ms)","trace[1922489029] 'applied index is now lower than readState.Index' (duration: 58.712µs)"],"step_count":2} {"level":"warn","ts":"2026-04-16T23:04:33.409858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.437985ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-16T23:04:33.409982Z","caller":"traceutil/trace.go:171","msg":"trace[1986448284] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8395; }","duration":"155.634961ms","start":"2026-04-16T23:04:33.254317Z","end":"2026-04-16T23:04:33.409952Z","steps":["trace[1986448284] 'agreement among raft nodes before linearized reading' (duration: 155.25653ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T23:04:33.44113Z","caller":"traceutil/trace.go:171","msg":"trace[2146517201] transaction","detail":"{read_only:false; response_revision:8396; number_of_response:1; }","duration":"154.756816ms","start":"2026-04-16T23:04:33.286344Z","end":"2026-04-16T23:04:33.441101Z","steps":["trace[2146517201] 'process raft request' (duration: 154.400726ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T23:04:33.441259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.707937ms","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-16T23:04:33.441341Z","caller":"traceutil/trace.go:171","msg":"trace[957222908] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8396; }","duration":"158.835691ms","start":"2026-04-16T23:04:33.282484Z","end":"2026-04-16T23:04:33.441319Z","steps":["trace[957222908] 'agreement among raft nodes before linearized reading' (duration: 158.557833ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T23:04:33.441444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.488846ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-04-16T23:04:33.441481Z","caller":"traceutil/trace.go:171","msg":"trace[1663336243] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8396; }","duration":"149.569659ms","start":"2026-04-16T23:04:33.2919Z","end":"2026-04-16T23:04:33.44147Z","steps":["trace[1663336243] 'agreement among raft nodes before linearized reading' (duration: 149.079515ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T23:04:33.442002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.218367ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"info","ts":"2026-04-16T23:04:33.44216Z","caller":"traceutil/trace.go:171","msg":"trace[1668208568] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8396; }","duration":"175.410141ms","start":"2026-04-16T23:04:33.266722Z","end":"2026-04-16T23:04:33.442132Z","steps":["trace[1668208568] 'agreement among raft nodes before linearized reading' (duration: 174.237148ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T23:04:34.977378Z","caller":"traceutil/trace.go:171","msg":"trace[197189977] transaction","detail":"{read_only:false; response_revision:8408; number_of_response:1; }","duration":"106.290032ms","start":"2026-04-16T23:04:34.871062Z","end":"2026-04-16T23:04:34.977352Z","steps":["trace[197189977] 'process raft request' (duration: 106.083676ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T23:05:03.94933Z","caller":"traceutil/trace.go:171","msg":"trace[1354767795] transaction","detail":"{read_only:false; response_revision:8617; number_of_response:1; }","duration":"264.369654ms","start":"2026-04-16T23:05:03.684919Z","end":"2026-04-16T23:05:03.949288Z","steps":["trace[1354767795] 'process raft request' (duration: 247.30157ms)","trace[1354767795] 'compare' (duration: 16.735445ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T23:05:04.148117Z","caller":"traceutil/trace.go:171","msg":"trace[1543390246] linearizableReadLoop","detail":"{readStateIndex:8931; appliedIndex:8929; }","duration":"455.774648ms","start":"2026-04-16T23:05:03.692319Z","end":"2026-04-16T23:05:04.148094Z","steps":["trace[1543390246] 'read index received' (duration: 239.91756ms)","trace[1543390246] 'applied index is now lower than readState.Index' (duration: 215.855788ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T23:05:04.148244Z","caller":"traceutil/trace.go:171","msg":"trace[1794739533] transaction","detail":"{read_only:false; response_revision:8618; number_of_response:1; }","duration":"462.261102ms","start":"2026-04-16T23:05:03.685973Z","end":"2026-04-16T23:05:04.148234Z","steps":["trace[1794739533] 'process raft request' (duration: 461.953303ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T23:05:04.148365Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T23:05:03.685934Z","time spent":"462.334664ms","remote":"127.0.0.1:38806","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T23:05:04.148641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"412.514501ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"warn","ts":"2026-04-16T23:05:04.148705Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.302352ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/schemareplications/\" range_end:\"/registry/rabbitmq.com/schemareplications0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T23:05:04.148737Z","caller":"traceutil/trace.go:171","msg":"trace[1491132699] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8618; }","duration":"412.652365ms","start":"2026-04-16T23:05:03.73606Z","end":"2026-04-16T23:05:04.148712Z","steps":["trace[1491132699] 'agreement among raft nodes before linearized reading' (duration: 412.339486ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T23:05:04.148803Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T23:05:03.736035Z","time spent":"412.748828ms","remote":"127.0.0.1:38806","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-16T23:05:04.148993Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.195538ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/barbican-api-7856cf7575-sj7dz.18a6f8cb02c42bfb\" ","response":"range_response_count:1 size:1135"} {"level":"warn","ts":"2026-04-16T23:05:04.149064Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"411.871904ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-04-16T23:05:04.149093Z","caller":"traceutil/trace.go:171","msg":"trace[151006959] range","detail":"{range_begin:/registry/events/openstack/barbican-api-7856cf7575-sj7dz.18a6f8cb02c42bfb; range_end:; response_count:1; response_revision:8618; }","duration":"294.353363ms","start":"2026-04-16T23:05:03.854714Z","end":"2026-04-16T23:05:04.149068Z","steps":["trace[151006959] 'agreement among raft nodes before linearized reading' (duration: 294.011033ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T23:05:04.149112Z","caller":"traceutil/trace.go:171","msg":"trace[1212871502] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8618; }","duration":"411.929375ms","start":"2026-04-16T23:05:03.737169Z","end":"2026-04-16T23:05:04.149099Z","steps":["trace[1212871502] 'agreement among raft nodes before linearized reading' (duration: 411.721899ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T23:05:04.149166Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T23:05:03.737163Z","time spent":"411.970136ms","remote":"127.0.0.1:38806","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-16T23:05:04.149173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.904904ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-pvv5z\" ","response":"range_response_count:1 size:6531"} {"level":"info","ts":"2026-04-16T23:05:04.149209Z","caller":"traceutil/trace.go:171","msg":"trace[2143661918] range","detail":"{range_begin:/registry/pods/openstack/keepalived-pvv5z; range_end:; response_count:1; response_revision:8618; }","duration":"122.980536ms","start":"2026-04-16T23:05:04.026218Z","end":"2026-04-16T23:05:04.149198Z","steps":["trace[2143661918] 'agreement among raft nodes before linearized reading' (duration: 122.848692ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T23:05:04.149161Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"456.826867ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T23:05:04.149343Z","caller":"traceutil/trace.go:171","msg":"trace[923582389] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8618; }","duration":"457.039203ms","start":"2026-04-16T23:05:03.692275Z","end":"2026-04-16T23:05:04.149315Z","steps":["trace[923582389] 'agreement among raft nodes before linearized reading' (duration: 456.775596ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T23:05:04.149452Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T23:05:03.692261Z","time spent":"457.175157ms","remote":"127.0.0.1:38552","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-16T23:05:04.148778Z","caller":"traceutil/trace.go:171","msg":"trace[1491879035] range","detail":"{range_begin:/registry/rabbitmq.com/schemareplications/; range_end:/registry/rabbitmq.com/schemareplications0; response_count:0; response_revision:8618; }","duration":"167.447196ms","start":"2026-04-16T23:05:03.981311Z","end":"2026-04-16T23:05:04.148758Z","steps":["trace[1491879035] 'agreement among raft nodes before linearized reading' (duration: 167.289162ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T23:05:16.849735Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.802008ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-16T23:05:16.849895Z","caller":"traceutil/trace.go:171","msg":"trace[1257316550] linearizableReadLoop","detail":"{readStateIndex:9046; appliedIndex:9045; }","duration":"156.695481ms","start":"2026-04-16T23:05:16.693177Z","end":"2026-04-16T23:05:16.849873Z","steps":["trace[1257316550] 'read index received' (duration: 25.632396ms)","trace[1257316550] 'applied index is now lower than readState.Index' (duration: 131.061335ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T23:05:16.849921Z","caller":"traceutil/trace.go:171","msg":"trace[564366498] transaction","detail":"{read_only:false; response_revision:8728; number_of_response:1; }","duration":"172.000725ms","start":"2026-04-16T23:05:16.677881Z","end":"2026-04-16T23:05:16.849882Z","steps":["trace[564366498] 'process raft request' (duration: 40.90278ms)","trace[564366498] 'compare' (duration: 130.667943ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T23:05:16.850003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.824004ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T23:05:16.850034Z","caller":"traceutil/trace.go:171","msg":"trace[1870163815] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8728; }","duration":"156.904057ms","start":"2026-04-16T23:05:16.69312Z","end":"2026-04-16T23:05:16.850024Z","steps":["trace[1870163815] 'agreement among raft nodes before linearized reading' (duration: 156.838015ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T23:05:16.85647Z","caller":"traceutil/trace.go:171","msg":"trace[1748502846] transaction","detail":"{read_only:false; response_revision:8729; number_of_response:1; }","duration":"100.994512ms","start":"2026-04-16T23:05:16.755457Z","end":"2026-04-16T23:05:16.856451Z","steps":["trace[1748502846] 'process raft request' (duration: 100.886869ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T23:05:16.881389Z","caller":"traceutil/trace.go:171","msg":"trace[514628490] transaction","detail":"{read_only:false; response_revision:8730; number_of_response:1; }","duration":"112.127408ms","start":"2026-04-16T23:05:16.769225Z","end":"2026-04-16T23:05:16.881353Z","steps":["trace[514628490] 'process raft request' (duration: 111.910982ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T23:05:16.881562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.497604ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-tk9mn\" ","response":"range_response_count:1 size:4645"} {"level":"info","ts":"2026-04-16T23:05:16.881608Z","caller":"traceutil/trace.go:171","msg":"trace[1795181833] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-tk9mn; range_end:; response_count:1; response_revision:8730; }","duration":"126.598278ms","start":"2026-04-16T23:05:16.754997Z","end":"2026-04-16T23:05:16.881595Z","steps":["trace[1795181833] 'agreement among raft nodes before linearized reading' (duration: 126.458164ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T23:05:16.881806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.996949ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T23:05:16.881849Z","caller":"traceutil/trace.go:171","msg":"trace[1568049794] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:8730; }","duration":"115.064411ms","start":"2026-04-16T23:05:16.766774Z","end":"2026-04-16T23:05:16.881839Z","steps":["trace[1568049794] 'agreement among raft nodes before linearized reading' (duration: 114.997349ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T23:05:17.734813Z","caller":"traceutil/trace.go:171","msg":"trace[968163188] transaction","detail":"{read_only:false; response_revision:8733; number_of_response:1; }","duration":"116.530933ms","start":"2026-04-16T23:05:17.618246Z","end":"2026-04-16T23:05:17.734777Z","steps":["trace[968163188] 'process raft request' (duration: 65.196728ms)","trace[968163188] 'compare' (duration: 51.057198ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T23:05:18.354743Z","caller":"traceutil/trace.go:171","msg":"trace[1458765400] transaction","detail":"{read_only:false; response_revision:8739; number_of_response:1; }","duration":"117.384987ms","start":"2026-04-16T23:05:18.237329Z","end":"2026-04-16T23:05:18.354714Z","steps":["trace[1458765400] 'process raft request' (duration: 117.148191ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T23:05:18.37255Z","caller":"traceutil/trace.go:171","msg":"trace[1479274241] transaction","detail":"{read_only:false; response_revision:8741; number_of_response:1; }","duration":"134.893523ms","start":"2026-04-16T23:05:18.237635Z","end":"2026-04-16T23:05:18.372529Z","steps":["trace[1479274241] 'process raft request' (duration: 134.644376ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T23:05:18.372533Z","caller":"traceutil/trace.go:171","msg":"trace[2058734559] transaction","detail":"{read_only:false; response_revision:8740; number_of_response:1; }","duration":"135.081218ms","start":"2026-04-16T23:05:18.23738Z","end":"2026-04-16T23:05:18.372461Z","steps":["trace[2058734559] 'process raft request' (duration: 134.683797ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T23:05:18.372554Z","caller":"traceutil/trace.go:171","msg":"trace[477436913] linearizableReadLoop","detail":"{readStateIndex:9059; appliedIndex:9057; }","duration":"133.938967ms","start":"2026-04-16T23:05:18.238583Z","end":"2026-04-16T23:05:18.372522Z","steps":["trace[477436913] 'read index received' (duration: 116.101811ms)","trace[477436913] 'applied index is now lower than readState.Index' (duration: 17.835086ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T23:05:18.37295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.338828ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-pvv5z\" ","response":"range_response_count:1 size:6531"} {"level":"info","ts":"2026-04-16T23:05:18.373028Z","caller":"traceutil/trace.go:171","msg":"trace[1050436801] range","detail":"{range_begin:/registry/pods/openstack/keepalived-pvv5z; range_end:; response_count:1; response_revision:8741; }","duration":"134.465661ms","start":"2026-04-16T23:05:18.238543Z","end":"2026-04-16T23:05:18.373009Z","steps":["trace[1050436801] 'agreement among raft nodes before linearized reading' (duration: 134.101151ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T23:05:18.465863Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.644138ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0\" ","response":"range_response_count:1 size:1342"} {"level":"info","ts":"2026-04-16T23:05:18.465962Z","caller":"traceutil/trace.go:171","msg":"trace[1481481212] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0; range_end:; response_count:1; response_revision:8741; }","duration":"224.760941ms","start":"2026-04-16T23:05:18.241175Z","end":"2026-04-16T23:05:18.465936Z","steps":["trace[1481481212] 'agreement among raft nodes before linearized reading' (duration: 224.439451ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T23:05:32.260713Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002405.wal"} {"level":"info","ts":"2026-04-16T23:06:56.657737Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"35b2766da46a76bb","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-16T23:06:56.66578Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-04-16T23:06:56.665945Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-04-16T23:09:00.152783Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8048} {"level":"info","ts":"2026-04-16T23:09:00.217166Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8048,"took":"61.688442ms","hash":1158189587,"current-db-size-bytes":58052608,"current-db-size":"58 MB","current-db-size-in-use-bytes":29265920,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-04-16T23:09:00.21724Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1158189587,"revision":8048,"compact-revision":5956} {"level":"info","ts":"2026-04-16T23:14:00.169013Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10613} {"level":"info","ts":"2026-04-16T23:14:00.251226Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10613,"took":"79.122243ms","hash":938980971,"current-db-size-bytes":58052608,"current-db-size":"58 MB","current-db-size-in-use-bytes":21946368,"current-db-size-in-use":"22 MB"} {"level":"info","ts":"2026-04-16T23:14:00.251291Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":938980971,"revision":10613,"compact-revision":8048}