{"level":"warn","ts":"2026-03-20T05:30:41.696261Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-03-20T05:30:41.69635Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.250: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.250:2380","--initial-cluster=instance=https://199.204.45.250:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.250:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.250:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-03-20T05:30:41.696423Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-03-20T05:30:41.696436Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.250:2380"]} {"level":"info","ts":"2026-03-20T05:30:41.696456Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-03-20T05:30:41.697142Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.250:2379"]} {"level":"info","ts":"2026-03-20T05:30:41.697219Z","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.250:2380"],"listen-peer-urls":["https://199.204.45.250:2380"],"advertise-client-urls":["https://199.204.45.250:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.250:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.250:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-03-20T05:30:41.913991Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"157.597031ms"} {"level":"info","ts":"2026-03-20T05:30:41.963411Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"d98d5f2c752cc52d","cluster-id":"c785b4aaf4bd3b11"} {"level":"info","ts":"2026-03-20T05:30:41.963497Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d switched to configuration voters=()"} {"level":"info","ts":"2026-03-20T05:30:41.963522Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d became follower at term 0"} {"level":"info","ts":"2026-03-20T05:30:41.963533Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft d98d5f2c752cc52d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-03-20T05:30:41.963547Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d became follower at term 1"} {"level":"info","ts":"2026-03-20T05:30:41.963586Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d switched to configuration voters=(15676290522495632685)"} {"level":"warn","ts":"2026-03-20T05:30:41.969493Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-03-20T05:30:41.970635Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-03-20T05:30:41.971886Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-03-20T05:30:41.974063Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"d98d5f2c752cc52d","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-03-20T05:30:41.974614Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"d98d5f2c752cc52d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-03-20T05:30:41.974635Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-03-20T05:30:41.975089Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-03-20T05:30:41.975125Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-03-20T05:30:41.975383Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d switched to configuration voters=(15676290522495632685)"} {"level":"info","ts":"2026-03-20T05:30:41.978077Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"c785b4aaf4bd3b11","local-member-id":"d98d5f2c752cc52d","added-peer-id":"d98d5f2c752cc52d","added-peer-peer-urls":["https://199.204.45.250:2380"]} {"level":"info","ts":"2026-03-20T05:30:41.98105Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-03-20T05:30:41.981204Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.250:2380"} {"level":"info","ts":"2026-03-20T05:30:41.981289Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.250:2380"} {"level":"info","ts":"2026-03-20T05:30:41.981398Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"d98d5f2c752cc52d","initial-advertise-peer-urls":["https://199.204.45.250:2380"],"listen-peer-urls":["https://199.204.45.250:2380"],"advertise-client-urls":["https://199.204.45.250:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.250:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-03-20T05:30:41.981474Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-03-20T05:30:42.864009Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d is starting a new election at term 1"} {"level":"info","ts":"2026-03-20T05:30:42.864076Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d became pre-candidate at term 1"} {"level":"info","ts":"2026-03-20T05:30:42.86412Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d received MsgPreVoteResp from d98d5f2c752cc52d at term 1"} {"level":"info","ts":"2026-03-20T05:30:42.86414Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d became candidate at term 2"} {"level":"info","ts":"2026-03-20T05:30:42.864151Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d received MsgVoteResp from d98d5f2c752cc52d at term 2"} {"level":"info","ts":"2026-03-20T05:30:42.864168Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d became leader at term 2"} {"level":"info","ts":"2026-03-20T05:30:42.864196Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: d98d5f2c752cc52d elected leader d98d5f2c752cc52d at term 2"} {"level":"info","ts":"2026-03-20T05:30:42.86506Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-03-20T05:30:42.865957Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"d98d5f2c752cc52d","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.250:2379]}","request-path":"/0/members/d98d5f2c752cc52d/attributes","cluster-id":"c785b4aaf4bd3b11","publish-timeout":"7s"} {"level":"info","ts":"2026-03-20T05:30:42.865958Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-03-20T05:30:42.865988Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-03-20T05:30:42.866229Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-03-20T05:30:42.866289Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-03-20T05:30:42.866565Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"c785b4aaf4bd3b11","local-member-id":"d98d5f2c752cc52d","cluster-version":"3.5"} {"level":"info","ts":"2026-03-20T05:30:42.8667Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-03-20T05:30:42.866744Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-03-20T05:30:42.868402Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.250:2379"} {"level":"info","ts":"2026-03-20T05:30:42.869639Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-03-20T05:31:01.069263Z","caller":"traceutil/trace.go:171","msg":"trace[1454425744] transaction","detail":"{read_only:false; response_revision:441; number_of_response:1; }","duration":"181.317475ms","start":"2026-03-20T05:31:00.887914Z","end":"2026-03-20T05:31:01.069232Z","steps":["trace[1454425744] 'process raft request' (duration: 181.15687ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T05:31:01.341549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.505713ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-03-20T05:31:01.34174Z","caller":"traceutil/trace.go:171","msg":"trace[186900297] linearizableReadLoop","detail":"{readStateIndex:457; appliedIndex:456; }","duration":"268.664645ms","start":"2026-03-20T05:31:01.073051Z","end":"2026-03-20T05:31:01.341715Z","steps":["trace[186900297] 'read index received' (duration: 50.73502ms)","trace[186900297] 'applied index is now lower than readState.Index' (duration: 217.927555ms)"],"step_count":2} {"level":"warn","ts":"2026-03-20T05:31:01.342004Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.81607ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/etcd-instance\" ","response":"range_response_count:1 size:5336"} {"level":"info","ts":"2026-03-20T05:31:01.342069Z","caller":"traceutil/trace.go:171","msg":"trace[566172730] range","detail":"{range_begin:/registry/pods/kube-system/etcd-instance; range_end:; response_count:1; response_revision:441; }","duration":"269.057967ms","start":"2026-03-20T05:31:01.072995Z","end":"2026-03-20T05:31:01.342053Z","steps":["trace[566172730] 'agreement among raft nodes before linearized reading' (duration: 268.781939ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T05:31:17.731413Z","caller":"traceutil/trace.go:171","msg":"trace[804328117] linearizableReadLoop","detail":"{readStateIndex:559; appliedIndex:558; }","duration":"147.08578ms","start":"2026-03-20T05:31:17.584291Z","end":"2026-03-20T05:31:17.731377Z","steps":["trace[804328117] 'read index received' (duration: 146.978687ms)","trace[804328117] 'applied index is now lower than readState.Index' (duration: 106.293µs)"],"step_count":2} {"level":"info","ts":"2026-03-20T05:31:17.731514Z","caller":"traceutil/trace.go:171","msg":"trace[758431796] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"166.784354ms","start":"2026-03-20T05:31:17.564702Z","end":"2026-03-20T05:31:17.731486Z","steps":["trace[758431796] 'process raft request' (duration: 166.551017ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T05:31:17.731551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.244784ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-20T05:31:17.731703Z","caller":"traceutil/trace.go:171","msg":"trace[1686091219] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:540; }","duration":"147.415499ms","start":"2026-03-20T05:31:17.584256Z","end":"2026-03-20T05:31:17.731671Z","steps":["trace[1686091219] 'agreement among raft nodes before linearized reading' (duration: 147.235024ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T05:31:17.881926Z","caller":"traceutil/trace.go:171","msg":"trace[1079238769] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"134.616286ms","start":"2026-03-20T05:31:17.747285Z","end":"2026-03-20T05:31:17.881902Z","steps":["trace[1079238769] 'process raft request' (duration: 134.41494ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T05:31:17.903482Z","caller":"traceutil/trace.go:171","msg":"trace[2010402853] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"155.628526ms","start":"2026-03-20T05:31:17.747827Z","end":"2026-03-20T05:31:17.903455Z","steps":["trace[2010402853] 'process raft request' (duration: 155.464111ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T05:31:18.596887Z","caller":"traceutil/trace.go:171","msg":"trace[927633290] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"304.242359ms","start":"2026-03-20T05:31:18.29262Z","end":"2026-03-20T05:31:18.596862Z","steps":["trace[927633290] 'process raft request' (duration: 304.099075ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T05:31:18.597606Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:31:18.292602Z","time spent":"304.373532ms","remote":"127.0.0.1:52684","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-20T05:31:18.608233Z","caller":"traceutil/trace.go:171","msg":"trace[1479675908] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"130.863153ms","start":"2026-03-20T05:31:18.477347Z","end":"2026-03-20T05:31:18.60821Z","steps":["trace[1479675908] 'process raft request' (duration: 130.613746ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T05:31:19.988413Z","caller":"traceutil/trace.go:171","msg":"trace[625004289] transaction","detail":"{read_only:false; response_revision:681; number_of_response:1; }","duration":"107.806926ms","start":"2026-03-20T05:31:19.880586Z","end":"2026-03-20T05:31:19.988393Z","steps":["trace[625004289] 'process raft request' (duration: 107.56191ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T05:31:28.069139Z","caller":"traceutil/trace.go:171","msg":"trace[2030269074] transaction","detail":"{read_only:false; response_revision:794; number_of_response:1; }","duration":"104.271525ms","start":"2026-03-20T05:31:27.964834Z","end":"2026-03-20T05:31:28.069106Z","steps":["trace[2030269074] 'process raft request' (duration: 87.370919ms)","trace[2030269074] 'compare' (duration: 16.738841ms)"],"step_count":2} {"level":"warn","ts":"2026-03-20T05:32:26.436792Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.559952ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-20T05:32:26.436948Z","caller":"traceutil/trace.go:171","msg":"trace[702663423] linearizableReadLoop","detail":"{readStateIndex:1637; appliedIndex:1636; }","duration":"236.87127ms","start":"2026-03-20T05:32:26.200056Z","end":"2026-03-20T05:32:26.436927Z","steps":["trace[702663423] 'read index received' (duration: 115.051032ms)","trace[702663423] 'applied index is now lower than readState.Index' (duration: 121.818638ms)"],"step_count":2} {"level":"info","ts":"2026-03-20T05:32:26.436986Z","caller":"traceutil/trace.go:171","msg":"trace[1785616700] transaction","detail":"{read_only:false; response_revision:1575; number_of_response:1; }","duration":"257.424226ms","start":"2026-03-20T05:32:26.179531Z","end":"2026-03-20T05:32:26.436956Z","steps":["trace[1785616700] 'process raft request' (duration: 135.615148ms)","trace[1785616700] 'compare' (duration: 121.368726ms)"],"step_count":2} {"level":"warn","ts":"2026-03-20T05:32:26.437183Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.570802ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-5bd8ea1c-7266-4d95-aa8d-3cc5bf7298c7\" ","response":"range_response_count:1 size:3747"} {"level":"info","ts":"2026-03-20T05:32:26.437243Z","caller":"traceutil/trace.go:171","msg":"trace[928640618] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-5bd8ea1c-7266-4d95-aa8d-3cc5bf7298c7; range_end:; response_count:1; response_revision:1575; }","duration":"207.688015ms","start":"2026-03-20T05:32:26.229539Z","end":"2026-03-20T05:32:26.437227Z","steps":["trace[928640618] 'agreement among raft nodes before linearized reading' (duration: 207.513721ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T05:32:26.437234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.130778ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-03-20T05:32:26.437361Z","caller":"traceutil/trace.go:171","msg":"trace[248293586] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1575; }","duration":"237.341214ms","start":"2026-03-20T05:32:26.200002Z","end":"2026-03-20T05:32:26.437344Z","steps":["trace[248293586] 'agreement among raft nodes before linearized reading' (duration: 237.005064ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T05:32:39.208375Z","caller":"traceutil/trace.go:171","msg":"trace[840459855] transaction","detail":"{read_only:false; response_revision:1682; number_of_response:1; }","duration":"159.216979ms","start":"2026-03-20T05:32:39.049134Z","end":"2026-03-20T05:32:39.208351Z","steps":["trace[840459855] 'process raft request' (duration: 159.050594ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T05:32:39.230601Z","caller":"traceutil/trace.go:171","msg":"trace[1467726200] transaction","detail":"{read_only:false; response_revision:1683; number_of_response:1; }","duration":"179.882018ms","start":"2026-03-20T05:32:39.050688Z","end":"2026-03-20T05:32:39.23057Z","steps":["trace[1467726200] 'process raft request' (duration: 179.450805ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T05:33:16.889114Z","caller":"traceutil/trace.go:171","msg":"trace[1301371445] linearizableReadLoop","detail":"{readStateIndex:1954; appliedIndex:1953; }","duration":"201.555882ms","start":"2026-03-20T05:33:16.687522Z","end":"2026-03-20T05:33:16.889077Z","steps":["trace[1301371445] 'read index received' (duration: 201.318706ms)","trace[1301371445] 'applied index is now lower than readState.Index' (duration: 235.986µs)"],"step_count":2} {"level":"info","ts":"2026-03-20T05:33:16.889153Z","caller":"traceutil/trace.go:171","msg":"trace[2088364939] transaction","detail":"{read_only:false; response_revision:1880; number_of_response:1; }","duration":"209.187172ms","start":"2026-03-20T05:33:16.679931Z","end":"2026-03-20T05:33:16.889118Z","steps":["trace[2088364939] 'process raft request' (duration: 208.958006ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T05:33:16.889404Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.547222ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-03-20T05:33:16.889428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.882182ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-03-20T05:33:16.88949Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.335411ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-03-20T05:33:16.889458Z","caller":"traceutil/trace.go:171","msg":"trace[423582020] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1880; }","duration":"201.651624ms","start":"2026-03-20T05:33:16.687789Z","end":"2026-03-20T05:33:16.889441Z","steps":["trace[423582020] 'agreement among raft nodes before linearized reading' (duration: 201.467099ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T05:33:16.889608Z","caller":"traceutil/trace.go:171","msg":"trace[1543250673] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1880; }","duration":"202.026756ms","start":"2026-03-20T05:33:16.687485Z","end":"2026-03-20T05:33:16.889511Z","steps":["trace[1543250673] 'agreement among raft nodes before linearized reading' (duration: 201.741077ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T05:33:16.889647Z","caller":"traceutil/trace.go:171","msg":"trace[845545792] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1880; }","duration":"195.532877ms","start":"2026-03-20T05:33:16.69406Z","end":"2026-03-20T05:33:16.889593Z","steps":["trace[845545792] 'agreement among raft nodes before linearized reading' (duration: 195.269329ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T05:34:43.416393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.866868ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-03-20T05:34:43.416486Z","caller":"traceutil/trace.go:171","msg":"trace[1781690186] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:2498; }","duration":"128.025523ms","start":"2026-03-20T05:34:43.288442Z","end":"2026-03-20T05:34:43.416467Z","steps":["trace[1781690186] 'count revisions from in-memory index tree' (duration: 127.776066ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T05:34:43.539774Z","caller":"traceutil/trace.go:171","msg":"trace[134782071] transaction","detail":"{read_only:false; response_revision:2499; number_of_response:1; }","duration":"118.247314ms","start":"2026-03-20T05:34:43.421499Z","end":"2026-03-20T05:34:43.539746Z","steps":["trace[134782071] 'process raft request' (duration: 118.115681ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T05:34:43.55751Z","caller":"traceutil/trace.go:171","msg":"trace[839392682] transaction","detail":"{read_only:false; response_revision:2501; number_of_response:1; }","duration":"135.870836ms","start":"2026-03-20T05:34:43.421611Z","end":"2026-03-20T05:34:43.557482Z","steps":["trace[839392682] 'process raft request' (duration: 135.811535ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T05:34:43.557534Z","caller":"traceutil/trace.go:171","msg":"trace[576704771] transaction","detail":"{read_only:false; response_revision:2500; number_of_response:1; }","duration":"135.889347ms","start":"2026-03-20T05:34:43.421605Z","end":"2026-03-20T05:34:43.557494Z","steps":["trace[576704771] 'process raft request' (duration: 135.675781ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T05:38:27.184419Z","caller":"traceutil/trace.go:171","msg":"trace[1023567541] transaction","detail":"{read_only:false; response_revision:4372; number_of_response:1; }","duration":"147.387521ms","start":"2026-03-20T05:38:27.036983Z","end":"2026-03-20T05:38:27.184371Z","steps":["trace[1023567541] 'process raft request' (duration: 147.193265ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T05:38:27.295039Z","caller":"traceutil/trace.go:171","msg":"trace[1151407983] transaction","detail":"{read_only:false; response_revision:4373; number_of_response:1; }","duration":"215.00414ms","start":"2026-03-20T05:38:27.080005Z","end":"2026-03-20T05:38:27.295009Z","steps":["trace[1151407983] 'process raft request' (duration: 214.833875ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T05:38:30.861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.308282ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-03-20T05:38:30.861115Z","caller":"traceutil/trace.go:171","msg":"trace[770573223] linearizableReadLoop","detail":"{readStateIndex:4688; appliedIndex:4687; }","duration":"221.691113ms","start":"2026-03-20T05:38:30.639405Z","end":"2026-03-20T05:38:30.861096Z","steps":["trace[770573223] 'read index received' (duration: 99.197456ms)","trace[770573223] 'applied index is now lower than readState.Index' (duration: 122.492187ms)"],"step_count":2} {"level":"info","ts":"2026-03-20T05:38:30.86122Z","caller":"traceutil/trace.go:171","msg":"trace[762789181] transaction","detail":"{read_only:false; response_revision:4509; number_of_response:1; }","duration":"257.883098ms","start":"2026-03-20T05:38:30.603324Z","end":"2026-03-20T05:38:30.861207Z","steps":["trace[762789181] 'process raft request' (duration: 135.273548ms)","trace[762789181] 'compare' (duration: 122.019844ms)"],"step_count":2} {"level":"warn","ts":"2026-03-20T05:38:30.861483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.786795ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/nfd.k8s-sigs.io/nodefeaturerules/\" range_end:\"/registry/nfd.k8s-sigs.io/nodefeaturerules0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-20T05:38:30.861575Z","caller":"traceutil/trace.go:171","msg":"trace[1563173042] range","detail":"{range_begin:/registry/nfd.k8s-sigs.io/nodefeaturerules/; range_end:/registry/nfd.k8s-sigs.io/nodefeaturerules0; response_count:0; response_revision:4509; }","duration":"202.932819ms","start":"2026-03-20T05:38:30.658621Z","end":"2026-03-20T05:38:30.861554Z","steps":["trace[1563173042] 'agreement among raft nodes before linearized reading' (duration: 202.736993ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T05:38:30.861564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.154746ms","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-03-20T05:38:30.861669Z","caller":"traceutil/trace.go:171","msg":"trace[626668334] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4509; }","duration":"222.30171ms","start":"2026-03-20T05:38:30.639341Z","end":"2026-03-20T05:38:30.861643Z","steps":["trace[626668334] 'agreement among raft nodes before linearized reading' (duration: 222.087774ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T05:38:30.861751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.176794ms","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-03-20T05:38:30.861809Z","caller":"traceutil/trace.go:171","msg":"trace[239975936] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4509; }","duration":"136.268635ms","start":"2026-03-20T05:38:30.725527Z","end":"2026-03-20T05:38:30.861796Z","steps":["trace[239975936] 'agreement among raft nodes before linearized reading' (duration: 136.150212ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T05:38:30.861888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.618438ms","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-03-20T05:38:30.861978Z","caller":"traceutil/trace.go:171","msg":"trace[1713165996] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4509; }","duration":"143.745091ms","start":"2026-03-20T05:38:30.718211Z","end":"2026-03-20T05:38:30.861956Z","steps":["trace[1713165996] 'agreement among raft nodes before linearized reading' (duration: 143.491744ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T05:38:31.246445Z","caller":"traceutil/trace.go:171","msg":"trace[1305832548] transaction","detail":"{read_only:false; response_revision:4521; number_of_response:1; }","duration":"199.330489ms","start":"2026-03-20T05:38:31.047078Z","end":"2026-03-20T05:38:31.246408Z","steps":["trace[1305832548] 'process raft request' (duration: 149.898141ms)","trace[1305832548] 'compare' (duration: 49.223182ms)"],"step_count":2} {"level":"info","ts":"2026-03-20T05:38:31.246425Z","caller":"traceutil/trace.go:171","msg":"trace[331031002] linearizableReadLoop","detail":"{readStateIndex:4701; appliedIndex:4699; }","duration":"150.368833ms","start":"2026-03-20T05:38:31.096031Z","end":"2026-03-20T05:38:31.2464Z","steps":["trace[331031002] 'read index received' (duration: 19.714452ms)","trace[331031002] 'applied index is now lower than readState.Index' (duration: 130.652371ms)"],"step_count":2} {"level":"warn","ts":"2026-03-20T05:38:31.246986Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.934198ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:25 size:777681"} {"level":"info","ts":"2026-03-20T05:38:31.247044Z","caller":"traceutil/trace.go:171","msg":"trace[617217628] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:25; response_revision:4522; }","duration":"151.043122ms","start":"2026-03-20T05:38:31.095987Z","end":"2026-03-20T05:38:31.24703Z","steps":["trace[617217628] 'agreement among raft nodes before linearized reading' (duration: 150.546477ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T05:38:41.164505Z","caller":"traceutil/trace.go:171","msg":"trace[1778002708] linearizableReadLoop","detail":"{readStateIndex:4913; appliedIndex:4911; }","duration":"118.122076ms","start":"2026-03-20T05:38:41.046355Z","end":"2026-03-20T05:38:41.164477Z","steps":["trace[1778002708] 'read index received' (duration: 54.652721ms)","trace[1778002708] 'applied index is now lower than readState.Index' (duration: 63.467835ms)"],"step_count":2} {"level":"warn","ts":"2026-03-20T05:38:41.16469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.314412ms","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-03-20T05:38:41.164772Z","caller":"traceutil/trace.go:171","msg":"trace[1124596040] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4726; }","duration":"118.429325ms","start":"2026-03-20T05:38:41.046325Z","end":"2026-03-20T05:38:41.164754Z","steps":["trace[1124596040] 'agreement among raft nodes before linearized reading' (duration: 118.235139ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T05:38:41.164765Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.306447ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/memcached-metrics\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-20T05:38:41.164849Z","caller":"traceutil/trace.go:171","msg":"trace[1615692858] range","detail":"{range_begin:/registry/services/specs/openstack/memcached-metrics; range_end:; response_count:0; response_revision:4726; }","duration":"108.420711ms","start":"2026-03-20T05:38:41.056408Z","end":"2026-03-20T05:38:41.164829Z","steps":["trace[1615692858] 'agreement among raft nodes before linearized reading' (duration: 108.289837ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T05:38:49.139511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.863534ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-4c49b45e-fdde-4100-88d0-7a1fee994c57\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-03-20T05:38:49.139597Z","caller":"traceutil/trace.go:171","msg":"trace[745225201] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-4c49b45e-fdde-4100-88d0-7a1fee994c57; range_end:; response_count:1; response_revision:4884; }","duration":"124.681107ms","start":"2026-03-20T05:38:49.014898Z","end":"2026-03-20T05:38:49.139579Z","steps":["trace[745225201] 'range keys from in-memory index tree' (duration: 123.70011ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T05:38:49.449373Z","caller":"traceutil/trace.go:171","msg":"trace[1074486102] linearizableReadLoop","detail":"{readStateIndex:5078; appliedIndex:5075; }","duration":"288.89118ms","start":"2026-03-20T05:38:49.160453Z","end":"2026-03-20T05:38:49.449344Z","steps":["trace[1074486102] 'read index received' (duration: 75.105654ms)","trace[1074486102] 'applied index is now lower than readState.Index' (duration: 213.784375ms)"],"step_count":2} {"level":"info","ts":"2026-03-20T05:38:49.449469Z","caller":"traceutil/trace.go:171","msg":"trace[1988605954] transaction","detail":"{read_only:false; response_revision:4886; number_of_response:1; }","duration":"305.26654ms","start":"2026-03-20T05:38:49.144157Z","end":"2026-03-20T05:38:49.449424Z","steps":["trace[1988605954] 'process raft request' (duration: 304.960761ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T05:38:49.44953Z","caller":"traceutil/trace.go:171","msg":"trace[1397038741] transaction","detail":"{read_only:false; response_revision:4887; number_of_response:1; }","duration":"301.23896ms","start":"2026-03-20T05:38:49.148252Z","end":"2026-03-20T05:38:49.449491Z","steps":["trace[1397038741] 'process raft request' (duration: 301.034544ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T05:38:49.449604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.134587ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-03-20T05:38:49.449637Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:38:49.144135Z","time spent":"305.420294ms","remote":"127.0.0.1:52684","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-20T05:38:49.449647Z","caller":"traceutil/trace.go:171","msg":"trace[570294518] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4887; }","duration":"289.194548ms","start":"2026-03-20T05:38:49.160441Z","end":"2026-03-20T05:38:49.449635Z","steps":["trace[570294518] 'agreement among raft nodes before linearized reading' (duration: 289.031314ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T05:38:49.449715Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:38:49.14823Z","time spent":"301.385743ms","remote":"127.0.0.1:52574","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3751,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-20T05:38:49.466745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.066369ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-4c49b45e-fdde-4100-88d0-7a1fee994c57\" ","response":"range_response_count:1 size:3766"} {"level":"info","ts":"2026-03-20T05:38:49.466783Z","caller":"traceutil/trace.go:171","msg":"trace[298048383] transaction","detail":"{read_only:false; response_revision:4888; number_of_response:1; }","duration":"152.994235ms","start":"2026-03-20T05:38:49.313763Z","end":"2026-03-20T05:38:49.466757Z","steps":["trace[298048383] 'process raft request' (duration: 152.80097ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T05:38:49.46681Z","caller":"traceutil/trace.go:171","msg":"trace[1036692657] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-4c49b45e-fdde-4100-88d0-7a1fee994c57; range_end:; response_count:1; response_revision:4888; }","duration":"295.153962ms","start":"2026-03-20T05:38:49.171639Z","end":"2026-03-20T05:38:49.466793Z","steps":["trace[1036692657] 'agreement among raft nodes before linearized reading' (duration: 295.030909ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T05:38:49.46679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.563623ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-20T05:38:49.466881Z","caller":"traceutil/trace.go:171","msg":"trace[1985530970] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:4888; }","duration":"172.702957ms","start":"2026-03-20T05:38:49.294156Z","end":"2026-03-20T05:38:49.466859Z","steps":["trace[1985530970] 'agreement among raft nodes before linearized reading' (duration: 172.540672ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T05:38:49.466938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.77105ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-03-20T05:38:49.466961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.344665ms","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-03-20T05:38:49.466997Z","caller":"traceutil/trace.go:171","msg":"trace[27378426] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4888; }","duration":"195.884834ms","start":"2026-03-20T05:38:49.271098Z","end":"2026-03-20T05:38:49.466983Z","steps":["trace[27378426] 'agreement among raft nodes before linearized reading' (duration: 195.688079ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T05:38:49.467028Z","caller":"traceutil/trace.go:171","msg":"trace[718154332] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4888; }","duration":"256.434348ms","start":"2026-03-20T05:38:49.210574Z","end":"2026-03-20T05:38:49.467008Z","steps":["trace[718154332] 'agreement among raft nodes before linearized reading' (duration: 256.246883ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T05:38:49.603351Z","caller":"traceutil/trace.go:171","msg":"trace[156286791] transaction","detail":"{read_only:false; response_revision:4890; number_of_response:1; }","duration":"132.346527ms","start":"2026-03-20T05:38:49.470979Z","end":"2026-03-20T05:38:49.603326Z","steps":["trace[156286791] 'process raft request' (duration: 92.466661ms)","trace[156286791] 'compare' (duration: 39.688981ms)"],"step_count":2} {"level":"info","ts":"2026-03-20T05:38:49.603574Z","caller":"traceutil/trace.go:171","msg":"trace[1873652304] transaction","detail":"{read_only:false; response_revision:4891; number_of_response:1; }","duration":"132.46046ms","start":"2026-03-20T05:38:49.471086Z","end":"2026-03-20T05:38:49.603546Z","steps":["trace[1873652304] 'process raft request' (duration: 132.200693ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T05:39:00.340203Z","caller":"traceutil/trace.go:171","msg":"trace[216603222] transaction","detail":"{read_only:false; response_revision:5045; number_of_response:1; }","duration":"111.258698ms","start":"2026-03-20T05:39:00.228913Z","end":"2026-03-20T05:39:00.340172Z","steps":["trace[216603222] 'process raft request' (duration: 86.970781ms)","trace[216603222] 'compare' (duration: 24.137643ms)"],"step_count":2} {"level":"info","ts":"2026-03-20T05:40:42.895018Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2793} {"level":"info","ts":"2026-03-20T05:40:42.954887Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2793,"took":"58.507279ms","hash":3414824683,"current-db-size-bytes":42229760,"current-db-size":"42 MB","current-db-size-in-use-bytes":31682560,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-03-20T05:40:42.954967Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3414824683,"revision":2793,"compact-revision":-1} {"level":"info","ts":"2026-03-20T05:45:05.409893Z","caller":"traceutil/trace.go:171","msg":"trace[1118376933] transaction","detail":"{read_only:false; response_revision:7587; number_of_response:1; }","duration":"135.603889ms","start":"2026-03-20T05:45:05.274257Z","end":"2026-03-20T05:45:05.409861Z","steps":["trace[1118376933] 'process raft request' (duration: 135.345681ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T05:45:05.528957Z","caller":"traceutil/trace.go:171","msg":"trace[1395506828] transaction","detail":"{read_only:false; response_revision:7590; number_of_response:1; }","duration":"113.806745ms","start":"2026-03-20T05:45:05.415125Z","end":"2026-03-20T05:45:05.528932Z","steps":["trace[1395506828] 'process raft request' (duration: 113.713312ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T05:45:05.529002Z","caller":"traceutil/trace.go:171","msg":"trace[498122812] transaction","detail":"{read_only:false; response_revision:7589; number_of_response:1; }","duration":"113.837436ms","start":"2026-03-20T05:45:05.415099Z","end":"2026-03-20T05:45:05.528937Z","steps":["trace[498122812] 'process raft request' (duration: 113.581699ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T05:45:05.749169Z","caller":"traceutil/trace.go:171","msg":"trace[990003239] transaction","detail":"{read_only:false; response_revision:7592; number_of_response:1; }","duration":"134.54648ms","start":"2026-03-20T05:45:05.614596Z","end":"2026-03-20T05:45:05.749142Z","steps":["trace[990003239] 'process raft request' (duration: 124.344067ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T05:45:31.159413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.12896ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-03-20T05:45:31.159504Z","caller":"traceutil/trace.go:171","msg":"trace[1090586680] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:7762; }","duration":"164.293225ms","start":"2026-03-20T05:45:30.995196Z","end":"2026-03-20T05:45:31.159489Z","steps":["trace[1090586680] 'count revisions from in-memory index tree' (duration: 164.018447ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T05:45:31.313173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.104134ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-03-20T05:45:31.313303Z","caller":"traceutil/trace.go:171","msg":"trace[932969306] linearizableReadLoop","detail":"{readStateIndex:8050; appliedIndex:8049; }","duration":"204.215524ms","start":"2026-03-20T05:45:31.109065Z","end":"2026-03-20T05:45:31.313281Z","steps":["trace[932969306] 'read index received' (duration: 52.031µs)","trace[932969306] 'applied index is now lower than readState.Index' (duration: 204.161472ms)"],"step_count":2} {"level":"warn","ts":"2026-03-20T05:45:31.313622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.499172ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/rook-ceph/rook-ceph-csi-config\" ","response":"range_response_count:1 size:512"} {"level":"info","ts":"2026-03-20T05:45:31.313734Z","caller":"traceutil/trace.go:171","msg":"trace[519058615] range","detail":"{range_begin:/registry/configmaps/rook-ceph/rook-ceph-csi-config; range_end:; response_count:1; response_revision:7762; }","duration":"204.685837ms","start":"2026-03-20T05:45:31.109019Z","end":"2026-03-20T05:45:31.313705Z","steps":["trace[519058615] 'agreement among raft nodes before linearized reading' (duration: 204.349728ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T05:45:31.313892Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.85647ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-4t82n\" ","response":"range_response_count:1 size:4455"} {"level":"info","ts":"2026-03-20T05:45:31.313979Z","caller":"traceutil/trace.go:171","msg":"trace[325247903] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-4t82n; range_end:; response_count:1; response_revision:7762; }","duration":"173.992344ms","start":"2026-03-20T05:45:31.139965Z","end":"2026-03-20T05:45:31.313957Z","steps":["trace[325247903] 'agreement among raft nodes before linearized reading' (duration: 173.439539ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T05:45:42.916172Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5799} {"level":"info","ts":"2026-03-20T05:45:43.02505Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5799,"took":"107.116567ms","hash":3285381887,"current-db-size-bytes":42950656,"current-db-size":"43 MB","current-db-size-in-use-bytes":23384064,"current-db-size-in-use":"23 MB"} {"level":"info","ts":"2026-03-20T05:45:43.025107Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3285381887,"revision":5799,"compact-revision":2793} {"level":"info","ts":"2026-03-20T05:45:47.025339Z","caller":"traceutil/trace.go:171","msg":"trace[484417274] transaction","detail":"{read_only:false; number_of_response:1; response_revision:7885; }","duration":"100.258765ms","start":"2026-03-20T05:45:46.92505Z","end":"2026-03-20T05:45:47.025309Z","steps":["trace[484417274] 'process raft request' (duration: 100.041008ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T05:45:47.736794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.891207ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-20T05:45:47.736877Z","caller":"traceutil/trace.go:171","msg":"trace[1388497459] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:7889; }","duration":"149.001521ms","start":"2026-03-20T05:45:47.587856Z","end":"2026-03-20T05:45:47.736858Z","steps":["trace[1388497459] 'range keys from in-memory index tree' (duration: 148.837226ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T05:49:17.519974Z","caller":"traceutil/trace.go:171","msg":"trace[581243798] transaction","detail":"{read_only:false; response_revision:9565; number_of_response:1; }","duration":"131.654613ms","start":"2026-03-20T05:49:17.388298Z","end":"2026-03-20T05:49:17.519953Z","steps":["trace[581243798] 'process raft request' (duration: 127.861217ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T05:49:17.527518Z","caller":"traceutil/trace.go:171","msg":"trace[583106145] transaction","detail":"{read_only:false; response_revision:9566; number_of_response:1; }","duration":"134.339378ms","start":"2026-03-20T05:49:17.393141Z","end":"2026-03-20T05:49:17.52748Z","steps":["trace[583106145] 'process raft request' (duration: 134.095081ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T05:49:28.648342Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"d98d5f2c752cc52d","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-03-20T05:49:28.654496Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-03-20T05:49:28.654558Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-03-20T05:50:42.923385Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":7854} {"level":"info","ts":"2026-03-20T05:50:42.995643Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":7854,"took":"70.002622ms","hash":1746306989,"current-db-size-bytes":42950656,"current-db-size":"43 MB","current-db-size-in-use-bytes":25612288,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-03-20T05:50:42.995807Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1746306989,"revision":7854,"compact-revision":5799} {"level":"info","ts":"2026-03-20T05:55:42.928886Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10020} {"level":"info","ts":"2026-03-20T05:55:43.009972Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10020,"took":"79.33993ms","hash":1159285678,"current-db-size-bytes":42950656,"current-db-size":"43 MB","current-db-size-in-use-bytes":16732160,"current-db-size-in-use":"17 MB"} {"level":"info","ts":"2026-03-20T05:55:43.010047Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1159285678,"revision":10020,"compact-revision":7854}