{"level":"warn","ts":"2026-08-19T20:29:04.398711Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-19T20:29:04.398798Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.213:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.213:2380","--initial-cluster=instance=https://199.19.213.213:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.213:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.213: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-08-19T20:29:04.398938Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-19T20:29:04.398959Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.213:2380"]} {"level":"info","ts":"2026-08-19T20:29:04.399067Z","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-08-19T20:29:04.399715Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.213:2379"]} {"level":"info","ts":"2026-08-19T20:29:04.399837Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.213:2380"],"listen-peer-urls":["https://199.19.213.213:2380"],"advertise-client-urls":["https://199.19.213.213:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.213:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.213: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-08-19T20:29:04.409084Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"9.030673ms"} {"level":"info","ts":"2026-08-19T20:29:04.42648Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"f3faf6a3dfbe0100","cluster-id":"4c2e50e35fb92a79"} {"level":"info","ts":"2026-08-19T20:29:04.426554Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3faf6a3dfbe0100 switched to configuration voters=()"} {"level":"info","ts":"2026-08-19T20:29:04.426722Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3faf6a3dfbe0100 became follower at term 0"} {"level":"info","ts":"2026-08-19T20:29:04.426739Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft f3faf6a3dfbe0100 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-19T20:29:04.426755Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3faf6a3dfbe0100 became follower at term 1"} {"level":"info","ts":"2026-08-19T20:29:04.426814Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3faf6a3dfbe0100 switched to configuration voters=(17580635279088025856)"} {"level":"warn","ts":"2026-08-19T20:29:04.436091Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-19T20:29:04.445003Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-19T20:29:04.481778Z","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-08-19T20:29:04.487178Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"f3faf6a3dfbe0100","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-19T20:29:04.488027Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"f3faf6a3dfbe0100","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-19T20:29:04.488084Z","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-08-19T20:29:04.488276Z","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-08-19T20:29:04.488378Z","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-08-19T20:29:04.492988Z","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-08-19T20:29:04.493104Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.213:2380"} {"level":"info","ts":"2026-08-19T20:29:04.493215Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.213:2380"} {"level":"info","ts":"2026-08-19T20:29:04.493331Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-19T20:29:04.493303Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"f3faf6a3dfbe0100","initial-advertise-peer-urls":["https://199.19.213.213:2380"],"listen-peer-urls":["https://199.19.213.213:2380"],"advertise-client-urls":["https://199.19.213.213:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.213:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-19T20:29:04.53162Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3faf6a3dfbe0100 switched to configuration voters=(17580635279088025856)"} {"level":"info","ts":"2026-08-19T20:29:04.532021Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"4c2e50e35fb92a79","local-member-id":"f3faf6a3dfbe0100","added-peer-id":"f3faf6a3dfbe0100","added-peer-peer-urls":["https://199.19.213.213:2380"]} {"level":"info","ts":"2026-08-19T20:29:04.927475Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3faf6a3dfbe0100 is starting a new election at term 1"} {"level":"info","ts":"2026-08-19T20:29:04.927633Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3faf6a3dfbe0100 became pre-candidate at term 1"} {"level":"info","ts":"2026-08-19T20:29:04.927682Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3faf6a3dfbe0100 received MsgPreVoteResp from f3faf6a3dfbe0100 at term 1"} {"level":"info","ts":"2026-08-19T20:29:04.927747Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3faf6a3dfbe0100 became candidate at term 2"} {"level":"info","ts":"2026-08-19T20:29:04.927791Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3faf6a3dfbe0100 received MsgVoteResp from f3faf6a3dfbe0100 at term 2"} {"level":"info","ts":"2026-08-19T20:29:04.927827Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3faf6a3dfbe0100 became leader at term 2"} {"level":"info","ts":"2026-08-19T20:29:04.927875Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: f3faf6a3dfbe0100 elected leader f3faf6a3dfbe0100 at term 2"} {"level":"info","ts":"2026-08-19T20:29:04.928814Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"f3faf6a3dfbe0100","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.213:2379]}","request-path":"/0/members/f3faf6a3dfbe0100/attributes","cluster-id":"4c2e50e35fb92a79","publish-timeout":"7s"} {"level":"info","ts":"2026-08-19T20:29:04.928817Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-19T20:29:04.928908Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-19T20:29:04.928902Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-19T20:29:04.92912Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-19T20:29:04.929169Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-19T20:29:04.929831Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"4c2e50e35fb92a79","local-member-id":"f3faf6a3dfbe0100","cluster-version":"3.5"} {"level":"info","ts":"2026-08-19T20:29:04.929953Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-19T20:29:04.929992Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-08-19T20:29:04.934582Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-08-19T20:29:04.940115Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.213:2379"} {"level":"info","ts":"2026-08-19T20:29:09.743426Z","caller":"traceutil/trace.go:171","msg":"trace[1596095568] transaction","detail":"{read_only:false; response_revision:255; number_of_response:1; }","duration":"116.072406ms","start":"2026-08-19T20:29:09.627314Z","end":"2026-08-19T20:29:09.743386Z","steps":["trace[1596095568] 'process raft request' (duration: 39.915743ms)","trace[1596095568] 'compare' (duration: 75.917341ms)"],"step_count":2} {"level":"info","ts":"2026-08-19T20:29:12.970423Z","caller":"traceutil/trace.go:171","msg":"trace[1430180261] transaction","detail":"{read_only:false; response_revision:326; number_of_response:1; }","duration":"175.966563ms","start":"2026-08-19T20:29:12.794424Z","end":"2026-08-19T20:29:12.970391Z","steps":["trace[1430180261] 'process raft request' (duration: 175.67658ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T20:29:14.418935Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.396966ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-19T20:29:14.419063Z","caller":"traceutil/trace.go:171","msg":"trace[1153705485] linearizableReadLoop","detail":"{readStateIndex:345; appliedIndex:344; }","duration":"558.766703ms","start":"2026-08-19T20:29:13.860285Z","end":"2026-08-19T20:29:14.419052Z","steps":["trace[1153705485] 'read index received' (duration: 93.931µs)","trace[1153705485] 'applied index is now lower than readState.Index' (duration: 558.671992ms)"],"step_count":2} {"level":"warn","ts":"2026-08-19T20:29:14.41911Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"558.821784ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/root-ca-cert-publisher\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-19T20:29:14.419133Z","caller":"traceutil/trace.go:171","msg":"trace[1183186702] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/root-ca-cert-publisher; range_end:; response_count:0; response_revision:334; }","duration":"558.870294ms","start":"2026-08-19T20:29:13.860253Z","end":"2026-08-19T20:29:14.419123Z","steps":["trace[1183186702] 'agreement among raft nodes before linearized reading' (duration: 558.832204ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T20:29:14.419163Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:29:13.86024Z","time spent":"558.917815ms","remote":"127.0.0.1:58950","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":0,"response size":28,"request content":"key:\"/registry/serviceaccounts/kube-system/root-ca-cert-publisher\" "} {"level":"info","ts":"2026-08-19T20:29:14.419165Z","caller":"traceutil/trace.go:171","msg":"trace[1490562774] transaction","detail":"{read_only:false; response_revision:334; number_of_response:1; }","duration":"558.875294ms","start":"2026-08-19T20:29:13.860248Z","end":"2026-08-19T20:29:14.419123Z","steps":["trace[1490562774] 'process raft request' (duration: 293.893831ms)","trace[1490562774] 'compare' (duration: 264.299715ms)"],"step_count":2} {"level":"warn","ts":"2026-08-19T20:29:14.419467Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:29:13.860227Z","time spent":"559.043887ms","remote":"127.0.0.1:59038","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-19T20:29:14.868479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.850159ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-08-19T20:29:14.868563Z","caller":"traceutil/trace.go:171","msg":"trace[1187359101] linearizableReadLoop","detail":"{readStateIndex:346; appliedIndex:345; }","duration":"361.360255ms","start":"2026-08-19T20:29:14.507187Z","end":"2026-08-19T20:29:14.868547Z","steps":["trace[1187359101] 'read index received' (duration: 188.334343ms)","trace[1187359101] 'applied index is now lower than readState.Index' (duration: 173.025092ms)"],"step_count":2} {"level":"info","ts":"2026-08-19T20:29:14.86863Z","caller":"traceutil/trace.go:171","msg":"trace[1264332452] transaction","detail":"{read_only:false; response_revision:335; number_of_response:1; }","duration":"443.772259ms","start":"2026-08-19T20:29:14.424832Z","end":"2026-08-19T20:29:14.868604Z","steps":["trace[1264332452] 'process raft request' (duration: 270.747538ms)","trace[1264332452] 'compare' (duration: 172.708788ms)"],"step_count":2} {"level":"warn","ts":"2026-08-19T20:29:14.868713Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"361.518846ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-08-19T20:29:14.868727Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:29:14.42481Z","time spent":"443.87248ms","remote":"127.0.0.1:58950","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":194,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-19T20:29:14.868737Z","caller":"traceutil/trace.go:171","msg":"trace[949971760] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:335; }","duration":"361.618708ms","start":"2026-08-19T20:29:14.507111Z","end":"2026-08-19T20:29:14.86873Z","steps":["trace[949971760] 'agreement among raft nodes before linearized reading' (duration: 361.500026ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T20:29:14.868724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.724322ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-08-19T20:29:14.868765Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:29:14.507095Z","time spent":"361.663238ms","remote":"127.0.0.1:59038","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-08-19T20:29:14.868787Z","caller":"traceutil/trace.go:171","msg":"trace[1877351831] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:335; }","duration":"298.819873ms","start":"2026-08-19T20:29:14.569943Z","end":"2026-08-19T20:29:14.868763Z","steps":["trace[1877351831] 'agreement among raft nodes before linearized reading' (duration: 298.709332ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T20:29:15.051439Z","caller":"traceutil/trace.go:171","msg":"trace[47409234] linearizableReadLoop","detail":"{readStateIndex:348; appliedIndex:346; }","duration":"178.523571ms","start":"2026-08-19T20:29:14.872898Z","end":"2026-08-19T20:29:15.051422Z","steps":["trace[47409234] 'read index received' (duration: 167.681339ms)","trace[47409234] 'applied index is now lower than readState.Index' (duration: 10.841602ms)"],"step_count":2} {"level":"info","ts":"2026-08-19T20:29:15.051529Z","caller":"traceutil/trace.go:171","msg":"trace[899181666] transaction","detail":"{read_only:false; response_revision:336; number_of_response:1; }","duration":"179.009546ms","start":"2026-08-19T20:29:14.872455Z","end":"2026-08-19T20:29:15.051464Z","steps":["trace[899181666] 'process raft request' (duration: 168.112184ms)","trace[899181666] 'compare' (duration: 10.71218ms)"],"step_count":2} {"level":"info","ts":"2026-08-19T20:29:15.051537Z","caller":"traceutil/trace.go:171","msg":"trace[139892166] transaction","detail":"{read_only:false; response_revision:337; number_of_response:1; }","duration":"178.747313ms","start":"2026-08-19T20:29:14.872749Z","end":"2026-08-19T20:29:15.051496Z","steps":["trace[139892166] 'process raft request' (duration: 178.631231ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T20:29:15.051755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.833634ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-08-19T20:29:15.051793Z","caller":"traceutil/trace.go:171","msg":"trace[1916143775] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:337; }","duration":"178.906195ms","start":"2026-08-19T20:29:14.872879Z","end":"2026-08-19T20:29:15.051785Z","steps":["trace[1916143775] 'agreement among raft nodes before linearized reading' (duration: 178.652122ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T20:29:24.225563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"534.465907ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-19T20:29:24.225785Z","caller":"traceutil/trace.go:171","msg":"trace[1162183285] transaction","detail":"{read_only:false; response_revision:417; number_of_response:1; }","duration":"883.350131ms","start":"2026-08-19T20:29:23.342406Z","end":"2026-08-19T20:29:24.225756Z","steps":["trace[1162183285] 'process raft request' (duration: 348.566541ms)","trace[1162183285] 'compare' (duration: 534.247144ms)"],"step_count":2} {"level":"warn","ts":"2026-08-19T20:29:24.22591Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:29:23.34238Z","time spent":"883.491774ms","remote":"127.0.0.1:58934","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6740,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-19T20:29:29.633816Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":72233634925391298,"retry-timeout":"500ms"} {"level":"info","ts":"2026-08-19T20:29:29.919858Z","caller":"traceutil/trace.go:171","msg":"trace[2130476549] linearizableReadLoop","detail":"{readStateIndex:444; appliedIndex:443; }","duration":"786.991081ms","start":"2026-08-19T20:29:29.132843Z","end":"2026-08-19T20:29:29.919834Z","steps":["trace[2130476549] 'read index received' (duration: 786.764058ms)","trace[2130476549] 'applied index is now lower than readState.Index' (duration: 226.083µs)"],"step_count":2} {"level":"info","ts":"2026-08-19T20:29:29.919983Z","caller":"traceutil/trace.go:171","msg":"trace[1702258919] transaction","detail":"{read_only:false; response_revision:429; number_of_response:1; }","duration":"792.298108ms","start":"2026-08-19T20:29:29.127672Z","end":"2026-08-19T20:29:29.919971Z","steps":["trace[1702258919] 'process raft request' (duration: 792.035815ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T20:29:29.920085Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:29:29.127661Z","time spent":"792.349629ms","remote":"127.0.0.1:59038","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-19T20:29:29.92025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"717.502823ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-08-19T20:29:29.92028Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"787.420695ms","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-08-19T20:29:29.920331Z","caller":"traceutil/trace.go:171","msg":"trace[1508759046] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:429; }","duration":"717.636924ms","start":"2026-08-19T20:29:29.202675Z","end":"2026-08-19T20:29:29.920311Z","steps":["trace[1508759046] 'agreement among raft nodes before linearized reading' (duration: 717.504883ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T20:29:29.920359Z","caller":"traceutil/trace.go:171","msg":"trace[993960454] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:429; }","duration":"787.508976ms","start":"2026-08-19T20:29:29.132826Z","end":"2026-08-19T20:29:29.920335Z","steps":["trace[993960454] 'agreement among raft nodes before linearized reading' (duration: 787.391035ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T20:29:29.920371Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:29:29.202655Z","time spent":"717.708195ms","remote":"127.0.0.1:59038","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-08-19T20:29:29.920403Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:29:29.132819Z","time spent":"787.574607ms","remote":"127.0.0.1:59038","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-08-19T20:29:29.9211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"348.918974ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-19T20:29:29.92124Z","caller":"traceutil/trace.go:171","msg":"trace[1558110401] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:429; }","duration":"349.108207ms","start":"2026-08-19T20:29:29.57211Z","end":"2026-08-19T20:29:29.921218Z","steps":["trace[1558110401] 'agreement among raft nodes before linearized reading' (duration: 348.209027ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T20:29:29.921306Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:29:29.572091Z","time spent":"349.205088ms","remote":"127.0.0.1:58754","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-08-19T20:29:40.392166Z","caller":"traceutil/trace.go:171","msg":"trace[474111335] linearizableReadLoop","detail":"{readStateIndex:500; appliedIndex:499; }","duration":"379.091973ms","start":"2026-08-19T20:29:40.013051Z","end":"2026-08-19T20:29:40.392143Z","steps":["trace[474111335] 'read index received' (duration: 378.913771ms)","trace[474111335] 'applied index is now lower than readState.Index' (duration: 177.112µs)"],"step_count":2} {"level":"info","ts":"2026-08-19T20:29:40.392226Z","caller":"traceutil/trace.go:171","msg":"trace[1344482038] transaction","detail":"{read_only:false; response_revision:482; number_of_response:1; }","duration":"383.483968ms","start":"2026-08-19T20:29:40.008721Z","end":"2026-08-19T20:29:40.392205Z","steps":["trace[1344482038] 'process raft request' (duration: 383.307996ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T20:29:40.392315Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:29:40.008704Z","time spent":"383.555599ms","remote":"127.0.0.1:59038","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-19T20:29:40.392322Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"379.266844ms","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-08-19T20:29:40.39237Z","caller":"traceutil/trace.go:171","msg":"trace[576869884] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:482; }","duration":"379.334065ms","start":"2026-08-19T20:29:40.013018Z","end":"2026-08-19T20:29:40.392352Z","steps":["trace[576869884] 'agreement among raft nodes before linearized reading' (duration: 379.255944ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T20:29:40.392419Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:29:40.013007Z","time spent":"379.400595ms","remote":"127.0.0.1:59038","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-08-19T20:29:40.392471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"377.537426ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-08-19T20:29:40.392537Z","caller":"traceutil/trace.go:171","msg":"trace[1020526472] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:482; }","duration":"377.603917ms","start":"2026-08-19T20:29:40.014917Z","end":"2026-08-19T20:29:40.39252Z","steps":["trace[1020526472] 'agreement among raft nodes before linearized reading' (duration: 377.491085ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T20:29:40.392597Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:29:40.014863Z","time spent":"377.723137ms","remote":"127.0.0.1:59038","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-08-19T20:29:46.251134Z","caller":"traceutil/trace.go:171","msg":"trace[649468472] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"283.879997ms","start":"2026-08-19T20:29:45.967228Z","end":"2026-08-19T20:29:46.251108Z","steps":["trace[649468472] 'process raft request' (duration: 283.547394ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T20:29:46.259437Z","caller":"traceutil/trace.go:171","msg":"trace[1721838651] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"289.285894ms","start":"2026-08-19T20:29:45.970127Z","end":"2026-08-19T20:29:46.259413Z","steps":["trace[1721838651] 'process raft request' (duration: 289.170963ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T20:29:46.259399Z","caller":"traceutil/trace.go:171","msg":"trace[294465537] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"289.322475ms","start":"2026-08-19T20:29:45.970053Z","end":"2026-08-19T20:29:46.259376Z","steps":["trace[294465537] 'process raft request' (duration: 289.151003ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T20:29:46.259499Z","caller":"traceutil/trace.go:171","msg":"trace[650153996] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"279.190907ms","start":"2026-08-19T20:29:45.980261Z","end":"2026-08-19T20:29:46.259452Z","steps":["trace[650153996] 'process raft request' (duration: 279.078586ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T20:29:46.259613Z","caller":"traceutil/trace.go:171","msg":"trace[231858225] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"274.845711ms","start":"2026-08-19T20:29:45.984736Z","end":"2026-08-19T20:29:46.259582Z","steps":["trace[231858225] 'process raft request' (duration: 274.678229ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T20:29:46.259654Z","caller":"traceutil/trace.go:171","msg":"trace[1254499723] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"274.862741ms","start":"2026-08-19T20:29:45.984771Z","end":"2026-08-19T20:29:46.259633Z","steps":["trace[1254499723] 'process raft request' (duration: 274.718959ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T20:29:46.259783Z","caller":"traceutil/trace.go:171","msg":"trace[725602453] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"269.557164ms","start":"2026-08-19T20:29:45.990214Z","end":"2026-08-19T20:29:46.259771Z","steps":["trace[725602453] 'process raft request' (duration: 269.328512ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T20:29:46.259868Z","caller":"traceutil/trace.go:171","msg":"trace[305785231] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"264.998726ms","start":"2026-08-19T20:29:45.994856Z","end":"2026-08-19T20:29:46.259855Z","steps":["trace[305785231] 'process raft request' (duration: 264.827584ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T20:29:46.259927Z","caller":"traceutil/trace.go:171","msg":"trace[619078524] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"275.238015ms","start":"2026-08-19T20:29:45.984665Z","end":"2026-08-19T20:29:46.259903Z","steps":["trace[619078524] 'process raft request' (duration: 274.713159ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T20:29:46.260128Z","caller":"traceutil/trace.go:171","msg":"trace[1822886881] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"264.4263ms","start":"2026-08-19T20:29:45.99568Z","end":"2026-08-19T20:29:46.260107Z","steps":["trace[1822886881] 'process raft request' (duration: 264.149937ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T20:29:46.260239Z","caller":"traceutil/trace.go:171","msg":"trace[398164392] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"246.985064ms","start":"2026-08-19T20:29:46.01324Z","end":"2026-08-19T20:29:46.260225Z","steps":["trace[398164392] 'process raft request' (duration: 246.760852ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T20:29:46.260291Z","caller":"traceutil/trace.go:171","msg":"trace[715103917] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"119.097386ms","start":"2026-08-19T20:29:46.141174Z","end":"2026-08-19T20:29:46.260271Z","steps":["trace[715103917] 'process raft request' (duration: 118.997254ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T20:29:52.572249Z","caller":"traceutil/trace.go:171","msg":"trace[2062428346] linearizableReadLoop","detail":"{readStateIndex:664; appliedIndex:663; }","duration":"113.274784ms","start":"2026-08-19T20:29:52.458957Z","end":"2026-08-19T20:29:52.572232Z","steps":["trace[2062428346] 'read index received' (duration: 113.100593ms)","trace[2062428346] 'applied index is now lower than readState.Index' (duration: 173.701µs)"],"step_count":2} {"level":"warn","ts":"2026-08-19T20:29:52.572677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.704879ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-08-19T20:29:52.572679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.773494ms","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-08-19T20:29:52.572747Z","caller":"traceutil/trace.go:171","msg":"trace[681373690] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:639; }","duration":"113.82479ms","start":"2026-08-19T20:29:52.458904Z","end":"2026-08-19T20:29:52.572729Z","steps":["trace[681373690] 'agreement among raft nodes before linearized reading' (duration: 113.462196ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T20:29:52.572763Z","caller":"traceutil/trace.go:171","msg":"trace[1137964084] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:639; }","duration":"103.895966ms","start":"2026-08-19T20:29:52.468845Z","end":"2026-08-19T20:29:52.572741Z","steps":["trace[1137964084] 'agreement among raft nodes before linearized reading' (duration: 103.662483ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T20:29:52.572428Z","caller":"traceutil/trace.go:171","msg":"trace[695952789] transaction","detail":"{read_only:false; response_revision:639; number_of_response:1; }","duration":"235.090259ms","start":"2026-08-19T20:29:52.33731Z","end":"2026-08-19T20:29:52.5724Z","steps":["trace[695952789] 'process raft request' (duration: 234.793926ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T20:29:52.897445Z","caller":"traceutil/trace.go:171","msg":"trace[1173936934] transaction","detail":"{read_only:false; response_revision:641; number_of_response:1; }","duration":"317.666079ms","start":"2026-08-19T20:29:52.579743Z","end":"2026-08-19T20:29:52.897409Z","steps":["trace[1173936934] 'process raft request' (duration: 218.555584ms)","trace[1173936934] 'compare' (duration: 98.873533ms)"],"step_count":2} {"level":"info","ts":"2026-08-19T20:29:52.897595Z","caller":"traceutil/trace.go:171","msg":"trace[1692844071] linearizableReadLoop","detail":"{readStateIndex:667; appliedIndex:665; }","duration":"262.287466ms","start":"2026-08-19T20:29:52.635275Z","end":"2026-08-19T20:29:52.897563Z","steps":["trace[1692844071] 'read index received' (duration: 163.11332ms)","trace[1692844071] 'applied index is now lower than readState.Index' (duration: 99.172236ms)"],"step_count":2} {"level":"info","ts":"2026-08-19T20:29:52.897743Z","caller":"traceutil/trace.go:171","msg":"trace[1693366199] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"317.941672ms","start":"2026-08-19T20:29:52.579752Z","end":"2026-08-19T20:29:52.897694Z","steps":["trace[1693366199] 'process raft request' (duration: 317.597538ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T20:29:52.897821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.533858ms","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-08-19T20:29:52.897867Z","caller":"traceutil/trace.go:171","msg":"trace[1728666774] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:642; }","duration":"262.593459ms","start":"2026-08-19T20:29:52.63526Z","end":"2026-08-19T20:29:52.897854Z","steps":["trace[1728666774] 'agreement among raft nodes before linearized reading' (duration: 262.404407ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T20:29:52.89788Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:29:52.579734Z","time spent":"318.073654ms","remote":"127.0.0.1:59038","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-19T20:29:52.898128Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:29:52.579721Z","time spent":"317.925923ms","remote":"127.0.0.1:59038","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-19T20:29:53.519775Z","caller":"traceutil/trace.go:171","msg":"trace[1969479880] transaction","detail":"{read_only:false; response_revision:643; number_of_response:1; }","duration":"802.740357ms","start":"2026-08-19T20:29:52.716998Z","end":"2026-08-19T20:29:53.519738Z","steps":["trace[1969479880] 'process raft request' (duration: 747.671817ms)","trace[1969479880] 'compare' (duration: 54.308692ms)"],"step_count":2} {"level":"warn","ts":"2026-08-19T20:29:53.519968Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:29:52.716975Z","time spent":"802.89586ms","remote":"127.0.0.1:58834","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036305,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-19T20:29:53.566666Z","caller":"traceutil/trace.go:171","msg":"trace[1631467710] transaction","detail":"{read_only:false; response_revision:644; number_of_response:1; }","duration":"665.057655ms","start":"2026-08-19T20:29:52.901583Z","end":"2026-08-19T20:29:53.566641Z","steps":["trace[1631467710] 'process raft request' (duration: 664.509499ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T20:29:53.56683Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:29:52.90156Z","time spent":"665.169516ms","remote":"127.0.0.1:59038","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-19T20:29:54.489512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"842.219742ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/job-controller\" ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-08-19T20:29:54.489592Z","caller":"traceutil/trace.go:171","msg":"trace[1598015133] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/job-controller; range_end:; response_count:1; response_revision:645; }","duration":"842.355933ms","start":"2026-08-19T20:29:53.647217Z","end":"2026-08-19T20:29:54.489573Z","steps":["trace[1598015133] 'range keys from in-memory index tree' (duration: 842.102431ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T20:29:54.48965Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:29:53.647193Z","time spent":"842.447345ms","remote":"127.0.0.1:58950","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":216,"request content":"key:\"/registry/serviceaccounts/kube-system/job-controller\" "} {"level":"warn","ts":"2026-08-19T20:29:54.489616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"919.290214ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-19T20:29:54.489731Z","caller":"traceutil/trace.go:171","msg":"trace[1284458262] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:645; }","duration":"919.421176ms","start":"2026-08-19T20:29:53.570284Z","end":"2026-08-19T20:29:54.489705Z","steps":["trace[1284458262] 'agreement among raft nodes before linearized reading' (duration: 71.553834ms)","trace[1284458262] 'range keys from in-memory index tree' (duration: 847.70394ms)"],"step_count":2} {"level":"warn","ts":"2026-08-19T20:29:54.489791Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:29:53.570239Z","time spent":"919.538507ms","remote":"127.0.0.1:58754","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-08-19T20:29:54.851299Z","caller":"traceutil/trace.go:171","msg":"trace[861161870] linearizableReadLoop","detail":"{readStateIndex:672; appliedIndex:671; }","duration":"278.955564ms","start":"2026-08-19T20:29:54.572325Z","end":"2026-08-19T20:29:54.851281Z","steps":["trace[861161870] 'read index received' (duration: 278.778032ms)","trace[861161870] 'applied index is now lower than readState.Index' (duration: 176.922µs)"],"step_count":2} {"level":"info","ts":"2026-08-19T20:29:54.851385Z","caller":"traceutil/trace.go:171","msg":"trace[603378318] transaction","detail":"{read_only:false; response_revision:646; number_of_response:1; }","duration":"349.702539ms","start":"2026-08-19T20:29:54.501641Z","end":"2026-08-19T20:29:54.851343Z","steps":["trace[603378318] 'process raft request' (duration: 349.534487ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T20:29:54.851434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.105716ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-19T20:29:54.851465Z","caller":"traceutil/trace.go:171","msg":"trace[256091911] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:646; }","duration":"279.186187ms","start":"2026-08-19T20:29:54.572264Z","end":"2026-08-19T20:29:54.85145Z","steps":["trace[256091911] 'agreement among raft nodes before linearized reading' (duration: 279.121556ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T20:29:54.851564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.160033ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-08-19T20:29:54.851557Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:29:54.501617Z","time spent":"349.85184ms","remote":"127.0.0.1:58934","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2735,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-19T20:29:54.851594Z","caller":"traceutil/trace.go:171","msg":"trace[1202221964] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:646; }","duration":"252.221503ms","start":"2026-08-19T20:29:54.599365Z","end":"2026-08-19T20:29:54.851587Z","steps":["trace[1202221964] 'agreement among raft nodes before linearized reading' (duration: 252.105392ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T20:29:56.396766Z","caller":"traceutil/trace.go:171","msg":"trace[1915210510] transaction","detail":"{read_only:false; response_revision:668; number_of_response:1; }","duration":"138.1695ms","start":"2026-08-19T20:29:56.258568Z","end":"2026-08-19T20:29:56.396737Z","steps":["trace[1915210510] 'process raft request' (duration: 125.239824ms)","trace[1915210510] 'compare' (duration: 12.594263ms)"],"step_count":2} {"level":"info","ts":"2026-08-19T20:29:56.39684Z","caller":"traceutil/trace.go:171","msg":"trace[1276407317] transaction","detail":"{read_only:false; response_revision:669; number_of_response:1; }","duration":"136.728995ms","start":"2026-08-19T20:29:56.260098Z","end":"2026-08-19T20:29:56.396827Z","steps":["trace[1276407317] 'process raft request' (duration: 136.548793ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T20:29:56.556267Z","caller":"traceutil/trace.go:171","msg":"trace[1341479096] transaction","detail":"{read_only:false; response_revision:674; number_of_response:1; }","duration":"124.439986ms","start":"2026-08-19T20:29:56.431805Z","end":"2026-08-19T20:29:56.556245Z","steps":["trace[1341479096] 'process raft request' (duration: 124.394325ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T20:29:56.556247Z","caller":"traceutil/trace.go:171","msg":"trace[733661307] transaction","detail":"{read_only:false; response_revision:672; number_of_response:1; }","duration":"152.816964ms","start":"2026-08-19T20:29:56.403399Z","end":"2026-08-19T20:29:56.556216Z","steps":["trace[733661307] 'process raft request' (duration: 150.326797ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T20:29:56.556485Z","caller":"traceutil/trace.go:171","msg":"trace[622274237] transaction","detail":"{read_only:false; response_revision:673; number_of_response:1; }","duration":"144.253874ms","start":"2026-08-19T20:29:56.412185Z","end":"2026-08-19T20:29:56.556439Z","steps":["trace[622274237] 'process raft request' (duration: 143.88983ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T20:29:57.282614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"375.998212ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-19T20:29:57.282833Z","caller":"traceutil/trace.go:171","msg":"trace[1985007623] transaction","detail":"{read_only:false; response_revision:685; number_of_response:1; }","duration":"606.721153ms","start":"2026-08-19T20:29:56.67606Z","end":"2026-08-19T20:29:57.282781Z","steps":["trace[1985007623] 'process raft request' (duration: 229.947913ms)","trace[1985007623] 'compare' (duration: 375.667968ms)"],"step_count":2} {"level":"warn","ts":"2026-08-19T20:29:57.283121Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:29:56.676042Z","time spent":"606.909835ms","remote":"127.0.0.1:58800","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4156,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-19T20:29:57.283161Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"451.475154ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-19T20:29:57.283218Z","caller":"traceutil/trace.go:171","msg":"trace[905205551] linearizableReadLoop","detail":"{readStateIndex:711; appliedIndex:710; }","duration":"451.06843ms","start":"2026-08-19T20:29:56.831688Z","end":"2026-08-19T20:29:57.282756Z","steps":["trace[905205551] 'read index received' (duration: 74.262409ms)","trace[905205551] 'applied index is now lower than readState.Index' (duration: 376.803991ms)"],"step_count":2} {"level":"info","ts":"2026-08-19T20:29:57.28334Z","caller":"traceutil/trace.go:171","msg":"trace[231864285] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io; range_end:; response_count:0; response_revision:685; }","duration":"451.560354ms","start":"2026-08-19T20:29:56.831638Z","end":"2026-08-19T20:29:57.283198Z","steps":["trace[231864285] 'agreement among raft nodes before linearized reading' (duration: 451.16625ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T20:29:57.283366Z","caller":"traceutil/trace.go:171","msg":"trace[2008085143] transaction","detail":"{read_only:false; response_revision:686; number_of_response:1; }","duration":"250.680667ms","start":"2026-08-19T20:29:57.032605Z","end":"2026-08-19T20:29:57.283286Z","steps":["trace[2008085143] 'process raft request' (duration: 250.141702ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T20:29:57.283407Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:29:56.8316Z","time spent":"451.787557ms","remote":"127.0.0.1:58800","response type":"/etcdserverpb.KV/Range","request count":0,"request size":84,"response count":0,"response size":28,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" "} {"level":"warn","ts":"2026-08-19T20:29:57.284043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"420.815402ms","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-08-19T20:29:57.284114Z","caller":"traceutil/trace.go:171","msg":"trace[149602075] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:686; }","duration":"420.934884ms","start":"2026-08-19T20:29:56.863147Z","end":"2026-08-19T20:29:57.284082Z","steps":["trace[149602075] 'agreement among raft nodes before linearized reading' (duration: 420.60831ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T20:29:57.284163Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:29:56.86312Z","time spent":"421.032264ms","remote":"127.0.0.1:59038","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":"warn","ts":"2026-08-19T20:29:57.284317Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"370.09822ms","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-08-19T20:29:57.284415Z","caller":"traceutil/trace.go:171","msg":"trace[649546425] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:686; }","duration":"370.194291ms","start":"2026-08-19T20:29:56.914167Z","end":"2026-08-19T20:29:57.284361Z","steps":["trace[649546425] 'agreement among raft nodes before linearized reading' (duration: 369.885117ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T20:29:57.284637Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"375.401016ms","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-08-19T20:29:57.284694Z","caller":"traceutil/trace.go:171","msg":"trace[1045380351] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:686; }","duration":"375.542277ms","start":"2026-08-19T20:29:56.909139Z","end":"2026-08-19T20:29:57.284682Z","steps":["trace[1045380351] 'agreement among raft nodes before linearized reading' (duration: 375.270774ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T20:29:57.284756Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:29:56.909123Z","time spent":"375.595977ms","remote":"127.0.0.1:59038","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-08-19T20:29:57.284457Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:29:56.914156Z","time spent":"370.290263ms","remote":"127.0.0.1:59038","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-08-19T20:29:57.843507Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":72233634925391764,"retry-timeout":"500ms"} {"level":"info","ts":"2026-08-19T20:29:57.900412Z","caller":"traceutil/trace.go:171","msg":"trace[1316875882] transaction","detail":"{read_only:false; response_revision:693; number_of_response:1; }","duration":"589.376647ms","start":"2026-08-19T20:29:57.311004Z","end":"2026-08-19T20:29:57.900381Z","steps":["trace[1316875882] 'process raft request' (duration: 589.196925ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T20:29:57.900597Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:29:57.310991Z","time spent":"589.512899ms","remote":"127.0.0.1:58800","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4068,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-19T20:29:58.026052Z","caller":"traceutil/trace.go:171","msg":"trace[140432566] transaction","detail":"{read_only:false; response_revision:694; number_of_response:1; }","duration":"592.510099ms","start":"2026-08-19T20:29:57.433477Z","end":"2026-08-19T20:29:58.025987Z","steps":["trace[140432566] 'process raft request' (duration: 580.316812ms)","trace[140432566] 'compare' (duration: 11.852184ms)"],"step_count":2} {"level":"info","ts":"2026-08-19T20:29:58.026202Z","caller":"traceutil/trace.go:171","msg":"trace[2036047748] transaction","detail":"{read_only:false; response_revision:695; number_of_response:1; }","duration":"458.718957ms","start":"2026-08-19T20:29:57.56743Z","end":"2026-08-19T20:29:58.026149Z","steps":["trace[2036047748] 'process raft request' (duration: 458.385454ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T20:29:58.026487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"682.968297ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-pgxcv\" ","response":"range_response_count:1 size:17524"} {"level":"info","ts":"2026-08-19T20:29:58.026508Z","caller":"traceutil/trace.go:171","msg":"trace[2130423378] linearizableReadLoop","detail":"{readStateIndex:721; appliedIndex:718; }","duration":"682.417071ms","start":"2026-08-19T20:29:57.343468Z","end":"2026-08-19T20:29:58.025885Z","steps":["trace[2130423378] 'read index received' (duration: 556.838416ms)","trace[2130423378] 'applied index is now lower than readState.Index' (duration: 125.577695ms)"],"step_count":2} {"level":"info","ts":"2026-08-19T20:29:58.026567Z","caller":"traceutil/trace.go:171","msg":"trace[1187087918] range","detail":"{range_begin:/registry/pods/kube-system/cilium-pgxcv; range_end:; response_count:1; response_revision:695; }","duration":"683.124808ms","start":"2026-08-19T20:29:57.343424Z","end":"2026-08-19T20:29:58.026549Z","steps":["trace[1187087918] 'agreement among raft nodes before linearized reading' (duration: 682.858405ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T20:29:58.026621Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:29:57.343407Z","time spent":"683.201529ms","remote":"127.0.0.1:58934","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":17547,"request content":"key:\"/registry/pods/kube-system/cilium-pgxcv\" "} {"level":"warn","ts":"2026-08-19T20:29:58.026624Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:29:57.567404Z","time spent":"459.127821ms","remote":"127.0.0.1:59038","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-19T20:29:58.026819Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"456.2045ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-19T20:29:58.026803Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:29:57.433451Z","time spent":"592.977294ms","remote":"127.0.0.1:58800","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3353,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-19T20:29:58.027097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.69133ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-19T20:29:58.027139Z","caller":"traceutil/trace.go:171","msg":"trace[1580954349] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io; range_end:; response_count:0; response_revision:695; }","duration":"195.843401ms","start":"2026-08-19T20:29:57.831284Z","end":"2026-08-19T20:29:58.027127Z","steps":["trace[1580954349] 'agreement among raft nodes before linearized reading' (duration: 195.661689ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T20:29:58.027217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"395.389023ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-19T20:29:58.027263Z","caller":"traceutil/trace.go:171","msg":"trace[530958333] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io; range_end:; response_count:0; response_revision:695; }","duration":"395.431514ms","start":"2026-08-19T20:29:57.631818Z","end":"2026-08-19T20:29:58.02725Z","steps":["trace[530958333] 'agreement among raft nodes before linearized reading' (duration: 395.366323ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T20:29:58.026862Z","caller":"traceutil/trace.go:171","msg":"trace[207008576] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:695; }","duration":"456.313091ms","start":"2026-08-19T20:29:57.570538Z","end":"2026-08-19T20:29:58.026852Z","steps":["trace[207008576] 'agreement among raft nodes before linearized reading' (duration: 456.1414ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T20:29:58.02757Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:29:57.570528Z","time spent":"457.029169ms","remote":"127.0.0.1:58754","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-08-19T20:29:58.027475Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:29:57.631775Z","time spent":"395.695496ms","remote":"127.0.0.1:58800","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":28,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" "} {"level":"warn","ts":"2026-08-19T20:29:58.027672Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"447.497649ms","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-08-19T20:29:58.028012Z","caller":"traceutil/trace.go:171","msg":"trace[1876866783] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:695; }","duration":"447.865153ms","start":"2026-08-19T20:29:57.580116Z","end":"2026-08-19T20:29:58.027981Z","steps":["trace[1876866783] 'agreement among raft nodes before linearized reading' (duration: 447.102625ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T20:29:58.028096Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:29:57.580101Z","time spent":"447.974584ms","remote":"127.0.0.1:59038","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-08-19T20:30:08.773101Z","caller":"traceutil/trace.go:171","msg":"trace[1201987270] linearizableReadLoop","detail":"{readStateIndex:825; appliedIndex:824; }","duration":"200.494138ms","start":"2026-08-19T20:30:08.572591Z","end":"2026-08-19T20:30:08.773085Z","steps":["trace[1201987270] 'read index received' (duration: 200.313722ms)","trace[1201987270] 'applied index is now lower than readState.Index' (duration: 179.936µs)"],"step_count":2} {"level":"warn","ts":"2026-08-19T20:30:08.773273Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.677416ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-19T20:30:08.773277Z","caller":"traceutil/trace.go:171","msg":"trace[1486877770] transaction","detail":"{read_only:false; response_revision:795; number_of_response:1; }","duration":"294.341612ms","start":"2026-08-19T20:30:08.478892Z","end":"2026-08-19T20:30:08.773233Z","steps":["trace[1486877770] 'process raft request' (duration: 294.064092ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T20:30:08.773314Z","caller":"traceutil/trace.go:171","msg":"trace[502477693] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:795; }","duration":"200.7851ms","start":"2026-08-19T20:30:08.572522Z","end":"2026-08-19T20:30:08.773307Z","steps":["trace[502477693] 'agreement among raft nodes before linearized reading' (duration: 200.665805ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T20:30:12.138057Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"564.934334ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-19T20:30:12.138155Z","caller":"traceutil/trace.go:171","msg":"trace[2005709706] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:813; }","duration":"565.086519ms","start":"2026-08-19T20:30:11.573051Z","end":"2026-08-19T20:30:12.138137Z","steps":["trace[2005709706] 'range keys from in-memory index tree' (duration: 564.83123ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T20:30:12.138265Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:30:11.573025Z","time spent":"565.228825ms","remote":"127.0.0.1:58754","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-08-19T20:30:12.188878Z","caller":"traceutil/trace.go:171","msg":"trace[556011008] transaction","detail":"{read_only:false; response_revision:814; number_of_response:1; }","duration":"405.564223ms","start":"2026-08-19T20:30:11.783282Z","end":"2026-08-19T20:30:12.188846Z","steps":["trace[556011008] 'process raft request' (duration: 405.354526ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T20:30:12.189088Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:30:11.783263Z","time spent":"405.694098ms","remote":"127.0.0.1:58922","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4905,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-19T20:30:42.850747Z","caller":"traceutil/trace.go:171","msg":"trace[1004980445] transaction","detail":"{read_only:false; response_revision:1042; number_of_response:1; }","duration":"101.15417ms","start":"2026-08-19T20:30:42.749572Z","end":"2026-08-19T20:30:42.850726Z","steps":["trace[1004980445] 'process raft request' (duration: 99.148455ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T20:30:49.058058Z","caller":"traceutil/trace.go:171","msg":"trace[39592334] linearizableReadLoop","detail":"{readStateIndex:1104; appliedIndex:1103; }","duration":"155.181606ms","start":"2026-08-19T20:30:48.902862Z","end":"2026-08-19T20:30:49.058043Z","steps":["trace[39592334] 'read index received' (duration: 154.478545ms)","trace[39592334] 'applied index is now lower than readState.Index' (duration: 701.981µs)"],"step_count":2} {"level":"info","ts":"2026-08-19T20:30:49.058195Z","caller":"traceutil/trace.go:171","msg":"trace[1910293878] transaction","detail":"{read_only:false; response_revision:1065; number_of_response:1; }","duration":"257.7037ms","start":"2026-08-19T20:30:48.800485Z","end":"2026-08-19T20:30:49.058189Z","steps":["trace[1910293878] 'process raft request' (duration: 256.869734ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T20:30:49.058459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.589079ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-08-19T20:30:49.058482Z","caller":"traceutil/trace.go:171","msg":"trace[1091351387] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1065; }","duration":"155.654791ms","start":"2026-08-19T20:30:48.902821Z","end":"2026-08-19T20:30:49.058476Z","steps":["trace[1091351387] 'agreement among raft nodes before linearized reading' (duration: 155.564688ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T20:31:11.051866Z","caller":"traceutil/trace.go:171","msg":"trace[887701482] transaction","detail":"{read_only:false; response_revision:1137; number_of_response:1; }","duration":"100.024231ms","start":"2026-08-19T20:31:10.951824Z","end":"2026-08-19T20:31:11.051848Z","steps":["trace[887701482] 'process raft request' (duration: 99.917408ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T20:31:48.19313Z","caller":"traceutil/trace.go:171","msg":"trace[1841266311] transaction","detail":"{read_only:false; response_revision:1258; number_of_response:1; }","duration":"107.653449ms","start":"2026-08-19T20:31:48.085437Z","end":"2026-08-19T20:31:48.19309Z","steps":["trace[1841266311] 'process raft request' (duration: 107.446844ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T20:31:48.361826Z","caller":"traceutil/trace.go:171","msg":"trace[1793522959] transaction","detail":"{read_only:false; response_revision:1261; number_of_response:1; }","duration":"141.470141ms","start":"2026-08-19T20:31:48.220335Z","end":"2026-08-19T20:31:48.361806Z","steps":["trace[1793522959] 'process raft request' (duration: 132.78092ms)"],"step_count":1}