{"level":"warn","ts":"2026-04-20T02:04:03.967782Z","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-20T02:04:03.967868Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.49: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.49:2380","--initial-cluster=instance=https://199.204.45.49:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.49:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.49: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-20T02:04:03.967939Z","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-20T02:04:03.967956Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.49:2380"]} {"level":"info","ts":"2026-04-20T02:04:03.967977Z","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-20T02:04:03.968664Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.49:2379"]} {"level":"info","ts":"2026-04-20T02:04:03.968752Z","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.49:2380"],"listen-peer-urls":["https://199.204.45.49:2380"],"advertise-client-urls":["https://199.204.45.49:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.49:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.49: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-20T02:04:03.972496Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.493887ms"} {"level":"info","ts":"2026-04-20T02:04:03.978232Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"d0ba3c4de8c6ef7a","cluster-id":"e76701b877f442ac"} {"level":"info","ts":"2026-04-20T02:04:03.978303Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0ba3c4de8c6ef7a switched to configuration voters=()"} {"level":"info","ts":"2026-04-20T02:04:03.978324Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0ba3c4de8c6ef7a became follower at term 0"} {"level":"info","ts":"2026-04-20T02:04:03.978352Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft d0ba3c4de8c6ef7a [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-20T02:04:03.978364Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0ba3c4de8c6ef7a became follower at term 1"} {"level":"info","ts":"2026-04-20T02:04:03.978405Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0ba3c4de8c6ef7a switched to configuration voters=(15040400210872692602)"} {"level":"warn","ts":"2026-04-20T02:04:03.983773Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-20T02:04:03.985181Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-20T02:04:03.986603Z","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-20T02:04:03.988684Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"d0ba3c4de8c6ef7a","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-20T02:04:03.9888Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"d0ba3c4de8c6ef7a","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-20T02:04:03.989009Z","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-20T02:04:03.989616Z","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-20T02:04:03.989662Z","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-20T02:04:03.98978Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0ba3c4de8c6ef7a switched to configuration voters=(15040400210872692602)"} {"level":"info","ts":"2026-04-20T02:04:03.989963Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"e76701b877f442ac","local-member-id":"d0ba3c4de8c6ef7a","added-peer-id":"d0ba3c4de8c6ef7a","added-peer-peer-urls":["https://199.204.45.49:2380"]} {"level":"info","ts":"2026-04-20T02:04:03.992762Z","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-20T02:04:03.992902Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.49:2380"} {"level":"info","ts":"2026-04-20T02:04:03.992964Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"d0ba3c4de8c6ef7a","initial-advertise-peer-urls":["https://199.204.45.49:2380"],"listen-peer-urls":["https://199.204.45.49:2380"],"advertise-client-urls":["https://199.204.45.49:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.49:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-20T02:04:03.993014Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.49:2380"} {"level":"info","ts":"2026-04-20T02:04:03.993032Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-20T02:04:04.879421Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0ba3c4de8c6ef7a is starting a new election at term 1"} {"level":"info","ts":"2026-04-20T02:04:04.87947Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0ba3c4de8c6ef7a became pre-candidate at term 1"} {"level":"info","ts":"2026-04-20T02:04:04.879499Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0ba3c4de8c6ef7a received MsgPreVoteResp from d0ba3c4de8c6ef7a at term 1"} {"level":"info","ts":"2026-04-20T02:04:04.879514Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0ba3c4de8c6ef7a became candidate at term 2"} {"level":"info","ts":"2026-04-20T02:04:04.879523Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0ba3c4de8c6ef7a received MsgVoteResp from d0ba3c4de8c6ef7a at term 2"} {"level":"info","ts":"2026-04-20T02:04:04.879534Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0ba3c4de8c6ef7a became leader at term 2"} {"level":"info","ts":"2026-04-20T02:04:04.879549Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: d0ba3c4de8c6ef7a elected leader d0ba3c4de8c6ef7a at term 2"} {"level":"info","ts":"2026-04-20T02:04:04.880509Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"d0ba3c4de8c6ef7a","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.49:2379]}","request-path":"/0/members/d0ba3c4de8c6ef7a/attributes","cluster-id":"e76701b877f442ac","publish-timeout":"7s"} {"level":"info","ts":"2026-04-20T02:04:04.880552Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-20T02:04:04.880616Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-20T02:04:04.880761Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-20T02:04:04.880768Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T02:04:04.88082Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-20T02:04:04.881819Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"e76701b877f442ac","local-member-id":"d0ba3c4de8c6ef7a","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T02:04:04.881902Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T02:04:04.881934Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T02:04:04.884375Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-20T02:04:04.884375Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.49:2379"} {"level":"info","ts":"2026-04-20T02:04:22.623855Z","caller":"traceutil/trace.go:171","msg":"trace[502141380] transaction","detail":"{read_only:false; response_revision:420; number_of_response:1; }","duration":"105.924347ms","start":"2026-04-20T02:04:22.517909Z","end":"2026-04-20T02:04:22.623833Z","steps":["trace[502141380] 'process raft request' (duration: 105.805543ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:04:22.961154Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.600699ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-20T02:04:22.961373Z","caller":"traceutil/trace.go:171","msg":"trace[2103135136] linearizableReadLoop","detail":"{readStateIndex:434; appliedIndex:433; }","duration":"172.309593ms","start":"2026-04-20T02:04:22.789018Z","end":"2026-04-20T02:04:22.961328Z","steps":["trace[2103135136] 'read index received' (duration: 80.012µs)","trace[2103135136] 'applied index is now lower than readState.Index' (duration: 172.226921ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T02:04:22.961528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.519759ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T02:04:22.961567Z","caller":"traceutil/trace.go:171","msg":"trace[2069954755] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:421; }","duration":"172.603801ms","start":"2026-04-20T02:04:22.78895Z","end":"2026-04-20T02:04:22.961554Z","steps":["trace[2069954755] 'agreement among raft nodes before linearized reading' (duration: 172.530889ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:04:22.961575Z","caller":"traceutil/trace.go:171","msg":"trace[965728722] transaction","detail":"{read_only:false; response_revision:421; number_of_response:1; }","duration":"295.806366ms","start":"2026-04-20T02:04:22.665571Z","end":"2026-04-20T02:04:22.961377Z","steps":["trace[965728722] 'process raft request' (duration: 108.569981ms)","trace[965728722] 'compare' (duration: 181.454655ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T02:04:22.961697Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.662647ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/coredns\" ","response":"range_response_count:1 size:4056"} {"level":"info","ts":"2026-04-20T02:04:22.961782Z","caller":"traceutil/trace.go:171","msg":"trace[1867477663] range","detail":"{range_begin:/registry/deployments/kube-system/coredns; range_end:; response_count:1; response_revision:421; }","duration":"132.79008ms","start":"2026-04-20T02:04:22.828968Z","end":"2026-04-20T02:04:22.961759Z","steps":["trace[1867477663] 'agreement among raft nodes before linearized reading' (duration: 132.572664ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:04:36.300458Z","caller":"traceutil/trace.go:171","msg":"trace[1232311282] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"109.274731ms","start":"2026-04-20T02:04:36.19116Z","end":"2026-04-20T02:04:36.300435Z","steps":["trace[1232311282] 'process raft request' (duration: 109.2354ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:04:36.30059Z","caller":"traceutil/trace.go:171","msg":"trace[1129921050] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"149.687098ms","start":"2026-04-20T02:04:36.150871Z","end":"2026-04-20T02:04:36.300558Z","steps":["trace[1129921050] 'process raft request' (duration: 149.123592ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:04:36.300598Z","caller":"traceutil/trace.go:171","msg":"trace[1399485053] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"119.811802ms","start":"2026-04-20T02:04:36.180702Z","end":"2026-04-20T02:04:36.300514Z","steps":["trace[1399485053] 'process raft request' (duration: 119.545814ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:04:36.300808Z","caller":"traceutil/trace.go:171","msg":"trace[1789165843] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"129.049048ms","start":"2026-04-20T02:04:36.171709Z","end":"2026-04-20T02:04:36.300758Z","steps":["trace[1789165843] 'process raft request' (duration: 128.466001ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:04:36.300634Z","caller":"traceutil/trace.go:171","msg":"trace[5391752] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"146.721356ms","start":"2026-04-20T02:04:36.153862Z","end":"2026-04-20T02:04:36.300584Z","steps":["trace[5391752] 'process raft request' (duration: 146.232252ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:04:36.300818Z","caller":"traceutil/trace.go:171","msg":"trace[1668792638] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"119.923345ms","start":"2026-04-20T02:04:36.180813Z","end":"2026-04-20T02:04:36.300736Z","steps":["trace[1668792638] 'process raft request' (duration: 119.463092ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:04:36.300772Z","caller":"traceutil/trace.go:171","msg":"trace[1663344853] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"118.686012ms","start":"2026-04-20T02:04:36.18207Z","end":"2026-04-20T02:04:36.300756Z","steps":["trace[1663344853] 'process raft request' (duration: 118.254449ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:04:36.300942Z","caller":"traceutil/trace.go:171","msg":"trace[587835539] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"131.32454ms","start":"2026-04-20T02:04:36.169119Z","end":"2026-04-20T02:04:36.300444Z","steps":["trace[587835539] 'process raft request' (duration: 131.018311ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:04:36.300794Z","caller":"traceutil/trace.go:171","msg":"trace[1099976993] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"127.739501ms","start":"2026-04-20T02:04:36.17304Z","end":"2026-04-20T02:04:36.30078Z","steps":["trace[1099976993] 'process raft request' (duration: 127.169645ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:04:36.311127Z","caller":"traceutil/trace.go:171","msg":"trace[110054416] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"106.126633ms","start":"2026-04-20T02:04:36.20497Z","end":"2026-04-20T02:04:36.311097Z","steps":["trace[110054416] 'process raft request' (duration: 105.62762ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:04:42.82374Z","caller":"traceutil/trace.go:171","msg":"trace[1356176516] linearizableReadLoop","detail":"{readStateIndex:648; appliedIndex:647; }","duration":"101.904536ms","start":"2026-04-20T02:04:42.721805Z","end":"2026-04-20T02:04:42.82371Z","steps":["trace[1356176516] 'read index received' (duration: 101.173496ms)","trace[1356176516] 'applied index is now lower than readState.Index' (duration: 729.95µs)"],"step_count":2} {"level":"info","ts":"2026-04-20T02:04:42.823773Z","caller":"traceutil/trace.go:171","msg":"trace[1002550360] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"268.585894ms","start":"2026-04-20T02:04:42.555156Z","end":"2026-04-20T02:04:42.823742Z","steps":["trace[1002550360] 'process raft request' (duration: 268.055989ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:04:42.824067Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.231606ms","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-20T02:04:42.824222Z","caller":"traceutil/trace.go:171","msg":"trace[712482551] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:624; }","duration":"102.451541ms","start":"2026-04-20T02:04:42.721746Z","end":"2026-04-20T02:04:42.824197Z","steps":["trace[712482551] 'agreement among raft nodes before linearized reading' (duration: 102.099282ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:04:43.153454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.892465ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-20T02:04:43.153564Z","caller":"traceutil/trace.go:171","msg":"trace[1601466664] linearizableReadLoop","detail":"{readStateIndex:649; appliedIndex:648; }","duration":"265.126099ms","start":"2026-04-20T02:04:42.88842Z","end":"2026-04-20T02:04:43.153546Z","steps":["trace[1601466664] 'read index received' (duration: 73.642µs)","trace[1601466664] 'applied index is now lower than readState.Index' (duration: 265.051247ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T02:04:43.153643Z","caller":"traceutil/trace.go:171","msg":"trace[2131876400] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"324.703815ms","start":"2026-04-20T02:04:42.828929Z","end":"2026-04-20T02:04:43.153632Z","steps":["trace[2131876400] 'process raft request' (duration: 39.548364ms)","trace[2131876400] 'compare' (duration: 284.73999ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T02:04:43.153707Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:04:42.828899Z","time spent":"324.777087ms","remote":"127.0.0.1:52492","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T02:04:43.153914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.466808ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-28knw\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-04-20T02:04:43.154055Z","caller":"traceutil/trace.go:171","msg":"trace[99013383] range","detail":"{range_begin:/registry/pods/kube-system/cilium-28knw; range_end:; response_count:1; response_revision:625; }","duration":"265.680243ms","start":"2026-04-20T02:04:42.888349Z","end":"2026-04-20T02:04:43.154029Z","steps":["trace[99013383] 'agreement among raft nodes before linearized reading' (duration: 265.353634ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:04:43.321376Z","caller":"traceutil/trace.go:171","msg":"trace[174901341] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"153.7383ms","start":"2026-04-20T02:04:43.167616Z","end":"2026-04-20T02:04:43.321354Z","steps":["trace[174901341] 'process raft request' (duration: 153.687208ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:04:43.321383Z","caller":"traceutil/trace.go:171","msg":"trace[380594470] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"425.700536ms","start":"2026-04-20T02:04:42.895645Z","end":"2026-04-20T02:04:43.321346Z","steps":["trace[380594470] 'process raft request' (duration: 375.078197ms)","trace[380594470] 'compare' (duration: 50.434154ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T02:04:43.321538Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:04:42.895618Z","time spent":"425.845201ms","remote":"127.0.0.1:52464","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-20T02:04:43.321651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.845657ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-20T02:04:43.321744Z","caller":"traceutil/trace.go:171","msg":"trace[2028275821] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:627; }","duration":"253.990061ms","start":"2026-04-20T02:04:43.06774Z","end":"2026-04-20T02:04:43.32173Z","steps":["trace[2028275821] 'agreement among raft nodes before linearized reading' (duration: 253.714593ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:04:43.32176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.34223ms","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-20T02:04:43.321795Z","caller":"traceutil/trace.go:171","msg":"trace[1869375368] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:627; }","duration":"258.424782ms","start":"2026-04-20T02:04:43.063361Z","end":"2026-04-20T02:04:43.321786Z","steps":["trace[1869375368] 'agreement among raft nodes before linearized reading' (duration: 258.291549ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:04:43.322072Z","caller":"traceutil/trace.go:171","msg":"trace[743583350] linearizableReadLoop","detail":"{readStateIndex:650; appliedIndex:649; }","duration":"167.807919ms","start":"2026-04-20T02:04:43.153591Z","end":"2026-04-20T02:04:43.321399Z","steps":["trace[743583350] 'read index received' (duration: 117.143039ms)","trace[743583350] 'applied index is now lower than readState.Index' (duration: 50.65915ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T02:04:43.322584Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.035696ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T02:04:43.322632Z","caller":"traceutil/trace.go:171","msg":"trace[82067067] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:627; }","duration":"100.107007ms","start":"2026-04-20T02:04:43.222513Z","end":"2026-04-20T02:04:43.32262Z","steps":["trace[82067067] 'agreement among raft nodes before linearized reading' (duration: 100.034835ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:06:08.689335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.119426ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-20T02:06:08.689651Z","caller":"traceutil/trace.go:171","msg":"trace[194129067] linearizableReadLoop","detail":"{readStateIndex:1902; appliedIndex:1900; }","duration":"228.138402ms","start":"2026-04-20T02:06:08.461485Z","end":"2026-04-20T02:06:08.689624Z","steps":["trace[194129067] 'read index received' (duration: 40.551µs)","trace[194129067] 'applied index is now lower than readState.Index' (duration: 228.096541ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T02:06:08.68967Z","caller":"traceutil/trace.go:171","msg":"trace[693945268] transaction","detail":"{read_only:false; response_revision:1830; number_of_response:1; }","duration":"325.615359ms","start":"2026-04-20T02:06:08.364027Z","end":"2026-04-20T02:06:08.689643Z","steps":["trace[693945268] 'process raft request' (duration: 325.503826ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:06:08.689783Z","caller":"traceutil/trace.go:171","msg":"trace[419203715] transaction","detail":"{read_only:false; response_revision:1829; number_of_response:1; }","duration":"344.879398ms","start":"2026-04-20T02:06:08.344884Z","end":"2026-04-20T02:06:08.689763Z","steps":["trace[419203715] 'process raft request' (duration: 102.178516ms)","trace[419203715] 'compare' (duration: 241.970392ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T02:06:08.689832Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:06:08.363999Z","time spent":"325.748302ms","remote":"127.0.0.1:52492","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T02:06:08.689879Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:06:08.344874Z","time spent":"344.95321ms","remote":"127.0.0.1:52396","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3728,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T02:06:08.689862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.352399ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-20T02:06:08.689901Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.74088ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-20T02:06:08.689964Z","caller":"traceutil/trace.go:171","msg":"trace[454840460] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1830; }","duration":"141.830963ms","start":"2026-04-20T02:06:08.548117Z","end":"2026-04-20T02:06:08.689948Z","steps":["trace[454840460] 'agreement among raft nodes before linearized reading' (duration: 141.642208ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:06:08.689963Z","caller":"traceutil/trace.go:171","msg":"trace[2035114378] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:1830; }","duration":"228.503083ms","start":"2026-04-20T02:06:08.461436Z","end":"2026-04-20T02:06:08.689939Z","steps":["trace[2035114378] 'agreement among raft nodes before linearized reading' (duration: 228.301927ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:06:53.074569Z","caller":"traceutil/trace.go:171","msg":"trace[1305226328] transaction","detail":"{read_only:false; response_revision:2126; number_of_response:1; }","duration":"116.124761ms","start":"2026-04-20T02:06:52.958396Z","end":"2026-04-20T02:06:53.07452Z","steps":["trace[1305226328] 'process raft request' (duration: 115.926876ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:06:53.270808Z","caller":"traceutil/trace.go:171","msg":"trace[1979469684] linearizableReadLoop","detail":"{readStateIndex:2208; appliedIndex:2207; }","duration":"144.006478ms","start":"2026-04-20T02:06:53.12677Z","end":"2026-04-20T02:06:53.270777Z","steps":["trace[1979469684] 'read index received' (duration: 60.42299ms)","trace[1979469684] 'applied index is now lower than readState.Index' (duration: 83.581948ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T02:06:53.270814Z","caller":"traceutil/trace.go:171","msg":"trace[1741074652] transaction","detail":"{read_only:false; response_revision:2127; number_of_response:1; }","duration":"172.531272ms","start":"2026-04-20T02:06:53.098239Z","end":"2026-04-20T02:06:53.27077Z","steps":["trace[1741074652] 'process raft request' (duration: 88.957064ms)","trace[1741074652] 'compare' (duration: 83.092364ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T02:06:53.270846Z","caller":"traceutil/trace.go:171","msg":"trace[349232471] transaction","detail":"{read_only:false; response_revision:2128; number_of_response:1; }","duration":"138.26641ms","start":"2026-04-20T02:06:53.132535Z","end":"2026-04-20T02:06:53.270801Z","steps":["trace[349232471] 'process raft request' (duration: 137.89817ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:06:53.300133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.328994ms","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-04-20T02:06:53.30024Z","caller":"traceutil/trace.go:171","msg":"trace[974853228] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2128; }","duration":"173.476158ms","start":"2026-04-20T02:06:53.126737Z","end":"2026-04-20T02:06:53.300213Z","steps":["trace[974853228] 'agreement among raft nodes before linearized reading' (duration: 144.130041ms)","trace[974853228] 'range keys from in-memory index tree' (duration: 29.10037ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T02:07:04.158054Z","caller":"traceutil/trace.go:171","msg":"trace[483459271] transaction","detail":"{read_only:false; response_revision:2186; number_of_response:1; }","duration":"103.420823ms","start":"2026-04-20T02:07:04.054592Z","end":"2026-04-20T02:07:04.158013Z","steps":["trace[483459271] 'process raft request' (duration: 94.771125ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:08:21.97704Z","caller":"traceutil/trace.go:171","msg":"trace[653501944] transaction","detail":"{read_only:false; response_revision:2656; number_of_response:1; }","duration":"114.659632ms","start":"2026-04-20T02:08:21.862343Z","end":"2026-04-20T02:08:21.977003Z","steps":["trace[653501944] 'process raft request' (duration: 100.461564ms)","trace[653501944] 'compare' (duration: 14.064434ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T02:08:22.440097Z","caller":"traceutil/trace.go:171","msg":"trace[1760273454] transaction","detail":"{read_only:false; response_revision:2657; number_of_response:1; }","duration":"179.238556ms","start":"2026-04-20T02:08:22.260828Z","end":"2026-04-20T02:08:22.440066Z","steps":["trace[1760273454] 'process raft request' (duration: 179.055551ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:10:58.389515Z","caller":"traceutil/trace.go:171","msg":"trace[1574265862] transaction","detail":"{read_only:false; response_revision:3668; number_of_response:1; }","duration":"142.704941ms","start":"2026-04-20T02:10:58.246761Z","end":"2026-04-20T02:10:58.389466Z","steps":["trace[1574265862] 'process raft request' (duration: 105.292609ms)","trace[1574265862] 'compare' (duration: 37.031602ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T02:12:21.019892Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.749224ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T02:12:21.019983Z","caller":"traceutil/trace.go:171","msg":"trace[1586216754] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4830; }","duration":"229.878677ms","start":"2026-04-20T02:12:20.790085Z","end":"2026-04-20T02:12:21.019964Z","steps":["trace[1586216754] 'range keys from in-memory index tree' (duration: 229.64124ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:12:21.02004Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.951516ms","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-20T02:12:21.020391Z","caller":"traceutil/trace.go:171","msg":"trace[445084192] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4830; }","duration":"187.390788ms","start":"2026-04-20T02:12:20.832978Z","end":"2026-04-20T02:12:21.020369Z","steps":["trace[445084192] 'range keys from in-memory index tree' (duration: 186.654818ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:12:22.81223Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.498116ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/monitoring/goldpinger\" ","response":"range_response_count:1 size:799"} {"level":"info","ts":"2026-04-20T02:12:22.812331Z","caller":"traceutil/trace.go:171","msg":"trace[252291250] range","detail":"{range_begin:/registry/serviceaccounts/monitoring/goldpinger; range_end:; response_count:1; response_revision:4876; }","duration":"124.702632ms","start":"2026-04-20T02:12:22.687605Z","end":"2026-04-20T02:12:22.812308Z","steps":["trace[252291250] 'range keys from in-memory index tree' (duration: 124.25359ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:12:22.812706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.433934ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:26 size:822305"} {"level":"info","ts":"2026-04-20T02:12:22.812802Z","caller":"traceutil/trace.go:171","msg":"trace[963265290] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:26; response_revision:4876; }","duration":"118.570287ms","start":"2026-04-20T02:12:22.694212Z","end":"2026-04-20T02:12:22.812782Z","steps":["trace[963265290] 'range keys from in-memory index tree' (duration: 117.871478ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:12:39.633789Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"478.392098ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-20T02:12:39.633866Z","caller":"traceutil/trace.go:171","msg":"trace[880013117] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5193; }","duration":"478.506941ms","start":"2026-04-20T02:12:39.155342Z","end":"2026-04-20T02:12:39.633849Z","steps":["trace[880013117] 'range keys from in-memory index tree' (duration: 478.213963ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:12:39.633922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.641562ms","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-20T02:12:39.633982Z","caller":"traceutil/trace.go:171","msg":"trace[1137656274] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5193; }","duration":"212.705033ms","start":"2026-04-20T02:12:39.421262Z","end":"2026-04-20T02:12:39.633967Z","steps":["trace[1137656274] 'range keys from in-memory index tree' (duration: 212.474357ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:12:39.634022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.232296ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:557"} {"level":"info","ts":"2026-04-20T02:12:39.634113Z","caller":"traceutil/trace.go:171","msg":"trace[529037568] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5193; }","duration":"186.35706ms","start":"2026-04-20T02:12:39.447737Z","end":"2026-04-20T02:12:39.634094Z","steps":["trace[529037568] 'range keys from in-memory index tree' (duration: 186.072212ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:12:39.634028Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.853783ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-ddde8d9f-285d-4303-8afb-8db0c4277c5c\" ","response":"range_response_count:1 size:3645"} {"level":"info","ts":"2026-04-20T02:12:39.634231Z","caller":"traceutil/trace.go:171","msg":"trace[455028309] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-ddde8d9f-285d-4303-8afb-8db0c4277c5c; range_end:; response_count:1; response_revision:5193; }","duration":"292.273475ms","start":"2026-04-20T02:12:39.341891Z","end":"2026-04-20T02:12:39.634164Z","steps":["trace[455028309] 'range keys from in-memory index tree' (duration: 291.662258ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:12:39.633903Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:12:39.155329Z","time spent":"478.564882ms","remote":"127.0.0.1:52492","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-20T02:14:04.905336Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2882} {"level":"info","ts":"2026-04-20T02:14:04.965853Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2882,"took":"58.768741ms","hash":3560226764,"current-db-size-bytes":57319424,"current-db-size":"57 MB","current-db-size-in-use-bytes":33320960,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-04-20T02:14:04.965936Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3560226764,"revision":2882,"compact-revision":-1} {"level":"info","ts":"2026-04-20T02:18:27.956925Z","caller":"traceutil/trace.go:171","msg":"trace[875197368] linearizableReadLoop","detail":"{readStateIndex:8230; appliedIndex:8229; }","duration":"165.975717ms","start":"2026-04-20T02:18:27.790922Z","end":"2026-04-20T02:18:27.956898Z","steps":["trace[875197368] 'read index received' (duration: 165.827033ms)","trace[875197368] 'applied index is now lower than readState.Index' (duration: 147.604µs)"],"step_count":2} {"level":"info","ts":"2026-04-20T02:18:27.957263Z","caller":"traceutil/trace.go:171","msg":"trace[227574838] transaction","detail":"{read_only:false; response_revision:7952; number_of_response:1; }","duration":"195.065247ms","start":"2026-04-20T02:18:27.762184Z","end":"2026-04-20T02:18:27.957249Z","steps":["trace[227574838] 'process raft request' (duration: 194.544853ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:18:27.957671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.746569ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T02:18:27.957751Z","caller":"traceutil/trace.go:171","msg":"trace[2145871936] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:7952; }","duration":"166.915173ms","start":"2026-04-20T02:18:27.790818Z","end":"2026-04-20T02:18:27.957733Z","steps":["trace[2145871936] 'agreement among raft nodes before linearized reading' (duration: 166.79936ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:19:04.911448Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6001} {"level":"info","ts":"2026-04-20T02:19:05.015551Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6001,"took":"102.084765ms","hash":2338900723,"current-db-size-bytes":57319424,"current-db-size":"57 MB","current-db-size-in-use-bytes":22515712,"current-db-size-in-use":"22 MB"} {"level":"info","ts":"2026-04-20T02:19:05.015647Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2338900723,"revision":6001,"compact-revision":2882} {"level":"info","ts":"2026-04-20T02:19:20.853635Z","caller":"traceutil/trace.go:171","msg":"trace[828317961] transaction","detail":"{read_only:false; response_revision:8328; number_of_response:1; }","duration":"133.322783ms","start":"2026-04-20T02:19:20.720268Z","end":"2026-04-20T02:19:20.853591Z","steps":["trace[828317961] 'process raft request' (duration: 132.915332ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:19:21.319114Z","caller":"traceutil/trace.go:171","msg":"trace[1136189051] transaction","detail":"{read_only:false; response_revision:8330; number_of_response:1; }","duration":"123.340372ms","start":"2026-04-20T02:19:21.195743Z","end":"2026-04-20T02:19:21.319083Z","steps":["trace[1136189051] 'process raft request' (duration: 92.610059ms)","trace[1136189051] 'compare' (duration: 30.594949ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T02:19:22.18081Z","caller":"traceutil/trace.go:171","msg":"trace[1875288501] transaction","detail":"{read_only:false; response_revision:8335; number_of_response:1; }","duration":"283.682976ms","start":"2026-04-20T02:19:21.897052Z","end":"2026-04-20T02:19:22.180735Z","steps":["trace[1875288501] 'process raft request' (duration: 237.877604ms)","trace[1875288501] 'compare' (duration: 45.399911ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T02:19:22.180889Z","caller":"traceutil/trace.go:171","msg":"trace[1016943488] transaction","detail":"{read_only:false; response_revision:8338; number_of_response:1; }","duration":"280.061408ms","start":"2026-04-20T02:19:21.900798Z","end":"2026-04-20T02:19:22.180859Z","steps":["trace[1016943488] 'process raft request' (duration: 279.879883ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:19:22.180844Z","caller":"traceutil/trace.go:171","msg":"trace[339892390] transaction","detail":"{read_only:false; response_revision:8336; number_of_response:1; }","duration":"282.959167ms","start":"2026-04-20T02:19:21.897798Z","end":"2026-04-20T02:19:22.180757Z","steps":["trace[339892390] 'process raft request' (duration: 282.751451ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:19:22.180896Z","caller":"traceutil/trace.go:171","msg":"trace[99742326] transaction","detail":"{read_only:false; response_revision:8337; number_of_response:1; }","duration":"282.938286ms","start":"2026-04-20T02:19:21.897889Z","end":"2026-04-20T02:19:22.180828Z","steps":["trace[99742326] 'process raft request' (duration: 282.746881ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:19:22.180927Z","caller":"traceutil/trace.go:171","msg":"trace[1077171864] transaction","detail":"{read_only:false; response_revision:8339; number_of_response:1; }","duration":"279.508343ms","start":"2026-04-20T02:19:21.90138Z","end":"2026-04-20T02:19:22.180888Z","steps":["trace[1077171864] 'process raft request' (duration: 279.3976ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:19:22.181232Z","caller":"traceutil/trace.go:171","msg":"trace[115771503] linearizableReadLoop","detail":"{readStateIndex:8634; appliedIndex:8629; }","duration":"220.405872ms","start":"2026-04-20T02:19:21.960439Z","end":"2026-04-20T02:19:22.180845Z","steps":["trace[115771503] 'read index received' (duration: 174.519808ms)","trace[115771503] 'applied index is now lower than readState.Index' (duration: 45.884974ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T02:19:22.181299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.814503ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephclusters/openstack/ceph\" ","response":"range_response_count:1 size:5146"} {"level":"info","ts":"2026-04-20T02:19:22.181633Z","caller":"traceutil/trace.go:171","msg":"trace[1386353229] range","detail":"{range_begin:/registry/ceph.rook.io/cephclusters/openstack/ceph; range_end:; response_count:1; response_revision:8339; }","duration":"221.202863ms","start":"2026-04-20T02:19:21.960389Z","end":"2026-04-20T02:19:22.181592Z","steps":["trace[1386353229] 'agreement among raft nodes before linearized reading' (duration: 220.674629ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:19:22.853953Z","caller":"traceutil/trace.go:171","msg":"trace[1269026271] transaction","detail":"{read_only:false; response_revision:8343; number_of_response:1; }","duration":"166.85396ms","start":"2026-04-20T02:19:22.687057Z","end":"2026-04-20T02:19:22.853911Z","steps":["trace[1269026271] 'process raft request' (duration: 166.517381ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:20:22.709508Z","caller":"traceutil/trace.go:171","msg":"trace[1904073452] transaction","detail":"{read_only:false; response_revision:8937; number_of_response:1; }","duration":"112.482358ms","start":"2026-04-20T02:20:22.596982Z","end":"2026-04-20T02:20:22.709465Z","steps":["trace[1904073452] 'process raft request' (duration: 98.383496ms)","trace[1904073452] 'compare' (duration: 13.867645ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T02:20:28.895155Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002459.wal"} {"level":"info","ts":"2026-04-20T02:21:51.540934Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"d0ba3c4de8c6ef7a","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-20T02:21:51.545959Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-04-20T02:21:51.546046Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-04-20T02:24:04.918731Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8199} {"level":"info","ts":"2026-04-20T02:24:05.001591Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8199,"took":"80.678915ms","hash":1300643322,"current-db-size-bytes":57319424,"current-db-size":"57 MB","current-db-size-in-use-bytes":24379392,"current-db-size-in-use":"24 MB"} {"level":"info","ts":"2026-04-20T02:24:05.001695Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1300643322,"revision":8199,"compact-revision":6001} {"level":"info","ts":"2026-04-20T02:29:04.924698Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10581} {"level":"info","ts":"2026-04-20T02:29:05.001825Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10581,"took":"75.278742ms","hash":3397881170,"current-db-size-bytes":57319424,"current-db-size":"57 MB","current-db-size-in-use-bytes":19935232,"current-db-size-in-use":"20 MB"} {"level":"info","ts":"2026-04-20T02:29:05.001882Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3397881170,"revision":10581,"compact-revision":8199}