{"level":"warn","ts":"2026-04-08T22:56:18.850202Z","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-08T22:56:18.850283Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.209: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.209:2380","--initial-cluster=instance=https://199.204.45.209:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.209:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.209: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-08T22:56:18.850341Z","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-08T22:56:18.850353Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.209:2380"]} {"level":"info","ts":"2026-04-08T22:56:18.850371Z","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-08T22:56:18.850967Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.209:2379"]} {"level":"info","ts":"2026-04-08T22:56:18.851033Z","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.209:2380"],"listen-peer-urls":["https://199.204.45.209:2380"],"advertise-client-urls":["https://199.204.45.209:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.209:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.209: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-08T22:56:18.854535Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.309396ms"} {"level":"info","ts":"2026-04-08T22:56:18.859437Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"adfb641115bf6cbd","cluster-id":"3da6b677d4b80c6"} {"level":"info","ts":"2026-04-08T22:56:18.859495Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adfb641115bf6cbd switched to configuration voters=()"} {"level":"info","ts":"2026-04-08T22:56:18.859512Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adfb641115bf6cbd became follower at term 0"} {"level":"info","ts":"2026-04-08T22:56:18.859519Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft adfb641115bf6cbd [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-08T22:56:18.859528Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adfb641115bf6cbd became follower at term 1"} {"level":"info","ts":"2026-04-08T22:56:18.859555Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adfb641115bf6cbd switched to configuration voters=(12536724012257995965)"} {"level":"warn","ts":"2026-04-08T22:56:18.864381Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-08T22:56:18.866868Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-08T22:56:18.867999Z","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-08T22:56:18.870842Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"adfb641115bf6cbd","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-08T22:56:18.871161Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"adfb641115bf6cbd","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-08T22:56:18.871202Z","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-08T22:56:18.871222Z","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-08T22:56:18.871232Z","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-08T22:56:18.871719Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adfb641115bf6cbd switched to configuration voters=(12536724012257995965)"} {"level":"info","ts":"2026-04-08T22:56:18.871792Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"3da6b677d4b80c6","local-member-id":"adfb641115bf6cbd","added-peer-id":"adfb641115bf6cbd","added-peer-peer-urls":["https://199.204.45.209:2380"]} {"level":"info","ts":"2026-04-08T22:56:18.877783Z","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-08T22:56:18.877987Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.209:2380"} {"level":"info","ts":"2026-04-08T22:56:18.878069Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.209:2380"} {"level":"info","ts":"2026-04-08T22:56:18.878142Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"adfb641115bf6cbd","initial-advertise-peer-urls":["https://199.204.45.209:2380"],"listen-peer-urls":["https://199.204.45.209:2380"],"advertise-client-urls":["https://199.204.45.209:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.209:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-08T22:56:18.878186Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-08T22:56:19.160174Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adfb641115bf6cbd is starting a new election at term 1"} {"level":"info","ts":"2026-04-08T22:56:19.160226Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adfb641115bf6cbd became pre-candidate at term 1"} {"level":"info","ts":"2026-04-08T22:56:19.160256Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adfb641115bf6cbd received MsgPreVoteResp from adfb641115bf6cbd at term 1"} {"level":"info","ts":"2026-04-08T22:56:19.160268Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adfb641115bf6cbd became candidate at term 2"} {"level":"info","ts":"2026-04-08T22:56:19.160274Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adfb641115bf6cbd received MsgVoteResp from adfb641115bf6cbd at term 2"} {"level":"info","ts":"2026-04-08T22:56:19.160282Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adfb641115bf6cbd became leader at term 2"} {"level":"info","ts":"2026-04-08T22:56:19.16029Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: adfb641115bf6cbd elected leader adfb641115bf6cbd at term 2"} {"level":"info","ts":"2026-04-08T22:56:19.161749Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-08T22:56:19.162725Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-08T22:56:19.162725Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"adfb641115bf6cbd","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.209:2379]}","request-path":"/0/members/adfb641115bf6cbd/attributes","cluster-id":"3da6b677d4b80c6","publish-timeout":"7s"} {"level":"info","ts":"2026-04-08T22:56:19.162789Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-08T22:56:19.163184Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"3da6b677d4b80c6","local-member-id":"adfb641115bf6cbd","cluster-version":"3.5"} {"level":"info","ts":"2026-04-08T22:56:19.163374Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-08T22:56:19.163214Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-08T22:56:19.163424Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-08T22:56:19.163424Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-08T22:56:19.166171Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-08T22:56:19.166203Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.209:2379"} {"level":"info","ts":"2026-04-08T22:56:31.967714Z","caller":"traceutil/trace.go:171","msg":"trace[642403418] transaction","detail":"{read_only:false; response_revision:360; number_of_response:1; }","duration":"101.266708ms","start":"2026-04-08T22:56:31.866425Z","end":"2026-04-08T22:56:31.967692Z","steps":["trace[642403418] 'process raft request' (duration: 101.129304ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:56:54.822405Z","caller":"traceutil/trace.go:171","msg":"trace[438732890] linearizableReadLoop","detail":"{readStateIndex:599; appliedIndex:598; }","duration":"205.432041ms","start":"2026-04-08T22:56:54.616943Z","end":"2026-04-08T22:56:54.822375Z","steps":["trace[438732890] 'read index received' (duration: 204.382861ms)","trace[438732890] 'applied index is now lower than readState.Index' (duration: 1.04735ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T22:56:54.822471Z","caller":"traceutil/trace.go:171","msg":"trace[1497583013] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"387.797397ms","start":"2026-04-08T22:56:54.434632Z","end":"2026-04-08T22:56:54.82243Z","steps":["trace[1497583013] 'process raft request' (duration: 387.018584ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:56:54.822689Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.714659ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-w5c8j\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-04-08T22:56:54.822794Z","caller":"traceutil/trace.go:171","msg":"trace[124863178] range","detail":"{range_begin:/registry/pods/kube-system/cilium-w5c8j; range_end:; response_count:1; response_revision:577; }","duration":"205.887715ms","start":"2026-04-08T22:56:54.616888Z","end":"2026-04-08T22:56:54.822776Z","steps":["trace[124863178] 'agreement among raft nodes before linearized reading' (duration: 205.603857ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:56:54.823111Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:56:54.434587Z","time spent":"387.976472ms","remote":"127.0.0.1:55242","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036289,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-08T22:56:55.290506Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.885817ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-08T22:56:55.290725Z","caller":"traceutil/trace.go:171","msg":"trace[158403814] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"385.413826ms","start":"2026-04-08T22:56:54.905294Z","end":"2026-04-08T22:56:55.290707Z","steps":["trace[158403814] 'process raft request' (duration: 385.341444ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:56:55.290738Z","caller":"traceutil/trace.go:171","msg":"trace[1473258330] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"406.024011ms","start":"2026-04-08T22:56:54.884678Z","end":"2026-04-08T22:56:55.290702Z","steps":["trace[1473258330] 'process raft request' (duration: 159.735422ms)","trace[1473258330] 'compare' (duration: 245.693692ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T22:56:55.290855Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:56:54.905235Z","time spent":"385.53599ms","remote":"127.0.0.1:55330","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4543,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-08T22:56:55.290862Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:56:54.884654Z","time spent":"406.147575ms","remote":"127.0.0.1:55650","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-08T22:56:55.290958Z","caller":"traceutil/trace.go:171","msg":"trace[118966759] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"174.965148ms","start":"2026-04-08T22:56:55.11597Z","end":"2026-04-08T22:56:55.290935Z","steps":["trace[118966759] 'process raft request' (duration: 174.847174ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:57:10.255096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.472177ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-08T22:57:10.255264Z","caller":"traceutil/trace.go:171","msg":"trace[107243366] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:740; }","duration":"114.631851ms","start":"2026-04-08T22:57:10.140547Z","end":"2026-04-08T22:57:10.255179Z","steps":["trace[107243366] 'range keys from in-memory index tree' (duration: 114.274411ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:57:10.387419Z","caller":"traceutil/trace.go:171","msg":"trace[1229907070] transaction","detail":"{read_only:false; response_revision:741; number_of_response:1; }","duration":"128.026217ms","start":"2026-04-08T22:57:10.259377Z","end":"2026-04-08T22:57:10.387404Z","steps":["trace[1229907070] 'process raft request' (duration: 127.926475ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:58:23.074747Z","caller":"traceutil/trace.go:171","msg":"trace[870370364] linearizableReadLoop","detail":"{readStateIndex:1862; appliedIndex:1860; }","duration":"165.595176ms","start":"2026-04-08T22:58:22.909123Z","end":"2026-04-08T22:58:23.074718Z","steps":["trace[870370364] 'read index received' (duration: 70.871695ms)","trace[870370364] 'applied index is now lower than readState.Index' (duration: 94.722001ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T22:58:23.074805Z","caller":"traceutil/trace.go:171","msg":"trace[1803632786] transaction","detail":"{read_only:false; response_revision:1794; number_of_response:1; }","duration":"173.969523ms","start":"2026-04-08T22:58:22.900797Z","end":"2026-04-08T22:58:23.074767Z","steps":["trace[1803632786] 'process raft request' (duration: 151.140337ms)","trace[1803632786] 'compare' (duration: 22.6166ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T22:58:23.074991Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.804053ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T22:58:23.075077Z","caller":"traceutil/trace.go:171","msg":"trace[891007020] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:1794; }","duration":"165.966566ms","start":"2026-04-08T22:58:22.909086Z","end":"2026-04-08T22:58:23.075053Z","steps":["trace[891007020] 'agreement among raft nodes before linearized reading' (duration: 165.74671ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:58:23.107964Z","caller":"traceutil/trace.go:171","msg":"trace[1601547591] transaction","detail":"{read_only:false; response_revision:1795; number_of_response:1; }","duration":"126.602693ms","start":"2026-04-08T22:58:22.981337Z","end":"2026-04-08T22:58:23.10794Z","steps":["trace[1601547591] 'process raft request' (duration: 126.15005ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:58:23.108052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.835415ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-08T22:58:23.1082Z","caller":"traceutil/trace.go:171","msg":"trace[177237870] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; response_count:0; response_revision:1796; }","duration":"188.043871ms","start":"2026-04-08T22:58:22.920129Z","end":"2026-04-08T22:58:23.108172Z","steps":["trace[177237870] 'agreement among raft nodes before linearized reading' (duration: 187.700482ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:58:31.548025Z","caller":"traceutil/trace.go:171","msg":"trace[1307720500] transaction","detail":"{read_only:false; response_revision:1873; number_of_response:1; }","duration":"113.261226ms","start":"2026-04-08T22:58:31.434732Z","end":"2026-04-08T22:58:31.547993Z","steps":["trace[1307720500] 'process raft request' (duration: 106.287738ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:59:13.397283Z","caller":"traceutil/trace.go:171","msg":"trace[2101384531] transaction","detail":"{read_only:false; response_revision:2116; number_of_response:1; }","duration":"101.87411ms","start":"2026-04-08T22:59:13.295331Z","end":"2026-04-08T22:59:13.397205Z","steps":["trace[2101384531] 'process raft request' (duration: 101.666133ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T23:04:38.809372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.337018ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/monitoring/vector\" ","response":"range_response_count:1 size:894"} {"level":"info","ts":"2026-04-08T23:04:38.809489Z","caller":"traceutil/trace.go:171","msg":"trace[1119790957] range","detail":"{range_begin:/registry/serviceaccounts/monitoring/vector; range_end:; response_count:1; response_revision:4992; }","duration":"190.534224ms","start":"2026-04-08T23:04:38.618932Z","end":"2026-04-08T23:04:38.809467Z","steps":["trace[1119790957] 'range keys from in-memory index tree' (duration: 190.018769ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T23:04:38.809756Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.136024ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:25 size:777477"} {"level":"info","ts":"2026-04-08T23:04:38.809806Z","caller":"traceutil/trace.go:171","msg":"trace[261409278] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:25; response_revision:4992; }","duration":"112.193245ms","start":"2026-04-08T23:04:38.697599Z","end":"2026-04-08T23:04:38.809793Z","steps":["trace[261409278] 'range keys from in-memory index tree' (duration: 111.654321ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T23:04:38.809793Z","caller":"traceutil/trace.go:171","msg":"trace[1928532140] transaction","detail":"{read_only:false; response_revision:4993; number_of_response:1; }","duration":"107.474667ms","start":"2026-04-08T23:04:38.702236Z","end":"2026-04-08T23:04:38.809711Z","steps":["trace[1928532140] 'process raft request' (duration: 48.593693ms)","trace[1928532140] 'compare' (duration: 58.610117ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T23:04:39.293375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.780616ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-22b6187d-ef67-4924-8425-2494bbc7c352\" ","response":"range_response_count:1 size:3601"} {"level":"info","ts":"2026-04-08T23:04:39.293485Z","caller":"traceutil/trace.go:171","msg":"trace[391216698] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-22b6187d-ef67-4924-8425-2494bbc7c352; range_end:; response_count:1; response_revision:4996; }","duration":"110.9151ms","start":"2026-04-08T23:04:39.182545Z","end":"2026-04-08T23:04:39.29346Z","steps":["trace[391216698] 'range keys from in-memory index tree' (duration: 110.517259ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T23:04:49.392405Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.745206ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/kube-prometheus-stack-prometheus-node-exporter-msh2h\" ","response":"range_response_count:1 size:9901"} {"level":"info","ts":"2026-04-08T23:04:49.392518Z","caller":"traceutil/trace.go:171","msg":"trace[2037600176] range","detail":"{range_begin:/registry/pods/monitoring/kube-prometheus-stack-prometheus-node-exporter-msh2h; range_end:; response_count:1; response_revision:5202; }","duration":"102.8883ms","start":"2026-04-08T23:04:49.289604Z","end":"2026-04-08T23:04:49.392493Z","steps":["trace[2037600176] 'agreement among raft nodes before linearized reading' (duration: 102.626793ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T23:04:49.606838Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.418572ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-08T23:04:49.606918Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.380859ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/vector-xxtcl\" ","response":"range_response_count:1 size:5852"} {"level":"info","ts":"2026-04-08T23:04:49.606949Z","caller":"traceutil/trace.go:171","msg":"trace[303219100] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:5207; }","duration":"108.574067ms","start":"2026-04-08T23:04:49.498351Z","end":"2026-04-08T23:04:49.606925Z","steps":["trace[303219100] 'count revisions from in-memory index tree' (duration: 108.359391ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T23:04:49.607004Z","caller":"traceutil/trace.go:171","msg":"trace[41946966] range","detail":"{range_begin:/registry/pods/monitoring/vector-xxtcl; range_end:; response_count:1; response_revision:5207; }","duration":"109.530093ms","start":"2026-04-08T23:04:49.497449Z","end":"2026-04-08T23:04:49.606979Z","steps":["trace[41946966] 'range keys from in-memory index tree' (duration: 109.198364ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T23:04:49.607199Z","caller":"traceutil/trace.go:171","msg":"trace[909145723] transaction","detail":"{read_only:false; response_revision:5208; number_of_response:1; }","duration":"107.562949ms","start":"2026-04-08T23:04:49.499608Z","end":"2026-04-08T23:04:49.60717Z","steps":["trace[909145723] 'compare' (duration: 98.358586ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T23:04:49.607526Z","caller":"traceutil/trace.go:171","msg":"trace[1284553021] transaction","detail":"{read_only:false; response_revision:5209; number_of_response:1; }","duration":"105.989856ms","start":"2026-04-08T23:04:49.501501Z","end":"2026-04-08T23:04:49.607491Z","steps":["trace[1284553021] 'process raft request' (duration: 105.585365ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T23:04:49.60774Z","caller":"traceutil/trace.go:171","msg":"trace[1486350250] transaction","detail":"{read_only:false; response_revision:5210; number_of_response:1; }","duration":"101.166103ms","start":"2026-04-08T23:04:49.506545Z","end":"2026-04-08T23:04:49.607711Z","steps":["trace[1486350250] 'process raft request' (duration: 100.826344ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T23:04:49.811423Z","caller":"traceutil/trace.go:171","msg":"trace[377507394] linearizableReadLoop","detail":"{readStateIndex:5402; appliedIndex:5401; }","duration":"135.007991ms","start":"2026-04-08T23:04:49.676389Z","end":"2026-04-08T23:04:49.811397Z","steps":["trace[377507394] 'read index received' (duration: 134.823786ms)","trace[377507394] 'applied index is now lower than readState.Index' (duration: 183.065µs)"],"step_count":2} {"level":"info","ts":"2026-04-08T23:04:49.811533Z","caller":"traceutil/trace.go:171","msg":"trace[2113394802] transaction","detail":"{read_only:false; response_revision:5211; number_of_response:1; }","duration":"192.779625ms","start":"2026-04-08T23:04:49.61872Z","end":"2026-04-08T23:04:49.8115Z","steps":["trace[2113394802] 'process raft request' (duration: 192.515278ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T23:04:49.81168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.260088ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"info","ts":"2026-04-08T23:04:49.811729Z","caller":"traceutil/trace.go:171","msg":"trace[394072444] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5211; }","duration":"135.401442ms","start":"2026-04-08T23:04:49.676312Z","end":"2026-04-08T23:04:49.811714Z","steps":["trace[394072444] 'agreement among raft nodes before linearized reading' (duration: 135.208736ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T23:04:57.432292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.99167ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-04-08T23:04:57.432381Z","caller":"traceutil/trace.go:171","msg":"trace[1290433504] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5388; }","duration":"112.180395ms","start":"2026-04-08T23:04:57.320184Z","end":"2026-04-08T23:04:57.432364Z","steps":["trace[1290433504] 'range keys from in-memory index tree' (duration: 111.504296ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T23:04:57.623029Z","caller":"traceutil/trace.go:171","msg":"trace[679055144] transaction","detail":"{read_only:false; response_revision:5390; number_of_response:1; }","duration":"181.919366ms","start":"2026-04-08T23:04:57.441091Z","end":"2026-04-08T23:04:57.62301Z","steps":["trace[679055144] 'process raft request' (duration: 167.83407ms)","trace[679055144] 'compare' (duration: 13.752727ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T23:04:57.636503Z","caller":"traceutil/trace.go:171","msg":"trace[1488120341] transaction","detail":"{read_only:false; response_revision:5391; number_of_response:1; }","duration":"170.306799ms","start":"2026-04-08T23:04:57.46615Z","end":"2026-04-08T23:04:57.636457Z","steps":["trace[1488120341] 'process raft request' (duration: 170.044822ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T23:06:19.819188Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2997} {"level":"info","ts":"2026-04-08T23:06:19.896888Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2997,"took":"75.783104ms","hash":2120835414,"current-db-size-bytes":57872384,"current-db-size":"58 MB","current-db-size-in-use-bytes":33939456,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-04-08T23:06:19.896982Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2120835414,"revision":2997,"compact-revision":-1} {"level":"info","ts":"2026-04-08T23:10:55.0923Z","caller":"traceutil/trace.go:171","msg":"trace[1784043411] transaction","detail":"{read_only:false; response_revision:8160; number_of_response:1; }","duration":"261.91319ms","start":"2026-04-08T23:10:54.830359Z","end":"2026-04-08T23:10:55.092272Z","steps":["trace[1784043411] 'process raft request' (duration: 261.742726ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T23:10:55.268826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.495991ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-08T23:10:55.269047Z","caller":"traceutil/trace.go:171","msg":"trace[157752300] transaction","detail":"{read_only:false; response_revision:8162; number_of_response:1; }","duration":"105.363974ms","start":"2026-04-08T23:10:55.163662Z","end":"2026-04-08T23:10:55.269026Z","steps":["trace[157752300] 'process raft request' (duration: 105.293782ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T23:10:55.269126Z","caller":"traceutil/trace.go:171","msg":"trace[504473327] linearizableReadLoop","detail":"{readStateIndex:8442; appliedIndex:8441; }","duration":"283.047047ms","start":"2026-04-08T23:10:54.986051Z","end":"2026-04-08T23:10:55.269098Z","steps":["trace[504473327] 'read index received' (duration: 106.624728ms)","trace[504473327] 'applied index is now lower than readState.Index' (duration: 176.416999ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T23:10:55.269108Z","caller":"traceutil/trace.go:171","msg":"trace[197396752] transaction","detail":"{read_only:false; response_revision:8161; number_of_response:1; }","duration":"423.409229ms","start":"2026-04-08T23:10:54.845643Z","end":"2026-04-08T23:10:55.269052Z","steps":["trace[197396752] 'process raft request' (duration: 303.390093ms)","trace[197396752] 'compare' (duration: 119.293046ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T23:10:55.269341Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T23:10:54.845627Z","time spent":"423.637836ms","remote":"127.0.0.1:55406","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-08T23:10:55.269507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.452398ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"warn","ts":"2026-04-08T23:10:55.269528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.738787ms","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-04-08T23:10:55.26967Z","caller":"traceutil/trace.go:171","msg":"trace[1248967414] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8162; }","duration":"283.662534ms","start":"2026-04-08T23:10:54.985956Z","end":"2026-04-08T23:10:55.269618Z","steps":["trace[1248967414] 'agreement among raft nodes before linearized reading' (duration: 283.321215ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T23:10:55.269673Z","caller":"traceutil/trace.go:171","msg":"trace[200253852] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:8162; }","duration":"241.954952ms","start":"2026-04-08T23:10:55.027686Z","end":"2026-04-08T23:10:55.269641Z","steps":["trace[200253852] 'agreement among raft nodes before linearized reading' (duration: 241.668364ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T23:11:06.695012Z","caller":"traceutil/trace.go:171","msg":"trace[1501124707] transaction","detail":"{read_only:false; response_revision:8224; number_of_response:1; }","duration":"209.377241ms","start":"2026-04-08T23:11:06.4856Z","end":"2026-04-08T23:11:06.694977Z","steps":["trace[1501124707] 'process raft request' (duration: 209.199646ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T23:11:06.807769Z","caller":"traceutil/trace.go:171","msg":"trace[241807273] transaction","detail":"{read_only:false; response_revision:8225; number_of_response:1; }","duration":"302.55223ms","start":"2026-04-08T23:11:06.505175Z","end":"2026-04-08T23:11:06.807728Z","steps":["trace[241807273] 'process raft request' (duration: 214.83511ms)","trace[241807273] 'compare' (duration: 87.311179ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T23:11:06.807942Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T23:11:06.505139Z","time spent":"302.708534ms","remote":"127.0.0.1:55406","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T23:11:07.598205Z","caller":"traceutil/trace.go:171","msg":"trace[2126071383] linearizableReadLoop","detail":"{readStateIndex:8511; appliedIndex:8510; }","duration":"108.296294ms","start":"2026-04-08T23:11:07.489879Z","end":"2026-04-08T23:11:07.598175Z","steps":["trace[2126071383] 'read index received' (duration: 65.865763ms)","trace[2126071383] 'applied index is now lower than readState.Index' (duration: 42.428771ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T23:11:07.598255Z","caller":"traceutil/trace.go:171","msg":"trace[1943152277] transaction","detail":"{read_only:false; response_revision:8227; number_of_response:1; }","duration":"247.908043ms","start":"2026-04-08T23:11:07.350288Z","end":"2026-04-08T23:11:07.598197Z","steps":["trace[1943152277] 'process raft request' (duration: 205.515714ms)","trace[1943152277] 'compare' (duration: 42.03759ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T23:11:07.598481Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.587452ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-nxss6\" ","response":"range_response_count:1 size:6524"} {"level":"info","ts":"2026-04-08T23:11:07.598563Z","caller":"traceutil/trace.go:171","msg":"trace[2139938171] range","detail":"{range_begin:/registry/pods/openstack/keepalived-nxss6; range_end:; response_count:1; response_revision:8227; }","duration":"108.712465ms","start":"2026-04-08T23:11:07.489831Z","end":"2026-04-08T23:11:07.598543Z","steps":["trace[2139938171] 'agreement among raft nodes before linearized reading' (duration: 108.467198ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T23:11:19.826115Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6126} {"level":"info","ts":"2026-04-08T23:11:19.92824Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6126,"took":"99.546983ms","hash":4196790869,"current-db-size-bytes":57872384,"current-db-size":"58 MB","current-db-size-in-use-bytes":23068672,"current-db-size-in-use":"23 MB"} {"level":"info","ts":"2026-04-08T23:11:19.928324Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4196790869,"revision":6126,"compact-revision":2997} {"level":"info","ts":"2026-04-08T23:11:35.68725Z","caller":"traceutil/trace.go:171","msg":"trace[571567686] linearizableReadLoop","detail":"{readStateIndex:8724; appliedIndex:8723; }","duration":"132.247739ms","start":"2026-04-08T23:11:35.554978Z","end":"2026-04-08T23:11:35.687226Z","steps":["trace[571567686] 'read index received' (duration: 131.92853ms)","trace[571567686] 'applied index is now lower than readState.Index' (duration: 318.299µs)"],"step_count":2} {"level":"warn","ts":"2026-04-08T23:11:35.687444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.441774ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T23:11:35.687477Z","caller":"traceutil/trace.go:171","msg":"trace[769501384] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8431; }","duration":"132.540327ms","start":"2026-04-08T23:11:35.554928Z","end":"2026-04-08T23:11:35.687468Z","steps":["trace[769501384] 'agreement among raft nodes before linearized reading' (duration: 132.430094ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T23:11:35.687837Z","caller":"traceutil/trace.go:171","msg":"trace[1064086127] transaction","detail":"{read_only:false; response_revision:8431; number_of_response:1; }","duration":"225.45833ms","start":"2026-04-08T23:11:35.462366Z","end":"2026-04-08T23:11:35.687824Z","steps":["trace[1064086127] 'process raft request' (duration: 224.612877ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T23:11:47.88726Z","caller":"traceutil/trace.go:171","msg":"trace[829803984] linearizableReadLoop","detail":"{readStateIndex:8833; appliedIndex:8832; }","duration":"148.702729ms","start":"2026-04-08T23:11:47.738527Z","end":"2026-04-08T23:11:47.88723Z","steps":["trace[829803984] 'read index received' (duration: 118.78233ms)","trace[829803984] 'applied index is now lower than readState.Index' (duration: 29.918699ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T23:11:47.887289Z","caller":"traceutil/trace.go:171","msg":"trace[1514857978] transaction","detail":"{read_only:false; response_revision:8535; number_of_response:1; }","duration":"152.354069ms","start":"2026-04-08T23:11:47.73489Z","end":"2026-04-08T23:11:47.887244Z","steps":["trace[1514857978] 'process raft request' (duration: 122.376668ms)","trace[1514857978] 'compare' (duration: 29.726734ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T23:11:47.887607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.051078ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/openstack/rook-ceph-detect-version-mlqdk\" ","response":"range_response_count:1 size:2801"} {"level":"info","ts":"2026-04-08T23:11:47.887723Z","caller":"traceutil/trace.go:171","msg":"trace[1594492015] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/openstack/rook-ceph-detect-version-mlqdk; range_end:; response_count:1; response_revision:8535; }","duration":"149.212253ms","start":"2026-04-08T23:11:47.738471Z","end":"2026-04-08T23:11:47.887684Z","steps":["trace[1594492015] 'agreement among raft nodes before linearized reading' (duration: 148.887764ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T23:11:47.903349Z","caller":"traceutil/trace.go:171","msg":"trace[519540438] transaction","detail":"{read_only:false; response_revision:8536; number_of_response:1; }","duration":"163.842134ms","start":"2026-04-08T23:11:47.739478Z","end":"2026-04-08T23:11:47.90332Z","steps":["trace[519540438] 'process raft request' (duration: 163.657809ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T23:11:48.421073Z","caller":"traceutil/trace.go:171","msg":"trace[933182383] linearizableReadLoop","detail":"{readStateIndex:8845; appliedIndex:8843; }","duration":"106.69066ms","start":"2026-04-08T23:11:48.314348Z","end":"2026-04-08T23:11:48.421038Z","steps":["trace[933182383] 'read index received' (duration: 67.798657ms)","trace[933182383] 'applied index is now lower than readState.Index' (duration: 38.890233ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T23:11:48.421404Z","caller":"traceutil/trace.go:171","msg":"trace[685852898] transaction","detail":"{read_only:false; response_revision:8546; number_of_response:1; }","duration":"116.960341ms","start":"2026-04-08T23:11:48.304395Z","end":"2026-04-08T23:11:48.421355Z","steps":["trace[685852898] 'process raft request' (duration: 116.470277ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T23:11:48.421302Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.878506ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T23:11:48.421721Z","caller":"traceutil/trace.go:171","msg":"trace[822556249] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:8546; }","duration":"107.225206ms","start":"2026-04-08T23:11:48.314312Z","end":"2026-04-08T23:11:48.421537Z","steps":["trace[822556249] 'agreement among raft nodes before linearized reading' (duration: 106.867616ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T23:11:49.416426Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.670368ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1821"} {"level":"info","ts":"2026-04-08T23:11:49.416754Z","caller":"traceutil/trace.go:171","msg":"trace[1490639790] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:8552; }","duration":"190.899124ms","start":"2026-04-08T23:11:49.225652Z","end":"2026-04-08T23:11:49.416551Z","steps":["trace[1490639790] 'range keys from in-memory index tree' (duration: 190.462642ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T23:12:38.043997Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002471.wal"} {"level":"warn","ts":"2026-04-08T23:13:00.953936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.377487ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-08T23:13:00.954252Z","caller":"traceutil/trace.go:171","msg":"trace[1645823926] linearizableReadLoop","detail":"{readStateIndex:9584; appliedIndex:9583; }","duration":"176.573632ms","start":"2026-04-08T23:13:00.777653Z","end":"2026-04-08T23:13:00.954227Z","steps":["trace[1645823926] 'read index received' (duration: 60.720092ms)","trace[1645823926] 'applied index is now lower than readState.Index' (duration: 115.85146ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T23:13:00.954541Z","caller":"traceutil/trace.go:171","msg":"trace[1324283318] transaction","detail":"{read_only:false; response_revision:9267; number_of_response:1; }","duration":"225.534301ms","start":"2026-04-08T23:13:00.728938Z","end":"2026-04-08T23:13:00.954472Z","steps":["trace[1324283318] 'process raft request' (duration: 109.484456ms)","trace[1324283318] 'compare' (duration: 115.239673ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T23:13:00.954736Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.058606ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-04-08T23:13:00.954846Z","caller":"traceutil/trace.go:171","msg":"trace[1101634098] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:9267; }","duration":"177.19473ms","start":"2026-04-08T23:13:00.777622Z","end":"2026-04-08T23:13:00.954817Z","steps":["trace[1101634098] 'agreement among raft nodes before linearized reading' (duration: 176.878761ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T23:13:00.955011Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.229761ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"info","ts":"2026-04-08T23:13:00.955194Z","caller":"traceutil/trace.go:171","msg":"trace[1312739506] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:9267; }","duration":"131.377596ms","start":"2026-04-08T23:13:00.823709Z","end":"2026-04-08T23:13:00.955087Z","steps":["trace[1312739506] 'agreement among raft nodes before linearized reading' (duration: 131.046567ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T23:13:55.42669Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"adfb641115bf6cbd","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-08T23:13:55.43228Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-04-08T23:13:55.432415Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-04-08T23:16:19.83434Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8300} {"level":"info","ts":"2026-04-08T23:16:19.914787Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8300,"took":"77.855704ms","hash":4267791696,"current-db-size-bytes":57872384,"current-db-size":"58 MB","current-db-size-in-use-bytes":24829952,"current-db-size-in-use":"25 MB"} {"level":"info","ts":"2026-04-08T23:16:19.914866Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4267791696,"revision":8300,"compact-revision":6126} {"level":"warn","ts":"2026-04-08T23:16:44.19038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.999511ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-08T23:16:44.190525Z","caller":"traceutil/trace.go:171","msg":"trace[539819428] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:10818; }","duration":"132.186236ms","start":"2026-04-08T23:16:44.058312Z","end":"2026-04-08T23:16:44.190498Z","steps":["trace[539819428] 'count revisions from in-memory index tree' (duration: 131.920289ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T23:21:19.840253Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10685} {"level":"info","ts":"2026-04-08T23:21:19.919804Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10685,"took":"76.940917ms","hash":3869034112,"current-db-size-bytes":57872384,"current-db-size":"58 MB","current-db-size-in-use-bytes":20537344,"current-db-size-in-use":"20 MB"} {"level":"info","ts":"2026-04-08T23:21:19.919886Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3869034112,"revision":10685,"compact-revision":8300}