{"level":"warn","ts":"2026-04-18T09:07:52.864194Z","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-18T09:07:52.864302Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.44: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.44:2380","--initial-cluster=instance=https://199.204.45.44:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.44:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.44: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-18T09:07:52.864385Z","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-18T09:07:52.864408Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.44:2380"]} {"level":"info","ts":"2026-04-18T09:07:52.864454Z","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-18T09:07:52.865182Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.44:2379"]} {"level":"info","ts":"2026-04-18T09:07:52.865255Z","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.44:2380"],"listen-peer-urls":["https://199.204.45.44:2380"],"advertise-client-urls":["https://199.204.45.44:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.44:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.44: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-18T09:07:52.869119Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.600987ms"} {"level":"info","ts":"2026-04-18T09:07:52.879746Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"a0a01fc7fbf6be45","cluster-id":"92fa3fee501eaaec"} {"level":"info","ts":"2026-04-18T09:07:52.879857Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a0a01fc7fbf6be45 switched to configuration voters=()"} {"level":"info","ts":"2026-04-18T09:07:52.879889Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a0a01fc7fbf6be45 became follower at term 0"} {"level":"info","ts":"2026-04-18T09:07:52.879908Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft a0a01fc7fbf6be45 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-18T09:07:52.87993Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a0a01fc7fbf6be45 became follower at term 1"} {"level":"info","ts":"2026-04-18T09:07:52.87998Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a0a01fc7fbf6be45 switched to configuration voters=(11574285986128379461)"} {"level":"warn","ts":"2026-04-18T09:07:52.886061Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-18T09:07:52.888375Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-18T09:07:52.890459Z","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-18T09:07:52.892505Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"a0a01fc7fbf6be45","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-18T09:07:52.892686Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"a0a01fc7fbf6be45","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-18T09:07:52.892792Z","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-18T09:07:52.892926Z","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-18T09:07:52.892939Z","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-18T09:07:52.894002Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a0a01fc7fbf6be45 switched to configuration voters=(11574285986128379461)"} {"level":"info","ts":"2026-04-18T09:07:52.894147Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"92fa3fee501eaaec","local-member-id":"a0a01fc7fbf6be45","added-peer-id":"a0a01fc7fbf6be45","added-peer-peer-urls":["https://199.204.45.44:2380"]} {"level":"info","ts":"2026-04-18T09:07:52.894617Z","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-18T09:07:52.894859Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"a0a01fc7fbf6be45","initial-advertise-peer-urls":["https://199.204.45.44:2380"],"listen-peer-urls":["https://199.204.45.44:2380"],"advertise-client-urls":["https://199.204.45.44:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.44:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-18T09:07:52.894896Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-18T09:07:52.895083Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.44:2380"} {"level":"info","ts":"2026-04-18T09:07:52.895154Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.44:2380"} {"level":"info","ts":"2026-04-18T09:07:53.381051Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a0a01fc7fbf6be45 is starting a new election at term 1"} {"level":"info","ts":"2026-04-18T09:07:53.381197Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a0a01fc7fbf6be45 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-18T09:07:53.381257Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a0a01fc7fbf6be45 received MsgPreVoteResp from a0a01fc7fbf6be45 at term 1"} {"level":"info","ts":"2026-04-18T09:07:53.381289Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a0a01fc7fbf6be45 became candidate at term 2"} {"level":"info","ts":"2026-04-18T09:07:53.381308Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a0a01fc7fbf6be45 received MsgVoteResp from a0a01fc7fbf6be45 at term 2"} {"level":"info","ts":"2026-04-18T09:07:53.381326Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a0a01fc7fbf6be45 became leader at term 2"} {"level":"info","ts":"2026-04-18T09:07:53.381348Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: a0a01fc7fbf6be45 elected leader a0a01fc7fbf6be45 at term 2"} {"level":"info","ts":"2026-04-18T09:07:53.382737Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-18T09:07:53.383729Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-18T09:07:53.383774Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"a0a01fc7fbf6be45","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.44:2379]}","request-path":"/0/members/a0a01fc7fbf6be45/attributes","cluster-id":"92fa3fee501eaaec","publish-timeout":"7s"} {"level":"info","ts":"2026-04-18T09:07:53.384066Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-18T09:07:53.387208Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-18T09:07:53.387563Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-18T09:07:53.387644Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"92fa3fee501eaaec","local-member-id":"a0a01fc7fbf6be45","cluster-version":"3.5"} {"level":"info","ts":"2026-04-18T09:07:53.387781Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-18T09:07:53.387827Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-18T09:07:53.391447Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.44:2379"} {"level":"info","ts":"2026-04-18T09:07:53.391512Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-18T09:08:03.559904Z","caller":"traceutil/trace.go:171","msg":"trace[1164295434] transaction","detail":"{read_only:false; response_revision:336; number_of_response:1; }","duration":"104.77343ms","start":"2026-04-18T09:08:03.455106Z","end":"2026-04-18T09:08:03.55988Z","steps":["trace[1164295434] 'process raft request' (duration: 104.613406ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:08:03.559874Z","caller":"traceutil/trace.go:171","msg":"trace[395681235] transaction","detail":"{read_only:false; response_revision:335; number_of_response:1; }","duration":"105.362094ms","start":"2026-04-18T09:08:03.454474Z","end":"2026-04-18T09:08:03.559836Z","steps":["trace[395681235] 'process raft request' (duration: 105.027746ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:08:24.891062Z","caller":"traceutil/trace.go:171","msg":"trace[795076194] linearizableReadLoop","detail":"{readStateIndex:488; appliedIndex:487; }","duration":"105.123236ms","start":"2026-04-18T09:08:24.785912Z","end":"2026-04-18T09:08:24.891035Z","steps":["trace[795076194] 'read index received' (duration: 104.962933ms)","trace[795076194] 'applied index is now lower than readState.Index' (duration: 159.343µs)"],"step_count":2} {"level":"info","ts":"2026-04-18T09:08:24.891168Z","caller":"traceutil/trace.go:171","msg":"trace[486662542] transaction","detail":"{read_only:false; response_revision:470; number_of_response:1; }","duration":"106.127172ms","start":"2026-04-18T09:08:24.785006Z","end":"2026-04-18T09:08:24.891134Z","steps":["trace[486662542] 'process raft request' (duration: 105.867926ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:08:24.891238Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.26755ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T09:08:24.891299Z","caller":"traceutil/trace.go:171","msg":"trace[237144662] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:0; response_revision:470; }","duration":"105.390583ms","start":"2026-04-18T09:08:24.785896Z","end":"2026-04-18T09:08:24.891287Z","steps":["trace[237144662] 'agreement among raft nodes before linearized reading' (duration: 105.2528ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:08:31.881787Z","caller":"traceutil/trace.go:171","msg":"trace[690966744] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"379.504308ms","start":"2026-04-18T09:08:31.502245Z","end":"2026-04-18T09:08:31.88175Z","steps":["trace[690966744] 'process raft request' (duration: 379.250172ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:08:31.881887Z","caller":"traceutil/trace.go:171","msg":"trace[106561295] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"456.356764ms","start":"2026-04-18T09:08:31.42544Z","end":"2026-04-18T09:08:31.881797Z","steps":["trace[106561295] 'process raft request' (duration: 450.245826ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:08:31.882506Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:08:31.502212Z","time spent":"379.697782ms","remote":"127.0.0.1:56784","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-18T09:08:31.88326Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:08:31.425415Z","time spent":"456.630031ms","remote":"127.0.0.1:56468","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T09:08:46.824831Z","caller":"traceutil/trace.go:171","msg":"trace[1091391275] linearizableReadLoop","detail":"{readStateIndex:768; appliedIndex:767; }","duration":"105.090036ms","start":"2026-04-18T09:08:46.719711Z","end":"2026-04-18T09:08:46.824801Z","steps":["trace[1091391275] 'read index received' (duration: 104.949313ms)","trace[1091391275] 'applied index is now lower than readState.Index' (duration: 139.183µs)"],"step_count":2} {"level":"info","ts":"2026-04-18T09:08:46.824935Z","caller":"traceutil/trace.go:171","msg":"trace[1492891451] transaction","detail":"{read_only:false; response_revision:741; number_of_response:1; }","duration":"162.058014ms","start":"2026-04-18T09:08:46.662814Z","end":"2026-04-18T09:08:46.824872Z","steps":["trace[1492891451] 'process raft request' (duration: 161.812038ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:08:46.825084Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.356052ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.44\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-04-18T09:08:46.825134Z","caller":"traceutil/trace.go:171","msg":"trace[754075850] range","detail":"{range_begin:/registry/masterleases/199.204.45.44; range_end:; response_count:1; response_revision:741; }","duration":"105.479625ms","start":"2026-04-18T09:08:46.719644Z","end":"2026-04-18T09:08:46.825123Z","steps":["trace[754075850] 'agreement among raft nodes before linearized reading' (duration: 105.27478ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:09:59.787928Z","caller":"traceutil/trace.go:171","msg":"trace[1267876648] transaction","detail":"{read_only:false; response_revision:1797; number_of_response:1; }","duration":"132.568044ms","start":"2026-04-18T09:09:59.655326Z","end":"2026-04-18T09:09:59.787894Z","steps":["trace[1267876648] 'process raft request' (duration: 127.130314ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:10:00.184533Z","caller":"traceutil/trace.go:171","msg":"trace[903562548] transaction","detail":"{read_only:false; response_revision:1798; number_of_response:1; }","duration":"295.755226ms","start":"2026-04-18T09:09:59.888737Z","end":"2026-04-18T09:10:00.184492Z","steps":["trace[903562548] 'process raft request' (duration: 204.640797ms)","trace[903562548] 'compare' (duration: 90.763651ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T09:10:00.184737Z","caller":"traceutil/trace.go:171","msg":"trace[1039128933] linearizableReadLoop","detail":"{readStateIndex:1869; appliedIndex:1868; }","duration":"293.559243ms","start":"2026-04-18T09:09:59.891151Z","end":"2026-04-18T09:10:00.184711Z","steps":["trace[1039128933] 'read index received' (duration: 202.248269ms)","trace[1039128933] 'applied index is now lower than readState.Index' (duration: 91.308784ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T09:10:00.184943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.782028ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-50935a14-0aad-4801-b28a-07cf245827cb\" ","response":"range_response_count:1 size:3626"} {"level":"info","ts":"2026-04-18T09:10:00.18497Z","caller":"traceutil/trace.go:171","msg":"trace[834609738] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-50935a14-0aad-4801-b28a-07cf245827cb; range_end:; response_count:1; response_revision:1798; }","duration":"293.86729ms","start":"2026-04-18T09:09:59.891093Z","end":"2026-04-18T09:10:00.18496Z","steps":["trace[834609738] 'agreement among raft nodes before linearized reading' (duration: 293.730517ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:10:00.185095Z","caller":"traceutil/trace.go:171","msg":"trace[1001703043] transaction","detail":"{read_only:false; response_revision:1799; number_of_response:1; }","duration":"204.703498ms","start":"2026-04-18T09:09:59.98034Z","end":"2026-04-18T09:10:00.185043Z","steps":["trace[1001703043] 'process raft request' (duration: 204.117764ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:10:00.637365Z","caller":"traceutil/trace.go:171","msg":"trace[1114614041] linearizableReadLoop","detail":"{readStateIndex:1871; appliedIndex:1870; }","duration":"432.817928ms","start":"2026-04-18T09:10:00.204506Z","end":"2026-04-18T09:10:00.637324Z","steps":["trace[1114614041] 'read index received' (duration: 432.622203ms)","trace[1114614041] 'applied index is now lower than readState.Index' (duration: 194.275µs)"],"step_count":2} {"level":"info","ts":"2026-04-18T09:10:00.637446Z","caller":"traceutil/trace.go:171","msg":"trace[1606341868] transaction","detail":"{read_only:false; response_revision:1800; number_of_response:1; }","duration":"444.979891ms","start":"2026-04-18T09:10:00.192424Z","end":"2026-04-18T09:10:00.637404Z","steps":["trace[1606341868] 'process raft request' (duration: 444.670802ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:10:00.63759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"433.065005ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-50935a14-0aad-4801-b28a-07cf245827cb\" ","response":"range_response_count:1 size:3746"} {"level":"warn","ts":"2026-04-18T09:10:00.637645Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:10:00.192396Z","time spent":"445.138635ms","remote":"127.0.0.1:56468","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3731,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T09:10:00.637677Z","caller":"traceutil/trace.go:171","msg":"trace[1858357233] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-50935a14-0aad-4801-b28a-07cf245827cb; range_end:; response_count:1; response_revision:1800; }","duration":"433.228449ms","start":"2026-04-18T09:10:00.204426Z","end":"2026-04-18T09:10:00.637654Z","steps":["trace[1858357233] 'agreement among raft nodes before linearized reading' (duration: 433.061285ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:10:00.637727Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:10:00.204404Z","time spent":"433.314991ms","remote":"127.0.0.1:56468","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3770,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-50935a14-0aad-4801-b28a-07cf245827cb\" "} {"level":"warn","ts":"2026-04-18T09:10:00.639411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"380.37661ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-04-18T09:10:00.639496Z","caller":"traceutil/trace.go:171","msg":"trace[972591244] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1801; }","duration":"380.513933ms","start":"2026-04-18T09:10:00.258961Z","end":"2026-04-18T09:10:00.639475Z","steps":["trace[972591244] 'agreement among raft nodes before linearized reading' (duration: 380.265337ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:10:00.639514Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.32484ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-18T09:10:00.639544Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:10:00.258939Z","time spent":"380.591614ms","remote":"127.0.0.1:56756","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5436,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"info","ts":"2026-04-18T09:10:00.639597Z","caller":"traceutil/trace.go:171","msg":"trace[1117303855] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:1801; }","duration":"172.461303ms","start":"2026-04-18T09:10:00.467119Z","end":"2026-04-18T09:10:00.63958Z","steps":["trace[1117303855] 'agreement among raft nodes before linearized reading' (duration: 172.277859ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:10:00.639895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.035701ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-04-18T09:10:00.640022Z","caller":"traceutil/trace.go:171","msg":"trace[1512740323] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1801; }","duration":"169.269746ms","start":"2026-04-18T09:10:00.470727Z","end":"2026-04-18T09:10:00.639997Z","steps":["trace[1512740323] 'agreement among raft nodes before linearized reading' (duration: 168.58086ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:10:13.669629Z","caller":"traceutil/trace.go:171","msg":"trace[2114757936] linearizableReadLoop","detail":"{readStateIndex:1988; appliedIndex:1987; }","duration":"102.141284ms","start":"2026-04-18T09:10:13.567461Z","end":"2026-04-18T09:10:13.669603Z","steps":["trace[2114757936] 'read index received' (duration: 101.884088ms)","trace[2114757936] 'applied index is now lower than readState.Index' (duration: 256.066µs)"],"step_count":2} {"level":"info","ts":"2026-04-18T09:10:13.669707Z","caller":"traceutil/trace.go:171","msg":"trace[193041710] transaction","detail":"{read_only:false; response_revision:1914; number_of_response:1; }","duration":"207.439844ms","start":"2026-04-18T09:10:13.462229Z","end":"2026-04-18T09:10:13.669669Z","steps":["trace[193041710] 'process raft request' (duration: 207.225099ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:10:13.669874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.387221ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:11987"} {"level":"info","ts":"2026-04-18T09:10:13.66994Z","caller":"traceutil/trace.go:171","msg":"trace[225781471] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:1914; }","duration":"102.501413ms","start":"2026-04-18T09:10:13.567413Z","end":"2026-04-18T09:10:13.669915Z","steps":["trace[225781471] 'agreement among raft nodes before linearized reading' (duration: 102.292358ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:10:44.502929Z","caller":"traceutil/trace.go:171","msg":"trace[1268597837] transaction","detail":"{read_only:false; response_revision:2099; number_of_response:1; }","duration":"129.091564ms","start":"2026-04-18T09:10:44.373792Z","end":"2026-04-18T09:10:44.502883Z","steps":["trace[1268597837] 'process raft request' (duration: 128.867228ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:10:50.683896Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.65118ms","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-18T09:10:50.684016Z","caller":"traceutil/trace.go:171","msg":"trace[1247283777] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2130; }","duration":"110.865757ms","start":"2026-04-18T09:10:50.573127Z","end":"2026-04-18T09:10:50.683993Z","steps":["trace[1247283777] 'range keys from in-memory index tree' (duration: 110.350024ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:10:51.336761Z","caller":"traceutil/trace.go:171","msg":"trace[63661376] linearizableReadLoop","detail":"{readStateIndex:2213; appliedIndex:2212; }","duration":"118.008718ms","start":"2026-04-18T09:10:51.218723Z","end":"2026-04-18T09:10:51.336732Z","steps":["trace[63661376] 'read index received' (duration: 117.625858ms)","trace[63661376] 'applied index is now lower than readState.Index' (duration: 380.94µs)"],"step_count":2} {"level":"info","ts":"2026-04-18T09:10:51.336856Z","caller":"traceutil/trace.go:171","msg":"trace[753372089] transaction","detail":"{read_only:false; response_revision:2132; number_of_response:1; }","duration":"146.623024ms","start":"2026-04-18T09:10:51.190194Z","end":"2026-04-18T09:10:51.336817Z","steps":["trace[753372089] 'process raft request' (duration: 146.329557ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:10:51.337076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.321396ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:557"} {"level":"info","ts":"2026-04-18T09:10:51.337128Z","caller":"traceutil/trace.go:171","msg":"trace[1915193973] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:2132; }","duration":"118.407778ms","start":"2026-04-18T09:10:51.218704Z","end":"2026-04-18T09:10:51.337112Z","steps":["trace[1915193973] 'agreement among raft nodes before linearized reading' (duration: 118.174243ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:11:47.213468Z","caller":"traceutil/trace.go:171","msg":"trace[375409554] transaction","detail":"{read_only:false; response_revision:2605; number_of_response:1; }","duration":"235.865931ms","start":"2026-04-18T09:11:46.977572Z","end":"2026-04-18T09:11:47.213438Z","steps":["trace[375409554] 'process raft request' (duration: 235.691216ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:12:21.033079Z","caller":"traceutil/trace.go:171","msg":"trace[1214545652] transaction","detail":"{read_only:false; response_revision:2809; number_of_response:1; }","duration":"115.327537ms","start":"2026-04-18T09:12:20.917722Z","end":"2026-04-18T09:12:21.03305Z","steps":["trace[1214545652] 'process raft request' (duration: 115.150653ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:12:21.241688Z","caller":"traceutil/trace.go:171","msg":"trace[1446434270] transaction","detail":"{read_only:false; response_revision:2810; number_of_response:1; }","duration":"319.062439ms","start":"2026-04-18T09:12:20.922585Z","end":"2026-04-18T09:12:21.241647Z","steps":["trace[1446434270] 'process raft request' (duration: 233.937663ms)","trace[1446434270] 'compare' (duration: 84.941911ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T09:12:21.242106Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:12:20.922567Z","time spent":"319.210032ms","remote":"127.0.0.1:56536","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-18T09:16:24.489041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.695891ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-18T09:16:24.489335Z","caller":"traceutil/trace.go:171","msg":"trace[196276816] transaction","detail":"{read_only:false; response_revision:5036; number_of_response:1; }","duration":"272.365853ms","start":"2026-04-18T09:16:24.216903Z","end":"2026-04-18T09:16:24.489269Z","steps":["trace[196276816] 'process raft request' (duration: 22.141719ms)","trace[196276816] 'compare' (duration: 249.352783ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T09:16:34.450796Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.087788ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-18T09:16:34.450963Z","caller":"traceutil/trace.go:171","msg":"trace[1806086937] linearizableReadLoop","detail":"{readStateIndex:5438; appliedIndex:5437; }","duration":"221.930226ms","start":"2026-04-18T09:16:34.229011Z","end":"2026-04-18T09:16:34.450941Z","steps":["trace[1806086937] 'read index received' (duration: 43.891µs)","trace[1806086937] 'applied index is now lower than readState.Index' (duration: 221.884205ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T09:16:34.451006Z","caller":"traceutil/trace.go:171","msg":"trace[1513117824] transaction","detail":"{read_only:false; response_revision:5240; number_of_response:1; }","duration":"239.63424ms","start":"2026-04-18T09:16:34.211329Z","end":"2026-04-18T09:16:34.450963Z","steps":["trace[1513117824] 'process raft request' (duration: 10.104631ms)","trace[1513117824] 'get key's previous created_revision and leaseID' {req_type:put; key:/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io; req_size:531; } (duration: 228.31931ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T09:16:34.451144Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.047754ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-18T09:16:34.4512Z","caller":"traceutil/trace.go:171","msg":"trace[1253462204] range","detail":"{range_begin:/registry/controllerrevisions/; range_end:/registry/controllerrevisions0; response_count:0; response_revision:5240; }","duration":"182.136715ms","start":"2026-04-18T09:16:34.26905Z","end":"2026-04-18T09:16:34.451186Z","steps":["trace[1253462204] 'agreement among raft nodes before linearized reading' (duration: 182.010662ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:16:34.451178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.146252ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T09:16:34.451294Z","caller":"traceutil/trace.go:171","msg":"trace[936401810] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5240; }","duration":"222.301146ms","start":"2026-04-18T09:16:34.228955Z","end":"2026-04-18T09:16:34.451257Z","steps":["trace[936401810] 'agreement among raft nodes before linearized reading' (duration: 222.081521ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:16:42.087373Z","caller":"traceutil/trace.go:171","msg":"trace[571684624] linearizableReadLoop","detail":"{readStateIndex:5618; appliedIndex:5617; }","duration":"109.705913ms","start":"2026-04-18T09:16:41.977634Z","end":"2026-04-18T09:16:42.08734Z","steps":["trace[571684624] 'read index received' (duration: 109.499138ms)","trace[571684624] 'applied index is now lower than readState.Index' (duration: 204.755µs)"],"step_count":2} {"level":"info","ts":"2026-04-18T09:16:42.087507Z","caller":"traceutil/trace.go:171","msg":"trace[1422970854] transaction","detail":"{read_only:false; response_revision:5416; number_of_response:1; }","duration":"177.827061ms","start":"2026-04-18T09:16:41.909625Z","end":"2026-04-18T09:16:42.087452Z","steps":["trace[1422970854] 'process raft request' (duration: 177.467093ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:16:42.087818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.142124ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/loki-chunks-cache-0\" ","response":"range_response_count:1 size:4463"} {"level":"info","ts":"2026-04-18T09:16:42.087882Z","caller":"traceutil/trace.go:171","msg":"trace[1117891406] range","detail":"{range_begin:/registry/pods/monitoring/loki-chunks-cache-0; range_end:; response_count:1; response_revision:5416; }","duration":"110.266406ms","start":"2026-04-18T09:16:41.977598Z","end":"2026-04-18T09:16:42.087864Z","steps":["trace[1117891406] 'agreement among raft nodes before linearized reading' (duration: 109.928958ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:17:53.63391Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2989} {"level":"info","ts":"2026-04-18T09:17:53.702619Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2989,"took":"66.777107ms","hash":3965104107,"current-db-size-bytes":58519552,"current-db-size":"58 MB","current-db-size-in-use-bytes":33857536,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-04-18T09:17:53.702681Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3965104107,"revision":2989,"compact-revision":-1} {"level":"info","ts":"2026-04-18T09:22:43.4678Z","caller":"traceutil/trace.go:171","msg":"trace[1358625217] linearizableReadLoop","detail":"{readStateIndex:8510; appliedIndex:8509; }","duration":"234.160116ms","start":"2026-04-18T09:22:43.23362Z","end":"2026-04-18T09:22:43.467781Z","steps":["trace[1358625217] 'read index received' (duration: 233.974482ms)","trace[1358625217] 'applied index is now lower than readState.Index' (duration: 185.004µs)"],"step_count":2} {"level":"info","ts":"2026-04-18T09:22:43.46785Z","caller":"traceutil/trace.go:171","msg":"trace[1873169521] transaction","detail":"{read_only:false; response_revision:8222; number_of_response:1; }","duration":"282.118883ms","start":"2026-04-18T09:22:43.185715Z","end":"2026-04-18T09:22:43.467834Z","steps":["trace[1873169521] 'process raft request' (duration: 281.939369ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:22:43.467959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.31265ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T09:22:43.467987Z","caller":"traceutil/trace.go:171","msg":"trace[291618673] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8222; }","duration":"234.392752ms","start":"2026-04-18T09:22:43.233588Z","end":"2026-04-18T09:22:43.467981Z","steps":["trace[291618673] 'agreement among raft nodes before linearized reading' (duration: 234.290779ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:22:43.468147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.790332ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-9wm2t\" ","response":"range_response_count:1 size:6520"} {"level":"info","ts":"2026-04-18T09:22:43.468236Z","caller":"traceutil/trace.go:171","msg":"trace[2120343188] range","detail":"{range_begin:/registry/pods/openstack/keepalived-9wm2t; range_end:; response_count:1; response_revision:8222; }","duration":"183.915575ms","start":"2026-04-18T09:22:43.284293Z","end":"2026-04-18T09:22:43.468209Z","steps":["trace[2120343188] 'agreement among raft nodes before linearized reading' (duration: 183.68004ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:22:53.640643Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6079} {"level":"info","ts":"2026-04-18T09:22:53.732406Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6079,"took":"90.459752ms","hash":3032330166,"current-db-size-bytes":58519552,"current-db-size":"58 MB","current-db-size-in-use-bytes":23728128,"current-db-size-in-use":"24 MB"} {"level":"info","ts":"2026-04-18T09:22:53.73251Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3032330166,"revision":6079,"compact-revision":2989} {"level":"info","ts":"2026-04-18T09:22:54.723784Z","caller":"traceutil/trace.go:171","msg":"trace[1098341686] transaction","detail":"{read_only:false; response_revision:8283; number_of_response:1; }","duration":"142.199919ms","start":"2026-04-18T09:22:54.581564Z","end":"2026-04-18T09:22:54.723764Z","steps":["trace[1098341686] 'process raft request' (duration: 142.074756ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:22:54.980127Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.936697ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-18T09:22:54.980193Z","caller":"traceutil/trace.go:171","msg":"trace[562687317] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8283; }","duration":"143.044578ms","start":"2026-04-18T09:22:54.837133Z","end":"2026-04-18T09:22:54.980178Z","steps":["trace[562687317] 'range keys from in-memory index tree' (duration: 142.792203ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:22:56.030193Z","caller":"traceutil/trace.go:171","msg":"trace[340422650] transaction","detail":"{read_only:false; response_revision:8287; number_of_response:1; }","duration":"248.678443ms","start":"2026-04-18T09:22:55.78149Z","end":"2026-04-18T09:22:56.030169Z","steps":["trace[340422650] 'process raft request' (duration: 238.891409ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:22:56.032751Z","caller":"traceutil/trace.go:171","msg":"trace[26267804] linearizableReadLoop","detail":"{readStateIndex:8580; appliedIndex:8578; }","duration":"121.389751ms","start":"2026-04-18T09:22:55.911336Z","end":"2026-04-18T09:22:56.032726Z","steps":["trace[26267804] 'read index received' (duration: 109.017145ms)","trace[26267804] 'applied index is now lower than readState.Index' (duration: 12.371636ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T09:22:56.032911Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.550806ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-18T09:22:56.032953Z","caller":"traceutil/trace.go:171","msg":"trace[212676959] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:8289; }","duration":"121.650047ms","start":"2026-04-18T09:22:55.911293Z","end":"2026-04-18T09:22:56.032943Z","steps":["trace[212676959] 'agreement among raft nodes before linearized reading' (duration: 121.557275ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:22:56.03278Z","caller":"traceutil/trace.go:171","msg":"trace[1527132475] transaction","detail":"{read_only:false; response_revision:8288; number_of_response:1; }","duration":"165.732781ms","start":"2026-04-18T09:22:55.867029Z","end":"2026-04-18T09:22:56.032762Z","steps":["trace[1527132475] 'process raft request' (duration: 165.515796ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:22:56.510037Z","caller":"traceutil/trace.go:171","msg":"trace[1944267193] transaction","detail":"{read_only:false; response_revision:8292; number_of_response:1; }","duration":"117.980219ms","start":"2026-04-18T09:22:56.392014Z","end":"2026-04-18T09:22:56.509994Z","steps":["trace[1944267193] 'process raft request' (duration: 101.918965ms)","trace[1944267193] 'compare' (duration: 15.950772ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T09:23:27.479955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.391736ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/nfd.k8s-sigs.io/nodefeatures/monitoring/instance\" ","response":"range_response_count:1 size:414394"} {"level":"info","ts":"2026-04-18T09:23:27.480047Z","caller":"traceutil/trace.go:171","msg":"trace[1370609668] range","detail":"{range_begin:/registry/nfd.k8s-sigs.io/nodefeatures/monitoring/instance; range_end:; response_count:1; response_revision:8510; }","duration":"145.526768ms","start":"2026-04-18T09:23:27.334499Z","end":"2026-04-18T09:23:27.480026Z","steps":["trace[1370609668] 'range keys from in-memory index tree' (duration: 145.035497ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:23:36.407021Z","caller":"traceutil/trace.go:171","msg":"trace[1721067433] linearizableReadLoop","detail":"{readStateIndex:8902; appliedIndex:8901; }","duration":"126.412591ms","start":"2026-04-18T09:23:36.280582Z","end":"2026-04-18T09:23:36.406995Z","steps":["trace[1721067433] 'read index received' (duration: 110.641444ms)","trace[1721067433] 'applied index is now lower than readState.Index' (duration: 15.769467ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T09:23:36.407124Z","caller":"traceutil/trace.go:171","msg":"trace[420557390] transaction","detail":"{read_only:false; response_revision:8597; number_of_response:1; }","duration":"223.342118ms","start":"2026-04-18T09:23:36.18374Z","end":"2026-04-18T09:23:36.407082Z","steps":["trace[420557390] 'process raft request' (duration: 207.468689ms)","trace[420557390] 'compare' (duration: 15.622533ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T09:23:36.407246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.644247ms","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-04-18T09:23:36.407288Z","caller":"traceutil/trace.go:171","msg":"trace[927654285] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8597; }","duration":"126.731559ms","start":"2026-04-18T09:23:36.280545Z","end":"2026-04-18T09:23:36.407277Z","steps":["trace[927654285] 'agreement among raft nodes before linearized reading' (duration: 126.581715ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:23:36.445683Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.361578ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-q74bp\" ","response":"range_response_count:1 size:4647"} {"level":"info","ts":"2026-04-18T09:23:36.445756Z","caller":"traceutil/trace.go:171","msg":"trace[2091279713] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-q74bp; range_end:; response_count:1; response_revision:8598; }","duration":"105.472221ms","start":"2026-04-18T09:23:36.340266Z","end":"2026-04-18T09:23:36.445738Z","steps":["trace[2091279713] 'agreement among raft nodes before linearized reading' (duration: 105.271726ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:23:36.445789Z","caller":"traceutil/trace.go:171","msg":"trace[1033403882] transaction","detail":"{read_only:false; response_revision:8598; number_of_response:1; }","duration":"104.766405ms","start":"2026-04-18T09:23:36.34098Z","end":"2026-04-18T09:23:36.445747Z","steps":["trace[1033403882] 'process raft request' (duration: 104.433126ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:23:36.945895Z","caller":"traceutil/trace.go:171","msg":"trace[2023543516] transaction","detail":"{read_only:false; response_revision:8605; number_of_response:1; }","duration":"124.834553ms","start":"2026-04-18T09:23:36.82103Z","end":"2026-04-18T09:23:36.945864Z","steps":["trace[2023543516] 'process raft request' (duration: 124.367892ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:23:36.997412Z","caller":"traceutil/trace.go:171","msg":"trace[1962709310] linearizableReadLoop","detail":"{readStateIndex:8912; appliedIndex:8910; }","duration":"126.051433ms","start":"2026-04-18T09:23:36.871313Z","end":"2026-04-18T09:23:36.997364Z","steps":["trace[1962709310] 'read index received' (duration: 74.052461ms)","trace[1962709310] 'applied index is now lower than readState.Index' (duration: 51.998022ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T09:23:36.997556Z","caller":"traceutil/trace.go:171","msg":"trace[1204251686] transaction","detail":"{read_only:false; response_revision:8606; number_of_response:1; }","duration":"142.953006ms","start":"2026-04-18T09:23:36.85459Z","end":"2026-04-18T09:23:36.997543Z","steps":["trace[1204251686] 'process raft request' (duration: 142.634739ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:23:36.997805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.482864ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:558"} {"level":"info","ts":"2026-04-18T09:23:36.997848Z","caller":"traceutil/trace.go:171","msg":"trace[1241830995] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:8606; }","duration":"126.578126ms","start":"2026-04-18T09:23:36.871257Z","end":"2026-04-18T09:23:36.997835Z","steps":["trace[1241830995] 'agreement among raft nodes before linearized reading' (duration: 126.429783ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:23:53.917764Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002377.wal"} {"level":"info","ts":"2026-04-18T09:25:36.784949Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"a0a01fc7fbf6be45","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-18T09:25:36.79016Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-04-18T09:25:36.790411Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-04-18T09:27:53.647292Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8275} {"level":"info","ts":"2026-04-18T09:27:53.72476Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8275,"took":"75.043844ms","hash":1993537414,"current-db-size-bytes":58519552,"current-db-size":"58 MB","current-db-size-in-use-bytes":24870912,"current-db-size-in-use":"25 MB"} {"level":"info","ts":"2026-04-18T09:27:53.724876Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1993537414,"revision":8275,"compact-revision":6079} {"level":"info","ts":"2026-04-18T09:32:53.654077Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10671} {"level":"info","ts":"2026-04-18T09:32:53.726172Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10671,"took":"70.377872ms","hash":1317350744,"current-db-size-bytes":58519552,"current-db-size":"58 MB","current-db-size-in-use-bytes":20606976,"current-db-size-in-use":"21 MB"} {"level":"info","ts":"2026-04-18T09:32:53.726231Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1317350744,"revision":10671,"compact-revision":8275}