{"level":"warn","ts":"2026-10-02T09:18:02.147602Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-02T09:18:02.147707Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.173: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.173:2380","--initial-cluster=instance=https://199.204.45.173:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.173:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.173: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-10-02T09:18:02.147781Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-02T09:18:02.147791Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.173:2380"]} {"level":"info","ts":"2026-10-02T09:18:02.147813Z","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-10-02T09:18:02.148634Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.173:2379"]} {"level":"info","ts":"2026-10-02T09:18:02.148732Z","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.204.45.173:2380"],"listen-peer-urls":["https://199.204.45.173:2380"],"advertise-client-urls":["https://199.204.45.173:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.173:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.173: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-10-02T09:18:02.152989Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.9955ms"} {"level":"info","ts":"2026-10-02T09:18:02.163728Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"24955693bdfc5c45","cluster-id":"c3a622743411f344"} {"level":"info","ts":"2026-10-02T09:18:02.163806Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"24955693bdfc5c45 switched to configuration voters=()"} {"level":"info","ts":"2026-10-02T09:18:02.163836Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"24955693bdfc5c45 became follower at term 0"} {"level":"info","ts":"2026-10-02T09:18:02.163853Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 24955693bdfc5c45 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-10-02T09:18:02.163864Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"24955693bdfc5c45 became follower at term 1"} {"level":"info","ts":"2026-10-02T09:18:02.163912Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"24955693bdfc5c45 switched to configuration voters=(2636108349442907205)"} {"level":"warn","ts":"2026-10-02T09:18:02.175933Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-10-02T09:18:02.178482Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-10-02T09:18:02.1806Z","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-10-02T09:18:02.182822Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"24955693bdfc5c45","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-10-02T09:18:02.183073Z","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-10-02T09:18:02.183208Z","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-10-02T09:18:02.183222Z","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-10-02T09:18:02.183116Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"24955693bdfc5c45","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-10-02T09:18:02.187586Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"24955693bdfc5c45 switched to configuration voters=(2636108349442907205)"} {"level":"info","ts":"2026-10-02T09:18:02.187765Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"c3a622743411f344","local-member-id":"24955693bdfc5c45","added-peer-id":"24955693bdfc5c45","added-peer-peer-urls":["https://199.204.45.173:2380"]} {"level":"info","ts":"2026-10-02T09:18:02.191609Z","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-10-02T09:18:02.191948Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"24955693bdfc5c45","initial-advertise-peer-urls":["https://199.204.45.173:2380"],"listen-peer-urls":["https://199.204.45.173:2380"],"advertise-client-urls":["https://199.204.45.173:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.173:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-10-02T09:18:02.19197Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-10-02T09:18:02.192356Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.173:2380"} {"level":"info","ts":"2026-10-02T09:18:02.192386Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.173:2380"} {"level":"info","ts":"2026-10-02T09:18:02.564459Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"24955693bdfc5c45 is starting a new election at term 1"} {"level":"info","ts":"2026-10-02T09:18:02.564567Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"24955693bdfc5c45 became pre-candidate at term 1"} {"level":"info","ts":"2026-10-02T09:18:02.564603Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"24955693bdfc5c45 received MsgPreVoteResp from 24955693bdfc5c45 at term 1"} {"level":"info","ts":"2026-10-02T09:18:02.564625Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"24955693bdfc5c45 became candidate at term 2"} {"level":"info","ts":"2026-10-02T09:18:02.564642Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"24955693bdfc5c45 received MsgVoteResp from 24955693bdfc5c45 at term 2"} {"level":"info","ts":"2026-10-02T09:18:02.56466Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"24955693bdfc5c45 became leader at term 2"} {"level":"info","ts":"2026-10-02T09:18:02.564674Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 24955693bdfc5c45 elected leader 24955693bdfc5c45 at term 2"} {"level":"info","ts":"2026-10-02T09:18:02.735567Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-10-02T09:18:03.214476Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"24955693bdfc5c45","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.173:2379]}","request-path":"/0/members/24955693bdfc5c45/attributes","cluster-id":"c3a622743411f344","publish-timeout":"7s"} {"level":"info","ts":"2026-10-02T09:18:03.214497Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-02T09:18:03.214917Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-10-02T09:18:03.215056Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-10-02T09:18:03.214547Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-02T09:18:03.218272Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-10-02T09:18:03.21829Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.173:2379"} {"level":"info","ts":"2026-10-02T09:18:03.273401Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"c3a622743411f344","local-member-id":"24955693bdfc5c45","cluster-version":"3.5"} {"level":"info","ts":"2026-10-02T09:18:03.273605Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-10-02T09:18:03.273776Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-10-02T09:18:08.754546Z","caller":"traceutil/trace.go:171","msg":"trace[1417362284] linearizableReadLoop","detail":"{readStateIndex:289; appliedIndex:288; }","duration":"160.598216ms","start":"2026-10-02T09:18:08.593913Z","end":"2026-10-02T09:18:08.754511Z","steps":["trace[1417362284] 'read index received' (duration: 160.475023ms)","trace[1417362284] 'applied index is now lower than readState.Index' (duration: 121.993µs)"],"step_count":2} {"level":"info","ts":"2026-10-02T09:18:08.754744Z","caller":"traceutil/trace.go:171","msg":"trace[130865632] transaction","detail":"{read_only:false; response_revision:283; number_of_response:1; }","duration":"179.546134ms","start":"2026-10-02T09:18:08.575144Z","end":"2026-10-02T09:18:08.75469Z","steps":["trace[130865632] 'process raft request' (duration: 179.184694ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T09:18:08.754893Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.903135ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/\" range_end:\"/registry/deployments/kube-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-02T09:18:08.755008Z","caller":"traceutil/trace.go:171","msg":"trace[580406774] range","detail":"{range_begin:/registry/deployments/kube-system/; range_end:/registry/deployments/kube-system0; response_count:0; response_revision:283; }","duration":"161.127541ms","start":"2026-10-02T09:18:08.593862Z","end":"2026-10-02T09:18:08.754989Z","steps":["trace[580406774] 'agreement among raft nodes before linearized reading' (duration: 160.834923ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T09:18:09.142605Z","caller":"traceutil/trace.go:171","msg":"trace[2067753568] linearizableReadLoop","detail":"{readStateIndex:290; appliedIndex:289; }","duration":"387.910495ms","start":"2026-10-02T09:18:08.754664Z","end":"2026-10-02T09:18:09.142574Z","steps":["trace[2067753568] 'read index received' (duration: 387.773401ms)","trace[2067753568] 'applied index is now lower than readState.Index' (duration: 136.024µs)"],"step_count":2} {"level":"info","ts":"2026-10-02T09:18:09.142691Z","caller":"traceutil/trace.go:171","msg":"trace[1169872250] transaction","detail":"{read_only:false; response_revision:284; number_of_response:1; }","duration":"437.838688ms","start":"2026-10-02T09:18:08.704782Z","end":"2026-10-02T09:18:09.142621Z","steps":["trace[1169872250] 'process raft request' (duration: 437.632382ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T09:18:09.14286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"438.954849ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:1 size:664"} {"level":"info","ts":"2026-10-02T09:18:09.142904Z","caller":"traceutil/trace.go:171","msg":"trace[1454594797] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:1; response_revision:284; }","duration":"439.064911ms","start":"2026-10-02T09:18:08.703829Z","end":"2026-10-02T09:18:09.142894Z","steps":["trace[1454594797] 'agreement among raft nodes before linearized reading' (duration: 438.887427ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T09:18:09.14286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"433.50834ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-node-lease/instance\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-02T09:18:09.142943Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-02T09:18:08.703807Z","time spent":"439.128414ms","remote":"127.0.0.1:50526","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":1,"response size":687,"request content":"key:\"/registry/csinodes/instance\" "} {"level":"info","ts":"2026-10-02T09:18:09.14299Z","caller":"traceutil/trace.go:171","msg":"trace[427565242] range","detail":"{range_begin:/registry/leases/kube-node-lease/instance; range_end:; response_count:0; response_revision:284; }","duration":"433.693795ms","start":"2026-10-02T09:18:08.709254Z","end":"2026-10-02T09:18:09.142947Z","steps":["trace[427565242] 'agreement among raft nodes before linearized reading' (duration: 433.389037ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T09:18:09.143083Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-02T09:18:08.709239Z","time spent":"433.825928ms","remote":"127.0.0.1:50388","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-node-lease/instance\" "} {"level":"warn","ts":"2026-10-02T09:18:09.143521Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-02T09:18:08.704759Z","time spent":"438.033174ms","remote":"127.0.0.1:50224","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":592,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-02T09:18:09.420566Z","caller":"traceutil/trace.go:171","msg":"trace[163691876] transaction","detail":"{read_only:false; number_of_response:0; response_revision:284; }","duration":"616.794156ms","start":"2026-10-02T09:18:08.803713Z","end":"2026-10-02T09:18:09.420507Z","steps":["trace[163691876] 'process raft request' (duration: 616.518788ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T09:18:09.420712Z","caller":"traceutil/trace.go:171","msg":"trace[1437369493] transaction","detail":"{read_only:false; number_of_response:0; response_revision:285; }","duration":"593.240502ms","start":"2026-10-02T09:18:08.827436Z","end":"2026-10-02T09:18:09.420677Z","steps":["trace[1437369493] 'process raft request' (duration: 593.113629ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T09:18:09.42076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"659.277446ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/coredns\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-02T09:18:09.42079Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-02T09:18:08.803689Z","time spent":"617.010352ms","remote":"127.0.0.1:50298","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-02T09:18:09.420848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"455.653575ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-02T09:18:09.420866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"348.091747ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"warn","ts":"2026-10-02T09:18:09.420872Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-02T09:18:08.827419Z","time spent":"593.374466ms","remote":"127.0.0.1:50300","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-02T09:18:09.42088Z","caller":"traceutil/trace.go:171","msg":"trace[1992861707] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:0; response_revision:285; }","duration":"455.732966ms","start":"2026-10-02T09:18:08.965133Z","end":"2026-10-02T09:18:09.420866Z","steps":["trace[1992861707] 'agreement among raft nodes before linearized reading' (duration: 455.694795ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T09:18:09.420914Z","caller":"traceutil/trace.go:171","msg":"trace[742760100] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:285; }","duration":"348.177679ms","start":"2026-10-02T09:18:09.072715Z","end":"2026-10-02T09:18:09.420893Z","steps":["trace[742760100] 'agreement among raft nodes before linearized reading' (duration: 348.108987ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T09:18:09.420939Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-02T09:18:08.965102Z","time spent":"455.822519ms","remote":"127.0.0.1:50388","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-10-02T09:18:09.420958Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-02T09:18:09.072693Z","time spent":"348.256412ms","remote":"127.0.0.1:50388","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-10-02T09:18:09.420766Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"452.627242ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-02T09:18:09.420599Z","caller":"traceutil/trace.go:171","msg":"trace[1664723737] linearizableReadLoop","detail":"{readStateIndex:296; appliedIndex:290; }","duration":"277.89552ms","start":"2026-10-02T09:18:09.142683Z","end":"2026-10-02T09:18:09.420579Z","steps":["trace[1664723737] 'read index received' (duration: 277.642163ms)","trace[1664723737] 'applied index is now lower than readState.Index' (duration: 252.337µs)"],"step_count":2} {"level":"info","ts":"2026-10-02T09:18:09.42117Z","caller":"traceutil/trace.go:171","msg":"trace[1767587166] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:0; response_revision:285; }","duration":"453.116126ms","start":"2026-10-02T09:18:08.968025Z","end":"2026-10-02T09:18:09.421141Z","steps":["trace[1767587166] 'agreement among raft nodes before linearized reading' (duration: 452.654093ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T09:18:09.421225Z","caller":"traceutil/trace.go:171","msg":"trace[1659928319] transaction","detail":"{read_only:false; number_of_response:0; response_revision:285; }","duration":"595.973157ms","start":"2026-10-02T09:18:08.825237Z","end":"2026-10-02T09:18:09.421211Z","steps":["trace[1659928319] 'process raft request' (duration: 595.240527ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T09:18:09.421279Z","caller":"traceutil/trace.go:171","msg":"trace[2097057148] transaction","detail":"{read_only:false; number_of_response:0; response_revision:285; }","duration":"595.551885ms","start":"2026-10-02T09:18:08.825715Z","end":"2026-10-02T09:18:09.421267Z","steps":["trace[2097057148] 'process raft request' (duration: 594.787785ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T09:18:09.421277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"659.824431ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/resourcequota-controller\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-02T09:18:09.421299Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-02T09:18:08.825226Z","time spent":"596.036309ms","remote":"127.0.0.1:50300","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-02T09:18:09.421331Z","caller":"traceutil/trace.go:171","msg":"trace[48380991] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/resourcequota-controller; range_end:; response_count:0; response_revision:285; }","duration":"659.923764ms","start":"2026-10-02T09:18:08.76139Z","end":"2026-10-02T09:18:09.421314Z","steps":["trace[48380991] 'agreement among raft nodes before linearized reading' (duration: 659.810171ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T09:18:09.421231Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-02T09:18:08.967996Z","time spent":"453.213298ms","remote":"127.0.0.1:50388","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-10-02T09:18:09.421365Z","caller":"traceutil/trace.go:171","msg":"trace[1076870077] transaction","detail":"{read_only:false; response_revision:285; number_of_response:1; }","duration":"596.225294ms","start":"2026-10-02T09:18:08.82508Z","end":"2026-10-02T09:18:09.421305Z","steps":["trace[1076870077] 'process raft request' (duration: 595.280209ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T09:18:09.421378Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-02T09:18:08.761361Z","time spent":"660.004876ms","remote":"127.0.0.1:50310","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":0,"response size":28,"request content":"key:\"/registry/serviceaccounts/kube-system/resourcequota-controller\" "} {"level":"info","ts":"2026-10-02T09:18:09.420808Z","caller":"traceutil/trace.go:171","msg":"trace[1663514431] range","detail":"{range_begin:/registry/configmaps/kube-system/coredns; range_end:; response_count:0; response_revision:285; }","duration":"659.408679ms","start":"2026-10-02T09:18:08.761387Z","end":"2026-10-02T09:18:09.420796Z","steps":["trace[1663514431] 'agreement among raft nodes before linearized reading' (duration: 659.266766ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T09:18:09.421513Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-02T09:18:08.761367Z","time spent":"660.1342ms","remote":"127.0.0.1:50248","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":0,"response size":28,"request content":"key:\"/registry/configmaps/kube-system/coredns\" "} {"level":"warn","ts":"2026-10-02T09:18:09.421502Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-02T09:18:08.825017Z","time spent":"596.392548ms","remote":"127.0.0.1:50300","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5882,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-02T09:18:09.421592Z","caller":"traceutil/trace.go:171","msg":"trace[174230613] transaction","detail":"{read_only:false; number_of_response:0; response_revision:285; }","duration":"595.761871ms","start":"2026-10-02T09:18:08.825817Z","end":"2026-10-02T09:18:09.421579Z","steps":["trace[174230613] 'process raft request' (duration: 594.706322ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T09:18:09.421663Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-02T09:18:08.825803Z","time spent":"595.824433ms","remote":"127.0.0.1:50300","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-02T09:18:09.422927Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-02T09:18:08.8257Z","time spent":"595.604497ms","remote":"127.0.0.1:50300","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-02T09:18:09.423745Z","caller":"traceutil/trace.go:171","msg":"trace[633225368] transaction","detail":"{read_only:false; response_revision:286; number_of_response:1; }","duration":"275.933406ms","start":"2026-10-02T09:18:09.147786Z","end":"2026-10-02T09:18:09.42372Z","steps":["trace[633225368] 'process raft request' (duration: 275.724461ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T09:18:09.424201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.865299ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-02T09:18:09.424253Z","caller":"traceutil/trace.go:171","msg":"trace[976849543] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:0; response_revision:286; }","duration":"277.949082ms","start":"2026-10-02T09:18:09.14629Z","end":"2026-10-02T09:18:09.424239Z","steps":["trace[976849543] 'agreement among raft nodes before linearized reading' (duration: 277.816168ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T09:18:09.424429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.180768ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:1 size:664"} {"level":"info","ts":"2026-10-02T09:18:09.424465Z","caller":"traceutil/trace.go:171","msg":"trace[1045771606] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:1; response_revision:286; }","duration":"278.22856ms","start":"2026-10-02T09:18:09.146225Z","end":"2026-10-02T09:18:09.424454Z","steps":["trace[1045771606] 'agreement among raft nodes before linearized reading' (duration: 278.159648ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T09:18:09.424635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.489326ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4017"} {"level":"info","ts":"2026-10-02T09:18:09.42476Z","caller":"traceutil/trace.go:171","msg":"trace[1840555279] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:286; }","duration":"278.658631ms","start":"2026-10-02T09:18:09.146081Z","end":"2026-10-02T09:18:09.42474Z","steps":["trace[1840555279] 'agreement among raft nodes before linearized reading' (duration: 278.452446ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T09:18:39.89132Z","caller":"traceutil/trace.go:171","msg":"trace[1821721723] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"106.54369ms","start":"2026-10-02T09:18:39.784736Z","end":"2026-10-02T09:18:39.89128Z","steps":["trace[1821721723] 'process raft request' (duration: 95.895069ms)","trace[1821721723] 'compare' (duration: 10.505467ms)"],"step_count":2} {"level":"info","ts":"2026-10-02T09:18:41.031886Z","caller":"traceutil/trace.go:171","msg":"trace[1503381870] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"133.872127ms","start":"2026-10-02T09:18:40.897999Z","end":"2026-10-02T09:18:41.031871Z","steps":["trace[1503381870] 'process raft request' (duration: 115.460124ms)","trace[1503381870] 'compare' (duration: 18.226338ms)"],"step_count":2} {"level":"info","ts":"2026-10-02T09:18:41.032222Z","caller":"traceutil/trace.go:171","msg":"trace[1410592548] transaction","detail":"{read_only:false; response_revision:545; number_of_response:1; }","duration":"133.094295ms","start":"2026-10-02T09:18:40.899119Z","end":"2026-10-02T09:18:41.032213Z","steps":["trace[1410592548] 'process raft request' (duration: 132.686014ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T09:18:41.032472Z","caller":"traceutil/trace.go:171","msg":"trace[1017888546] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"133.30575ms","start":"2026-10-02T09:18:40.899136Z","end":"2026-10-02T09:18:41.032442Z","steps":["trace[1017888546] 'process raft request' (duration: 133.122265ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T09:18:41.034434Z","caller":"traceutil/trace.go:171","msg":"trace[39047766] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"122.374032ms","start":"2026-10-02T09:18:40.912016Z","end":"2026-10-02T09:18:41.03439Z","steps":["trace[39047766] 'process raft request' (duration: 122.112504ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T09:18:41.043735Z","caller":"traceutil/trace.go:171","msg":"trace[1694801304] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"128.252313ms","start":"2026-10-02T09:18:40.915453Z","end":"2026-10-02T09:18:41.043706Z","steps":["trace[1694801304] 'process raft request' (duration: 123.045961ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T09:18:41.044036Z","caller":"traceutil/trace.go:171","msg":"trace[1189614547] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"130.613047ms","start":"2026-10-02T09:18:40.913414Z","end":"2026-10-02T09:18:41.044027Z","steps":["trace[1189614547] 'process raft request' (duration: 120.892061ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T09:18:41.04802Z","caller":"traceutil/trace.go:171","msg":"trace[905693116] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"126.67589ms","start":"2026-10-02T09:18:40.921325Z","end":"2026-10-02T09:18:41.048001Z","steps":["trace[905693116] 'process raft request' (duration: 120.709227ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T09:18:47.883704Z","caller":"traceutil/trace.go:171","msg":"trace[725520188] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"176.147961ms","start":"2026-10-02T09:18:47.707534Z","end":"2026-10-02T09:18:47.883682Z","steps":["trace[725520188] 'process raft request' (duration: 175.956146ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T09:18:47.969766Z","caller":"traceutil/trace.go:171","msg":"trace[1224587299] linearizableReadLoop","detail":"{readStateIndex:652; appliedIndex:649; }","duration":"224.488291ms","start":"2026-10-02T09:18:47.745263Z","end":"2026-10-02T09:18:47.969751Z","steps":["trace[1224587299] 'read index received' (duration: 138.319717ms)","trace[1224587299] 'applied index is now lower than readState.Index' (duration: 86.168064ms)"],"step_count":2} {"level":"info","ts":"2026-10-02T09:18:47.969835Z","caller":"traceutil/trace.go:171","msg":"trace[670754688] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"260.789843ms","start":"2026-10-02T09:18:47.709038Z","end":"2026-10-02T09:18:47.969828Z","steps":["trace[670754688] 'process raft request' (duration: 260.6819ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T09:18:47.96983Z","caller":"traceutil/trace.go:171","msg":"trace[1842169876] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"261.80934ms","start":"2026-10-02T09:18:47.707988Z","end":"2026-10-02T09:18:47.969797Z","steps":["trace[1842169876] 'process raft request' (duration: 210.250252ms)","trace[1842169876] 'compare' (duration: 51.366503ms)"],"step_count":2} {"level":"warn","ts":"2026-10-02T09:18:47.970362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.087007ms","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-10-02T09:18:47.970391Z","caller":"traceutil/trace.go:171","msg":"trace[493019726] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:626; }","duration":"225.154229ms","start":"2026-10-02T09:18:47.745229Z","end":"2026-10-02T09:18:47.970384Z","steps":["trace[493019726] 'agreement among raft nodes before linearized reading' (duration: 225.049797ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T09:18:48.004978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.233599ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-qfpw7\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-10-02T09:18:48.005057Z","caller":"traceutil/trace.go:171","msg":"trace[677154689] range","detail":"{range_begin:/registry/pods/kube-system/cilium-qfpw7; range_end:; response_count:1; response_revision:627; }","duration":"159.339252ms","start":"2026-10-02T09:18:47.845697Z","end":"2026-10-02T09:18:48.005037Z","steps":["trace[677154689] 'agreement among raft nodes before linearized reading' (duration: 159.193698ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T09:18:48.710152Z","caller":"traceutil/trace.go:171","msg":"trace[1182144969] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"683.070929ms","start":"2026-10-02T09:18:48.02706Z","end":"2026-10-02T09:18:48.710131Z","steps":["trace[1182144969] 'process raft request' (duration: 654.519112ms)","trace[1182144969] 'compare' (duration: 27.853348ms)"],"step_count":2} {"level":"info","ts":"2026-10-02T09:18:48.710193Z","caller":"traceutil/trace.go:171","msg":"trace[290947635] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"628.965601ms","start":"2026-10-02T09:18:48.081194Z","end":"2026-10-02T09:18:48.710159Z","steps":["trace[290947635] 'process raft request' (duration: 628.688204ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T09:18:48.710345Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-02T09:18:48.081174Z","time spent":"629.087875ms","remote":"127.0.0.1:50456","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":897,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-02T09:18:48.710332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"471.843847ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-02T09:18:48.71041Z","caller":"traceutil/trace.go:171","msg":"trace[1863948133] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:630; }","duration":"471.960091ms","start":"2026-10-02T09:18:48.23843Z","end":"2026-10-02T09:18:48.71039Z","steps":["trace[1863948133] 'agreement among raft nodes before linearized reading' (duration: 471.821537ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T09:18:48.710452Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-02T09:18:48.238417Z","time spent":"472.028402ms","remote":"127.0.0.1:47142","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-10-02T09:18:48.710551Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-02T09:18:48.027036Z","time spent":"683.207774ms","remote":"127.0.0.1:50300","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-02T09:18:48.710811Z","caller":"traceutil/trace.go:171","msg":"trace[1460678236] linearizableReadLoop","detail":"{readStateIndex:656; appliedIndex:654; }","duration":"471.489698ms","start":"2026-10-02T09:18:48.238474Z","end":"2026-10-02T09:18:48.709963Z","steps":["trace[1460678236] 'read index received' (duration: 443.045434ms)","trace[1460678236] 'applied index is now lower than readState.Index' (duration: 28.443024ms)"],"step_count":2} {"level":"info","ts":"2026-10-02T09:18:50.105619Z","caller":"traceutil/trace.go:171","msg":"trace[1194874409] transaction","detail":"{read_only:false; response_revision:646; number_of_response:1; }","duration":"133.11215ms","start":"2026-10-02T09:18:49.972491Z","end":"2026-10-02T09:18:50.105603Z","steps":["trace[1194874409] 'process raft request' (duration: 130.442846ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T09:18:50.105742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.025189ms","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-10-02T09:18:50.105789Z","caller":"traceutil/trace.go:171","msg":"trace[1765066529] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:646; }","duration":"132.105812ms","start":"2026-10-02T09:18:49.973669Z","end":"2026-10-02T09:18:50.105775Z","steps":["trace[1765066529] 'agreement among raft nodes before linearized reading' (duration: 131.963618ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T09:18:50.105935Z","caller":"traceutil/trace.go:171","msg":"trace[1389713335] linearizableReadLoop","detail":"{readStateIndex:672; appliedIndex:671; }","duration":"131.524445ms","start":"2026-10-02T09:18:49.973699Z","end":"2026-10-02T09:18:50.105224Z","steps":["trace[1389713335] 'read index received' (duration: 129.13493ms)","trace[1389713335] 'applied index is now lower than readState.Index' (duration: 2.388695ms)"],"step_count":2} {"level":"warn","ts":"2026-10-02T09:18:50.106339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.149993ms","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-10-02T09:18:50.106397Z","caller":"traceutil/trace.go:171","msg":"trace[370778241] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:646; }","duration":"132.201074ms","start":"2026-10-02T09:18:49.97416Z","end":"2026-10-02T09:18:50.106361Z","steps":["trace[370778241] 'agreement among raft nodes before linearized reading' (duration: 131.904656ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T09:19:47.858914Z","caller":"traceutil/trace.go:171","msg":"trace[519032172] transaction","detail":"{read_only:false; response_revision:1108; number_of_response:1; }","duration":"184.629678ms","start":"2026-10-02T09:19:47.674254Z","end":"2026-10-02T09:19:47.858883Z","steps":["trace[519032172] 'process raft request' (duration: 184.374101ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T09:20:06.696928Z","caller":"traceutil/trace.go:171","msg":"trace[1618589511] linearizableReadLoop","detail":"{readStateIndex:1232; appliedIndex:1231; }","duration":"118.95264ms","start":"2026-10-02T09:20:06.577951Z","end":"2026-10-02T09:20:06.696904Z","steps":["trace[1618589511] 'read index received' (duration: 118.749574ms)","trace[1618589511] 'applied index is now lower than readState.Index' (duration: 202.256µs)"],"step_count":2} {"level":"warn","ts":"2026-10-02T09:20:06.697169Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.193896ms","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-10-02T09:20:06.697236Z","caller":"traceutil/trace.go:171","msg":"trace[895675642] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1188; }","duration":"119.286529ms","start":"2026-10-02T09:20:06.577909Z","end":"2026-10-02T09:20:06.697195Z","steps":["trace[895675642] 'agreement among raft nodes before linearized reading' (duration: 119.100514ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T09:20:06.697582Z","caller":"traceutil/trace.go:171","msg":"trace[9056223] transaction","detail":"{read_only:false; response_revision:1188; number_of_response:1; }","duration":"136.523006ms","start":"2026-10-02T09:20:06.561049Z","end":"2026-10-02T09:20:06.697572Z","steps":["trace[9056223] 'process raft request' (duration: 135.717304ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T09:20:06.697926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.062703ms","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-10-02T09:20:06.698008Z","caller":"traceutil/trace.go:171","msg":"trace[315975268] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1188; }","duration":"112.170115ms","start":"2026-10-02T09:20:06.585817Z","end":"2026-10-02T09:20:06.697987Z","steps":["trace[315975268] 'agreement among raft nodes before linearized reading' (duration: 111.97178ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T09:20:06.987493Z","caller":"traceutil/trace.go:171","msg":"trace[1868621234] transaction","detail":"{read_only:false; response_revision:1189; number_of_response:1; }","duration":"279.92588ms","start":"2026-10-02T09:20:06.707532Z","end":"2026-10-02T09:20:06.987458Z","steps":["trace[1868621234] 'process raft request' (duration: 279.639782ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T09:20:06.987742Z","caller":"traceutil/trace.go:171","msg":"trace[502337853] linearizableReadLoop","detail":"{readStateIndex:1236; appliedIndex:1232; }","duration":"129.869666ms","start":"2026-10-02T09:20:06.857851Z","end":"2026-10-02T09:20:06.987721Z","steps":["trace[502337853] 'read index received' (duration: 10.34058ms)","trace[502337853] 'applied index is now lower than readState.Index' (duration: 119.528096ms)"],"step_count":2} {"level":"info","ts":"2026-10-02T09:20:06.987814Z","caller":"traceutil/trace.go:171","msg":"trace[1430020639] transaction","detail":"{read_only:false; response_revision:1190; number_of_response:1; }","duration":"280.203178ms","start":"2026-10-02T09:20:06.707594Z","end":"2026-10-02T09:20:06.987797Z","steps":["trace[1430020639] 'process raft request' (duration: 279.809207ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T09:20:06.987861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.99749ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-02T09:20:06.987893Z","caller":"traceutil/trace.go:171","msg":"trace[1237001209] transaction","detail":"{read_only:false; response_revision:1191; number_of_response:1; }","duration":"280.474315ms","start":"2026-10-02T09:20:06.707409Z","end":"2026-10-02T09:20:06.987883Z","steps":["trace[1237001209] 'process raft request' (duration: 280.232488ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T09:20:06.987907Z","caller":"traceutil/trace.go:171","msg":"trace[370230401] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:1191; }","duration":"130.105982ms","start":"2026-10-02T09:20:06.857788Z","end":"2026-10-02T09:20:06.987894Z","steps":["trace[370230401] 'agreement among raft nodes before linearized reading' (duration: 130.00535ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T09:20:07.920695Z","caller":"traceutil/trace.go:171","msg":"trace[1913092692] transaction","detail":"{read_only:false; response_revision:1193; number_of_response:1; }","duration":"129.087995ms","start":"2026-10-02T09:20:07.791582Z","end":"2026-10-02T09:20:07.92067Z","steps":["trace[1913092692] 'process raft request' (duration: 128.961781ms)"],"step_count":1}