{"level":"warn","ts":"2026-07-25T06:50:33.44261Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-25T06:50:33.442701Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.179: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.19.213.179:2380","--initial-cluster=instance=https://199.19.213.179:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.179:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.179: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-07-25T06:50:33.444457Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-25T06:50:33.444482Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.179:2380"]} {"level":"info","ts":"2026-07-25T06:50:33.44473Z","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-07-25T06:50:33.446026Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.179:2379"]} {"level":"info","ts":"2026-07-25T06:50:33.450313Z","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":8,"max-cpu-available":8,"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.19.213.179:2380"],"listen-peer-urls":["https://199.19.213.179:2380"],"advertise-client-urls":["https://199.19.213.179:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.179:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.179: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-07-25T06:50:33.45456Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.788379ms"} {"level":"info","ts":"2026-07-25T06:50:33.466367Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"69895f7c3b831156","cluster-id":"caac76e5ff14ceff"} {"level":"info","ts":"2026-07-25T06:50:33.466506Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"69895f7c3b831156 switched to configuration voters=()"} {"level":"info","ts":"2026-07-25T06:50:33.466574Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"69895f7c3b831156 became follower at term 0"} {"level":"info","ts":"2026-07-25T06:50:33.466636Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 69895f7c3b831156 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-25T06:50:33.466656Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"69895f7c3b831156 became follower at term 1"} {"level":"info","ts":"2026-07-25T06:50:33.466781Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"69895f7c3b831156 switched to configuration voters=(7604714432970821974)"} {"level":"warn","ts":"2026-07-25T06:50:33.474865Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-25T06:50:33.476624Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-25T06:50:33.477877Z","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-07-25T06:50:33.48033Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"69895f7c3b831156","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-25T06:50:33.480648Z","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-07-25T06:50:33.480782Z","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-07-25T06:50:33.480799Z","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-07-25T06:50:33.480771Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"69895f7c3b831156","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-25T06:50:33.482562Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"69895f7c3b831156 switched to configuration voters=(7604714432970821974)"} {"level":"info","ts":"2026-07-25T06:50:33.48278Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"caac76e5ff14ceff","local-member-id":"69895f7c3b831156","added-peer-id":"69895f7c3b831156","added-peer-peer-urls":["https://199.19.213.179:2380"]} {"level":"info","ts":"2026-07-25T06:50:33.485018Z","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-07-25T06:50:33.485091Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.179:2380"} {"level":"info","ts":"2026-07-25T06:50:33.485147Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.179:2380"} {"level":"info","ts":"2026-07-25T06:50:33.485259Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"69895f7c3b831156","initial-advertise-peer-urls":["https://199.19.213.179:2380"],"listen-peer-urls":["https://199.19.213.179:2380"],"advertise-client-urls":["https://199.19.213.179:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.179:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-25T06:50:33.485297Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-25T06:50:34.467761Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"69895f7c3b831156 is starting a new election at term 1"} {"level":"info","ts":"2026-07-25T06:50:34.467834Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"69895f7c3b831156 became pre-candidate at term 1"} {"level":"info","ts":"2026-07-25T06:50:34.46788Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"69895f7c3b831156 received MsgPreVoteResp from 69895f7c3b831156 at term 1"} {"level":"info","ts":"2026-07-25T06:50:34.467911Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"69895f7c3b831156 became candidate at term 2"} {"level":"info","ts":"2026-07-25T06:50:34.467923Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"69895f7c3b831156 received MsgVoteResp from 69895f7c3b831156 at term 2"} {"level":"info","ts":"2026-07-25T06:50:34.46794Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"69895f7c3b831156 became leader at term 2"} {"level":"info","ts":"2026-07-25T06:50:34.46796Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 69895f7c3b831156 elected leader 69895f7c3b831156 at term 2"} {"level":"info","ts":"2026-07-25T06:50:34.469048Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"69895f7c3b831156","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.179:2379]}","request-path":"/0/members/69895f7c3b831156/attributes","cluster-id":"caac76e5ff14ceff","publish-timeout":"7s"} {"level":"info","ts":"2026-07-25T06:50:34.469055Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-25T06:50:34.46908Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-25T06:50:34.469208Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-25T06:50:34.469455Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-25T06:50:34.469546Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-25T06:50:34.470346Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"caac76e5ff14ceff","local-member-id":"69895f7c3b831156","cluster-version":"3.5"} {"level":"info","ts":"2026-07-25T06:50:34.47044Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-25T06:50:34.470468Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-25T06:50:34.472119Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-25T06:50:34.475496Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.179:2379"} {"level":"info","ts":"2026-07-25T06:51:17.879732Z","caller":"traceutil/trace.go:171","msg":"trace[884676269] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"164.093586ms","start":"2026-07-25T06:51:17.7156Z","end":"2026-07-25T06:51:17.879693Z","steps":["trace[884676269] 'process raft request' (duration: 163.614548ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:51:18.574421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"410.005315ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-07-25T06:51:18.574505Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.002803ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-s8sbj\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-07-25T06:51:18.574583Z","caller":"traceutil/trace.go:171","msg":"trace[1200513034] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:579; }","duration":"410.242959ms","start":"2026-07-25T06:51:18.164291Z","end":"2026-07-25T06:51:18.574534Z","steps":["trace[1200513034] 'range keys from in-memory index tree' (duration: 409.835632ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:51:18.574654Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:51:18.164224Z","time spent":"410.418442ms","remote":"127.0.0.1:40050","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-07-25T06:51:18.574583Z","caller":"traceutil/trace.go:171","msg":"trace[1211067226] range","detail":"{range_begin:/registry/pods/kube-system/cilium-s8sbj; range_end:; response_count:1; response_revision:579; }","duration":"244.120365ms","start":"2026-07-25T06:51:18.330446Z","end":"2026-07-25T06:51:18.574567Z","steps":["trace[1211067226] 'range keys from in-memory index tree' (duration: 243.89786ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:51:18.578083Z","caller":"traceutil/trace.go:171","msg":"trace[1285647676] linearizableReadLoop","detail":"{readStateIndex:607; appliedIndex:606; }","duration":"109.217673ms","start":"2026-07-25T06:51:18.468833Z","end":"2026-07-25T06:51:18.578051Z","steps":["trace[1285647676] 'read index received' (duration: 105.977688ms)","trace[1285647676] 'applied index is now lower than readState.Index' (duration: 3.238935ms)"],"step_count":2} {"level":"warn","ts":"2026-07-25T06:51:18.578648Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.788312ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-25T06:51:18.578706Z","caller":"traceutil/trace.go:171","msg":"trace[1089681370] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:580; }","duration":"109.921555ms","start":"2026-07-25T06:51:18.468766Z","end":"2026-07-25T06:51:18.578688Z","steps":["trace[1089681370] 'agreement among raft nodes before linearized reading' (duration: 109.803123ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:51:18.579076Z","caller":"traceutil/trace.go:171","msg":"trace[8654714] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"212.448203ms","start":"2026-07-25T06:51:18.366437Z","end":"2026-07-25T06:51:18.578885Z","steps":["trace[8654714] 'process raft request' (duration: 209.365281ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:51:34.223972Z","caller":"traceutil/trace.go:171","msg":"trace[910414128] transaction","detail":"{read_only:false; response_revision:755; number_of_response:1; }","duration":"192.536182ms","start":"2026-07-25T06:51:34.031401Z","end":"2026-07-25T06:51:34.223937Z","steps":["trace[910414128] 'process raft request' (duration: 192.352589ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:52:59.341316Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.599191ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-25T06:52:59.341398Z","caller":"traceutil/trace.go:171","msg":"trace[1908227816] linearizableReadLoop","detail":"{readStateIndex:1183; appliedIndex:1182; }","duration":"236.700505ms","start":"2026-07-25T06:52:59.104686Z","end":"2026-07-25T06:52:59.341387Z","steps":["trace[1908227816] 'read index received' (duration: 79.511458ms)","trace[1908227816] 'applied index is now lower than readState.Index' (duration: 157.188087ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T06:52:59.341456Z","caller":"traceutil/trace.go:171","msg":"trace[685788992] transaction","detail":"{read_only:false; response_revision:1133; number_of_response:1; }","duration":"283.276304ms","start":"2026-07-25T06:52:59.058173Z","end":"2026-07-25T06:52:59.341449Z","steps":["trace[685788992] 'process raft request' (duration: 126.138148ms)","trace[685788992] 'compare' (duration: 156.437649ms)"],"step_count":2} {"level":"warn","ts":"2026-07-25T06:52:59.34169Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.977539ms","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-07-25T06:52:59.341794Z","caller":"traceutil/trace.go:171","msg":"trace[1529820902] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1133; }","duration":"237.121411ms","start":"2026-07-25T06:52:59.104652Z","end":"2026-07-25T06:52:59.341773Z","steps":["trace[1529820902] 'agreement among raft nodes before linearized reading' (duration: 236.872927ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:52:59.341706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.734337ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-07-25T06:52:59.341931Z","caller":"traceutil/trace.go:171","msg":"trace[1703465980] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1133; }","duration":"236.978979ms","start":"2026-07-25T06:52:59.104909Z","end":"2026-07-25T06:52:59.341888Z","steps":["trace[1703465980] 'agreement among raft nodes before linearized reading' (duration: 236.656545ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:53:01.641919Z","caller":"traceutil/trace.go:171","msg":"trace[1399424678] transaction","detail":"{read_only:false; response_revision:1141; number_of_response:1; }","duration":"256.978578ms","start":"2026-07-25T06:53:01.384918Z","end":"2026-07-25T06:53:01.641897Z","steps":["trace[1399424678] 'process raft request' (duration: 256.648855ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:53:01.651154Z","caller":"traceutil/trace.go:171","msg":"trace[1668682291] transaction","detail":"{read_only:false; response_revision:1142; number_of_response:1; }","duration":"245.962247ms","start":"2026-07-25T06:53:01.405174Z","end":"2026-07-25T06:53:01.651136Z","steps":["trace[1668682291] 'process raft request' (duration: 245.877216ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:54:40.027142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.045374ms","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-07-25T06:54:40.027232Z","caller":"traceutil/trace.go:171","msg":"trace[730410690] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1462; }","duration":"187.190547ms","start":"2026-07-25T06:54:39.840023Z","end":"2026-07-25T06:54:40.027214Z","steps":["trace[730410690] 'range keys from in-memory index tree' (duration: 186.840118ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:54:40.253715Z","caller":"traceutil/trace.go:171","msg":"trace[934326164] linearizableReadLoop","detail":"{readStateIndex:1534; appliedIndex:1533; }","duration":"157.864379ms","start":"2026-07-25T06:54:40.095816Z","end":"2026-07-25T06:54:40.253681Z","steps":["trace[934326164] 'read index received' (duration: 107.858648ms)","trace[934326164] 'applied index is now lower than readState.Index' (duration: 50.004391ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T06:54:40.253768Z","caller":"traceutil/trace.go:171","msg":"trace[1625734276] transaction","detail":"{read_only:false; response_revision:1464; number_of_response:1; }","duration":"158.71743ms","start":"2026-07-25T06:54:40.095016Z","end":"2026-07-25T06:54:40.253733Z","steps":["trace[1625734276] 'process raft request' (duration: 108.677128ms)","trace[1625734276] 'compare' (duration: 49.844797ms)"],"step_count":2} {"level":"warn","ts":"2026-07-25T06:54:40.254031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.190666ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-07-25T06:54:40.254109Z","caller":"traceutil/trace.go:171","msg":"trace[1628996250] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1464; }","duration":"158.272508ms","start":"2026-07-25T06:54:40.095806Z","end":"2026-07-25T06:54:40.254078Z","steps":["trace[1628996250] 'agreement among raft nodes before linearized reading' (duration: 158.052993ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:54:40.254113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.304223ms","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-07-25T06:54:40.254184Z","caller":"traceutil/trace.go:171","msg":"trace[1350564391] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1464; }","duration":"103.449418ms","start":"2026-07-25T06:54:40.150716Z","end":"2026-07-25T06:54:40.254166Z","steps":["trace[1350564391] 'agreement among raft nodes before linearized reading' (duration: 103.203121ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:54:40.749603Z","caller":"traceutil/trace.go:171","msg":"trace[1955233210] transaction","detail":"{read_only:false; response_revision:1465; number_of_response:1; }","duration":"491.094035ms","start":"2026-07-25T06:54:40.258481Z","end":"2026-07-25T06:54:40.749575Z","steps":["trace[1955233210] 'process raft request' (duration: 490.88736ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:54:40.749858Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:54:40.258467Z","time spent":"491.25845ms","remote":"127.0.0.1:40050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-25T06:54:40.761902Z","caller":"traceutil/trace.go:171","msg":"trace[1850690311] linearizableReadLoop","detail":"{readStateIndex:1536; appliedIndex:1534; }","duration":"464.342871ms","start":"2026-07-25T06:54:40.297536Z","end":"2026-07-25T06:54:40.761879Z","steps":["trace[1850690311] 'read index received' (duration: 451.876437ms)","trace[1850690311] 'applied index is now lower than readState.Index' (duration: 12.465344ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T06:54:40.761961Z","caller":"traceutil/trace.go:171","msg":"trace[59368302] transaction","detail":"{read_only:false; response_revision:1466; number_of_response:1; }","duration":"503.380764ms","start":"2026-07-25T06:54:40.258558Z","end":"2026-07-25T06:54:40.761939Z","steps":["trace[59368302] 'process raft request' (duration: 503.150429ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:54:40.762022Z","caller":"traceutil/trace.go:171","msg":"trace[728189707] transaction","detail":"{read_only:false; response_revision:1467; number_of_response:1; }","duration":"424.23455ms","start":"2026-07-25T06:54:40.337776Z","end":"2026-07-25T06:54:40.76201Z","steps":["trace[728189707] 'process raft request' (duration: 424.062716ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:54:40.762058Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:54:40.258537Z","time spent":"503.469637ms","remote":"127.0.0.1:40050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-25T06:54:40.76214Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:54:40.337751Z","time spent":"424.308331ms","remote":"127.0.0.1:40050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-25T06:54:40.762273Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"374.653231ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-25T06:54:40.762326Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.080685ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-25T06:54:40.762355Z","caller":"traceutil/trace.go:171","msg":"trace[1105602582] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:1467; }","duration":"374.789954ms","start":"2026-07-25T06:54:40.387543Z","end":"2026-07-25T06:54:40.762333Z","steps":["trace[1105602582] 'agreement among raft nodes before linearized reading' (duration: 374.593269ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:54:40.762368Z","caller":"traceutil/trace.go:171","msg":"trace[1140201216] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1467; }","duration":"293.157237ms","start":"2026-07-25T06:54:40.469198Z","end":"2026-07-25T06:54:40.762356Z","steps":["trace[1140201216] 'agreement among raft nodes before linearized reading' (duration: 293.087435ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:54:40.762355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"464.786172ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-07-25T06:54:40.762406Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:54:40.387522Z","time spent":"374.872057ms","remote":"127.0.0.1:41700","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"info","ts":"2026-07-25T06:54:40.762443Z","caller":"traceutil/trace.go:171","msg":"trace[477966005] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; response_count:0; response_revision:1467; }","duration":"464.901335ms","start":"2026-07-25T06:54:40.297522Z","end":"2026-07-25T06:54:40.762423Z","steps":["trace[477966005] 'agreement among raft nodes before linearized reading' (duration: 464.70738ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:54:40.762499Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:54:40.297472Z","time spent":"465.015638ms","remote":"127.0.0.1:40160","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":30,"request content":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true "} {"level":"info","ts":"2026-07-25T06:54:55.998506Z","caller":"traceutil/trace.go:171","msg":"trace[801374190] transaction","detail":"{read_only:false; response_revision:1515; number_of_response:1; }","duration":"163.49632ms","start":"2026-07-25T06:54:55.834986Z","end":"2026-07-25T06:54:55.998482Z","steps":["trace[801374190] 'process raft request' (duration: 163.351936ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:55:54.62151Z","caller":"traceutil/trace.go:171","msg":"trace[236083098] transaction","detail":"{read_only:false; response_revision:1708; number_of_response:1; }","duration":"170.864465ms","start":"2026-07-25T06:55:54.450623Z","end":"2026-07-25T06:55:54.621488Z","steps":["trace[236083098] 'process raft request' (duration: 170.748111ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:59:58.372877Z","caller":"traceutil/trace.go:171","msg":"trace[1633830555] transaction","detail":"{read_only:false; response_revision:2510; number_of_response:1; }","duration":"187.084931ms","start":"2026-07-25T06:59:58.185763Z","end":"2026-07-25T06:59:58.372848Z","steps":["trace[1633830555] 'process raft request' (duration: 186.885517ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:59:58.553771Z","caller":"traceutil/trace.go:171","msg":"trace[1859623812] transaction","detail":"{read_only:false; response_revision:2511; number_of_response:1; }","duration":"366.782669ms","start":"2026-07-25T06:59:58.186947Z","end":"2026-07-25T06:59:58.553729Z","steps":["trace[1859623812] 'process raft request' (duration: 331.565928ms)","trace[1859623812] 'compare' (duration: 35.044007ms)"],"step_count":2} {"level":"warn","ts":"2026-07-25T06:59:58.554332Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:59:58.186938Z","time spent":"366.927913ms","remote":"127.0.0.1:40050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-25T06:59:59.484255Z","caller":"traceutil/trace.go:171","msg":"trace[996432876] transaction","detail":"{read_only:false; response_revision:2513; number_of_response:1; }","duration":"390.236366ms","start":"2026-07-25T06:59:59.093998Z","end":"2026-07-25T06:59:59.484235Z","steps":["trace[996432876] 'process raft request' (duration: 390.119304ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:59:59.48437Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:59:59.093974Z","time spent":"390.334999ms","remote":"127.0.0.1:40050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-25T07:00:00.842016Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.659061ms","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-07-25T07:00:00.842112Z","caller":"traceutil/trace.go:171","msg":"trace[2034068611] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2517; }","duration":"283.809075ms","start":"2026-07-25T07:00:00.558282Z","end":"2026-07-25T07:00:00.842091Z","steps":["trace[2034068611] 'range keys from in-memory index tree' (duration: 283.491917ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T07:00:00.842377Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.724639ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-07-25T07:00:00.842456Z","caller":"traceutil/trace.go:171","msg":"trace[2027027975] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2517; }","duration":"161.853122ms","start":"2026-07-25T07:00:00.680586Z","end":"2026-07-25T07:00:00.842439Z","steps":["trace[2027027975] 'range keys from in-memory index tree' (duration: 161.32938ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T07:00:16.778975Z","caller":"traceutil/trace.go:171","msg":"trace[431311068] linearizableReadLoop","detail":"{readStateIndex:2758; appliedIndex:2757; }","duration":"282.815422ms","start":"2026-07-25T07:00:16.496143Z","end":"2026-07-25T07:00:16.778958Z","steps":["trace[431311068] 'read index received' (duration: 282.72268ms)","trace[431311068] 'applied index is now lower than readState.Index' (duration: 92.022µs)"],"step_count":2} {"level":"warn","ts":"2026-07-25T07:00:16.779074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.939785ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-25T07:00:16.779091Z","caller":"traceutil/trace.go:171","msg":"trace[441934738] range","detail":"{range_begin:/registry/ingressclasses/; range_end:/registry/ingressclasses0; response_count:0; response_revision:2618; }","duration":"283.043557ms","start":"2026-07-25T07:00:16.496042Z","end":"2026-07-25T07:00:16.779086Z","steps":["trace[441934738] 'agreement among raft nodes before linearized reading' (duration: 282.991706ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T07:00:16.779231Z","caller":"traceutil/trace.go:171","msg":"trace[790688198] transaction","detail":"{read_only:false; response_revision:2618; number_of_response:1; }","duration":"296.389628ms","start":"2026-07-25T07:00:16.482815Z","end":"2026-07-25T07:00:16.779204Z","steps":["trace[790688198] 'process raft request' (duration: 296.02788ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T07:00:32.847823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.056374ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-07-25T07:00:33.414872Z","caller":"traceutil/trace.go:171","msg":"trace[780594240] transaction","detail":"{read_only:false; response_revision:2694; number_of_response:1; }","duration":"173.880143ms","start":"2026-07-25T07:00:33.240964Z","end":"2026-07-25T07:00:33.414844Z","steps":["trace[780594240] 'process raft request' (duration: 173.687029ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T07:00:34.139659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"670.379706ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-25T07:00:34.139777Z","caller":"traceutil/trace.go:171","msg":"trace[391407324] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2694; }","duration":"670.566871ms","start":"2026-07-25T07:00:33.46919Z","end":"2026-07-25T07:00:34.139757Z","steps":["trace[391407324] 'range keys from in-memory index tree' (duration: 670.228463ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T07:00:34.139823Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T07:00:33.469164Z","time spent":"670.650433ms","remote":"127.0.0.1:39760","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-25T07:00:34.140904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"513.93712ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-25T07:00:34.141019Z","caller":"traceutil/trace.go:171","msg":"trace[1689535228] linearizableReadLoop","detail":"{readStateIndex:2839; appliedIndex:2838; }","duration":"447.88469ms","start":"2026-07-25T07:00:33.693117Z","end":"2026-07-25T07:00:34.141002Z","steps":["trace[1689535228] 'read index received' (duration: 32.421µs)","trace[1689535228] 'applied index is now lower than readState.Index' (duration: 447.851229ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T07:00:34.141237Z","caller":"traceutil/trace.go:171","msg":"trace[1213651598] transaction","detail":"{read_only:false; response_revision:2695; number_of_response:1; }","duration":"544.550093ms","start":"2026-07-25T07:00:33.596672Z","end":"2026-07-25T07:00:34.141222Z","steps":["trace[1213651598] 'process raft request' (duration: 30.181173ms)","trace[1213651598] 'compare' (duration: 513.806567ms)"],"step_count":2} {"level":"warn","ts":"2026-07-25T07:00:34.141345Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T07:00:33.596646Z","time spent":"544.657155ms","remote":"127.0.0.1:40050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-25T07:00:34.141571Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"448.454573ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-25T07:00:34.14162Z","caller":"traceutil/trace.go:171","msg":"trace[1134108471] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:2695; }","duration":"448.504824ms","start":"2026-07-25T07:00:33.693103Z","end":"2026-07-25T07:00:34.141608Z","steps":["trace[1134108471] 'agreement among raft nodes before linearized reading' (duration: 448.431772ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T07:00:34.141667Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T07:00:33.693055Z","time spent":"448.588816ms","remote":"127.0.0.1:40002","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":28,"request content":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true "} {"level":"warn","ts":"2026-07-25T07:00:34.141858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.885231ms","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-07-25T07:00:34.141938Z","caller":"traceutil/trace.go:171","msg":"trace[8661381] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2695; }","duration":"249.011924ms","start":"2026-07-25T07:00:33.892907Z","end":"2026-07-25T07:00:34.141919Z","steps":["trace[8661381] 'agreement among raft nodes before linearized reading' (duration: 248.767369ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T07:00:34.141926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.328422ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-07-25T07:00:34.14201Z","caller":"traceutil/trace.go:171","msg":"trace[1431130034] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2695; }","duration":"228.439834ms","start":"2026-07-25T07:00:33.913549Z","end":"2026-07-25T07:00:34.141988Z","steps":["trace[1431130034] 'agreement among raft nodes before linearized reading' (duration: 228.184878ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T07:00:34.297348Z","caller":"traceutil/trace.go:171","msg":"trace[1697168885] transaction","detail":"{read_only:false; response_revision:2697; number_of_response:1; }","duration":"150.459017ms","start":"2026-07-25T07:00:34.146769Z","end":"2026-07-25T07:00:34.297228Z","steps":["trace[1697168885] 'process raft request' (duration: 106.676806ms)","trace[1697168885] 'compare' (duration: 43.652518ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T07:00:34.29736Z","caller":"traceutil/trace.go:171","msg":"trace[69800921] linearizableReadLoop","detail":"{readStateIndex:2841; appliedIndex:2839; }","duration":"146.821483ms","start":"2026-07-25T07:00:34.150499Z","end":"2026-07-25T07:00:34.29732Z","steps":["trace[69800921] 'read index received' (duration: 64.543025ms)","trace[69800921] 'applied index is now lower than readState.Index' (duration: 82.270818ms)"],"step_count":2} {"level":"warn","ts":"2026-07-25T07:00:34.29758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.049158ms","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-07-25T07:00:34.29764Z","caller":"traceutil/trace.go:171","msg":"trace[736839780] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:2698; }","duration":"147.14648ms","start":"2026-07-25T07:00:34.150479Z","end":"2026-07-25T07:00:34.297625Z","steps":["trace[736839780] 'agreement among raft nodes before linearized reading' (duration: 146.959946ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T07:00:34.616628Z","caller":"traceutil/trace.go:171","msg":"trace[509681473] transaction","detail":"{read_only:false; response_revision:2700; number_of_response:1; }","duration":"123.713223ms","start":"2026-07-25T07:00:34.492864Z","end":"2026-07-25T07:00:34.616577Z","steps":["trace[509681473] 'process raft request' (duration: 107.483794ms)","trace[509681473] 'compare' (duration: 15.933632ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T07:00:34.701988Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":1642} {"level":"info","ts":"2026-07-25T07:00:34.823863Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":1642,"took":"120.815516ms","hash":2700459416,"current-db-size-bytes":23207936,"current-db-size":"23 MB","current-db-size-in-use-bytes":5873664,"current-db-size-in-use":"5.9 MB"} {"level":"info","ts":"2026-07-25T07:00:34.823929Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2700459416,"revision":1642,"compact-revision":-1} {"level":"info","ts":"2026-07-25T07:00:35.06458Z","caller":"traceutil/trace.go:171","msg":"trace[1766991343] transaction","detail":"{read_only:false; response_revision:2706; number_of_response:1; }","duration":"169.296537ms","start":"2026-07-25T07:00:34.895245Z","end":"2026-07-25T07:00:35.064542Z","steps":["trace[1766991343] 'process raft request' (duration: 169.048241ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T07:00:35.549034Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.341876ms","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-07-25T07:00:35.549108Z","caller":"traceutil/trace.go:171","msg":"trace[782221895] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2706; }","duration":"129.458079ms","start":"2026-07-25T07:00:35.419633Z","end":"2026-07-25T07:00:35.549092Z","steps":["trace[782221895] 'range keys from in-memory index tree' (duration: 129.191522ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T07:00:35.549203Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"423.190675ms","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-07-25T07:00:35.549313Z","caller":"traceutil/trace.go:171","msg":"trace[883973347] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2706; }","duration":"423.347348ms","start":"2026-07-25T07:00:35.125948Z","end":"2026-07-25T07:00:35.549295Z","steps":["trace[883973347] 'range keys from in-memory index tree' (duration: 422.874687ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T07:00:35.549556Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T07:00:35.125925Z","time spent":"423.41953ms","remote":"127.0.0.1:40050","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-07-25T07:01:12.442007Z","caller":"traceutil/trace.go:171","msg":"trace[2017039022] transaction","detail":"{read_only:false; response_revision:2904; number_of_response:1; }","duration":"226.232123ms","start":"2026-07-25T07:01:12.215755Z","end":"2026-07-25T07:01:12.441987Z","steps":["trace[2017039022] 'process raft request' (duration: 226.089699ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T07:01:12.483969Z","caller":"traceutil/trace.go:171","msg":"trace[1297654871] transaction","detail":"{read_only:false; response_revision:2905; number_of_response:1; }","duration":"218.41768ms","start":"2026-07-25T07:01:12.265522Z","end":"2026-07-25T07:01:12.483939Z","steps":["trace[1297654871] 'process raft request' (duration: 213.20636ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T07:05:34.709886Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2700} {"level":"info","ts":"2026-07-25T07:05:34.728581Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2700,"took":"18.327981ms","hash":918151142,"current-db-size-bytes":23207936,"current-db-size":"23 MB","current-db-size-in-use-bytes":6361088,"current-db-size-in-use":"6.4 MB"} {"level":"info","ts":"2026-07-25T07:05:34.728646Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":918151142,"revision":2700,"compact-revision":1642} {"level":"info","ts":"2026-07-25T07:05:46.17292Z","caller":"traceutil/trace.go:171","msg":"trace[1307809349] linearizableReadLoop","detail":"{readStateIndex:4395; appliedIndex:4393; }","duration":"125.790428ms","start":"2026-07-25T07:05:46.047106Z","end":"2026-07-25T07:05:46.172896Z","steps":["trace[1307809349] 'read index received' (duration: 75.998435ms)","trace[1307809349] 'applied index is now lower than readState.Index' (duration: 49.791053ms)"],"step_count":2} {"level":"warn","ts":"2026-07-25T07:05:46.173176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.058363ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:526"} {"level":"info","ts":"2026-07-25T07:05:46.173278Z","caller":"traceutil/trace.go:171","msg":"trace[2992154] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:4186; }","duration":"126.208397ms","start":"2026-07-25T07:05:46.047048Z","end":"2026-07-25T07:05:46.173256Z","steps":["trace[2992154] 'agreement among raft nodes before linearized reading' (duration: 126.006622ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T07:05:46.173024Z","caller":"traceutil/trace.go:171","msg":"trace[636384651] transaction","detail":"{read_only:false; response_revision:4186; number_of_response:1; }","duration":"126.389921ms","start":"2026-07-25T07:05:46.046599Z","end":"2026-07-25T07:05:46.172989Z","steps":["trace[636384651] 'process raft request' (duration: 123.919454ms)"],"step_count":1}