{"level":"warn","ts":"2026-07-14T22:59:28.32772Z","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-14T22:59:28.327843Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.89: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.89:2380","--initial-cluster=instance=https://199.204.45.89:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.89:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.89: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-14T22:59:28.32793Z","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-14T22:59:28.327943Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.89:2380"]} {"level":"info","ts":"2026-07-14T22:59:28.327964Z","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-14T22:59:28.328648Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.89:2379"]} {"level":"info","ts":"2026-07-14T22:59:28.328732Z","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.89:2380"],"listen-peer-urls":["https://199.204.45.89:2380"],"advertise-client-urls":["https://199.204.45.89:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.89:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.89: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-14T22:59:28.333303Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.33013ms"} {"level":"info","ts":"2026-07-14T22:59:28.342265Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"c3b8446219deb8c1","cluster-id":"fe02a46d8aa9751f"} {"level":"info","ts":"2026-07-14T22:59:28.34234Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 switched to configuration voters=()"} {"level":"info","ts":"2026-07-14T22:59:28.342362Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 became follower at term 0"} {"level":"info","ts":"2026-07-14T22:59:28.342381Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft c3b8446219deb8c1 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-14T22:59:28.342389Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 became follower at term 1"} {"level":"info","ts":"2026-07-14T22:59:28.342438Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 switched to configuration voters=(14103097421242218689)"} {"level":"warn","ts":"2026-07-14T22:59:28.349908Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-14T22:59:28.351636Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-14T22:59:28.353426Z","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-14T22:59:28.355577Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"c3b8446219deb8c1","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-14T22:59:28.35612Z","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-14T22:59:28.356072Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"c3b8446219deb8c1","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-14T22:59:28.356237Z","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-14T22:59:28.356257Z","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-14T22:59:28.356937Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 switched to configuration voters=(14103097421242218689)"} {"level":"info","ts":"2026-07-14T22:59:28.361594Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"fe02a46d8aa9751f","local-member-id":"c3b8446219deb8c1","added-peer-id":"c3b8446219deb8c1","added-peer-peer-urls":["https://199.204.45.89:2380"]} {"level":"info","ts":"2026-07-14T22:59:28.366622Z","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-14T22:59:28.366799Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.89:2380"} {"level":"info","ts":"2026-07-14T22:59:28.366951Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.89:2380"} {"level":"info","ts":"2026-07-14T22:59:28.368053Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-14T22:59:28.368014Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"c3b8446219deb8c1","initial-advertise-peer-urls":["https://199.204.45.89:2380"],"listen-peer-urls":["https://199.204.45.89:2380"],"advertise-client-urls":["https://199.204.45.89:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.89:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-14T22:59:29.244219Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 is starting a new election at term 1"} {"level":"info","ts":"2026-07-14T22:59:29.24474Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 became pre-candidate at term 1"} {"level":"info","ts":"2026-07-14T22:59:29.244775Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 received MsgPreVoteResp from c3b8446219deb8c1 at term 1"} {"level":"info","ts":"2026-07-14T22:59:29.244793Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 became candidate at term 2"} {"level":"info","ts":"2026-07-14T22:59:29.244811Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 received MsgVoteResp from c3b8446219deb8c1 at term 2"} {"level":"info","ts":"2026-07-14T22:59:29.244913Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 became leader at term 2"} {"level":"info","ts":"2026-07-14T22:59:29.244934Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: c3b8446219deb8c1 elected leader c3b8446219deb8c1 at term 2"} {"level":"info","ts":"2026-07-14T22:59:29.251686Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-14T22:59:29.252902Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"c3b8446219deb8c1","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.89:2379]}","request-path":"/0/members/c3b8446219deb8c1/attributes","cluster-id":"fe02a46d8aa9751f","publish-timeout":"7s"} {"level":"info","ts":"2026-07-14T22:59:29.252978Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-14T22:59:29.253135Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-14T22:59:29.253504Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"fe02a46d8aa9751f","local-member-id":"c3b8446219deb8c1","cluster-version":"3.5"} {"level":"info","ts":"2026-07-14T22:59:29.253654Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-14T22:59:29.253598Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-14T22:59:29.253705Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-14T22:59:29.253709Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-14T22:59:29.255714Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-14T22:59:29.256899Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.89:2379"} {"level":"info","ts":"2026-07-14T22:59:38.533765Z","caller":"traceutil/trace.go:171","msg":"trace[1760514946] transaction","detail":"{read_only:false; number_of_response:1; response_revision:353; }","duration":"228.854154ms","start":"2026-07-14T22:59:38.30488Z","end":"2026-07-14T22:59:38.533734Z","steps":["trace[1760514946] 'process raft request' (duration: 133.077658ms)","trace[1760514946] 'compare' (duration: 95.660165ms)"],"step_count":2} {"level":"info","ts":"2026-07-14T22:59:38.533746Z","caller":"traceutil/trace.go:171","msg":"trace[2042778573] linearizableReadLoop","detail":"{readStateIndex:363; appliedIndex:362; }","duration":"210.160358ms","start":"2026-07-14T22:59:38.323555Z","end":"2026-07-14T22:59:38.533715Z","steps":["trace[2042778573] 'read index received' (duration: 114.303102ms)","trace[2042778573] 'applied index is now lower than readState.Index' (duration: 95.856026ms)"],"step_count":2} {"level":"warn","ts":"2026-07-14T22:59:38.533954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.337978ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-07-14T22:59:38.534059Z","caller":"traceutil/trace.go:171","msg":"trace[2046629500] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-controller; range_end:; response_count:1; response_revision:353; }","duration":"210.524728ms","start":"2026-07-14T22:59:38.323515Z","end":"2026-07-14T22:59:38.534039Z","steps":["trace[2046629500] 'agreement among raft nodes before linearized reading' (duration: 210.284408ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T22:59:38.534105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.562461ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" ","response":"range_response_count:1 size:214"} {"level":"info","ts":"2026-07-14T22:59:38.534149Z","caller":"traceutil/trace.go:171","msg":"trace[1086387646] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslice-controller; range_end:; response_count:1; response_revision:353; }","duration":"160.682381ms","start":"2026-07-14T22:59:38.373452Z","end":"2026-07-14T22:59:38.534135Z","steps":["trace[1086387646] 'agreement among raft nodes before linearized reading' (duration: 160.566141ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T22:59:38.534598Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.854824ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/node-controller\" ","response":"range_response_count:1 size:195"} {"level":"info","ts":"2026-07-14T22:59:38.534634Z","caller":"traceutil/trace.go:171","msg":"trace[323198592] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/node-controller; range_end:; response_count:1; response_revision:353; }","duration":"110.934154ms","start":"2026-07-14T22:59:38.423688Z","end":"2026-07-14T22:59:38.534622Z","steps":["trace[323198592] 'agreement among raft nodes before linearized reading' (duration: 110.877374ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T22:59:45.134076Z","caller":"traceutil/trace.go:171","msg":"trace[1772881386] transaction","detail":"{read_only:false; response_revision:410; number_of_response:1; }","duration":"874.917831ms","start":"2026-07-14T22:59:44.259127Z","end":"2026-07-14T22:59:45.134045Z","steps":["trace[1772881386] 'process raft request' (duration: 874.651441ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T22:59:45.134902Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T22:59:44.259099Z","time spent":"875.077792ms","remote":"127.0.0.1:47166","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6946,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-14T22:59:45.164926Z","caller":"traceutil/trace.go:171","msg":"trace[720157980] linearizableReadLoop","detail":"{readStateIndex:423; appliedIndex:421; }","duration":"434.569593ms","start":"2026-07-14T22:59:44.730322Z","end":"2026-07-14T22:59:45.164891Z","steps":["trace[720157980] 'read index received' (duration: 403.493134ms)","trace[720157980] 'applied index is now lower than readState.Index' (duration: 31.074999ms)"],"step_count":2} {"level":"info","ts":"2026-07-14T22:59:45.165107Z","caller":"traceutil/trace.go:171","msg":"trace[1284719129] transaction","detail":"{read_only:false; response_revision:411; number_of_response:1; }","duration":"879.947503ms","start":"2026-07-14T22:59:44.285146Z","end":"2026-07-14T22:59:45.165093Z","steps":["trace[1284719129] 'process raft request' (duration: 879.599991ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T22:59:45.165227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"434.897004ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-07-14T22:59:45.165308Z","caller":"traceutil/trace.go:171","msg":"trace[1967149046] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:411; }","duration":"435.029214ms","start":"2026-07-14T22:59:44.730258Z","end":"2026-07-14T22:59:45.165287Z","steps":["trace[1967149046] 'agreement among raft nodes before linearized reading' (duration: 434.895494ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T22:59:45.165345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.356661ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-07-14T22:59:45.165349Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T22:59:44.730223Z","time spent":"435.117755ms","remote":"127.0.0.1:47214","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-07-14T22:59:45.165389Z","caller":"traceutil/trace.go:171","msg":"trace[1726160062] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:411; }","duration":"252.435592ms","start":"2026-07-14T22:59:44.912939Z","end":"2026-07-14T22:59:45.165375Z","steps":["trace[1726160062] 'agreement among raft nodes before linearized reading' (duration: 252.355902ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T22:59:45.165251Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T22:59:44.285108Z","time spent":"880.029173ms","remote":"127.0.0.1:47214","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-14T22:59:45.16551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"435.167735ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-07-14T22:59:45.16558Z","caller":"traceutil/trace.go:171","msg":"trace[2015869114] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:411; }","duration":"435.293865ms","start":"2026-07-14T22:59:44.730265Z","end":"2026-07-14T22:59:45.165559Z","steps":["trace[2015869114] 'agreement among raft nodes before linearized reading' (duration: 435.146745ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T22:59:45.16564Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T22:59:44.73024Z","time spent":"435.380286ms","remote":"127.0.0.1:47214","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":"warn","ts":"2026-07-14T22:59:45.165662Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.520899ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-14T22:59:45.165771Z","caller":"traceutil/trace.go:171","msg":"trace[830267342] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:411; }","duration":"140.67346ms","start":"2026-07-14T22:59:45.025059Z","end":"2026-07-14T22:59:45.165733Z","steps":["trace[830267342] 'agreement among raft nodes before linearized reading' (duration: 140.497739ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T23:00:07.052127Z","caller":"traceutil/trace.go:171","msg":"trace[1126315010] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"407.129522ms","start":"2026-07-14T23:00:06.644966Z","end":"2026-07-14T23:00:07.052096Z","steps":["trace[1126315010] 'process raft request' (duration: 406.987731ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:00:07.052266Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T23:00:06.644946Z","time spent":"407.256493ms","remote":"127.0.0.1:47020","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-14T23:00:07.060632Z","caller":"traceutil/trace.go:171","msg":"trace[1710869785] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"413.690955ms","start":"2026-07-14T23:00:06.646895Z","end":"2026-07-14T23:00:07.060586Z","steps":["trace[1710869785] 'process raft request' (duration: 413.487323ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T23:00:07.060695Z","caller":"traceutil/trace.go:171","msg":"trace[1511654582] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"403.502231ms","start":"2026-07-14T23:00:06.657157Z","end":"2026-07-14T23:00:07.060659Z","steps":["trace[1511654582] 'process raft request' (duration: 403.32132ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T23:00:07.060858Z","caller":"traceutil/trace.go:171","msg":"trace[829094266] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"414.038827ms","start":"2026-07-14T23:00:06.646809Z","end":"2026-07-14T23:00:07.060848Z","steps":["trace[829094266] 'process raft request' (duration: 413.449703ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:00:07.060899Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T23:00:06.646788Z","time spent":"414.092007ms","remote":"127.0.0.1:47020","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-14T23:00:07.060905Z","caller":"traceutil/trace.go:171","msg":"trace[1595244304] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"233.643718ms","start":"2026-07-14T23:00:06.827243Z","end":"2026-07-14T23:00:07.060887Z","steps":["trace[1595244304] 'process raft request' (duration: 233.579188ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T23:00:07.061041Z","caller":"traceutil/trace.go:171","msg":"trace[1114045780] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"403.874723ms","start":"2026-07-14T23:00:06.657154Z","end":"2026-07-14T23:00:07.061029Z","steps":["trace[1114045780] 'process raft request' (duration: 403.27861ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T23:00:07.061067Z","caller":"traceutil/trace.go:171","msg":"trace[1089981481] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"400.11108ms","start":"2026-07-14T23:00:06.66095Z","end":"2026-07-14T23:00:07.061061Z","steps":["trace[1089981481] 'process raft request' (duration: 399.613826ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:00:07.061083Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T23:00:06.657128Z","time spent":"403.938674ms","remote":"127.0.0.1:47020","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-14T23:00:07.061051Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T23:00:06.657126Z","time spent":"403.784223ms","remote":"127.0.0.1:47020","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-14T23:00:07.061144Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T23:00:06.660924Z","time spent":"400.16062ms","remote":"127.0.0.1:47020","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-14T23:00:07.061182Z","caller":"traceutil/trace.go:171","msg":"trace[1758707061] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"380.330706ms","start":"2026-07-14T23:00:06.680841Z","end":"2026-07-14T23:00:07.061172Z","steps":["trace[1758707061] 'process raft request' (duration: 379.873763ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T23:00:07.061177Z","caller":"traceutil/trace.go:171","msg":"trace[711626218] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"392.304001ms","start":"2026-07-14T23:00:06.668808Z","end":"2026-07-14T23:00:07.061112Z","steps":["trace[711626218] 'process raft request' (duration: 391.860538ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T23:00:07.061041Z","caller":"traceutil/trace.go:171","msg":"trace[689168324] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"403.840023ms","start":"2026-07-14T23:00:06.657193Z","end":"2026-07-14T23:00:07.061033Z","steps":["trace[689168324] 'process raft request' (duration: 403.32085ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:00:07.061377Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T23:00:06.668801Z","time spent":"392.528542ms","remote":"127.0.0.1:47020","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-14T23:00:07.061223Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T23:00:06.68083Z","time spent":"380.372586ms","remote":"127.0.0.1:47020","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-14T23:00:07.061253Z","caller":"traceutil/trace.go:171","msg":"trace[418605735] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"356.473237ms","start":"2026-07-14T23:00:06.704773Z","end":"2026-07-14T23:00:07.061246Z","steps":["trace[418605735] 'process raft request' (duration: 355.988354ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:00:07.061654Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T23:00:06.704754Z","time spent":"356.881479ms","remote":"127.0.0.1:47020","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-14T23:00:07.060814Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T23:00:06.64689Z","time spent":"413.828145ms","remote":"127.0.0.1:47020","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-14T23:00:07.061286Z","caller":"traceutil/trace.go:171","msg":"trace[725285868] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"400.128ms","start":"2026-07-14T23:00:06.661147Z","end":"2026-07-14T23:00:07.061275Z","steps":["trace[725285868] 'process raft request' (duration: 399.479716ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:00:07.061927Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T23:00:06.661142Z","time spent":"400.742504ms","remote":"127.0.0.1:47020","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-14T23:00:07.061461Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T23:00:06.657174Z","time spent":"404.264346ms","remote":"127.0.0.1:47020","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-14T23:00:13.275589Z","caller":"traceutil/trace.go:171","msg":"trace[1486608728] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"137.814724ms","start":"2026-07-14T23:00:13.137745Z","end":"2026-07-14T23:00:13.27556Z","steps":["trace[1486608728] 'process raft request' (duration: 137.646953ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T23:00:13.404485Z","caller":"traceutil/trace.go:171","msg":"trace[587150345] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"136.009631ms","start":"2026-07-14T23:00:13.268456Z","end":"2026-07-14T23:00:13.404465Z","steps":["trace[587150345] 'process raft request' (duration: 134.653282ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:00:13.723787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.074609ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-14T23:00:13.724076Z","caller":"traceutil/trace.go:171","msg":"trace[1152843773] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"313.737538ms","start":"2026-07-14T23:00:13.410322Z","end":"2026-07-14T23:00:13.724059Z","steps":["trace[1152843773] 'process raft request' (duration: 313.583217ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T23:00:13.724049Z","caller":"traceutil/trace.go:171","msg":"trace[1485208524] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"313.755367ms","start":"2026-07-14T23:00:13.410252Z","end":"2026-07-14T23:00:13.724008Z","steps":["trace[1485208524] 'process raft request' (duration: 87.172706ms)","trace[1485208524] 'compare' (duration: 225.766896ms)"],"step_count":2} {"level":"warn","ts":"2026-07-14T23:00:13.724199Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T23:00:13.410296Z","time spent":"313.828028ms","remote":"127.0.0.1:47214","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-14T23:00:13.724201Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T23:00:13.410234Z","time spent":"313.891819ms","remote":"127.0.0.1:47214","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-14T23:00:13.72434Z","caller":"traceutil/trace.go:171","msg":"trace[418846092] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"260.711993ms","start":"2026-07-14T23:00:13.4636Z","end":"2026-07-14T23:00:13.724312Z","steps":["trace[418846092] 'process raft request' (duration: 260.40125ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:00:14.994049Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.104719597s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-07-14T23:00:14.994127Z","caller":"traceutil/trace.go:171","msg":"trace[1365132553] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:629; }","duration":"1.104812207s","start":"2026-07-14T23:00:13.889298Z","end":"2026-07-14T23:00:14.99411Z","steps":["trace[1365132553] 'range keys from in-memory index tree' (duration: 1.104551976s)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:00:14.994153Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T23:00:13.889219Z","time spent":"1.104928909s","remote":"127.0.0.1:47214","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-14T23:00:14.994578Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"971.03982ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-14T23:00:14.994595Z","caller":"traceutil/trace.go:171","msg":"trace[535361057] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:629; }","duration":"971.08016ms","start":"2026-07-14T23:00:14.02351Z","end":"2026-07-14T23:00:14.99459Z","steps":["trace[535361057] 'range keys from in-memory index tree' (duration: 970.98249ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:00:14.994632Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T23:00:14.0235Z","time spent":"971.12929ms","remote":"127.0.0.1:46952","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-07-14T23:00:15.114516Z","caller":"traceutil/trace.go:171","msg":"trace[586315504] linearizableReadLoop","detail":"{readStateIndex:650; appliedIndex:649; }","duration":"117.898698ms","start":"2026-07-14T23:00:14.996586Z","end":"2026-07-14T23:00:15.114484Z","steps":["trace[586315504] 'read index received' (duration: 116.967851ms)","trace[586315504] 'applied index is now lower than readState.Index' (duration: 929.847µs)"],"step_count":2} {"level":"warn","ts":"2026-07-14T23:00:15.114678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.059579ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-14T23:00:15.114722Z","caller":"traceutil/trace.go:171","msg":"trace[1997125419] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:630; }","duration":"118.20201ms","start":"2026-07-14T23:00:14.996506Z","end":"2026-07-14T23:00:15.114708Z","steps":["trace[1997125419] 'agreement among raft nodes before linearized reading' (duration: 118.09487ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T23:00:15.114929Z","caller":"traceutil/trace.go:171","msg":"trace[1778771357] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"944.547512ms","start":"2026-07-14T23:00:14.17033Z","end":"2026-07-14T23:00:15.114877Z","steps":["trace[1778771357] 'process raft request' (duration: 943.350333ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:00:15.115187Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T23:00:14.170292Z","time spent":"944.766343ms","remote":"127.0.0.1:47076","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036161,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-14T23:00:15.126238Z","caller":"traceutil/trace.go:171","msg":"trace[1905161845] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"127.256416ms","start":"2026-07-14T23:00:14.998947Z","end":"2026-07-14T23:00:15.126203Z","steps":["trace[1905161845] 'process raft request' (duration: 126.983164ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:00:15.984392Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13313097220419083129,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-14T23:00:16.274072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"879.937098ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-14T23:00:16.274259Z","caller":"traceutil/trace.go:171","msg":"trace[158684946] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:631; }","duration":"880.135719ms","start":"2026-07-14T23:00:15.394095Z","end":"2026-07-14T23:00:16.274231Z","steps":["trace[158684946] 'range keys from in-memory index tree' (duration: 879.918248ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:00:16.484906Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13313097220419083129,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-14T23:00:16.964014Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.783420652s","expected-duration":"1s"} {"level":"info","ts":"2026-07-14T23:00:16.964764Z","caller":"traceutil/trace.go:171","msg":"trace[722493772] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"1.787250789s","start":"2026-07-14T23:00:15.177445Z","end":"2026-07-14T23:00:16.964696Z","steps":["trace[722493772] 'process raft request' (duration: 1.786991177s)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:00:16.964988Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T23:00:15.177425Z","time spent":"1.787441431s","remote":"127.0.0.1:47262","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":897,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-14T23:00:17.04561Z","caller":"traceutil/trace.go:171","msg":"trace[976224753] linearizableReadLoop","detail":"{readStateIndex:653; appliedIndex:651; }","duration":"1.561259687s","start":"2026-07-14T23:00:15.484316Z","end":"2026-07-14T23:00:17.045576Z","steps":["trace[976224753] 'read index received' (duration: 1.480046903s)","trace[976224753] 'applied index is now lower than readState.Index' (duration: 81.211694ms)"],"step_count":2} {"level":"info","ts":"2026-07-14T23:00:17.045753Z","caller":"traceutil/trace.go:171","msg":"trace[76685541] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"1.221861774s","start":"2026-07-14T23:00:15.823849Z","end":"2026-07-14T23:00:17.04571Z","steps":["trace[76685541] 'process raft request' (duration: 1.220458414s)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:00:17.04591Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.56156917s","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-14T23:00:17.045954Z","caller":"traceutil/trace.go:171","msg":"trace[1968691462] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:633; }","duration":"1.5616784s","start":"2026-07-14T23:00:15.484264Z","end":"2026-07-14T23:00:17.045942Z","steps":["trace[1968691462] 'agreement among raft nodes before linearized reading' (duration: 1.561477119s)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:00:17.045955Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T23:00:15.82381Z","time spent":"1.222038696s","remote":"127.0.0.1:47214","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-14T23:00:17.04599Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T23:00:15.48424Z","time spent":"1.56174119s","remote":"127.0.0.1:47214","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-14T23:00:17.046142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.021352443s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-14T23:00:17.046175Z","caller":"traceutil/trace.go:171","msg":"trace[2125856086] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:633; }","duration":"1.021425733s","start":"2026-07-14T23:00:16.024738Z","end":"2026-07-14T23:00:17.046164Z","steps":["trace[2125856086] 'agreement among raft nodes before linearized reading' (duration: 1.021382792s)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:00:17.046198Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T23:00:16.02471Z","time spent":"1.021483964s","remote":"127.0.0.1:46968","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-14T23:00:17.046267Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.317288071s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-07-14T23:00:17.046311Z","caller":"traceutil/trace.go:171","msg":"trace[469904905] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:633; }","duration":"1.317337631s","start":"2026-07-14T23:00:15.728961Z","end":"2026-07-14T23:00:17.046299Z","steps":["trace[469904905] 'agreement among raft nodes before linearized reading' (duration: 1.317162309s)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:00:17.046345Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T23:00:15.728955Z","time spent":"1.317382761s","remote":"127.0.0.1:47214","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-14T23:00:17.046519Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.31723965s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-07-14T23:00:17.047185Z","caller":"traceutil/trace.go:171","msg":"trace[1873992570] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:633; }","duration":"1.318298848s","start":"2026-07-14T23:00:15.728857Z","end":"2026-07-14T23:00:17.047155Z","steps":["trace[1873992570] 'agreement among raft nodes before linearized reading' (duration: 1.317031089s)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:00:17.047275Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T23:00:15.728841Z","time spent":"1.318397639s","remote":"127.0.0.1:47214","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-14T23:00:18.678295Z","caller":"traceutil/trace.go:171","msg":"trace[1095167104] transaction","detail":"{read_only:false; response_revision:653; number_of_response:1; }","duration":"183.529965ms","start":"2026-07-14T23:00:18.494738Z","end":"2026-07-14T23:00:18.678268Z","steps":["trace[1095167104] 'process raft request' (duration: 182.831899ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:00:33.738587Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13313097220419083470,"retry-timeout":"500ms"} {"level":"info","ts":"2026-07-14T23:00:34.058222Z","caller":"traceutil/trace.go:171","msg":"trace[747598195] transaction","detail":"{read_only:false; response_revision:807; number_of_response:1; }","duration":"907.63393ms","start":"2026-07-14T23:00:33.150557Z","end":"2026-07-14T23:00:34.058191Z","steps":["trace[747598195] 'process raft request' (duration: 907.472318ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:00:34.058424Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T23:00:33.150517Z","time spent":"907.813872ms","remote":"127.0.0.1:47214","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-14T23:00:34.221866Z","caller":"traceutil/trace.go:171","msg":"trace[1205635220] transaction","detail":"{read_only:false; response_revision:808; number_of_response:1; }","duration":"1.068308292s","start":"2026-07-14T23:00:33.153526Z","end":"2026-07-14T23:00:34.221834Z","steps":["trace[1205635220] 'process raft request' (duration: 1.067225122s)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:00:34.222084Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T23:00:33.1535Z","time spent":"1.068470453s","remote":"127.0.0.1:47214","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-14T23:00:34.222096Z","caller":"traceutil/trace.go:171","msg":"trace[2048260607] linearizableReadLoop","detail":"{readStateIndex:835; appliedIndex:832; }","duration":"984.434061ms","start":"2026-07-14T23:00:33.237632Z","end":"2026-07-14T23:00:34.222066Z","steps":["trace[2048260607] 'read index received' (duration: 820.43623ms)","trace[2048260607] 'applied index is now lower than readState.Index' (duration: 163.996491ms)"],"step_count":2} {"level":"info","ts":"2026-07-14T23:00:34.222256Z","caller":"traceutil/trace.go:171","msg":"trace[818793521] transaction","detail":"{read_only:false; response_revision:809; number_of_response:1; }","duration":"1.068387303s","start":"2026-07-14T23:00:33.153854Z","end":"2026-07-14T23:00:34.222241Z","steps":["trace[818793521] 'process raft request' (duration: 1.067901918s)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:00:34.222385Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T23:00:33.153845Z","time spent":"1.068444683s","remote":"127.0.0.1:47214","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-14T23:00:34.222562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.07302ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-14T23:00:34.222604Z","caller":"traceutil/trace.go:171","msg":"trace[95583983] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:809; }","duration":"198.11289ms","start":"2026-07-14T23:00:34.024479Z","end":"2026-07-14T23:00:34.222592Z","steps":["trace[95583983] 'agreement among raft nodes before linearized reading' (duration: 198.039559ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:00:34.22269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"973.972219ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-7zb7k\" ","response":"range_response_count:1 size:3964"} {"level":"info","ts":"2026-07-14T23:00:34.222777Z","caller":"traceutil/trace.go:171","msg":"trace[1150435058] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-7zb7k; range_end:; response_count:1; response_revision:809; }","duration":"974.118239ms","start":"2026-07-14T23:00:33.248626Z","end":"2026-07-14T23:00:34.222744Z","steps":["trace[1150435058] 'agreement among raft nodes before linearized reading' (duration: 973.883067ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:00:34.222827Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T23:00:33.248607Z","time spent":"974.21103ms","remote":"127.0.0.1:47166","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3988,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-7zb7k\" "} {"level":"warn","ts":"2026-07-14T23:00:34.222783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"985.095278ms","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-14T23:00:34.222996Z","caller":"traceutil/trace.go:171","msg":"trace[1271714095] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:809; }","duration":"985.39745ms","start":"2026-07-14T23:00:33.237571Z","end":"2026-07-14T23:00:34.222969Z","steps":["trace[1271714095] 'agreement among raft nodes before linearized reading' (duration: 984.929556ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:00:34.223094Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T23:00:33.237549Z","time spent":"985.530821ms","remote":"127.0.0.1:47214","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-07-14T23:00:42.330124Z","caller":"traceutil/trace.go:171","msg":"trace[1295896105] transaction","detail":"{read_only:false; response_revision:895; number_of_response:1; }","duration":"100.220905ms","start":"2026-07-14T23:00:42.229864Z","end":"2026-07-14T23:00:42.330085Z","steps":["trace[1295896105] 'process raft request' (duration: 99.000573ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:00:46.522253Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.183914ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-07-14T23:00:46.522353Z","caller":"traceutil/trace.go:171","msg":"trace[1496965499] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:957; }","duration":"170.373526ms","start":"2026-07-14T23:00:46.351956Z","end":"2026-07-14T23:00:46.52233Z","steps":["trace[1496965499] 'range keys from in-memory index tree' (duration: 169.899101ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:00:46.522371Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.535388ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-07-14T23:00:46.522482Z","caller":"traceutil/trace.go:171","msg":"trace[2134003336] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:957; }","duration":"169.688839ms","start":"2026-07-14T23:00:46.352764Z","end":"2026-07-14T23:00:46.522453Z","steps":["trace[2134003336] 'range keys from in-memory index tree' (duration: 169.314796ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:00:46.522482Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.78468ms","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-14T23:00:46.522606Z","caller":"traceutil/trace.go:171","msg":"trace[843627426] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:957; }","duration":"169.963752ms","start":"2026-07-14T23:00:46.352605Z","end":"2026-07-14T23:00:46.522569Z","steps":["trace[843627426] 'range keys from in-memory index tree' (duration: 169.555998ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T23:00:46.679766Z","caller":"traceutil/trace.go:171","msg":"trace[1214215210] transaction","detail":"{read_only:false; response_revision:959; number_of_response:1; }","duration":"152.006604ms","start":"2026-07-14T23:00:46.527735Z","end":"2026-07-14T23:00:46.679741Z","steps":["trace[1214215210] 'process raft request' (duration: 144.016125ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T23:00:46.679882Z","caller":"traceutil/trace.go:171","msg":"trace[272001776] transaction","detail":"{read_only:false; response_revision:960; number_of_response:1; }","duration":"152.119195ms","start":"2026-07-14T23:00:46.527755Z","end":"2026-07-14T23:00:46.679874Z","steps":["trace[272001776] 'process raft request' (duration: 151.802042ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:00:47.608188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.467499ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"warn","ts":"2026-07-14T23:00:52.483067Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.596447ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.89\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-07-14T23:00:52.483146Z","caller":"traceutil/trace.go:171","msg":"trace[573204614] range","detail":"{range_begin:/registry/masterleases/199.204.45.89; range_end:; response_count:1; response_revision:992; }","duration":"262.752988ms","start":"2026-07-14T23:00:52.220376Z","end":"2026-07-14T23:00:52.483129Z","steps":["trace[573204614] 'range keys from in-memory index tree' (duration: 262.373305ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:00:52.483363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.013063ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"} {"level":"info","ts":"2026-07-14T23:00:52.483441Z","caller":"traceutil/trace.go:171","msg":"trace[618757857] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:992; }","duration":"307.148784ms","start":"2026-07-14T23:00:52.176272Z","end":"2026-07-14T23:00:52.483421Z","steps":["trace[618757857] 'range keys from in-memory index tree' (duration: 306.845281ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:00:52.483474Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T23:00:52.176254Z","time spent":"307.214245ms","remote":"127.0.0.1:47214","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-07-14T23:00:52.782264Z","caller":"traceutil/trace.go:171","msg":"trace[15837913] transaction","detail":"{read_only:false; response_revision:993; number_of_response:1; }","duration":"294.97507ms","start":"2026-07-14T23:00:52.48726Z","end":"2026-07-14T23:00:52.782235Z","steps":["trace[15837913] 'process raft request' (duration: 219.390563ms)","trace[15837913] 'compare' (duration: 75.309004ms)"],"step_count":2} {"level":"info","ts":"2026-07-14T23:00:52.782643Z","caller":"traceutil/trace.go:171","msg":"trace[1425357831] linearizableReadLoop","detail":"{readStateIndex:1025; appliedIndex:1023; }","duration":"126.764002ms","start":"2026-07-14T23:00:52.655849Z","end":"2026-07-14T23:00:52.782613Z","steps":["trace[1425357831] 'read index received' (duration: 50.812572ms)","trace[1425357831] 'applied index is now lower than readState.Index' (duration: 75.95048ms)"],"step_count":2} {"level":"info","ts":"2026-07-14T23:00:52.78265Z","caller":"traceutil/trace.go:171","msg":"trace[284324847] transaction","detail":"{read_only:false; response_revision:994; number_of_response:1; }","duration":"181.435043ms","start":"2026-07-14T23:00:52.601169Z","end":"2026-07-14T23:00:52.782604Z","steps":["trace[284324847] 'process raft request' (duration: 180.944108ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:00:52.782891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.015035ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-07-14T23:00:52.782978Z","caller":"traceutil/trace.go:171","msg":"trace[31020644] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:995; }","duration":"127.123266ms","start":"2026-07-14T23:00:52.655837Z","end":"2026-07-14T23:00:52.78296Z","steps":["trace[31020644] 'agreement among raft nodes before linearized reading' (duration: 126.918224ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:00:53.31676Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.006691ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-14T23:00:53.316889Z","caller":"traceutil/trace.go:171","msg":"trace[816351119] transaction","detail":"{read_only:false; response_revision:996; number_of_response:1; }","duration":"530.233294ms","start":"2026-07-14T23:00:52.786634Z","end":"2026-07-14T23:00:53.316868Z","steps":["trace[816351119] 'process raft request' (duration: 375.015161ms)","trace[816351119] 'compare' (duration: 154.844349ms)"],"step_count":2} {"level":"warn","ts":"2026-07-14T23:00:53.316964Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T23:00:52.786618Z","time spent":"530.315795ms","remote":"127.0.0.1:47214","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-14T23:00:53.335846Z","caller":"traceutil/trace.go:171","msg":"trace[1249054152] transaction","detail":"{read_only:false; response_revision:997; number_of_response:1; }","duration":"548.985488ms","start":"2026-07-14T23:00:52.786833Z","end":"2026-07-14T23:00:53.335818Z","steps":["trace[1249054152] 'process raft request' (duration: 548.834516ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:00:53.336039Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T23:00:52.786825Z","time spent":"549.106639ms","remote":"127.0.0.1:47214","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-14T23:00:53.336031Z","caller":"traceutil/trace.go:171","msg":"trace[308284914] linearizableReadLoop","detail":"{readStateIndex:1029; appliedIndex:1026; }","duration":"547.953288ms","start":"2026-07-14T23:00:52.788039Z","end":"2026-07-14T23:00:53.335993Z","steps":["trace[308284914] 'read index received' (duration: 373.625677ms)","trace[308284914] 'applied index is now lower than readState.Index' (duration: 174.319221ms)"],"step_count":2} {"level":"info","ts":"2026-07-14T23:00:53.336174Z","caller":"traceutil/trace.go:171","msg":"trace[853772165] transaction","detail":"{read_only:false; response_revision:998; number_of_response:1; }","duration":"548.747446ms","start":"2026-07-14T23:00:52.787362Z","end":"2026-07-14T23:00:53.336109Z","steps":["trace[853772165] 'process raft request' (duration: 548.415772ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:00:53.336216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"548.16428ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:421"} {"level":"info","ts":"2026-07-14T23:00:53.336293Z","caller":"traceutil/trace.go:171","msg":"trace[174832330] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:998; }","duration":"548.260361ms","start":"2026-07-14T23:00:52.788014Z","end":"2026-07-14T23:00:53.336274Z","steps":["trace[174832330] 'agreement among raft nodes before linearized reading' (duration: 548.091319ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:00:53.336299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.711599ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-14T23:00:53.336332Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T23:00:52.788005Z","time spent":"548.320481ms","remote":"127.0.0.1:47160","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":445,"request content":"key:\"/registry/services/endpoints/default/kubernetes\" "} {"level":"warn","ts":"2026-07-14T23:00:53.33635Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T23:00:52.787343Z","time spent":"548.926767ms","remote":"127.0.0.1:47214","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-14T23:00:53.336378Z","caller":"traceutil/trace.go:171","msg":"trace[1591639981] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:998; }","duration":"310.889791ms","start":"2026-07-14T23:00:53.025471Z","end":"2026-07-14T23:00:53.336361Z","steps":["trace[1591639981] 'agreement among raft nodes before linearized reading' (duration: 310.73589ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:00:53.336412Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T23:00:53.025432Z","time spent":"310.974912ms","remote":"127.0.0.1:46952","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-14T23:00:53.33641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"390.44207ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-14T23:00:53.336469Z","caller":"traceutil/trace.go:171","msg":"trace[617659802] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:998; }","duration":"390.52893ms","start":"2026-07-14T23:00:52.945917Z","end":"2026-07-14T23:00:53.336446Z","steps":["trace[617659802] 'agreement among raft nodes before linearized reading' (duration: 390.423999ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:00:53.336328Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"400.271701ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-07-14T23:00:53.336507Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T23:00:52.945901Z","time spent":"390.597221ms","remote":"127.0.0.1:47164","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":1,"response size":31,"request content":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true "} {"level":"info","ts":"2026-07-14T23:00:53.336575Z","caller":"traceutil/trace.go:171","msg":"trace[1820577628] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:998; }","duration":"400.531453ms","start":"2026-07-14T23:00:52.935975Z","end":"2026-07-14T23:00:53.336506Z","steps":["trace[1820577628] 'agreement among raft nodes before linearized reading' (duration: 400.176279ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:00:53.336687Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T23:00:52.935953Z","time spent":"400.690875ms","remote":"127.0.0.1:47214","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-07-14T23:01:02.366437Z","caller":"traceutil/trace.go:171","msg":"trace[1988858944] transaction","detail":"{read_only:false; response_revision:1025; number_of_response:1; }","duration":"134.333944ms","start":"2026-07-14T23:01:02.232079Z","end":"2026-07-14T23:01:02.366413Z","steps":["trace[1988858944] 'process raft request' (duration: 129.622523ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T23:01:02.367033Z","caller":"traceutil/trace.go:171","msg":"trace[1399146829] transaction","detail":"{read_only:false; response_revision:1026; number_of_response:1; }","duration":"111.197193ms","start":"2026-07-14T23:01:02.255791Z","end":"2026-07-14T23:01:02.366988Z","steps":["trace[1399146829] 'process raft request' (duration: 111.035932ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T23:01:03.558697Z","caller":"traceutil/trace.go:171","msg":"trace[2084109299] transaction","detail":"{read_only:false; response_revision:1030; number_of_response:1; }","duration":"137.591816ms","start":"2026-07-14T23:01:03.421072Z","end":"2026-07-14T23:01:03.558664Z","steps":["trace[2084109299] 'process raft request' (duration: 137.121151ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T23:01:03.559047Z","caller":"traceutil/trace.go:171","msg":"trace[749970923] transaction","detail":"{read_only:false; response_revision:1031; number_of_response:1; }","duration":"137.750728ms","start":"2026-07-14T23:01:03.421259Z","end":"2026-07-14T23:01:03.55901Z","steps":["trace[749970923] 'process raft request' (duration: 137.318923ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T23:01:03.559164Z","caller":"traceutil/trace.go:171","msg":"trace[59372518] transaction","detail":"{read_only:false; response_revision:1032; number_of_response:1; }","duration":"137.529555ms","start":"2026-07-14T23:01:03.421607Z","end":"2026-07-14T23:01:03.559137Z","steps":["trace[59372518] 'process raft request' (duration: 137.291422ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T23:01:09.015175Z","caller":"traceutil/trace.go:171","msg":"trace[714895990] linearizableReadLoop","detail":"{readStateIndex:1085; appliedIndex:1084; }","duration":"104.062995ms","start":"2026-07-14T23:01:08.911093Z","end":"2026-07-14T23:01:09.015156Z","steps":["trace[714895990] 'read index received' (duration: 103.935434ms)","trace[714895990] 'applied index is now lower than readState.Index' (duration: 126.781µs)"],"step_count":2} {"level":"info","ts":"2026-07-14T23:01:09.015254Z","caller":"traceutil/trace.go:171","msg":"trace[1004751508] transaction","detail":"{read_only:false; response_revision:1051; number_of_response:1; }","duration":"115.572583ms","start":"2026-07-14T23:01:08.899651Z","end":"2026-07-14T23:01:09.015224Z","steps":["trace[1004751508] 'process raft request' (duration: 115.358761ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:01:09.015381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.277218ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-07-14T23:01:09.015414Z","caller":"traceutil/trace.go:171","msg":"trace[1988423324] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1051; }","duration":"104.376739ms","start":"2026-07-14T23:01:08.911029Z","end":"2026-07-14T23:01:09.015406Z","steps":["trace[1988423324] 'agreement among raft nodes before linearized reading' (duration: 104.246568ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T23:01:29.702742Z","caller":"traceutil/trace.go:171","msg":"trace[932493254] transaction","detail":"{read_only:false; response_revision:1119; number_of_response:1; }","duration":"111.558742ms","start":"2026-07-14T23:01:29.591163Z","end":"2026-07-14T23:01:29.702722Z","steps":["trace[932493254] 'process raft request' (duration: 111.420861ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T23:01:39.89604Z","caller":"traceutil/trace.go:171","msg":"trace[952377601] transaction","detail":"{read_only:false; response_revision:1153; number_of_response:1; }","duration":"113.007424ms","start":"2026-07-14T23:01:39.783008Z","end":"2026-07-14T23:01:39.896015Z","steps":["trace[952377601] 'process raft request' (duration: 55.887185ms)","trace[952377601] 'compare' (duration: 56.963027ms)"],"step_count":2} {"level":"info","ts":"2026-07-14T23:01:42.151628Z","caller":"traceutil/trace.go:171","msg":"trace[444960633] transaction","detail":"{read_only:false; response_revision:1161; number_of_response:1; }","duration":"134.547619ms","start":"2026-07-14T23:01:42.017052Z","end":"2026-07-14T23:01:42.151599Z","steps":["trace[444960633] 'process raft request' (duration: 38.680447ms)","trace[444960633] 'compare' (duration: 95.71682ms)"],"step_count":2} {"level":"info","ts":"2026-07-14T23:01:42.342745Z","caller":"traceutil/trace.go:171","msg":"trace[1943827893] transaction","detail":"{read_only:false; response_revision:1162; number_of_response:1; }","duration":"105.705893ms","start":"2026-07-14T23:01:42.237012Z","end":"2026-07-14T23:01:42.342718Z","steps":["trace[1943827893] 'process raft request' (duration: 54.561242ms)","trace[1943827893] 'compare' (duration: 51.03048ms)"],"step_count":2} {"level":"info","ts":"2026-07-14T23:01:49.333176Z","caller":"traceutil/trace.go:171","msg":"trace[879500967] transaction","detail":"{read_only:false; response_revision:1183; number_of_response:1; }","duration":"105.741233ms","start":"2026-07-14T23:01:49.227408Z","end":"2026-07-14T23:01:49.333149Z","steps":["trace[879500967] 'process raft request' (duration: 104.847182ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T23:01:50.050515Z","caller":"traceutil/trace.go:171","msg":"trace[1546783143] linearizableReadLoop","detail":"{readStateIndex:1227; appliedIndex:1226; }","duration":"109.290529ms","start":"2026-07-14T23:01:49.941209Z","end":"2026-07-14T23:01:50.050499Z","steps":["trace[1546783143] 'read index received' (duration: 109.114867ms)","trace[1546783143] 'applied index is now lower than readState.Index' (duration: 174.922µs)"],"step_count":2} {"level":"info","ts":"2026-07-14T23:01:50.05056Z","caller":"traceutil/trace.go:171","msg":"trace[2139395261] transaction","detail":"{read_only:false; response_revision:1185; number_of_response:1; }","duration":"212.265526ms","start":"2026-07-14T23:01:49.838269Z","end":"2026-07-14T23:01:50.050534Z","steps":["trace[2139395261] 'process raft request' (duration: 212.127995ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:01:50.050684Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.464061ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-07-14T23:01:50.050715Z","caller":"traceutil/trace.go:171","msg":"trace[1765567386] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1185; }","duration":"109.522042ms","start":"2026-07-14T23:01:49.941184Z","end":"2026-07-14T23:01:50.050706Z","steps":["trace[1765567386] 'agreement among raft nodes before linearized reading' (duration: 109.41346ms)"],"step_count":1}