{"level":"warn","ts":"2026-05-19T08:02:14.871241Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-19T08:02:14.871319Z","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-05-19T08:02:14.871377Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-19T08:02:14.871386Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.205:2380"]} {"level":"info","ts":"2026-05-19T08:02:14.871405Z","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-05-19T08:02:14.872003Z","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-05-19T08:02:14.872076Z","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-05-19T08:02:14.875549Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.26951ms"} {"level":"info","ts":"2026-05-19T08:02:14.887481Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"71d28e9ac1bc4e5d","cluster-id":"4a4ae660c7a9a6a7"} {"level":"info","ts":"2026-05-19T08:02:14.887585Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d switched to configuration voters=()"} {"level":"info","ts":"2026-05-19T08:02:14.887617Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became follower at term 0"} {"level":"info","ts":"2026-05-19T08:02:14.887632Z","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-05-19T08:02:14.887651Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became follower at term 1"} {"level":"info","ts":"2026-05-19T08:02:14.887727Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d switched to configuration voters=(8201774666721545821)"} {"level":"warn","ts":"2026-05-19T08:02:14.894347Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-19T08:02:14.896319Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-19T08:02:14.897623Z","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-05-19T08:02:14.900258Z","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-05-19T08:02:14.900437Z","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-05-19T08:02:14.9006Z","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-05-19T08:02:14.90075Z","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-05-19T08:02:14.900775Z","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-05-19T08:02:14.902937Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d switched to configuration voters=(8201774666721545821)"} {"level":"info","ts":"2026-05-19T08:02:14.903183Z","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-05-19T08:02:14.905107Z","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-05-19T08:02:14.905244Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.205:2380"} {"level":"info","ts":"2026-05-19T08:02:14.90528Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.205:2380"} {"level":"info","ts":"2026-05-19T08:02:14.905977Z","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-05-19T08:02:14.906036Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-19T08:02:15.68847Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d is starting a new election at term 1"} {"level":"info","ts":"2026-05-19T08:02:15.688523Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became pre-candidate at term 1"} {"level":"info","ts":"2026-05-19T08:02:15.688561Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d received MsgPreVoteResp from 71d28e9ac1bc4e5d at term 1"} {"level":"info","ts":"2026-05-19T08:02:15.688575Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became candidate at term 2"} {"level":"info","ts":"2026-05-19T08:02:15.688582Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d received MsgVoteResp from 71d28e9ac1bc4e5d at term 2"} {"level":"info","ts":"2026-05-19T08:02:15.688593Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became leader at term 2"} {"level":"info","ts":"2026-05-19T08:02:15.688602Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 71d28e9ac1bc4e5d elected leader 71d28e9ac1bc4e5d at term 2"} {"level":"info","ts":"2026-05-19T08:02:15.689798Z","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-05-19T08:02:15.68983Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-19T08:02:15.690123Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-19T08:02:15.691204Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-19T08:02:15.695267Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-19T08:02:15.695318Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.205:2379"} {"level":"info","ts":"2026-05-19T08:02:15.695421Z","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-05-19T08:02:15.695497Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-19T08:02:15.695526Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-19T08:02:15.695635Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-19T08:02:15.695689Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-19T08:02:45.823298Z","caller":"traceutil/trace.go:171","msg":"trace[265006749] transaction","detail":"{read_only:false; response_revision:471; number_of_response:1; }","duration":"151.480746ms","start":"2026-05-19T08:02:45.671785Z","end":"2026-05-19T08:02:45.823266Z","steps":["trace[265006749] 'process raft request' (duration: 151.297781ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T08:02:46.654054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.59367ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-19T08:02:46.654286Z","caller":"traceutil/trace.go:171","msg":"trace[1725125890] transaction","detail":"{read_only:false; response_revision:504; number_of_response:1; }","duration":"195.739856ms","start":"2026-05-19T08:02:46.458523Z","end":"2026-05-19T08:02:46.654263Z","steps":["trace[1725125890] 'process raft request' (duration: 93.542369ms)","trace[1725125890] 'compare' (duration: 101.478237ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T08:02:46.654358Z","caller":"traceutil/trace.go:171","msg":"trace[381214363] transaction","detail":"{read_only:false; response_revision:506; number_of_response:1; }","duration":"123.514196ms","start":"2026-05-19T08:02:46.53083Z","end":"2026-05-19T08:02:46.654344Z","steps":["trace[381214363] 'process raft request' (duration: 123.464374ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T08:02:46.654495Z","caller":"traceutil/trace.go:171","msg":"trace[433006873] transaction","detail":"{read_only:false; response_revision:505; number_of_response:1; }","duration":"188.110606ms","start":"2026-05-19T08:02:46.466334Z","end":"2026-05-19T08:02:46.654445Z","steps":["trace[433006873] 'process raft request' (duration: 187.842339ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T08:02:52.78611Z","caller":"traceutil/trace.go:171","msg":"trace[1860739547] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"133.285775ms","start":"2026-05-19T08:02:52.652797Z","end":"2026-05-19T08:02:52.786083Z","steps":["trace[1860739547] 'process raft request' (duration: 118.112317ms)","trace[1860739547] 'compare' (duration: 14.918221ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T08:02:53.453373Z","caller":"traceutil/trace.go:171","msg":"trace[1835827191] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"399.573356ms","start":"2026-05-19T08:02:53.05377Z","end":"2026-05-19T08:02:53.453343Z","steps":["trace[1835827191] 'process raft request' (duration: 399.318979ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T08:02:53.453578Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T08:02:53.05374Z","time spent":"399.755291ms","remote":"127.0.0.1:38190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T08:02:53.544966Z","caller":"traceutil/trace.go:171","msg":"trace[1159543222] linearizableReadLoop","detail":"{readStateIndex:601; appliedIndex:599; }","duration":"285.182052ms","start":"2026-05-19T08:02:53.259754Z","end":"2026-05-19T08:02:53.544936Z","steps":["trace[1159543222] 'read index received' (duration: 193.420552ms)","trace[1159543222] 'applied index is now lower than readState.Index' (duration: 91.76054ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T08:02:53.545199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.444519ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-05-19T08:02:53.545258Z","caller":"traceutil/trace.go:171","msg":"trace[1921848565] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:583; }","duration":"285.565572ms","start":"2026-05-19T08:02:53.259679Z","end":"2026-05-19T08:02:53.545245Z","steps":["trace[1921848565] 'agreement among raft nodes before linearized reading' (duration: 285.359677ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T08:02:53.545303Z","caller":"traceutil/trace.go:171","msg":"trace[1937888798] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"357.137296ms","start":"2026-05-19T08:02:53.188131Z","end":"2026-05-19T08:02:53.545268Z","steps":["trace[1937888798] 'process raft request' (duration: 355.256754ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T08:02:53.545514Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T08:02:53.188106Z","time spent":"357.288629ms","remote":"127.0.0.1:38096","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036313,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T08:03:09.285621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.928324ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-58kwc\" ","response":"range_response_count:1 size:3965"} {"level":"info","ts":"2026-05-19T08:03:09.28573Z","caller":"traceutil/trace.go:171","msg":"trace[500554193] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-58kwc; range_end:; response_count:1; response_revision:743; }","duration":"199.105139ms","start":"2026-05-19T08:03:09.086594Z","end":"2026-05-19T08:03:09.285699Z","steps":["trace[500554193] 'range keys from in-memory index tree' (duration: 198.731299ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T08:03:09.285602Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.570228ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.205\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-05-19T08:03:09.285916Z","caller":"traceutil/trace.go:171","msg":"trace[29430483] range","detail":"{range_begin:/registry/masterleases/199.204.45.205; range_end:; response_count:1; response_revision:743; }","duration":"369.891307ms","start":"2026-05-19T08:03:08.915946Z","end":"2026-05-19T08:03:09.285837Z","steps":["trace[29430483] 'range keys from in-memory index tree' (duration: 369.329571ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T08:03:09.286078Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T08:03:08.915921Z","time spent":"370.103543ms","remote":"127.0.0.1:38024","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.204.45.205\" "} {"level":"info","ts":"2026-05-19T08:03:36.659268Z","caller":"traceutil/trace.go:171","msg":"trace[253800087] transaction","detail":"{read_only:false; response_revision:1141; number_of_response:1; }","duration":"116.265095ms","start":"2026-05-19T08:03:36.542977Z","end":"2026-05-19T08:03:36.659242Z","steps":["trace[253800087] 'process raft request' (duration: 116.101321ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T08:03:52.431321Z","caller":"traceutil/trace.go:171","msg":"trace[1831191302] transaction","detail":"{read_only:false; response_revision:1278; number_of_response:1; }","duration":"120.692554ms","start":"2026-05-19T08:03:52.310587Z","end":"2026-05-19T08:03:52.431279Z","steps":["trace[1831191302] 'process raft request' (duration: 120.474738ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T08:04:23.339302Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.823182ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-05-19T08:04:23.339431Z","caller":"traceutil/trace.go:171","msg":"trace[640968765] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1807; }","duration":"118.963336ms","start":"2026-05-19T08:04:23.220445Z","end":"2026-05-19T08:04:23.339408Z","steps":["trace[640968765] 'range keys from in-memory index tree' (duration: 118.547974ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T08:04:23.339655Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.630493ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-4b3d57e7-f586-4d8e-8c87-5654c6225dee\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-05-19T08:04:23.339767Z","caller":"traceutil/trace.go:171","msg":"trace[818570665] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-4b3d57e7-f586-4d8e-8c87-5654c6225dee; range_end:; response_count:1; response_revision:1807; }","duration":"185.843489ms","start":"2026-05-19T08:04:23.153893Z","end":"2026-05-19T08:04:23.339736Z","steps":["trace[818570665] 'range keys from in-memory index tree' (duration: 185.344745ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T08:04:23.339744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.528631ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-05-19T08:04:23.339891Z","caller":"traceutil/trace.go:171","msg":"trace[601196862] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1807; }","duration":"298.731466ms","start":"2026-05-19T08:04:23.041127Z","end":"2026-05-19T08:04:23.339858Z","steps":["trace[601196862] 'range keys from in-memory index tree' (duration: 298.236992ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T08:04:23.690186Z","caller":"traceutil/trace.go:171","msg":"trace[1381493970] transaction","detail":"{read_only:false; response_revision:1810; number_of_response:1; }","duration":"199.95601ms","start":"2026-05-19T08:04:23.49019Z","end":"2026-05-19T08:04:23.690146Z","steps":["trace[1381493970] 'process raft request' (duration: 199.652941ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T08:04:23.708299Z","caller":"traceutil/trace.go:171","msg":"trace[1177734580] transaction","detail":"{read_only:false; response_revision:1811; number_of_response:1; }","duration":"149.368328ms","start":"2026-05-19T08:04:23.558905Z","end":"2026-05-19T08:04:23.708274Z","steps":["trace[1177734580] 'process raft request' (duration: 149.219504ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T08:04:36.683098Z","caller":"traceutil/trace.go:171","msg":"trace[1361716844] transaction","detail":"{read_only:false; response_revision:1925; number_of_response:1; }","duration":"176.398027ms","start":"2026-05-19T08:04:36.506668Z","end":"2026-05-19T08:04:36.683066Z","steps":["trace[1361716844] 'process raft request' (duration: 167.10681ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T08:05:07.019766Z","caller":"traceutil/trace.go:171","msg":"trace[884472568] transaction","detail":"{read_only:false; response_revision:2101; number_of_response:1; }","duration":"600.498829ms","start":"2026-05-19T08:05:06.41925Z","end":"2026-05-19T08:05:07.019749Z","steps":["trace[884472568] 'process raft request' (duration: 600.348344ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T08:05:07.019887Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T08:05:06.419228Z","time spent":"600.598311ms","remote":"127.0.0.1:38282","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T08:05:07.021232Z","caller":"traceutil/trace.go:171","msg":"trace[573343707] transaction","detail":"{read_only:false; response_revision:2102; number_of_response:1; }","duration":"601.927058ms","start":"2026-05-19T08:05:06.419295Z","end":"2026-05-19T08:05:07.021222Z","steps":["trace[573343707] 'process raft request' (duration: 601.805795ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T08:05:07.021279Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T08:05:06.419269Z","time spent":"601.987909ms","remote":"127.0.0.1:38282","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T08:05:07.021394Z","caller":"traceutil/trace.go:171","msg":"trace[1731123449] linearizableReadLoop","detail":"{readStateIndex:2178; appliedIndex:2176; }","duration":"452.688173ms","start":"2026-05-19T08:05:06.568696Z","end":"2026-05-19T08:05:07.021384Z","steps":["trace[1731123449] 'read index received' (duration: 450.947435ms)","trace[1731123449] 'applied index is now lower than readState.Index' (duration: 1.740218ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T08:05:07.021596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"452.91175ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-19T08:05:07.021615Z","caller":"traceutil/trace.go:171","msg":"trace[1141346523] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:2104; }","duration":"452.988421ms","start":"2026-05-19T08:05:06.56862Z","end":"2026-05-19T08:05:07.021609Z","steps":["trace[1141346523] 'agreement among raft nodes before linearized reading' (duration: 452.95799ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T08:05:07.021629Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T08:05:06.568592Z","time spent":"453.032163ms","remote":"127.0.0.1:38160","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":29,"request content":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true "} {"level":"info","ts":"2026-05-19T08:05:10.435058Z","caller":"traceutil/trace.go:171","msg":"trace[680720535] transaction","detail":"{read_only:false; response_revision:2108; number_of_response:1; }","duration":"225.882444ms","start":"2026-05-19T08:05:10.209152Z","end":"2026-05-19T08:05:10.435034Z","steps":["trace[680720535] 'process raft request' (duration: 225.669088ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T08:05:10.435581Z","caller":"traceutil/trace.go:171","msg":"trace[346369106] transaction","detail":"{read_only:false; response_revision:2109; number_of_response:1; }","duration":"226.357547ms","start":"2026-05-19T08:05:10.209146Z","end":"2026-05-19T08:05:10.435504Z","steps":["trace[346369106] 'process raft request' (duration: 225.846183ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T08:05:10.435708Z","caller":"traceutil/trace.go:171","msg":"trace[594480901] transaction","detail":"{read_only:false; response_revision:2110; number_of_response:1; }","duration":"225.73699ms","start":"2026-05-19T08:05:10.20996Z","end":"2026-05-19T08:05:10.435697Z","steps":["trace[594480901] 'process raft request' (duration: 225.401311ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T08:05:10.43623Z","caller":"traceutil/trace.go:171","msg":"trace[1300812712] linearizableReadLoop","detail":"{readStateIndex:2189; appliedIndex:2184; }","duration":"184.014301ms","start":"2026-05-19T08:05:10.252197Z","end":"2026-05-19T08:05:10.436211Z","steps":["trace[1300812712] 'read index received' (duration: 182.625233ms)","trace[1300812712] 'applied index is now lower than readState.Index' (duration: 1.386998ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T08:05:10.436352Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.470018ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-05-19T08:05:10.436391Z","caller":"traceutil/trace.go:171","msg":"trace[369598415] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2112; }","duration":"227.55381ms","start":"2026-05-19T08:05:10.208826Z","end":"2026-05-19T08:05:10.43638Z","steps":["trace[369598415] 'agreement among raft nodes before linearized reading' (duration: 227.433317ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T08:05:10.436413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.15657ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-19T08:05:10.436485Z","caller":"traceutil/trace.go:171","msg":"trace[1894739971] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2112; }","duration":"222.265194ms","start":"2026-05-19T08:05:10.214207Z","end":"2026-05-19T08:05:10.436473Z","steps":["trace[1894739971] 'agreement among raft nodes before linearized reading' (duration: 222.044388ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T08:05:10.436502Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.641033ms","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-05-19T08:05:10.436535Z","caller":"traceutil/trace.go:171","msg":"trace[212960234] transaction","detail":"{read_only:false; response_revision:2112; number_of_response:1; }","duration":"222.226853ms","start":"2026-05-19T08:05:10.214279Z","end":"2026-05-19T08:05:10.436505Z","steps":["trace[212960234] 'process raft request' (duration: 221.78564ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T08:05:10.43659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.436685ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T08:05:10.436606Z","caller":"traceutil/trace.go:171","msg":"trace[1000355276] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2112; }","duration":"219.468176ms","start":"2026-05-19T08:05:10.217133Z","end":"2026-05-19T08:05:10.436601Z","steps":["trace[1000355276] 'agreement among raft nodes before linearized reading' (duration: 219.443996ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T08:05:10.436518Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.37577ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-19T08:05:10.43659Z","caller":"traceutil/trace.go:171","msg":"trace[2110847529] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2112; }","duration":"227.747355ms","start":"2026-05-19T08:05:10.208825Z","end":"2026-05-19T08:05:10.436572Z","steps":["trace[2110847529] 'agreement among raft nodes before linearized reading' (duration: 227.485208ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T08:05:10.436678Z","caller":"traceutil/trace.go:171","msg":"trace[1346693815] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:2112; }","duration":"225.511294ms","start":"2026-05-19T08:05:10.211113Z","end":"2026-05-19T08:05:10.436624Z","steps":["trace[1346693815] 'agreement among raft nodes before linearized reading' (duration: 225.3851ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T08:05:10.436747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.926551ms","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-05-19T08:05:10.436764Z","caller":"traceutil/trace.go:171","msg":"trace[1018323378] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2112; }","duration":"227.971542ms","start":"2026-05-19T08:05:10.208788Z","end":"2026-05-19T08:05:10.43676Z","steps":["trace[1018323378] 'agreement among raft nodes before linearized reading' (duration: 227.92536ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T08:05:10.43682Z","caller":"traceutil/trace.go:171","msg":"trace[2099600044] transaction","detail":"{read_only:false; response_revision:2111; number_of_response:1; }","duration":"226.82003ms","start":"2026-05-19T08:05:10.209988Z","end":"2026-05-19T08:05:10.436808Z","steps":["trace[2099600044] 'process raft request' (duration: 225.662158ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T08:05:10.478343Z","caller":"traceutil/trace.go:171","msg":"trace[597332051] transaction","detail":"{read_only:false; response_revision:2113; number_of_response:1; }","duration":"224.921067ms","start":"2026-05-19T08:05:10.253395Z","end":"2026-05-19T08:05:10.478317Z","steps":["trace[597332051] 'process raft request' (duration: 224.65649ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T08:05:10.47843Z","caller":"traceutil/trace.go:171","msg":"trace[1749132036] transaction","detail":"{read_only:false; response_revision:2114; number_of_response:1; }","duration":"222.328205ms","start":"2026-05-19T08:05:10.256066Z","end":"2026-05-19T08:05:10.478395Z","steps":["trace[1749132036] 'process raft request' (duration: 222.15315ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T08:05:10.568897Z","caller":"traceutil/trace.go:171","msg":"trace[2004955345] transaction","detail":"{read_only:false; response_revision:2116; number_of_response:1; }","duration":"128.648023ms","start":"2026-05-19T08:05:10.440222Z","end":"2026-05-19T08:05:10.56887Z","steps":["trace[2004955345] 'process raft request' (duration: 128.561301ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T08:05:10.568995Z","caller":"traceutil/trace.go:171","msg":"trace[651096345] transaction","detail":"{read_only:false; response_revision:2115; number_of_response:1; }","duration":"128.766696ms","start":"2026-05-19T08:05:10.440177Z","end":"2026-05-19T08:05:10.568943Z","steps":["trace[651096345] 'process raft request' (duration: 92.672664ms)","trace[651096345] 'compare' (duration: 35.805484ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T08:05:10.569171Z","caller":"traceutil/trace.go:171","msg":"trace[9937094] transaction","detail":"{read_only:false; response_revision:2117; number_of_response:1; }","duration":"128.689044ms","start":"2026-05-19T08:05:10.440472Z","end":"2026-05-19T08:05:10.569161Z","steps":["trace[9937094] 'process raft request' (duration: 128.357465ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T08:05:10.56935Z","caller":"traceutil/trace.go:171","msg":"trace[2053843163] transaction","detail":"{read_only:false; response_revision:2118; number_of_response:1; }","duration":"128.134179ms","start":"2026-05-19T08:05:10.44117Z","end":"2026-05-19T08:05:10.569304Z","steps":["trace[2053843163] 'process raft request' (duration: 127.851931ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T08:05:10.569456Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.829662ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T08:05:10.570377Z","caller":"traceutil/trace.go:171","msg":"trace[1681105416] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2118; }","duration":"132.839169ms","start":"2026-05-19T08:05:10.43752Z","end":"2026-05-19T08:05:10.57036Z","steps":["trace[1681105416] 'agreement among raft nodes before linearized reading' (duration: 131.811551ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T08:05:10.820533Z","caller":"traceutil/trace.go:171","msg":"trace[231840036] transaction","detail":"{read_only:false; response_revision:2119; number_of_response:1; }","duration":"160.707714ms","start":"2026-05-19T08:05:10.659791Z","end":"2026-05-19T08:05:10.820499Z","steps":["trace[231840036] 'process raft request' (duration: 96.175862ms)","trace[231840036] 'compare' (duration: 64.401318ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T08:12:15.755564Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2989} {"level":"info","ts":"2026-05-19T08:12:15.831648Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2989,"took":"74.985183ms","hash":634034064,"current-db-size-bytes":36192256,"current-db-size":"36 MB","current-db-size-in-use-bytes":11161600,"current-db-size-in-use":"11 MB"} {"level":"info","ts":"2026-05-19T08:12:15.831729Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":634034064,"revision":2989,"compact-revision":-1}