{"level":"warn","ts":"2026-04-07T15:27:04.839277Z","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-07T15:27:04.839383Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.205: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.205:2380","--initial-cluster=instance=https://199.204.45.205:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.205:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.205: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-07T15:27:04.839456Z","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-07T15:27:04.839466Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.205:2380"]} {"level":"info","ts":"2026-04-07T15:27:04.839486Z","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-07T15:27:04.840404Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.205:2379"]} {"level":"info","ts":"2026-04-07T15:27:04.840488Z","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.205:2380"],"listen-peer-urls":["https://199.204.45.205:2380"],"advertise-client-urls":["https://199.204.45.205:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.205:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.205: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-07T15:27:04.845604Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.904136ms"} {"level":"info","ts":"2026-04-07T15:27:04.852597Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"71d28e9ac1bc4e5d","cluster-id":"4a4ae660c7a9a6a7"} {"level":"info","ts":"2026-04-07T15:27:04.852759Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d switched to configuration voters=()"} {"level":"info","ts":"2026-04-07T15:27:04.852808Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became follower at term 0"} {"level":"info","ts":"2026-04-07T15:27:04.852825Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 71d28e9ac1bc4e5d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-07T15:27:04.852846Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became follower at term 1"} {"level":"info","ts":"2026-04-07T15:27:04.852919Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d switched to configuration voters=(8201774666721545821)"} {"level":"warn","ts":"2026-04-07T15:27:04.864182Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-07T15:27:04.865696Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-07T15:27:04.866928Z","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-07T15:27:04.869462Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"71d28e9ac1bc4e5d","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-07T15:27:04.869608Z","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-07T15:27:04.869731Z","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-07T15:27:04.869643Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"71d28e9ac1bc4e5d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-07T15:27:04.869747Z","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-07T15:27:04.870617Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d switched to configuration voters=(8201774666721545821)"} {"level":"info","ts":"2026-04-07T15:27:04.870776Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"4a4ae660c7a9a6a7","local-member-id":"71d28e9ac1bc4e5d","added-peer-id":"71d28e9ac1bc4e5d","added-peer-peer-urls":["https://199.204.45.205:2380"]} {"level":"info","ts":"2026-04-07T15:27:04.874304Z","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-07T15:27:04.87445Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.205:2380"} {"level":"info","ts":"2026-04-07T15:27:04.874581Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.205:2380"} {"level":"info","ts":"2026-04-07T15:27:04.874655Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"71d28e9ac1bc4e5d","initial-advertise-peer-urls":["https://199.204.45.205:2380"],"listen-peer-urls":["https://199.204.45.205:2380"],"advertise-client-urls":["https://199.204.45.205:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.205:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-07T15:27:04.874719Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-07T15:27:05.053829Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d is starting a new election at term 1"} {"level":"info","ts":"2026-04-07T15:27:05.053947Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became pre-candidate at term 1"} {"level":"info","ts":"2026-04-07T15:27:05.054005Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d received MsgPreVoteResp from 71d28e9ac1bc4e5d at term 1"} {"level":"info","ts":"2026-04-07T15:27:05.054028Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became candidate at term 2"} {"level":"info","ts":"2026-04-07T15:27:05.054039Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d received MsgVoteResp from 71d28e9ac1bc4e5d at term 2"} {"level":"info","ts":"2026-04-07T15:27:05.054059Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became leader at term 2"} {"level":"info","ts":"2026-04-07T15:27:05.054125Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 71d28e9ac1bc4e5d elected leader 71d28e9ac1bc4e5d at term 2"} {"level":"info","ts":"2026-04-07T15:27:05.055374Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T15:27:05.055601Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"71d28e9ac1bc4e5d","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.205:2379]}","request-path":"/0/members/71d28e9ac1bc4e5d/attributes","cluster-id":"4a4ae660c7a9a6a7","publish-timeout":"7s"} {"level":"info","ts":"2026-04-07T15:27:05.055765Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-07T15:27:05.055798Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-07T15:27:05.055946Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-07T15:27:05.056049Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-07T15:27:05.056485Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"4a4ae660c7a9a6a7","local-member-id":"71d28e9ac1bc4e5d","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T15:27:05.056652Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T15:27:05.056716Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T15:27:05.059551Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-07T15:27:05.060789Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.205:2379"} {"level":"info","ts":"2026-04-07T15:27:33.347818Z","caller":"traceutil/trace.go:171","msg":"trace[1395945063] transaction","detail":"{read_only:false; response_revision:436; number_of_response:1; }","duration":"166.770809ms","start":"2026-04-07T15:27:33.181009Z","end":"2026-04-07T15:27:33.34778Z","steps":["trace[1395945063] 'process raft request' (duration: 166.573605ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T15:27:33.52773Z","caller":"traceutil/trace.go:171","msg":"trace[1375322473] transaction","detail":"{read_only:false; response_revision:437; number_of_response:1; }","duration":"174.216405ms","start":"2026-04-07T15:27:33.353477Z","end":"2026-04-07T15:27:33.527694Z","steps":["trace[1375322473] 'process raft request' (duration: 102.894769ms)","trace[1375322473] 'compare' (duration: 71.056221ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T15:27:33.527827Z","caller":"traceutil/trace.go:171","msg":"trace[1013871805] transaction","detail":"{read_only:false; response_revision:438; number_of_response:1; }","duration":"173.986951ms","start":"2026-04-07T15:27:33.353796Z","end":"2026-04-07T15:27:33.527783Z","steps":["trace[1013871805] 'process raft request' (duration: 173.800237ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T15:27:35.309702Z","caller":"traceutil/trace.go:171","msg":"trace[279769874] transaction","detail":"{read_only:false; response_revision:490; number_of_response:1; }","duration":"102.795487ms","start":"2026-04-07T15:27:35.206872Z","end":"2026-04-07T15:27:35.309668Z","steps":["trace[279769874] 'process raft request' (duration: 102.548042ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T15:27:35.310758Z","caller":"traceutil/trace.go:171","msg":"trace[1058467299] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"103.721795ms","start":"2026-04-07T15:27:35.206989Z","end":"2026-04-07T15:27:35.310711Z","steps":["trace[1058467299] 'process raft request' (duration: 102.617962ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T15:27:38.433486Z","caller":"traceutil/trace.go:171","msg":"trace[727988563] transaction","detail":"{read_only:false; response_revision:557; number_of_response:1; }","duration":"104.50547ms","start":"2026-04-07T15:27:38.328937Z","end":"2026-04-07T15:27:38.433442Z","steps":["trace[727988563] 'process raft request' (duration: 104.079022ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T15:27:41.565375Z","caller":"traceutil/trace.go:171","msg":"trace[752052773] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"197.503014ms","start":"2026-04-07T15:27:41.367835Z","end":"2026-04-07T15:27:41.565338Z","steps":["trace[752052773] 'process raft request' (duration: 196.840332ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T15:27:41.73223Z","caller":"traceutil/trace.go:171","msg":"trace[1195831497] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"110.209524ms","start":"2026-04-07T15:27:41.621984Z","end":"2026-04-07T15:27:41.732193Z","steps":["trace[1195831497] 'process raft request' (duration: 109.907918ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T15:27:42.21874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.681116ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T15:27:42.218875Z","caller":"traceutil/trace.go:171","msg":"trace[1161699868] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:583; }","duration":"350.870609ms","start":"2026-04-07T15:27:41.867973Z","end":"2026-04-07T15:27:42.218844Z","steps":["trace[1161699868] 'range keys from in-memory index tree' (duration: 350.587463ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T15:27:42.218922Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T15:27:41.867948Z","time spent":"350.961921ms","remote":"127.0.0.1:42078","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-07T15:27:56.623473Z","caller":"traceutil/trace.go:171","msg":"trace[563486603] transaction","detail":"{read_only:false; response_revision:742; number_of_response:1; }","duration":"214.971389ms","start":"2026-04-07T15:27:56.408472Z","end":"2026-04-07T15:27:56.623443Z","steps":["trace[563486603] 'process raft request' (duration: 199.360961ms)","trace[563486603] 'compare' (duration: 15.488516ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T15:28:47.854913Z","caller":"traceutil/trace.go:171","msg":"trace[1993317668] transaction","detail":"{read_only:false; response_revision:1394; number_of_response:1; }","duration":"114.196589ms","start":"2026-04-07T15:28:47.740685Z","end":"2026-04-07T15:28:47.854881Z","steps":["trace[1993317668] 'process raft request' (duration: 114.019876ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T15:28:47.914739Z","caller":"traceutil/trace.go:171","msg":"trace[1495647552] transaction","detail":"{read_only:false; response_revision:1395; number_of_response:1; }","duration":"149.087078ms","start":"2026-04-07T15:28:47.765595Z","end":"2026-04-07T15:28:47.914682Z","steps":["trace[1495647552] 'process raft request' (duration: 148.904825ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T15:29:13.424586Z","caller":"traceutil/trace.go:171","msg":"trace[2038935505] transaction","detail":"{read_only:false; response_revision:1812; number_of_response:1; }","duration":"119.563036ms","start":"2026-04-07T15:29:13.304974Z","end":"2026-04-07T15:29:13.424537Z","steps":["trace[2038935505] 'process raft request' (duration: 119.342782ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T15:29:14.04371Z","caller":"traceutil/trace.go:171","msg":"trace[2045705984] linearizableReadLoop","detail":"{readStateIndex:1887; appliedIndex:1886; }","duration":"306.38549ms","start":"2026-04-07T15:29:13.737303Z","end":"2026-04-07T15:29:14.043688Z","steps":["trace[2045705984] 'read index received' (duration: 306.226637ms)","trace[2045705984] 'applied index is now lower than readState.Index' (duration: 157.223µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T15:29:14.043802Z","caller":"traceutil/trace.go:171","msg":"trace[1212581283] transaction","detail":"{read_only:false; response_revision:1814; number_of_response:1; }","duration":"322.728789ms","start":"2026-04-07T15:29:13.721034Z","end":"2026-04-07T15:29:14.043763Z","steps":["trace[1212581283] 'process raft request' (duration: 322.480524ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T15:29:14.043962Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.580205ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-07T15:29:14.044128Z","caller":"traceutil/trace.go:171","msg":"trace[1044488726] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:1814; }","duration":"306.88105ms","start":"2026-04-07T15:29:13.737228Z","end":"2026-04-07T15:29:14.044109Z","steps":["trace[1044488726] 'agreement among raft nodes before linearized reading' (duration: 306.560504ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T15:29:14.044247Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T15:29:13.737199Z","time spent":"307.030804ms","remote":"127.0.0.1:56126","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":13,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true "} {"level":"warn","ts":"2026-04-07T15:29:14.044423Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T15:29:13.721006Z","time spent":"322.883221ms","remote":"127.0.0.1:42368","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T15:29:14.313365Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.597837ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T15:29:14.313511Z","caller":"traceutil/trace.go:171","msg":"trace[855874497] linearizableReadLoop","detail":"{readStateIndex:1888; appliedIndex:1887; }","duration":"269.697805ms","start":"2026-04-07T15:29:14.043787Z","end":"2026-04-07T15:29:14.313484Z","steps":["trace[855874497] 'read index received' (duration: 148.511907ms)","trace[855874497] 'applied index is now lower than readState.Index' (duration: 121.183588ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T15:29:14.313565Z","caller":"traceutil/trace.go:171","msg":"trace[91267841] transaction","detail":"{read_only:false; response_revision:1815; number_of_response:1; }","duration":"313.906622ms","start":"2026-04-07T15:29:13.999601Z","end":"2026-04-07T15:29:14.313507Z","steps":["trace[91267841] 'process raft request' (duration: 192.827225ms)","trace[91267841] 'compare' (duration: 120.330842ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T15:29:14.313625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"447.031491ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-07T15:29:14.313666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"334.040936ms","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":"warn","ts":"2026-04-07T15:29:14.31366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.655006ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-07T15:29:14.313737Z","caller":"traceutil/trace.go:171","msg":"trace[608020525] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1815; }","duration":"334.149988ms","start":"2026-04-07T15:29:13.979572Z","end":"2026-04-07T15:29:14.313722Z","steps":["trace[608020525] 'agreement among raft nodes before linearized reading' (duration: 333.965163ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T15:29:14.313741Z","caller":"traceutil/trace.go:171","msg":"trace[1498440411] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1815; }","duration":"447.157303ms","start":"2026-04-07T15:29:13.866519Z","end":"2026-04-07T15:29:14.313676Z","steps":["trace[1498440411] 'agreement among raft nodes before linearized reading' (duration: 447.044581ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T15:29:14.313774Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T15:29:13.97955Z","time spent":"334.21861ms","remote":"127.0.0.1:42368","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-07T15:29:14.313787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"497.004462ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-a7570b30-221e-43e0-baf8-275d7a16c2cf\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-04-07T15:29:14.313817Z","caller":"traceutil/trace.go:171","msg":"trace[1994350523] range","detail":"{range_begin:/registry/poddisruptionbudgets/; range_end:/registry/poddisruptionbudgets0; response_count:0; response_revision:1815; }","duration":"295.834749ms","start":"2026-04-07T15:29:14.017922Z","end":"2026-04-07T15:29:14.313757Z","steps":["trace[1994350523] 'agreement among raft nodes before linearized reading' (duration: 295.612004ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T15:29:14.31394Z","caller":"traceutil/trace.go:171","msg":"trace[163812217] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-a7570b30-221e-43e0-baf8-275d7a16c2cf; range_end:; response_count:1; response_revision:1815; }","duration":"497.173416ms","start":"2026-04-07T15:29:13.816742Z","end":"2026-04-07T15:29:14.313916Z","steps":["trace[163812217] 'agreement among raft nodes before linearized reading' (duration: 496.87279ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T15:29:14.313998Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T15:29:13.816727Z","time spent":"497.253047ms","remote":"127.0.0.1:42274","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3649,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-a7570b30-221e-43e0-baf8-275d7a16c2cf\" "} {"level":"warn","ts":"2026-04-07T15:29:14.313805Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T15:29:13.866491Z","time spent":"447.290445ms","remote":"127.0.0.1:42072","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-07T15:29:14.315074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.86279ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/datadir-percona-xtradb-pxc-0.18a41cbcc07cd130\" ","response":"range_response_count:1 size:982"} {"level":"info","ts":"2026-04-07T15:29:14.315221Z","caller":"traceutil/trace.go:171","msg":"trace[1358339229] range","detail":"{range_begin:/registry/events/openstack/datadir-percona-xtradb-pxc-0.18a41cbcc07cd130; range_end:; response_count:1; response_revision:1815; }","duration":"275.056183ms","start":"2026-04-07T15:29:14.040149Z","end":"2026-04-07T15:29:14.315205Z","steps":["trace[1358339229] 'agreement among raft nodes before linearized reading' (duration: 273.469262ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T15:29:14.315616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.809883ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-a7570b30-221e-43e0-baf8-275d7a16c2cf\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-04-07T15:29:14.315717Z","caller":"traceutil/trace.go:171","msg":"trace[1293378060] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-a7570b30-221e-43e0-baf8-275d7a16c2cf; range_end:; response_count:1; response_revision:1815; }","duration":"162.964867ms","start":"2026-04-07T15:29:14.15273Z","end":"2026-04-07T15:29:14.315695Z","steps":["trace[1293378060] 'agreement among raft nodes before linearized reading' (duration: 162.692641ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T15:29:14.316796Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T15:29:13.999574Z","time spent":"314.104317ms","remote":"127.0.0.1:42368","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T15:29:26.243942Z","caller":"traceutil/trace.go:171","msg":"trace[773075101] transaction","detail":"{read_only:false; response_revision:1916; number_of_response:1; }","duration":"135.159238ms","start":"2026-04-07T15:29:26.108717Z","end":"2026-04-07T15:29:26.243876Z","steps":["trace[773075101] 'process raft request' (duration: 134.300952ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T15:30:09.006152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.449161ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T15:30:09.006335Z","caller":"traceutil/trace.go:171","msg":"trace[850435623] transaction","detail":"{read_only:false; response_revision:2158; number_of_response:1; }","duration":"297.32752ms","start":"2026-04-07T15:30:08.708981Z","end":"2026-04-07T15:30:09.006308Z","steps":["trace[850435623] 'process raft request' (duration: 130.564973ms)","trace[850435623] 'compare' (duration: 166.184196ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T15:30:09.051675Z","caller":"traceutil/trace.go:171","msg":"trace[580035670] linearizableReadLoop","detail":"{readStateIndex:2243; appliedIndex:2241; }","duration":"291.85246ms","start":"2026-04-07T15:30:08.759773Z","end":"2026-04-07T15:30:09.051626Z","steps":["trace[580035670] 'read index received' (duration: 79.773047ms)","trace[580035670] 'applied index is now lower than readState.Index' (duration: 212.077453ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T15:30:09.051853Z","caller":"traceutil/trace.go:171","msg":"trace[768343983] transaction","detail":"{read_only:false; response_revision:2159; number_of_response:1; }","duration":"292.157286ms","start":"2026-04-07T15:30:08.759646Z","end":"2026-04-07T15:30:09.051803Z","steps":["trace[768343983] 'process raft request' (duration: 291.739428ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T15:30:09.052036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.136116ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-04-07T15:30:09.052042Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.534042ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T15:30:09.052103Z","caller":"traceutil/trace.go:171","msg":"trace[938290410] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2159; }","duration":"292.288588ms","start":"2026-04-07T15:30:08.759796Z","end":"2026-04-07T15:30:09.052085Z","steps":["trace[938290410] 'agreement among raft nodes before linearized reading' (duration: 292.043604ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T15:30:09.05215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.832139ms","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-07T15:30:09.052163Z","caller":"traceutil/trace.go:171","msg":"trace[947883969] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2159; }","duration":"184.727285ms","start":"2026-04-07T15:30:08.867408Z","end":"2026-04-07T15:30:09.052136Z","steps":["trace[947883969] 'agreement among raft nodes before linearized reading' (duration: 184.501991ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T15:30:09.052217Z","caller":"traceutil/trace.go:171","msg":"trace[1102736226] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2159; }","duration":"289.954312ms","start":"2026-04-07T15:30:08.762247Z","end":"2026-04-07T15:30:09.052201Z","steps":["trace[1102736226] 'agreement among raft nodes before linearized reading' (duration: 289.747798ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T15:30:09.052059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.425472ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:554"} {"level":"info","ts":"2026-04-07T15:30:09.052298Z","caller":"traceutil/trace.go:171","msg":"trace[426178155] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2159; }","duration":"287.674147ms","start":"2026-04-07T15:30:08.764595Z","end":"2026-04-07T15:30:09.052269Z","steps":["trace[426178155] 'agreement among raft nodes before linearized reading' (duration: 287.338579ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T15:30:09.052061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.253988ms","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-07T15:30:09.052405Z","caller":"traceutil/trace.go:171","msg":"trace[618820384] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2159; }","duration":"292.659377ms","start":"2026-04-07T15:30:08.759733Z","end":"2026-04-07T15:30:09.052393Z","steps":["trace[618820384] 'agreement among raft nodes before linearized reading' (duration: 292.094105ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T15:30:09.302607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.117835ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T15:30:09.303012Z","caller":"traceutil/trace.go:171","msg":"trace[1643325017] transaction","detail":"{read_only:false; response_revision:2163; number_of_response:1; }","duration":"244.986402ms","start":"2026-04-07T15:30:09.058005Z","end":"2026-04-07T15:30:09.302991Z","steps":["trace[1643325017] 'process raft request' (duration: 244.925031ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T15:30:09.302966Z","caller":"traceutil/trace.go:171","msg":"trace[464711590] transaction","detail":"{read_only:false; response_revision:2160; number_of_response:1; }","duration":"245.895692ms","start":"2026-04-07T15:30:09.05702Z","end":"2026-04-07T15:30:09.302916Z","steps":["trace[464711590] 'process raft request' (duration: 119.37879ms)","trace[464711590] 'compare' (duration: 125.995331ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T15:30:09.302992Z","caller":"traceutil/trace.go:171","msg":"trace[192367289] transaction","detail":"{read_only:false; response_revision:2161; number_of_response:1; }","duration":"245.705757ms","start":"2026-04-07T15:30:09.057243Z","end":"2026-04-07T15:30:09.302948Z","steps":["trace[192367289] 'process raft request' (duration: 245.468083ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T15:30:09.303059Z","caller":"traceutil/trace.go:171","msg":"trace[683386639] transaction","detail":"{read_only:false; response_revision:2162; number_of_response:1; }","duration":"245.188828ms","start":"2026-04-07T15:30:09.057828Z","end":"2026-04-07T15:30:09.303017Z","steps":["trace[683386639] 'process raft request' (duration: 245.018584ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T15:30:42.988902Z","caller":"traceutil/trace.go:171","msg":"trace[1238194117] transaction","detail":"{read_only:false; response_revision:2519; number_of_response:1; }","duration":"173.91995ms","start":"2026-04-07T15:30:42.814953Z","end":"2026-04-07T15:30:42.988873Z","steps":["trace[1238194117] 'process raft request' (duration: 173.739487ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T15:35:29.063065Z","caller":"traceutil/trace.go:171","msg":"trace[1397917355] transaction","detail":"{read_only:false; response_revision:5136; number_of_response:1; }","duration":"124.587082ms","start":"2026-04-07T15:35:28.93845Z","end":"2026-04-07T15:35:29.063037Z","steps":["trace[1397917355] 'process raft request' (duration: 124.189384ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T15:35:29.063412Z","caller":"traceutil/trace.go:171","msg":"trace[936519347] transaction","detail":"{read_only:false; response_revision:5138; number_of_response:1; }","duration":"101.98138ms","start":"2026-04-07T15:35:28.961399Z","end":"2026-04-07T15:35:29.06338Z","steps":["trace[936519347] 'process raft request' (duration: 101.810396ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T15:35:29.063503Z","caller":"traceutil/trace.go:171","msg":"trace[720536663] transaction","detail":"{read_only:false; response_revision:5137; number_of_response:1; }","duration":"124.885308ms","start":"2026-04-07T15:35:28.938582Z","end":"2026-04-07T15:35:29.063467Z","steps":["trace[720536663] 'process raft request' (duration: 124.322236ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T15:35:50.430646Z","caller":"traceutil/trace.go:171","msg":"trace[35854846] linearizableReadLoop","detail":"{readStateIndex:5649; appliedIndex:5648; }","duration":"119.000402ms","start":"2026-04-07T15:35:50.311605Z","end":"2026-04-07T15:35:50.430605Z","steps":["trace[35854846] 'read index received' (duration: 68.036762ms)","trace[35854846] 'applied index is now lower than readState.Index' (duration: 50.9616ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T15:35:50.430869Z","caller":"traceutil/trace.go:171","msg":"trace[2144844348] transaction","detail":"{read_only:false; response_revision:5448; number_of_response:1; }","duration":"120.706805ms","start":"2026-04-07T15:35:50.310118Z","end":"2026-04-07T15:35:50.430825Z","steps":["trace[2144844348] 'process raft request' (duration: 69.527471ms)","trace[2144844348] 'compare' (duration: 50.775056ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T15:35:50.43126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.627434ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-24944\" ","response":"range_response_count:1 size:6531"} {"level":"info","ts":"2026-04-07T15:35:50.431372Z","caller":"traceutil/trace.go:171","msg":"trace[768306413] range","detail":"{range_begin:/registry/pods/openstack/keepalived-24944; range_end:; response_count:1; response_revision:5448; }","duration":"119.788696ms","start":"2026-04-07T15:35:50.311564Z","end":"2026-04-07T15:35:50.431353Z","steps":["trace[768306413] 'agreement among raft nodes before linearized reading' (duration: 119.272646ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T15:35:50.443696Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.383498ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-07T15:35:50.443753Z","caller":"traceutil/trace.go:171","msg":"trace[264085624] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:5449; }","duration":"120.50722ms","start":"2026-04-07T15:35:50.323231Z","end":"2026-04-07T15:35:50.443738Z","steps":["trace[264085624] 'agreement among raft nodes before linearized reading' (duration: 120.347657ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T15:37:05.270547Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2989} {"level":"info","ts":"2026-04-07T15:37:05.350033Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2989,"took":"77.053412ms","hash":2290537805,"current-db-size-bytes":57311232,"current-db-size":"57 MB","current-db-size-in-use-bytes":33918976,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-04-07T15:37:05.350154Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2290537805,"revision":2989,"compact-revision":-1} {"level":"info","ts":"2026-04-07T15:41:48.159904Z","caller":"traceutil/trace.go:171","msg":"trace[2095229071] linearizableReadLoop","detail":"{readStateIndex:8494; appliedIndex:8493; }","duration":"110.983244ms","start":"2026-04-07T15:41:48.048883Z","end":"2026-04-07T15:41:48.159867Z","steps":["trace[2095229071] 'read index received' (duration: 110.639338ms)","trace[2095229071] 'applied index is now lower than readState.Index' (duration: 342.236µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T15:41:48.160014Z","caller":"traceutil/trace.go:171","msg":"trace[1316401195] transaction","detail":"{read_only:false; response_revision:8205; number_of_response:1; }","duration":"215.272065ms","start":"2026-04-07T15:41:47.944694Z","end":"2026-04-07T15:41:48.159966Z","steps":["trace[1316401195] 'process raft request' (duration: 214.847957ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T15:41:48.160191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.288181ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-07T15:41:48.160281Z","caller":"traceutil/trace.go:171","msg":"trace[1749762634] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:8205; }","duration":"111.460724ms","start":"2026-04-07T15:41:48.048804Z","end":"2026-04-07T15:41:48.160265Z","steps":["trace[1749762634] 'agreement among raft nodes before linearized reading' (duration: 111.211059ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T15:41:59.580709Z","caller":"traceutil/trace.go:171","msg":"trace[634043393] linearizableReadLoop","detail":"{readStateIndex:8556; appliedIndex:8555; }","duration":"250.292213ms","start":"2026-04-07T15:41:59.330394Z","end":"2026-04-07T15:41:59.580686Z","steps":["trace[634043393] 'read index received' (duration: 250.060049ms)","trace[634043393] 'applied index is now lower than readState.Index' (duration: 230.994µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T15:41:59.580767Z","caller":"traceutil/trace.go:171","msg":"trace[1035819761] transaction","detail":"{read_only:false; response_revision:8264; number_of_response:1; }","duration":"282.400154ms","start":"2026-04-07T15:41:59.298329Z","end":"2026-04-07T15:41:59.580729Z","steps":["trace[1035819761] 'process raft request' (duration: 282.19685ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T15:41:59.581014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.600879ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-07T15:41:59.581105Z","caller":"traceutil/trace.go:171","msg":"trace[1780019010] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8264; }","duration":"250.773442ms","start":"2026-04-07T15:41:59.330314Z","end":"2026-04-07T15:41:59.581087Z","steps":["trace[1780019010] 'agreement among raft nodes before linearized reading' (duration: 250.492226ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T15:41:59.581046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.911506ms","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":"warn","ts":"2026-04-07T15:41:59.581016Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.561448ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-07T15:41:59.581239Z","caller":"traceutil/trace.go:171","msg":"trace[1032427611] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8264; }","duration":"248.15189ms","start":"2026-04-07T15:41:59.333046Z","end":"2026-04-07T15:41:59.581198Z","steps":["trace[1032427611] 'agreement among raft nodes before linearized reading' (duration: 247.896155ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T15:41:59.581325Z","caller":"traceutil/trace.go:171","msg":"trace[1935956482] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8264; }","duration":"250.942285ms","start":"2026-04-07T15:41:59.33036Z","end":"2026-04-07T15:41:59.581303Z","steps":["trace[1935956482] 'agreement among raft nodes before linearized reading' (duration: 250.503597ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T15:42:00.439646Z","caller":"traceutil/trace.go:171","msg":"trace[1699381115] transaction","detail":"{read_only:false; response_revision:8270; number_of_response:1; }","duration":"231.587771ms","start":"2026-04-07T15:42:00.208021Z","end":"2026-04-07T15:42:00.439608Z","steps":["trace[1699381115] 'process raft request' (duration: 231.372087ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T15:42:01.706703Z","caller":"traceutil/trace.go:171","msg":"trace[25570134] transaction","detail":"{read_only:false; response_revision:8274; number_of_response:1; }","duration":"107.971664ms","start":"2026-04-07T15:42:01.5987Z","end":"2026-04-07T15:42:01.706672Z","steps":["trace[25570134] 'process raft request' (duration: 107.727169ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T15:42:01.711244Z","caller":"traceutil/trace.go:171","msg":"trace[1118265590] transaction","detail":"{read_only:false; response_revision:8275; number_of_response:1; }","duration":"112.004224ms","start":"2026-04-07T15:42:01.599226Z","end":"2026-04-07T15:42:01.71123Z","steps":["trace[1118265590] 'process raft request' (duration: 110.091656ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T15:42:01.711267Z","caller":"traceutil/trace.go:171","msg":"trace[912117739] transaction","detail":"{read_only:false; response_revision:8276; number_of_response:1; }","duration":"111.537165ms","start":"2026-04-07T15:42:01.5997Z","end":"2026-04-07T15:42:01.711237Z","steps":["trace[912117739] 'process raft request' (duration: 111.441322ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T15:42:01.71147Z","caller":"traceutil/trace.go:171","msg":"trace[1241425626] transaction","detail":"{read_only:false; response_revision:8277; number_of_response:1; }","duration":"111.647398ms","start":"2026-04-07T15:42:01.599814Z","end":"2026-04-07T15:42:01.711461Z","steps":["trace[1241425626] 'process raft request' (duration: 111.376512ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T15:42:01.711677Z","caller":"traceutil/trace.go:171","msg":"trace[1064476941] transaction","detail":"{read_only:false; response_revision:8278; number_of_response:1; }","duration":"110.24612ms","start":"2026-04-07T15:42:01.601422Z","end":"2026-04-07T15:42:01.711668Z","steps":["trace[1064476941] 'process raft request' (duration: 109.961644ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T15:42:05.277898Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6105} {"level":"info","ts":"2026-04-07T15:42:05.372608Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6105,"took":"92.154289ms","hash":3532343469,"current-db-size-bytes":57311232,"current-db-size":"57 MB","current-db-size-in-use-bytes":23748608,"current-db-size-in-use":"24 MB"} {"level":"info","ts":"2026-04-07T15:42:05.372695Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3532343469,"revision":6105,"compact-revision":2989} {"level":"info","ts":"2026-04-07T15:42:28.819206Z","caller":"traceutil/trace.go:171","msg":"trace[1006160756] transaction","detail":"{read_only:false; response_revision:8475; number_of_response:1; }","duration":"266.315113ms","start":"2026-04-07T15:42:28.552854Z","end":"2026-04-07T15:42:28.819169Z","steps":["trace[1006160756] 'process raft request' (duration: 265.993637ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T15:42:29.004743Z","caller":"traceutil/trace.go:171","msg":"trace[210556042] transaction","detail":"{read_only:false; response_revision:8476; number_of_response:1; }","duration":"398.031941ms","start":"2026-04-07T15:42:28.606682Z","end":"2026-04-07T15:42:29.004714Z","steps":["trace[210556042] 'process raft request' (duration: 397.761515ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T15:42:29.004939Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T15:42:28.606651Z","time spent":"398.188723ms","remote":"127.0.0.1:42368","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T15:42:29.005098Z","caller":"traceutil/trace.go:171","msg":"trace[223971787] linearizableReadLoop","detail":"{readStateIndex:8778; appliedIndex:8776; }","duration":"345.663006ms","start":"2026-04-07T15:42:28.659423Z","end":"2026-04-07T15:42:29.005086Z","steps":["trace[223971787] 'read index received' (duration: 159.4112ms)","trace[223971787] 'applied index is now lower than readState.Index' (duration: 186.250706ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T15:42:29.005285Z","caller":"traceutil/trace.go:171","msg":"trace[75152181] transaction","detail":"{read_only:false; response_revision:8477; number_of_response:1; }","duration":"302.004665ms","start":"2026-04-07T15:42:28.703269Z","end":"2026-04-07T15:42:29.005274Z","steps":["trace[75152181] 'process raft request' (duration: 301.390782ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T15:42:29.005352Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T15:42:28.703245Z","time spent":"302.071877ms","remote":"127.0.0.1:42368","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T15:42:29.005458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.582943ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T15:42:29.00557Z","caller":"traceutil/trace.go:171","msg":"trace[1638809074] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:8477; }","duration":"154.714666ms","start":"2026-04-07T15:42:28.850827Z","end":"2026-04-07T15:42:29.005541Z","steps":["trace[1638809074] 'agreement among raft nodes before linearized reading' (duration: 154.539153ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T15:42:29.005819Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.113495ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T15:42:29.005967Z","caller":"traceutil/trace.go:171","msg":"trace[535268242] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8477; }","duration":"136.295989ms","start":"2026-04-07T15:42:28.869657Z","end":"2026-04-07T15:42:29.005953Z","steps":["trace[535268242] 'agreement among raft nodes before linearized reading' (duration: 136.126056ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T15:42:29.006211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"346.762788ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-04-07T15:42:29.006327Z","caller":"traceutil/trace.go:171","msg":"trace[1936191628] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8477; }","duration":"346.942892ms","start":"2026-04-07T15:42:28.659355Z","end":"2026-04-07T15:42:29.006297Z","steps":["trace[1936191628] 'agreement among raft nodes before linearized reading' (duration: 346.609105ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T15:42:29.0064Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T15:42:28.659327Z","time spent":"347.057923ms","remote":"127.0.0.1:42368","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-07T15:42:32.158381Z","caller":"traceutil/trace.go:171","msg":"trace[381879413] transaction","detail":"{read_only:false; response_revision:8492; number_of_response:1; }","duration":"277.971356ms","start":"2026-04-07T15:42:31.880378Z","end":"2026-04-07T15:42:32.158349Z","steps":["trace[381879413] 'process raft request' (duration: 277.6595ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T15:42:32.158395Z","caller":"traceutil/trace.go:171","msg":"trace[1197327908] transaction","detail":"{read_only:false; response_revision:8494; number_of_response:1; }","duration":"276.893854ms","start":"2026-04-07T15:42:31.881474Z","end":"2026-04-07T15:42:32.158368Z","steps":["trace[1197327908] 'process raft request' (duration: 276.812562ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T15:42:32.158453Z","caller":"traceutil/trace.go:171","msg":"trace[398209886] transaction","detail":"{read_only:false; response_revision:8493; number_of_response:1; }","duration":"277.340253ms","start":"2026-04-07T15:42:31.88106Z","end":"2026-04-07T15:42:32.158401Z","steps":["trace[398209886] 'process raft request' (duration: 277.177449ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T15:42:32.158596Z","caller":"traceutil/trace.go:171","msg":"trace[1131400079] transaction","detail":"{read_only:false; response_revision:8495; number_of_response:1; }","duration":"249.572849ms","start":"2026-04-07T15:42:31.90901Z","end":"2026-04-07T15:42:32.158583Z","steps":["trace[1131400079] 'process raft request' (duration: 249.312624ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T15:42:41.821995Z","caller":"traceutil/trace.go:171","msg":"trace[1339858505] linearizableReadLoop","detail":"{readStateIndex:8891; appliedIndex:8890; }","duration":"108.869942ms","start":"2026-04-07T15:42:41.713092Z","end":"2026-04-07T15:42:41.821962Z","steps":["trace[1339858505] 'read index received' (duration: 108.701889ms)","trace[1339858505] 'applied index is now lower than readState.Index' (duration: 166.783µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T15:42:41.822156Z","caller":"traceutil/trace.go:171","msg":"trace[1285075889] transaction","detail":"{read_only:false; response_revision:8584; number_of_response:1; }","duration":"122.668018ms","start":"2026-04-07T15:42:41.699472Z","end":"2026-04-07T15:42:41.82214Z","steps":["trace[1285075889] 'process raft request' (duration: 122.28774ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T15:42:41.822526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.384542ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-07T15:42:41.822663Z","caller":"traceutil/trace.go:171","msg":"trace[793273717] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:8584; }","duration":"109.577386ms","start":"2026-04-07T15:42:41.713062Z","end":"2026-04-07T15:42:41.82264Z","steps":["trace[793273717] 'agreement among raft nodes before linearized reading' (duration: 109.335721ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T15:42:42.361697Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.95292ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T15:42:42.361806Z","caller":"traceutil/trace.go:171","msg":"trace[2083332854] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8587; }","duration":"167.130245ms","start":"2026-04-07T15:42:42.194651Z","end":"2026-04-07T15:42:42.361781Z","steps":["trace[2083332854] 'range keys from in-memory index tree' (duration: 166.826468ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T15:42:42.361915Z","caller":"traceutil/trace.go:171","msg":"trace[412590256] linearizableReadLoop","detail":"{readStateIndex:8895; appliedIndex:8894; }","duration":"147.125936ms","start":"2026-04-07T15:42:42.214688Z","end":"2026-04-07T15:42:42.361814Z","steps":["trace[412590256] 'read index received' (duration: 63.042188ms)","trace[412590256] 'applied index is now lower than readState.Index' (duration: 84.081388ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T15:42:42.361936Z","caller":"traceutil/trace.go:171","msg":"trace[665617414] transaction","detail":"{read_only:false; response_revision:8588; number_of_response:1; }","duration":"164.550173ms","start":"2026-04-07T15:42:42.197347Z","end":"2026-04-07T15:42:42.361897Z","steps":["trace[665617414] 'process raft request' (duration: 80.480726ms)","trace[665617414] 'compare' (duration: 83.74522ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T15:42:42.36219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.481803ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-07T15:42:42.362251Z","caller":"traceutil/trace.go:171","msg":"trace[1857255981] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8588; }","duration":"147.610175ms","start":"2026-04-07T15:42:42.214625Z","end":"2026-04-07T15:42:42.362235Z","steps":["trace[1857255981] 'agreement among raft nodes before linearized reading' (duration: 147.393741ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T15:42:42.362347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.87555ms","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":"warn","ts":"2026-04-07T15:42:42.362359Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.639477ms","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-07T15:42:42.362407Z","caller":"traceutil/trace.go:171","msg":"trace[1035026098] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8588; }","duration":"142.001313ms","start":"2026-04-07T15:42:42.220388Z","end":"2026-04-07T15:42:42.362389Z","steps":["trace[1035026098] 'agreement among raft nodes before linearized reading' (duration: 141.750378ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T15:42:42.362456Z","caller":"traceutil/trace.go:171","msg":"trace[304322063] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8588; }","duration":"141.791949ms","start":"2026-04-07T15:42:42.220641Z","end":"2026-04-07T15:42:42.362433Z","steps":["trace[304322063] 'agreement among raft nodes before linearized reading' (duration: 141.494073ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T15:43:05.199231Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000023d7.wal"} {"level":"info","ts":"2026-04-07T15:44:12.905407Z","caller":"traceutil/trace.go:171","msg":"trace[1789709464] transaction","detail":"{read_only:false; response_revision:9411; number_of_response:1; }","duration":"176.354018ms","start":"2026-04-07T15:44:12.729004Z","end":"2026-04-07T15:44:12.905358Z","steps":["trace[1789709464] 'process raft request' (duration: 164.965611ms)","trace[1789709464] 'compare' (duration: 10.664062ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T15:44:13.059729Z","caller":"traceutil/trace.go:171","msg":"trace[1094333512] transaction","detail":"{read_only:false; response_revision:9413; number_of_response:1; }","duration":"148.771128ms","start":"2026-04-07T15:44:12.910923Z","end":"2026-04-07T15:44:13.059694Z","steps":["trace[1094333512] 'process raft request' (duration: 128.30599ms)","trace[1094333512] 'compare' (duration: 20.261074ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T15:44:13.059842Z","caller":"traceutil/trace.go:171","msg":"trace[1959008947] transaction","detail":"{read_only:false; response_revision:9414; number_of_response:1; }","duration":"148.337739ms","start":"2026-04-07T15:44:12.911467Z","end":"2026-04-07T15:44:13.059805Z","steps":["trace[1959008947] 'process raft request' (duration: 148.173726ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T15:44:47.042425Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"71d28e9ac1bc4e5d","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-07T15:44:47.047472Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-04-07T15:44:47.047543Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-04-07T15:47:05.285607Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8303} {"level":"info","ts":"2026-04-07T15:47:05.377256Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8303,"took":"87.73305ms","hash":896877210,"current-db-size-bytes":57311232,"current-db-size":"57 MB","current-db-size-in-use-bytes":23896064,"current-db-size-in-use":"24 MB"} {"level":"info","ts":"2026-04-07T15:47:05.377352Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":896877210,"revision":8303,"compact-revision":6105} {"level":"info","ts":"2026-04-07T15:52:05.293618Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10515} {"level":"info","ts":"2026-04-07T15:52:05.370914Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10515,"took":"74.637974ms","hash":4229998563,"current-db-size-bytes":57311232,"current-db-size":"57 MB","current-db-size-in-use-bytes":20918272,"current-db-size-in-use":"21 MB"} {"level":"info","ts":"2026-04-07T15:52:05.371006Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4229998563,"revision":10515,"compact-revision":8303}