{"level":"warn","ts":"2026-06-03T02:37:30.943805Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-03T02:37:30.943939Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.154: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.154:2380","--initial-cluster=instance=https://199.19.213.154:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.154:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.154: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-06-03T02:37:30.944021Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-03T02:37:30.944051Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.154:2380"]} {"level":"info","ts":"2026-06-03T02:37:30.944079Z","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-06-03T02:37:30.944705Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.154:2379"]} {"level":"info","ts":"2026-06-03T02:37:30.944804Z","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.154:2380"],"listen-peer-urls":["https://199.19.213.154:2380"],"advertise-client-urls":["https://199.19.213.154:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.154:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.154: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-06-03T02:37:30.948852Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.811219ms"} {"level":"info","ts":"2026-06-03T02:37:30.955253Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"f4aebb100319a62d","cluster-id":"23a505f69026554e"} {"level":"info","ts":"2026-06-03T02:37:30.955354Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f4aebb100319a62d switched to configuration voters=()"} {"level":"info","ts":"2026-06-03T02:37:30.955393Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f4aebb100319a62d became follower at term 0"} {"level":"info","ts":"2026-06-03T02:37:30.95543Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft f4aebb100319a62d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-03T02:37:30.955461Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f4aebb100319a62d became follower at term 1"} {"level":"info","ts":"2026-06-03T02:37:30.955513Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f4aebb100319a62d switched to configuration voters=(17631235268647953965)"} {"level":"warn","ts":"2026-06-03T02:37:30.961943Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-03T02:37:30.964726Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-03T02:37:30.967003Z","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-06-03T02:37:30.969037Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"f4aebb100319a62d","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-03T02:37:30.969258Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"f4aebb100319a62d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-03T02:37:30.969906Z","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-06-03T02:37:30.970066Z","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-06-03T02:37:30.970082Z","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-06-03T02:37:30.970915Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f4aebb100319a62d switched to configuration voters=(17631235268647953965)"} {"level":"info","ts":"2026-06-03T02:37:30.976011Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"23a505f69026554e","local-member-id":"f4aebb100319a62d","added-peer-id":"f4aebb100319a62d","added-peer-peer-urls":["https://199.19.213.154:2380"]} {"level":"info","ts":"2026-06-03T02:37:30.977823Z","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-06-03T02:37:30.977979Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.154:2380"} {"level":"info","ts":"2026-06-03T02:37:30.978039Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.154:2380"} {"level":"info","ts":"2026-06-03T02:37:30.978305Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"f4aebb100319a62d","initial-advertise-peer-urls":["https://199.19.213.154:2380"],"listen-peer-urls":["https://199.19.213.154:2380"],"advertise-client-urls":["https://199.19.213.154:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.154:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-03T02:37:30.978352Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-03T02:37:31.556184Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f4aebb100319a62d is starting a new election at term 1"} {"level":"info","ts":"2026-06-03T02:37:31.556255Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f4aebb100319a62d became pre-candidate at term 1"} {"level":"info","ts":"2026-06-03T02:37:31.556277Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f4aebb100319a62d received MsgPreVoteResp from f4aebb100319a62d at term 1"} {"level":"info","ts":"2026-06-03T02:37:31.556309Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f4aebb100319a62d became candidate at term 2"} {"level":"info","ts":"2026-06-03T02:37:31.556326Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f4aebb100319a62d received MsgVoteResp from f4aebb100319a62d at term 2"} {"level":"info","ts":"2026-06-03T02:37:31.556346Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f4aebb100319a62d became leader at term 2"} {"level":"info","ts":"2026-06-03T02:37:31.556364Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: f4aebb100319a62d elected leader f4aebb100319a62d at term 2"} {"level":"info","ts":"2026-06-03T02:37:31.557447Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"f4aebb100319a62d","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.154:2379]}","request-path":"/0/members/f4aebb100319a62d/attributes","cluster-id":"23a505f69026554e","publish-timeout":"7s"} {"level":"info","ts":"2026-06-03T02:37:31.55753Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-03T02:37:31.55769Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-03T02:37:31.557714Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-03T02:37:31.557928Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-03T02:37:31.557959Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-03T02:37:31.558447Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"23a505f69026554e","local-member-id":"f4aebb100319a62d","cluster-version":"3.5"} {"level":"info","ts":"2026-06-03T02:37:31.558594Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-03T02:37:31.558628Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-03T02:37:31.560205Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-03T02:37:31.560594Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.154:2379"} {"level":"info","ts":"2026-06-03T02:37:40.292614Z","caller":"traceutil/trace.go:171","msg":"trace[991038514] linearizableReadLoop","detail":"{readStateIndex:314; appliedIndex:313; }","duration":"123.202706ms","start":"2026-06-03T02:37:40.169388Z","end":"2026-06-03T02:37:40.292591Z","steps":["trace[991038514] 'read index received' (duration: 121.604881ms)","trace[991038514] 'applied index is now lower than readState.Index' (duration: 1.597065ms)"],"step_count":2} {"level":"info","ts":"2026-06-03T02:37:40.292715Z","caller":"traceutil/trace.go:171","msg":"trace[1403159439] transaction","detail":"{read_only:false; response_revision:302; number_of_response:1; }","duration":"165.113927ms","start":"2026-06-03T02:37:40.127568Z","end":"2026-06-03T02:37:40.292682Z","steps":["trace[1403159439] 'process raft request' (duration: 163.414561ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T02:37:40.292858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.46193ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" ","response":"range_response_count:1 size:218"} {"level":"info","ts":"2026-06-03T02:37:40.292963Z","caller":"traceutil/trace.go:171","msg":"trace[747347019] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/service-account-controller; range_end:; response_count:1; response_revision:302; }","duration":"123.654042ms","start":"2026-06-03T02:37:40.169288Z","end":"2026-06-03T02:37:40.292942Z","steps":["trace[747347019] 'agreement among raft nodes before linearized reading' (duration: 123.414759ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T02:37:46.762721Z","caller":"traceutil/trace.go:171","msg":"trace[802790800] transaction","detail":"{read_only:false; response_revision:367; number_of_response:1; }","duration":"675.617437ms","start":"2026-06-03T02:37:46.087077Z","end":"2026-06-03T02:37:46.762694Z","steps":["trace[802790800] 'process raft request' (duration: 675.458005ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T02:37:46.763457Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T02:37:46.087061Z","time spent":"675.738769ms","remote":"127.0.0.1:53020","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4649,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-03T02:37:47.087226Z","caller":"traceutil/trace.go:171","msg":"trace[57231739] linearizableReadLoop","detail":"{readStateIndex:382; appliedIndex:380; }","duration":"388.042498ms","start":"2026-06-03T02:37:46.69916Z","end":"2026-06-03T02:37:47.087202Z","steps":["trace[57231739] 'read index received' (duration: 63.379891ms)","trace[57231739] 'applied index is now lower than readState.Index' (duration: 324.661407ms)"],"step_count":2} {"level":"info","ts":"2026-06-03T02:37:47.087354Z","caller":"traceutil/trace.go:171","msg":"trace[1146392564] transaction","detail":"{read_only:false; response_revision:368; number_of_response:1; }","duration":"786.247992ms","start":"2026-06-03T02:37:46.301082Z","end":"2026-06-03T02:37:47.08733Z","steps":["trace[1146392564] 'process raft request' (duration: 716.859972ms)","trace[1146392564] 'compare' (duration: 69.050665ms)"],"step_count":2} {"level":"warn","ts":"2026-06-03T02:37:47.087453Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"388.278881ms","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-06-03T02:37:47.087494Z","caller":"traceutil/trace.go:171","msg":"trace[2117344555] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:368; }","duration":"388.377922ms","start":"2026-06-03T02:37:46.699107Z","end":"2026-06-03T02:37:47.087485Z","steps":["trace[2117344555] 'agreement among raft nodes before linearized reading' (duration: 388.26618ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T02:37:47.08754Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T02:37:46.699084Z","time spent":"388.448494ms","remote":"127.0.0.1:53098","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-06-03T02:37:47.087489Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T02:37:46.301054Z","time spent":"786.364503ms","remote":"127.0.0.1:53098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-03T02:37:47.673925Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11974401305559551572,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-03T02:37:48.174267Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11974401305559551572,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-03T02:37:48.210864Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.119137156s","expected-duration":"1s"} {"level":"info","ts":"2026-06-03T02:37:48.287692Z","caller":"traceutil/trace.go:171","msg":"trace[1645564871] transaction","detail":"{read_only:false; response_revision:369; number_of_response:1; }","duration":"1.196022307s","start":"2026-06-03T02:37:47.091628Z","end":"2026-06-03T02:37:48.28765Z","steps":["trace[1645564871] 'process raft request' (duration: 1.11945031s)","trace[1645564871] 'compare' (duration: 76.360523ms)"],"step_count":2} {"level":"warn","ts":"2026-06-03T02:37:48.287831Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T02:37:47.091607Z","time spent":"1.196155239s","remote":"127.0.0.1:53098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-03T02:37:48.288739Z","caller":"traceutil/trace.go:171","msg":"trace[293076424] transaction","detail":"{read_only:false; response_revision:370; number_of_response:1; }","duration":"1.197092093s","start":"2026-06-03T02:37:47.091627Z","end":"2026-06-03T02:37:48.288719Z","steps":["trace[293076424] 'process raft request' (duration: 1.196604795s)"],"step_count":1} {"level":"warn","ts":"2026-06-03T02:37:48.28889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.116085417s","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-06-03T02:37:48.288951Z","caller":"traceutil/trace.go:171","msg":"trace[1035255769] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:370; }","duration":"1.116161249s","start":"2026-06-03T02:37:47.172762Z","end":"2026-06-03T02:37:48.288923Z","steps":["trace[1035255769] 'agreement among raft nodes before linearized reading' (duration: 1.116077038s)"],"step_count":1} {"level":"warn","ts":"2026-06-03T02:37:48.288984Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T02:37:47.172744Z","time spent":"1.11623306s","remote":"127.0.0.1:53098","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-03T02:37:48.288956Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T02:37:47.091609Z","time spent":"1.197209225s","remote":"127.0.0.1:53098","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-06-03T02:37:48.28831Z","caller":"traceutil/trace.go:171","msg":"trace[1581474165] linearizableReadLoop","detail":"{readStateIndex:384; appliedIndex:382; }","duration":"1.115490908s","start":"2026-06-03T02:37:47.172802Z","end":"2026-06-03T02:37:48.288293Z","steps":["trace[1581474165] 'read index received' (duration: 1.038244072s)","trace[1581474165] 'applied index is now lower than readState.Index' (duration: 77.246076ms)"],"step_count":2} {"level":"warn","ts":"2026-06-03T02:37:48.290327Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.020013414s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-06-03T02:37:48.290435Z","caller":"traceutil/trace.go:171","msg":"trace[355369200] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:370; }","duration":"1.020222777s","start":"2026-06-03T02:37:47.270197Z","end":"2026-06-03T02:37:48.29042Z","steps":["trace[355369200] 'agreement among raft nodes before linearized reading' (duration: 1.020064185s)"],"step_count":1} {"level":"warn","ts":"2026-06-03T02:37:48.290336Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"840.786433ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-03T02:37:48.290528Z","caller":"traceutil/trace.go:171","msg":"trace[1813368950] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:370; }","duration":"840.982596ms","start":"2026-06-03T02:37:47.449526Z","end":"2026-06-03T02:37:48.290509Z","steps":["trace[1813368950] 'agreement among raft nodes before linearized reading' (duration: 840.751232ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T02:37:48.290581Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T02:37:47.449468Z","time spent":"841.101588ms","remote":"127.0.0.1:52848","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-06-03T02:37:48.29068Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T02:37:47.270166Z","time spent":"1.02041411s","remote":"127.0.0.1:53098","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-03T02:37:55.856714Z","caller":"traceutil/trace.go:171","msg":"trace[1991043704] transaction","detail":"{read_only:false; response_revision:390; number_of_response:1; }","duration":"128.244867ms","start":"2026-06-03T02:37:55.728446Z","end":"2026-06-03T02:37:55.856691Z","steps":["trace[1991043704] 'process raft request' (duration: 128.106915ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T02:37:56.791141Z","caller":"traceutil/trace.go:171","msg":"trace[1806350865] linearizableReadLoop","detail":"{readStateIndex:407; appliedIndex:406; }","duration":"457.720883ms","start":"2026-06-03T02:37:56.333394Z","end":"2026-06-03T02:37:56.791115Z","steps":["trace[1806350865] 'read index received' (duration: 457.49595ms)","trace[1806350865] 'applied index is now lower than readState.Index' (duration: 223.833µs)"],"step_count":2} {"level":"info","ts":"2026-06-03T02:37:56.791282Z","caller":"traceutil/trace.go:171","msg":"trace[216602122] transaction","detail":"{read_only:false; response_revision:391; number_of_response:1; }","duration":"474.021177ms","start":"2026-06-03T02:37:56.317246Z","end":"2026-06-03T02:37:56.791268Z","steps":["trace[216602122] 'process raft request' (duration: 473.723072ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T02:37:56.791414Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T02:37:56.31722Z","time spent":"474.096277ms","remote":"127.0.0.1:53098","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-06-03T02:37:56.791436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"442.860761ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-06-03T02:37:56.79148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"458.09629ms","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-06-03T02:37:56.791479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.197859ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4375"} {"level":"info","ts":"2026-06-03T02:37:56.791532Z","caller":"traceutil/trace.go:171","msg":"trace[1591874295] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:391; }","duration":"442.978984ms","start":"2026-06-03T02:37:56.348499Z","end":"2026-06-03T02:37:56.791478Z","steps":["trace[1591874295] 'agreement among raft nodes before linearized reading' (duration: 442.848702ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T02:37:56.791611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"443.059465ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-06-03T02:37:56.791641Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T02:37:56.348479Z","time spent":"443.145526ms","remote":"127.0.0.1:53098","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":"info","ts":"2026-06-03T02:37:56.791542Z","caller":"traceutil/trace.go:171","msg":"trace[1909882473] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:391; }","duration":"458.1872ms","start":"2026-06-03T02:37:56.333339Z","end":"2026-06-03T02:37:56.791526Z","steps":["trace[1909882473] 'agreement among raft nodes before linearized reading' (duration: 458.089049ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T02:37:56.791744Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T02:37:56.333327Z","time spent":"458.402643ms","remote":"127.0.0.1:53098","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-03T02:37:56.791656Z","caller":"traceutil/trace.go:171","msg":"trace[1149607828] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:391; }","duration":"443.129215ms","start":"2026-06-03T02:37:56.348516Z","end":"2026-06-03T02:37:56.791645Z","steps":["trace[1149607828] 'agreement among raft nodes before linearized reading' (duration: 443.062514ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T02:37:56.792162Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T02:37:56.3485Z","time spent":"443.612213ms","remote":"127.0.0.1:53098","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-06-03T02:37:56.791563Z","caller":"traceutil/trace.go:171","msg":"trace[1771445836] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:391; }","duration":"330.311722ms","start":"2026-06-03T02:37:56.461228Z","end":"2026-06-03T02:37:56.79154Z","steps":["trace[1771445836] 'agreement among raft nodes before linearized reading' (duration: 330.148959ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T02:37:56.792397Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T02:37:56.461215Z","time spent":"331.162274ms","remote":"127.0.0.1:53012","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":4398,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-06-03T02:37:57.119289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.311854ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-03T02:37:57.119391Z","caller":"traceutil/trace.go:171","msg":"trace[1471943617] transaction","detail":"{read_only:false; response_revision:392; number_of_response:1; }","duration":"323.986674ms","start":"2026-06-03T02:37:56.79539Z","end":"2026-06-03T02:37:57.119376Z","steps":["trace[1471943617] 'process raft request' (duration: 73.389616ms)","trace[1471943617] 'compare' (duration: 250.214433ms)"],"step_count":2} {"level":"warn","ts":"2026-06-03T02:37:57.119434Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T02:37:56.795365Z","time spent":"324.051005ms","remote":"127.0.0.1:53098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-03T02:37:57.124788Z","caller":"traceutil/trace.go:171","msg":"trace[277736441] linearizableReadLoop","detail":"{readStateIndex:410; appliedIndex:408; }","duration":"222.141793ms","start":"2026-06-03T02:37:56.902612Z","end":"2026-06-03T02:37:57.124754Z","steps":["trace[277736441] 'read index received' (duration: 221.822229ms)","trace[277736441] 'applied index is now lower than readState.Index' (duration: 318.504µs)"],"step_count":2} {"level":"warn","ts":"2026-06-03T02:37:57.125196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.549649ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-03T02:37:57.125248Z","caller":"traceutil/trace.go:171","msg":"trace[1029551482] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:394; }","duration":"222.806704ms","start":"2026-06-03T02:37:56.902427Z","end":"2026-06-03T02:37:57.125233Z","steps":["trace[1029551482] 'agreement among raft nodes before linearized reading' (duration: 222.451578ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T02:37:57.125804Z","caller":"traceutil/trace.go:171","msg":"trace[127557195] transaction","detail":"{read_only:false; response_revision:393; number_of_response:1; }","duration":"330.126306ms","start":"2026-06-03T02:37:56.795664Z","end":"2026-06-03T02:37:57.125791Z","steps":["trace[127557195] 'process raft request' (duration: 328.861877ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T02:37:57.125917Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T02:37:56.795652Z","time spent":"330.189327ms","remote":"127.0.0.1:53098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-03T02:37:57.126045Z","caller":"traceutil/trace.go:171","msg":"trace[1289405501] transaction","detail":"{read_only:false; response_revision:394; number_of_response:1; }","duration":"329.372625ms","start":"2026-06-03T02:37:56.796663Z","end":"2026-06-03T02:37:57.126036Z","steps":["trace[1289405501] 'process raft request' (duration: 328.007424ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T02:37:57.126095Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T02:37:56.796646Z","time spent":"329.422805ms","remote":"127.0.0.1:53098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-03T02:38:11.372203Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11974401305559551818,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-03T02:38:11.646422Z","caller":"traceutil/trace.go:171","msg":"trace[1294846157] transaction","detail":"{read_only:false; response_revision:486; number_of_response:1; }","duration":"911.767564ms","start":"2026-06-03T02:38:10.734629Z","end":"2026-06-03T02:38:11.646397Z","steps":["trace[1294846157] 'process raft request' (duration: 911.633942ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T02:38:11.646518Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T02:38:10.734609Z","time spent":"911.866015ms","remote":"127.0.0.1:52908","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-03T02:38:11.871437Z","caller":"traceutil/trace.go:171","msg":"trace[681550639] transaction","detail":"{read_only:false; response_revision:487; number_of_response:1; }","duration":"1.132964935s","start":"2026-06-03T02:38:10.738448Z","end":"2026-06-03T02:38:11.871413Z","steps":["trace[681550639] 'process raft request' (duration: 1.132769782s)"],"step_count":1} {"level":"info","ts":"2026-06-03T02:38:11.871699Z","caller":"traceutil/trace.go:171","msg":"trace[1092896679] transaction","detail":"{read_only:false; response_revision:489; number_of_response:1; }","duration":"1.124129475s","start":"2026-06-03T02:38:10.747531Z","end":"2026-06-03T02:38:11.87166Z","steps":["trace[1092896679] 'process raft request' (duration: 1.123958743s)"],"step_count":1} {"level":"info","ts":"2026-06-03T02:38:11.871749Z","caller":"traceutil/trace.go:171","msg":"trace[468621950] transaction","detail":"{read_only:false; response_revision:490; number_of_response:1; }","duration":"1.120033995s","start":"2026-06-03T02:38:10.75168Z","end":"2026-06-03T02:38:11.871714Z","steps":["trace[468621950] 'process raft request' (duration: 1.119878263s)"],"step_count":1} {"level":"info","ts":"2026-06-03T02:38:11.871769Z","caller":"traceutil/trace.go:171","msg":"trace[1115318783] transaction","detail":"{read_only:false; response_revision:488; number_of_response:1; }","duration":"1.129121138s","start":"2026-06-03T02:38:10.742612Z","end":"2026-06-03T02:38:11.871733Z","steps":["trace[1115318783] 'process raft request' (duration: 1.128727473s)"],"step_count":1} {"level":"warn","ts":"2026-06-03T02:38:11.871852Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T02:38:10.742593Z","time spent":"1.1292208s","remote":"127.0.0.1:52908","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-03T02:38:11.871864Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T02:38:10.747512Z","time spent":"1.124288047s","remote":"127.0.0.1:52908","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-03T02:38:11.871865Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T02:38:10.751665Z","time spent":"1.120139477s","remote":"127.0.0.1:52908","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-03T02:38:11.871891Z","caller":"traceutil/trace.go:171","msg":"trace[1381321726] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"1.113007852s","start":"2026-06-03T02:38:10.758846Z","end":"2026-06-03T02:38:11.871854Z","steps":["trace[1381321726] 'process raft request' (duration: 1.112753659s)"],"step_count":1} {"level":"warn","ts":"2026-06-03T02:38:11.872036Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T02:38:10.758825Z","time spent":"1.113161024s","remote":"127.0.0.1:52908","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-03T02:38:11.872367Z","caller":"traceutil/trace.go:171","msg":"trace[478449545] transaction","detail":"{read_only:false; response_revision:492; number_of_response:1; }","duration":"1.113439279s","start":"2026-06-03T02:38:10.758913Z","end":"2026-06-03T02:38:11.872353Z","steps":["trace[478449545] 'process raft request' (duration: 1.112719338s)"],"step_count":1} {"level":"warn","ts":"2026-06-03T02:38:11.872436Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T02:38:10.758908Z","time spent":"1.113497569s","remote":"127.0.0.1:52908","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-03T02:38:11.872462Z","caller":"traceutil/trace.go:171","msg":"trace[494948633] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"1.11076502s","start":"2026-06-03T02:38:10.761677Z","end":"2026-06-03T02:38:11.872442Z","steps":["trace[494948633] 'process raft request' (duration: 1.110628148s)"],"step_count":1} {"level":"info","ts":"2026-06-03T02:38:11.872497Z","caller":"traceutil/trace.go:171","msg":"trace[261358917] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"1.104446736s","start":"2026-06-03T02:38:10.768033Z","end":"2026-06-03T02:38:11.87248Z","steps":["trace[261358917] 'process raft request' (duration: 1.104329565s)"],"step_count":1} {"level":"warn","ts":"2026-06-03T02:38:11.872553Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T02:38:10.761667Z","time spent":"1.110843081s","remote":"127.0.0.1:52908","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-03T02:38:11.872593Z","caller":"traceutil/trace.go:171","msg":"trace[242646303] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"1.097538846s","start":"2026-06-03T02:38:10.775044Z","end":"2026-06-03T02:38:11.872583Z","steps":["trace[242646303] 'process raft request' (duration: 1.097376024s)"],"step_count":1} {"level":"warn","ts":"2026-06-03T02:38:11.872649Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T02:38:10.775025Z","time spent":"1.097592446s","remote":"127.0.0.1:52908","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-03T02:38:11.872615Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T02:38:10.768014Z","time spent":"1.104561529s","remote":"127.0.0.1:52908","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-03T02:38:11.872847Z","caller":"traceutil/trace.go:171","msg":"trace[418297117] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"1.075664855s","start":"2026-06-03T02:38:10.797172Z","end":"2026-06-03T02:38:11.872837Z","steps":["trace[418297117] 'process raft request' (duration: 1.07534194s)"],"step_count":1} {"level":"warn","ts":"2026-06-03T02:38:11.872903Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T02:38:10.797147Z","time spent":"1.075733605s","remote":"127.0.0.1:52908","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-03T02:38:11.8724Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T02:38:10.738423Z","time spent":"1.133094077s","remote":"127.0.0.1:52908","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-03T02:38:11.873241Z","caller":"traceutil/trace.go:171","msg":"trace[430568430] linearizableReadLoop","detail":"{readStateIndex:517; appliedIndex:505; }","duration":"1.002054034s","start":"2026-06-03T02:38:10.871173Z","end":"2026-06-03T02:38:11.873227Z","steps":["trace[430568430] 'read index received' (duration: 775.15166ms)","trace[430568430] 'applied index is now lower than readState.Index' (duration: 226.901524ms)"],"step_count":2} {"level":"info","ts":"2026-06-03T02:38:11.87332Z","caller":"traceutil/trace.go:171","msg":"trace[1489793597] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"976.366738ms","start":"2026-06-03T02:38:10.896944Z","end":"2026-06-03T02:38:11.873311Z","steps":["trace[1489793597] 'process raft request' (duration: 975.8178ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T02:38:11.873379Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T02:38:10.896919Z","time spent":"976.427169ms","remote":"127.0.0.1:52908","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-03T02:38:11.873616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.00243687s","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-06-03T02:38:11.873656Z","caller":"traceutil/trace.go:171","msg":"trace[1727357472] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:497; }","duration":"1.002522472s","start":"2026-06-03T02:38:10.871123Z","end":"2026-06-03T02:38:11.873646Z","steps":["trace[1727357472] 'agreement among raft nodes before linearized reading' (duration: 1.00242729s)"],"step_count":1} {"level":"warn","ts":"2026-06-03T02:38:11.873684Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T02:38:10.871098Z","time spent":"1.002579322s","remote":"127.0.0.1:53098","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":"info","ts":"2026-06-03T02:38:11.88514Z","caller":"traceutil/trace.go:171","msg":"trace[51655929] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"234.249803ms","start":"2026-06-03T02:38:11.650877Z","end":"2026-06-03T02:38:11.885127Z","steps":["trace[51655929] 'process raft request' (duration: 234.07261ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T02:38:11.885217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"983.831287ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-03T02:38:11.885289Z","caller":"traceutil/trace.go:171","msg":"trace[1914138958] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:499; }","duration":"983.933929ms","start":"2026-06-03T02:38:10.901341Z","end":"2026-06-03T02:38:11.885275Z","steps":["trace[1914138958] 'agreement among raft nodes before linearized reading' (duration: 983.823317ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T02:38:11.885341Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T02:38:10.901328Z","time spent":"984.005ms","remote":"127.0.0.1:52848","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-06-03T02:38:11.885461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"695.507771ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-03T02:38:11.885494Z","caller":"traceutil/trace.go:171","msg":"trace[1394789213] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:499; }","duration":"695.557652ms","start":"2026-06-03T02:38:11.189926Z","end":"2026-06-03T02:38:11.885484Z","steps":["trace[1394789213] 'agreement among raft nodes before linearized reading' (duration: 695.39501ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T02:38:11.885515Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T02:38:11.189918Z","time spent":"695.591122ms","remote":"127.0.0.1:53098","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-06-03T02:38:11.885557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"696.191881ms","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-06-03T02:38:11.885604Z","caller":"traceutil/trace.go:171","msg":"trace[1317310506] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:499; }","duration":"696.292973ms","start":"2026-06-03T02:38:11.189304Z","end":"2026-06-03T02:38:11.885597Z","steps":["trace[1317310506] 'agreement among raft nodes before linearized reading' (duration: 696.200351ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T02:38:11.885629Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T02:38:11.189281Z","time spent":"696.341173ms","remote":"127.0.0.1:53098","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-03T02:38:11.885592Z","caller":"traceutil/trace.go:171","msg":"trace[1465392884] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"232.990544ms","start":"2026-06-03T02:38:11.652565Z","end":"2026-06-03T02:38:11.885556Z","steps":["trace[1465392884] 'process raft request' (duration: 232.476437ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T02:38:11.885767Z","caller":"traceutil/trace.go:171","msg":"trace[538700241] transaction","detail":"{read_only:false; number_of_response:1; response_revision:499; }","duration":"231.913688ms","start":"2026-06-03T02:38:11.653843Z","end":"2026-06-03T02:38:11.885757Z","steps":["trace[538700241] 'process raft request' (duration: 231.273539ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T02:38:11.885819Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"696.382144ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-06-03T02:38:11.885867Z","caller":"traceutil/trace.go:171","msg":"trace[462767473] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:499; }","duration":"696.455405ms","start":"2026-06-03T02:38:11.1894Z","end":"2026-06-03T02:38:11.885855Z","steps":["trace[462767473] 'agreement among raft nodes before linearized reading' (duration: 696.013398ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T02:38:11.885899Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T02:38:11.18939Z","time spent":"696.503566ms","remote":"127.0.0.1:53098","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-03T02:38:17.404666Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11974401305559551980,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-03T02:38:17.732427Z","caller":"traceutil/trace.go:171","msg":"trace[1053590599] linearizableReadLoop","detail":"{readStateIndex:609; appliedIndex:608; }","duration":"828.365421ms","start":"2026-06-03T02:38:16.904035Z","end":"2026-06-03T02:38:17.7324Z","steps":["trace[1053590599] 'read index received' (duration: 827.562956ms)","trace[1053590599] 'applied index is now lower than readState.Index' (duration: 801.444µs)"],"step_count":2} {"level":"info","ts":"2026-06-03T02:38:17.73251Z","caller":"traceutil/trace.go:171","msg":"trace[90962399] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"891.359919ms","start":"2026-06-03T02:38:16.841118Z","end":"2026-06-03T02:38:17.732477Z","steps":["trace[90962399] 'process raft request' (duration: 890.760028ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T02:38:17.732539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"828.481444ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-03T02:38:17.732575Z","caller":"traceutil/trace.go:171","msg":"trace[996981397] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:585; }","duration":"828.562095ms","start":"2026-06-03T02:38:16.904003Z","end":"2026-06-03T02:38:17.732565Z","steps":["trace[996981397] 'agreement among raft nodes before linearized reading' (duration: 828.486333ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T02:38:17.732609Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T02:38:16.903985Z","time spent":"828.616325ms","remote":"127.0.0.1:52848","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-06-03T02:38:17.732638Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T02:38:16.841097Z","time spent":"891.472772ms","remote":"127.0.0.1:52946","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036229,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-03T02:38:18.506327Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.756996ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-03T02:38:18.506594Z","caller":"traceutil/trace.go:171","msg":"trace[810570980] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"474.537291ms","start":"2026-06-03T02:38:18.032028Z","end":"2026-06-03T02:38:18.506565Z","steps":["trace[810570980] 'process raft request' (duration: 474.424646ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T02:38:18.506584Z","caller":"traceutil/trace.go:171","msg":"trace[1244997695] transaction","detail":"{read_only:false; response_revision:586; number_of_response:1; }","duration":"715.993907ms","start":"2026-06-03T02:38:17.790558Z","end":"2026-06-03T02:38:18.506552Z","steps":["trace[1244997695] 'process raft request' (duration: 488.883243ms)","trace[1244997695] 'compare' (duration: 226.487253ms)"],"step_count":2} {"level":"warn","ts":"2026-06-03T02:38:18.506703Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T02:38:18.032002Z","time spent":"474.632616ms","remote":"127.0.0.1:53098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-03T02:38:18.506708Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T02:38:17.790529Z","time spent":"716.116331ms","remote":"127.0.0.1:53170","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1092,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-03T02:38:18.506938Z","caller":"traceutil/trace.go:171","msg":"trace[2073863463] linearizableReadLoop","detail":"{readStateIndex:610; appliedIndex:609; }","duration":"602.347383ms","start":"2026-06-03T02:38:17.904576Z","end":"2026-06-03T02:38:18.506924Z","steps":["trace[2073863463] 'read index received' (duration: 374.890012ms)","trace[2073863463] 'applied index is now lower than readState.Index' (duration: 227.455881ms)"],"step_count":2} {"level":"warn","ts":"2026-06-03T02:38:18.507274Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"568.215654ms","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-06-03T02:38:18.507338Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"602.769133ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-03T02:38:18.507344Z","caller":"traceutil/trace.go:171","msg":"trace[1580180159] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:587; }","duration":"568.309478ms","start":"2026-06-03T02:38:17.939016Z","end":"2026-06-03T02:38:18.507326Z","steps":["trace[1580180159] 'agreement among raft nodes before linearized reading' (duration: 568.116709ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T02:38:18.507453Z","caller":"traceutil/trace.go:171","msg":"trace[2143461151] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:587; }","duration":"602.922059ms","start":"2026-06-03T02:38:17.904515Z","end":"2026-06-03T02:38:18.507437Z","steps":["trace[2143461151] 'agreement among raft nodes before linearized reading' (duration: 602.787742ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T02:38:18.507512Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T02:38:17.904474Z","time spent":"603.027553ms","remote":"127.0.0.1:52848","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-06-03T02:38:18.507611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"557.584339ms","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-06-03T02:38:18.507647Z","caller":"traceutil/trace.go:171","msg":"trace[995489947] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:587; }","duration":"557.65632ms","start":"2026-06-03T02:38:17.94998Z","end":"2026-06-03T02:38:18.507637Z","steps":["trace[995489947] 'agreement among raft nodes before linearized reading' (duration: 557.560706ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T02:38:18.507515Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T02:38:17.939003Z","time spent":"568.497397ms","remote":"127.0.0.1:53098","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-06-03T02:38:18.507669Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T02:38:17.949947Z","time spent":"557.717903ms","remote":"127.0.0.1:53098","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-06-03T02:38:18.507447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"555.465174ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-03T02:38:18.507747Z","caller":"traceutil/trace.go:171","msg":"trace[2075907279] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:587; }","duration":"555.798289ms","start":"2026-06-03T02:38:17.951942Z","end":"2026-06-03T02:38:18.507741Z","steps":["trace[2075907279] 'agreement among raft nodes before linearized reading' (duration: 555.334417ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T02:38:18.507774Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T02:38:17.95193Z","time spent":"555.83215ms","remote":"127.0.0.1:53098","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-06-03T02:38:18.507304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"555.213275ms","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-06-03T02:38:18.507977Z","caller":"traceutil/trace.go:171","msg":"trace[1101089959] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:587; }","duration":"555.931988ms","start":"2026-06-03T02:38:17.952033Z","end":"2026-06-03T02:38:18.507965Z","steps":["trace[1101089959] 'agreement among raft nodes before linearized reading' (duration: 555.121039ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T02:38:18.508007Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T02:38:17.952015Z","time spent":"555.978921ms","remote":"127.0.0.1:53098","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-06-03T02:38:19.018052Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11974401305559551987,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-03T02:38:19.286834Z","caller":"traceutil/trace.go:171","msg":"trace[498127803] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"774.326088ms","start":"2026-06-03T02:38:18.512477Z","end":"2026-06-03T02:38:19.286803Z","steps":["trace[498127803] 'process raft request' (duration: 724.250154ms)","trace[498127803] 'compare' (duration: 49.943727ms)"],"step_count":2} {"level":"warn","ts":"2026-06-03T02:38:19.286991Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T02:38:18.512456Z","time spent":"774.456914ms","remote":"127.0.0.1:53098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-03T02:38:19.700276Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.873686ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-03T02:38:19.700475Z","caller":"traceutil/trace.go:171","msg":"trace[333218276] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"1.187937708s","start":"2026-06-03T02:38:18.512496Z","end":"2026-06-03T02:38:19.700433Z","steps":["trace[333218276] 'process raft request' (duration: 1.077818339s)","trace[333218276] 'compare' (duration: 109.678337ms)"],"step_count":2} {"level":"warn","ts":"2026-06-03T02:38:19.700549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.183039381s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/envoy-gateway-gateway-helm-certgen:envoy-gateway-system\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-03T02:38:19.7006Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T02:38:18.512476Z","time spent":"1.188066664s","remote":"127.0.0.1:53098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-03T02:38:19.700603Z","caller":"traceutil/trace.go:171","msg":"trace[150508271] range","detail":"{range_begin:/registry/clusterrolebindings/envoy-gateway-gateway-helm-certgen:envoy-gateway-system; range_end:; response_count:0; response_revision:591; }","duration":"1.183081963s","start":"2026-06-03T02:38:18.517499Z","end":"2026-06-03T02:38:19.700581Z","steps":["trace[150508271] 'agreement among raft nodes before linearized reading' (duration: 1.18301741s)"],"step_count":1} {"level":"info","ts":"2026-06-03T02:38:19.700487Z","caller":"traceutil/trace.go:171","msg":"trace[146669243] linearizableReadLoop","detail":"{readStateIndex:615; appliedIndex:611; }","duration":"1.182969228s","start":"2026-06-03T02:38:18.517504Z","end":"2026-06-03T02:38:19.700473Z","steps":["trace[146669243] 'read index received' (duration: 719.229591ms)","trace[146669243] 'applied index is now lower than readState.Index' (duration: 463.738836ms)"],"step_count":2} {"level":"info","ts":"2026-06-03T02:38:19.70058Z","caller":"traceutil/trace.go:171","msg":"trace[2046704682] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"1.188031882s","start":"2026-06-03T02:38:18.512496Z","end":"2026-06-03T02:38:19.700528Z","steps":["trace[2046704682] 'process raft request' (duration: 1.187878225s)"],"step_count":1} {"level":"warn","ts":"2026-06-03T02:38:19.700671Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T02:38:18.517492Z","time spent":"1.183163726s","remote":"127.0.0.1:53180","response type":"/etcdserverpb.KV/Range","request count":0,"request size":87,"response count":0,"response size":28,"request content":"key:\"/registry/clusterrolebindings/envoy-gateway-gateway-helm-certgen:envoy-gateway-system\" "} {"level":"info","ts":"2026-06-03T02:38:19.700658Z","caller":"traceutil/trace.go:171","msg":"trace[955197796] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"1.187880055s","start":"2026-06-03T02:38:18.512706Z","end":"2026-06-03T02:38:19.700586Z","steps":["trace[955197796] 'process raft request' (duration: 1.187728508s)"],"step_count":1} {"level":"warn","ts":"2026-06-03T02:38:19.700863Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T02:38:18.512476Z","time spent":"1.188243632s","remote":"127.0.0.1:53098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-03T02:38:19.70089Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T02:38:18.512695Z","time spent":"1.188068035s","remote":"127.0.0.1:53098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-03T02:38:19.74817Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"843.034716ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-03T02:38:19.74828Z","caller":"traceutil/trace.go:171","msg":"trace[1895040659] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:591; }","duration":"843.211784ms","start":"2026-06-03T02:38:18.905043Z","end":"2026-06-03T02:38:19.748255Z","steps":["trace[1895040659] 'agreement among raft nodes before linearized reading' (duration: 842.991574ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T02:38:19.748335Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T02:38:18.905022Z","time spent":"843.302419ms","remote":"127.0.0.1:52848","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-06-03T02:38:21.40582Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11974401305559552004,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-03T02:38:21.651169Z","caller":"traceutil/trace.go:171","msg":"trace[477502206] linearizableReadLoop","detail":"{readStateIndex:622; appliedIndex:621; }","duration":"746.290365ms","start":"2026-06-03T02:38:20.904849Z","end":"2026-06-03T02:38:21.651139Z","steps":["trace[477502206] 'read index received' (duration: 745.188843ms)","trace[477502206] 'applied index is now lower than readState.Index' (duration: 1.100322ms)"],"step_count":2} {"level":"info","ts":"2026-06-03T02:38:21.651439Z","caller":"traceutil/trace.go:171","msg":"trace[806053469] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"843.483707ms","start":"2026-06-03T02:38:20.807932Z","end":"2026-06-03T02:38:21.651416Z","steps":["trace[806053469] 'process raft request' (duration: 842.425107ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T02:38:21.651583Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T02:38:20.807907Z","time spent":"843.590542ms","remote":"127.0.0.1:52946","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036297,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-03T02:38:21.651889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"747.023529ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-03T02:38:21.651993Z","caller":"traceutil/trace.go:171","msg":"trace[1452011741] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:597; }","duration":"747.126494ms","start":"2026-06-03T02:38:20.904834Z","end":"2026-06-03T02:38:21.65196Z","steps":["trace[1452011741] 'agreement among raft nodes before linearized reading' (duration: 746.540276ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T02:38:21.652045Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T02:38:20.904775Z","time spent":"747.260341ms","remote":"127.0.0.1:52854","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-06-03T02:38:21.652602Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"361.266003ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-03T02:38:21.652667Z","caller":"traceutil/trace.go:171","msg":"trace[1820513161] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:597; }","duration":"361.351448ms","start":"2026-06-03T02:38:21.291288Z","end":"2026-06-03T02:38:21.652639Z","steps":["trace[1820513161] 'agreement among raft nodes before linearized reading' (duration: 361.132057ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T02:38:21.652703Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T02:38:21.291268Z","time spent":"361.426181ms","remote":"127.0.0.1:53098","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-06-03T02:38:21.653277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"453.99971ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-hkg2j\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-06-03T02:38:21.653402Z","caller":"traceutil/trace.go:171","msg":"trace[577663651] range","detail":"{range_begin:/registry/pods/kube-system/cilium-hkg2j; range_end:; response_count:1; response_revision:597; }","duration":"454.133646ms","start":"2026-06-03T02:38:21.199206Z","end":"2026-06-03T02:38:21.65334Z","steps":["trace[577663651] 'agreement among raft nodes before linearized reading' (duration: 452.407354ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T02:38:21.653484Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T02:38:21.199192Z","time spent":"454.250942ms","remote":"127.0.0.1:53020","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16988,"request content":"key:\"/registry/pods/kube-system/cilium-hkg2j\" "} {"level":"info","ts":"2026-06-03T02:38:21.856524Z","caller":"traceutil/trace.go:171","msg":"trace[310831476] transaction","detail":"{read_only:false; response_revision:598; number_of_response:1; }","duration":"197.244804ms","start":"2026-06-03T02:38:21.659007Z","end":"2026-06-03T02:38:21.856252Z","steps":["trace[310831476] 'process raft request' (duration: 153.703516ms)","trace[310831476] 'compare' (duration: 43.465305ms)"],"step_count":2} {"level":"warn","ts":"2026-06-03T02:38:23.904616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000105535s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-06-03T02:38:23.904726Z","caller":"traceutil/trace.go:171","msg":"trace[1150063132] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000260203s","start":"2026-06-03T02:38:21.904441Z","end":"2026-06-03T02:38:23.904701Z","steps":["trace[1150063132] 'agreement among raft nodes before linearized reading' (duration: 2.000133897s)"],"step_count":1} {"level":"warn","ts":"2026-06-03T02:38:23.904797Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T02:38:21.90442Z","time spent":"2.000361447s","remote":"127.0.0.1:52848","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-03T02:38:25.628679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.351974149s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-03T02:38:25.629593Z","caller":"traceutil/trace.go:171","msg":"trace[878497255] linearizableReadLoop","detail":"{readStateIndex:624; appliedIndex:622; }","duration":"3.924246549s","start":"2026-06-03T02:38:21.705323Z","end":"2026-06-03T02:38:25.62957Z","steps":["trace[878497255] 'read index received' (duration: 107.396026ms)","trace[878497255] 'applied index is now lower than readState.Index' (duration: 3.816849243s)"],"step_count":2} {"level":"info","ts":"2026-06-03T02:38:25.6296Z","caller":"traceutil/trace.go:171","msg":"trace[1892756297] transaction","detail":"{read_only:false; response_revision:599; number_of_response:1; }","duration":"3.956797872s","start":"2026-06-03T02:38:21.672757Z","end":"2026-06-03T02:38:25.629555Z","steps":["trace[1892756297] 'process raft request' (duration: 603.841937ms)","trace[1892756297] 'compare' (duration: 3.350957382s)"],"step_count":2} {"level":"warn","ts":"2026-06-03T02:38:25.629966Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T02:38:21.672731Z","time spent":"3.9571794s","remote":"127.0.0.1:53020","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-03T02:38:25.629649Z","caller":"traceutil/trace.go:171","msg":"trace[596532839] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"3.909611731s","start":"2026-06-03T02:38:21.720011Z","end":"2026-06-03T02:38:25.629622Z","steps":["trace[596532839] 'process raft request' (duration: 3.909447363s)"],"step_count":1} {"level":"warn","ts":"2026-06-03T02:38:25.630232Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T02:38:21.72Z","time spent":"3.910161516s","remote":"127.0.0.1:53320","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-03T02:38:25.629748Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.924409476s","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-06-03T02:38:25.630391Z","caller":"traceutil/trace.go:171","msg":"trace[435206664] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:600; }","duration":"3.925060277s","start":"2026-06-03T02:38:21.705317Z","end":"2026-06-03T02:38:25.630377Z","steps":["trace[435206664] 'agreement among raft nodes before linearized reading' (duration: 3.924319622s)"],"step_count":1} {"level":"warn","ts":"2026-06-03T02:38:25.630421Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T02:38:21.705262Z","time spent":"3.925152902s","remote":"127.0.0.1:53098","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-06-03T02:38:25.632677Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.747057829s","expected-duration":"1s"} {"level":"info","ts":"2026-06-03T02:38:25.633229Z","caller":"traceutil/trace.go:171","msg":"trace[1280573851] transaction","detail":"{read_only:false; response_revision:601; number_of_response:1; }","duration":"1.74770766s","start":"2026-06-03T02:38:23.885497Z","end":"2026-06-03T02:38:25.633205Z","steps":["trace[1280573851] 'process raft request' (duration: 1.747512031s)"],"step_count":1} {"level":"warn","ts":"2026-06-03T02:38:25.633365Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T02:38:23.885474Z","time spent":"1.747812855s","remote":"127.0.0.1:53098","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-06-03T02:38:25.633763Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.728144496s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-03T02:38:25.633809Z","caller":"traceutil/trace.go:171","msg":"trace[781801278] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:601; }","duration":"1.728216519s","start":"2026-06-03T02:38:23.905581Z","end":"2026-06-03T02:38:25.633798Z","steps":["trace[781801278] 'agreement among raft nodes before linearized reading' (duration: 1.728151576s)"],"step_count":1} {"level":"warn","ts":"2026-06-03T02:38:25.63384Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T02:38:23.905562Z","time spent":"1.728271642s","remote":"127.0.0.1:52854","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-06-03T02:38:25.63384Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.772312552s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-03T02:38:25.633885Z","caller":"traceutil/trace.go:171","msg":"trace[1949308778] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:601; }","duration":"1.772415708s","start":"2026-06-03T02:38:23.861456Z","end":"2026-06-03T02:38:25.633872Z","steps":["trace[1949308778] 'agreement among raft nodes before linearized reading' (duration: 1.772242169s)"],"step_count":1} {"level":"warn","ts":"2026-06-03T02:38:25.633919Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T02:38:23.861436Z","time spent":"1.77247638s","remote":"127.0.0.1:53098","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-06-03T02:38:25.634175Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.928421734s","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-06-03T02:38:25.634391Z","caller":"traceutil/trace.go:171","msg":"trace[1823261151] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:601; }","duration":"3.928664936s","start":"2026-06-03T02:38:21.705705Z","end":"2026-06-03T02:38:25.63437Z","steps":["trace[1823261151] 'agreement among raft nodes before linearized reading' (duration: 3.928301779s)"],"step_count":1} {"level":"warn","ts":"2026-06-03T02:38:25.634551Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T02:38:21.705702Z","time spent":"3.928806382s","remote":"127.0.0.1:53098","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-06-03T02:38:25.634248Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.928810263s","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-06-03T02:38:25.634934Z","caller":"traceutil/trace.go:171","msg":"trace[1639401734] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:601; }","duration":"3.929481334s","start":"2026-06-03T02:38:21.705399Z","end":"2026-06-03T02:38:25.63488Z","steps":["trace[1639401734] 'agreement among raft nodes before linearized reading' (duration: 3.927752513s)"],"step_count":1} {"level":"warn","ts":"2026-06-03T02:38:25.635043Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T02:38:21.705375Z","time spent":"3.929643731s","remote":"127.0.0.1:53098","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-06-03T02:38:25.633726Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.232470154s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.154\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-06-03T02:38:25.636455Z","caller":"traceutil/trace.go:171","msg":"trace[1404244870] range","detail":"{range_begin:/registry/masterleases/199.19.213.154; range_end:; response_count:1; response_revision:601; }","duration":"1.235220812s","start":"2026-06-03T02:38:24.401214Z","end":"2026-06-03T02:38:25.636435Z","steps":["trace[1404244870] 'agreement among raft nodes before linearized reading' (duration: 1.23196782s)"],"step_count":1} {"level":"warn","ts":"2026-06-03T02:38:25.636837Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T02:38:24.401199Z","time spent":"1.235620141s","remote":"127.0.0.1:52896","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.19.213.154\" "} {"level":"info","ts":"2026-06-03T02:38:26.398043Z","caller":"traceutil/trace.go:171","msg":"trace[695713492] linearizableReadLoop","detail":"{readStateIndex:636; appliedIndex:635; }","duration":"178.01521ms","start":"2026-06-03T02:38:26.220007Z","end":"2026-06-03T02:38:26.398022Z","steps":["trace[695713492] 'read index received' (duration: 159.588741ms)","trace[695713492] 'applied index is now lower than readState.Index' (duration: 18.425499ms)"],"step_count":2} {"level":"info","ts":"2026-06-03T02:38:26.398128Z","caller":"traceutil/trace.go:171","msg":"trace[725715877] transaction","detail":"{read_only:false; response_revision:610; number_of_response:1; }","duration":"183.036264ms","start":"2026-06-03T02:38:26.215056Z","end":"2026-06-03T02:38:26.398092Z","steps":["trace[725715877] 'process raft request' (duration: 164.594015ms)","trace[725715877] 'compare' (duration: 18.136505ms)"],"step_count":2} {"level":"warn","ts":"2026-06-03T02:38:26.398257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.229949ms","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-06-03T02:38:26.398297Z","caller":"traceutil/trace.go:171","msg":"trace[1854766856] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/job-controller; range_end:; response_count:1; response_revision:610; }","duration":"178.302133ms","start":"2026-06-03T02:38:26.219984Z","end":"2026-06-03T02:38:26.398286Z","steps":["trace[1854766856] 'agreement among raft nodes before linearized reading' (duration: 178.122185ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T02:38:26.693639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.074635ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-03T02:38:26.69377Z","caller":"traceutil/trace.go:171","msg":"trace[1254965529] linearizableReadLoop","detail":"{readStateIndex:637; appliedIndex:636; }","duration":"292.366255ms","start":"2026-06-03T02:38:26.401382Z","end":"2026-06-03T02:38:26.693749Z","steps":["trace[1254965529] 'read index received' (duration: 106.029117ms)","trace[1254965529] 'applied index is now lower than readState.Index' (duration: 186.335728ms)"],"step_count":2} {"level":"info","ts":"2026-06-03T02:38:26.693803Z","caller":"traceutil/trace.go:171","msg":"trace[1120871158] transaction","detail":"{read_only:false; response_revision:611; number_of_response:1; }","duration":"445.910225ms","start":"2026-06-03T02:38:26.247861Z","end":"2026-06-03T02:38:26.693771Z","steps":["trace[1120871158] 'process raft request' (duration: 259.612229ms)","trace[1120871158] 'compare' (duration: 185.896667ms)"],"step_count":2} {"level":"warn","ts":"2026-06-03T02:38:26.693863Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.486511ms","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-06-03T02:38:26.693899Z","caller":"traceutil/trace.go:171","msg":"trace[1953344046] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/job-controller; range_end:; response_count:1; response_revision:611; }","duration":"292.559764ms","start":"2026-06-03T02:38:26.401326Z","end":"2026-06-03T02:38:26.693886Z","steps":["trace[1953344046] 'agreement among raft nodes before linearized reading' (duration: 292.479701ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T02:38:26.693951Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T02:38:26.247835Z","time spent":"446.035921ms","remote":"127.0.0.1:53020","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17232,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-03T02:38:26.969882Z","caller":"traceutil/trace.go:171","msg":"trace[783244762] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"191.796311ms","start":"2026-06-03T02:38:26.778052Z","end":"2026-06-03T02:38:26.969848Z","steps":["trace[783244762] 'process raft request' (duration: 191.720058ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T02:38:26.9701Z","caller":"traceutil/trace.go:171","msg":"trace[1816610048] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"192.85269ms","start":"2026-06-03T02:38:26.777219Z","end":"2026-06-03T02:38:26.970071Z","steps":["trace[1816610048] 'process raft request' (duration: 100.618675ms)","trace[1816610048] 'compare' (duration: 91.763524ms)"],"step_count":2} {"level":"info","ts":"2026-06-03T02:38:26.970189Z","caller":"traceutil/trace.go:171","msg":"trace[920098183] transaction","detail":"{read_only:false; response_revision:614; number_of_response:1; }","duration":"192.4203ms","start":"2026-06-03T02:38:26.777753Z","end":"2026-06-03T02:38:26.970173Z","steps":["trace[920098183] 'process raft request' (duration: 191.98212ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T02:38:26.970749Z","caller":"traceutil/trace.go:171","msg":"trace[1770049737] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"191.519649ms","start":"2026-06-03T02:38:26.779202Z","end":"2026-06-03T02:38:26.970721Z","steps":["trace[1770049737] 'process raft request' (duration: 190.596586ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T02:38:27.96027Z","caller":"traceutil/trace.go:171","msg":"trace[1312955447] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"253.261675ms","start":"2026-06-03T02:38:27.706978Z","end":"2026-06-03T02:38:27.96024Z","steps":["trace[1312955447] 'process raft request' (duration: 164.170727ms)","trace[1312955447] 'compare' (duration: 88.926191ms)"],"step_count":2} {"level":"info","ts":"2026-06-03T02:38:27.960289Z","caller":"traceutil/trace.go:171","msg":"trace[2069936563] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"253.240695ms","start":"2026-06-03T02:38:27.707029Z","end":"2026-06-03T02:38:27.96027Z","steps":["trace[2069936563] 'process raft request' (duration: 253.166561ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T02:38:27.960443Z","caller":"traceutil/trace.go:171","msg":"trace[1284653641] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"208.095973ms","start":"2026-06-03T02:38:27.752337Z","end":"2026-06-03T02:38:27.960433Z","steps":["trace[1284653641] 'process raft request' (duration: 207.900794ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T02:38:28.349167Z","caller":"traceutil/trace.go:171","msg":"trace[1053171157] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"113.359598ms","start":"2026-06-03T02:38:28.235702Z","end":"2026-06-03T02:38:28.349062Z","steps":["trace[1053171157] 'process raft request' (duration: 112.294499ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T02:38:30.097522Z","caller":"traceutil/trace.go:171","msg":"trace[513920632] linearizableReadLoop","detail":"{readStateIndex:661; appliedIndex:660; }","duration":"390.966012ms","start":"2026-06-03T02:38:29.706526Z","end":"2026-06-03T02:38:30.097492Z","steps":["trace[513920632] 'read index received' (duration: 386.718768ms)","trace[513920632] 'applied index is now lower than readState.Index' (duration: 4.245094ms)"],"step_count":2} {"level":"warn","ts":"2026-06-03T02:38:30.098292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"391.744537ms","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-06-03T02:38:30.098369Z","caller":"traceutil/trace.go:171","msg":"trace[2074841612] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:634; }","duration":"391.877643ms","start":"2026-06-03T02:38:29.706474Z","end":"2026-06-03T02:38:30.098352Z","steps":["trace[2074841612] 'agreement among raft nodes before linearized reading' (duration: 391.5954ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T02:38:30.098356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.891338ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"warn","ts":"2026-06-03T02:38:30.098407Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T02:38:29.706453Z","time spent":"391.946366ms","remote":"127.0.0.1:53098","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-03T02:38:30.098446Z","caller":"traceutil/trace.go:171","msg":"trace[1299202432] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:634; }","duration":"132.993003ms","start":"2026-06-03T02:38:29.965434Z","end":"2026-06-03T02:38:30.098427Z","steps":["trace[1299202432] 'agreement among raft nodes before linearized reading' (duration: 132.837235ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T02:38:30.098442Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"349.9743ms","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-06-03T02:38:30.098643Z","caller":"traceutil/trace.go:171","msg":"trace[1838178746] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:634; }","duration":"350.302275ms","start":"2026-06-03T02:38:29.748325Z","end":"2026-06-03T02:38:30.098628Z","steps":["trace[1838178746] 'agreement among raft nodes before linearized reading' (duration: 349.839814ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T02:38:30.098697Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.028433ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-03T02:38:30.098724Z","caller":"traceutil/trace.go:171","msg":"trace[2100329250] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:634; }","duration":"194.083436ms","start":"2026-06-03T02:38:29.904634Z","end":"2026-06-03T02:38:30.098717Z","steps":["trace[2100329250] 'agreement among raft nodes before linearized reading' (duration: 194.044724ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T02:38:30.098802Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T02:38:29.748304Z","time spent":"350.430271ms","remote":"127.0.0.1:53098","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-06-03T02:38:30.098827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.143061ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-03T02:38:30.09922Z","caller":"traceutil/trace.go:171","msg":"trace[1175493733] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:634; }","duration":"135.34445ms","start":"2026-06-03T02:38:29.963615Z","end":"2026-06-03T02:38:30.09896Z","steps":["trace[1175493733] 'agreement among raft nodes before linearized reading' (duration: 134.944602ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T02:38:30.099289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.497977ms","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-06-03T02:38:30.0994Z","caller":"traceutil/trace.go:171","msg":"trace[917141860] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:634; }","duration":"135.622213ms","start":"2026-06-03T02:38:29.963751Z","end":"2026-06-03T02:38:30.099373Z","steps":["trace[917141860] 'agreement among raft nodes before linearized reading' (duration: 134.479311ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T02:38:33.155809Z","caller":"traceutil/trace.go:171","msg":"trace[2041222058] transaction","detail":"{read_only:false; response_revision:698; number_of_response:1; }","duration":"131.152904ms","start":"2026-06-03T02:38:33.024596Z","end":"2026-06-03T02:38:33.155749Z","steps":["trace[2041222058] 'process raft request' (duration: 77.239227ms)","trace[2041222058] 'compare' (duration: 53.707618ms)"],"step_count":2} {"level":"info","ts":"2026-06-03T02:38:33.475043Z","caller":"traceutil/trace.go:171","msg":"trace[1355267310] transaction","detail":"{read_only:false; response_revision:699; number_of_response:1; }","duration":"147.27916ms","start":"2026-06-03T02:38:33.327737Z","end":"2026-06-03T02:38:33.475017Z","steps":["trace[1355267310] 'process raft request' (duration: 147.096181ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T02:38:33.578381Z","caller":"traceutil/trace.go:171","msg":"trace[1231291269] transaction","detail":"{read_only:false; response_revision:700; number_of_response:1; }","duration":"222.837161ms","start":"2026-06-03T02:38:33.355522Z","end":"2026-06-03T02:38:33.578359Z","steps":["trace[1231291269] 'process raft request' (duration: 184.82347ms)","trace[1231291269] 'compare' (duration: 37.551541ms)"],"step_count":2} {"level":"info","ts":"2026-06-03T02:38:35.122555Z","caller":"traceutil/trace.go:171","msg":"trace[1268769998] transaction","detail":"{read_only:false; response_revision:715; number_of_response:1; }","duration":"134.351703ms","start":"2026-06-03T02:38:34.988132Z","end":"2026-06-03T02:38:35.122484Z","steps":["trace[1268769998] 'process raft request' (duration: 134.184716ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T02:38:43.060661Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.44471966s","expected-duration":"1s"} {"level":"info","ts":"2026-06-03T02:38:43.061034Z","caller":"traceutil/trace.go:171","msg":"trace[1518136951] transaction","detail":"{read_only:false; response_revision:763; number_of_response:1; }","duration":"1.44515495s","start":"2026-06-03T02:38:41.615859Z","end":"2026-06-03T02:38:43.061014Z","steps":["trace[1518136951] 'process raft request' (duration: 1.444981862s)"],"step_count":1} {"level":"warn","ts":"2026-06-03T02:38:43.061125Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T02:38:41.61584Z","time spent":"1.445237833s","remote":"127.0.0.1:52946","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4423,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-03T02:38:49.281487Z","caller":"traceutil/trace.go:171","msg":"trace[89262446] transaction","detail":"{read_only:false; response_revision:836; number_of_response:1; }","duration":"126.542374ms","start":"2026-06-03T02:38:49.154921Z","end":"2026-06-03T02:38:49.281463Z","steps":["trace[89262446] 'process raft request' (duration: 126.366177ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T02:38:49.281673Z","caller":"traceutil/trace.go:171","msg":"trace[443191776] transaction","detail":"{read_only:false; response_revision:837; number_of_response:1; }","duration":"125.644957ms","start":"2026-06-03T02:38:49.155989Z","end":"2026-06-03T02:38:49.281634Z","steps":["trace[443191776] 'process raft request' (duration: 125.423277ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T02:38:50.614398Z","caller":"traceutil/trace.go:171","msg":"trace[788377637] transaction","detail":"{read_only:false; response_revision:839; number_of_response:1; }","duration":"172.853698ms","start":"2026-06-03T02:38:50.441516Z","end":"2026-06-03T02:38:50.61437Z","steps":["trace[788377637] 'process raft request' (duration: 172.638319ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T02:38:50.966176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.622552ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-03T02:38:50.966311Z","caller":"traceutil/trace.go:171","msg":"trace[1030699821] transaction","detail":"{read_only:false; response_revision:840; number_of_response:1; }","duration":"346.81159ms","start":"2026-06-03T02:38:50.619482Z","end":"2026-06-03T02:38:50.966294Z","steps":["trace[1030699821] 'process raft request' (duration: 177.987011ms)","trace[1030699821] 'compare' (duration: 168.517506ms)"],"step_count":2} {"level":"warn","ts":"2026-06-03T02:38:50.96639Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T02:38:50.619457Z","time spent":"346.903784ms","remote":"127.0.0.1:53020","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3856,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-03T02:38:50.966703Z","caller":"traceutil/trace.go:171","msg":"trace[1337710429] transaction","detail":"{read_only:false; response_revision:841; number_of_response:1; }","duration":"346.435334ms","start":"2026-06-03T02:38:50.620256Z","end":"2026-06-03T02:38:50.966691Z","steps":["trace[1337710429] 'process raft request' (duration: 346.082239ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T02:38:50.966759Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T02:38:50.620237Z","time spent":"346.491276ms","remote":"127.0.0.1:53020","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3856,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-03T02:38:50.966928Z","caller":"traceutil/trace.go:171","msg":"trace[1153907998] transaction","detail":"{read_only:false; response_revision:842; number_of_response:1; }","duration":"343.474461ms","start":"2026-06-03T02:38:50.623427Z","end":"2026-06-03T02:38:50.966901Z","steps":["trace[1153907998] 'process raft request' (duration: 343.029473ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T02:38:50.967065Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T02:38:50.623404Z","time spent":"343.585216ms","remote":"127.0.0.1:38786","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2316,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-03T02:38:58.518259Z","caller":"traceutil/trace.go:171","msg":"trace[1057582157] transaction","detail":"{read_only:false; response_revision:941; number_of_response:1; }","duration":"260.589113ms","start":"2026-06-03T02:38:58.257644Z","end":"2026-06-03T02:38:58.518233Z","steps":["trace[1057582157] 'process raft request' (duration: 260.367955ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T02:39:04.662257Z","caller":"traceutil/trace.go:171","msg":"trace[80579550] transaction","detail":"{read_only:false; response_revision:966; number_of_response:1; }","duration":"119.820312ms","start":"2026-06-03T02:39:04.542407Z","end":"2026-06-03T02:39:04.662227Z","steps":["trace[80579550] 'process raft request' (duration: 99.087022ms)","trace[80579550] 'compare' (duration: 20.569364ms)"],"step_count":2} {"level":"info","ts":"2026-06-03T02:39:05.562479Z","caller":"traceutil/trace.go:171","msg":"trace[790370463] transaction","detail":"{read_only:false; response_revision:969; number_of_response:1; }","duration":"263.431829ms","start":"2026-06-03T02:39:05.299028Z","end":"2026-06-03T02:39:05.56246Z","steps":["trace[790370463] 'process raft request' (duration: 245.46667ms)","trace[790370463] 'compare' (duration: 17.535272ms)"],"step_count":2} {"level":"info","ts":"2026-06-03T02:39:18.86946Z","caller":"traceutil/trace.go:171","msg":"trace[1580760504] transaction","detail":"{read_only:false; response_revision:1017; number_of_response:1; }","duration":"160.274313ms","start":"2026-06-03T02:39:18.709158Z","end":"2026-06-03T02:39:18.869432Z","steps":["trace[1580760504] 'process raft request' (duration: 160.127798ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T02:39:23.780205Z","caller":"traceutil/trace.go:171","msg":"trace[1087339839] transaction","detail":"{read_only:false; response_revision:1033; number_of_response:1; }","duration":"112.325813ms","start":"2026-06-03T02:39:23.66786Z","end":"2026-06-03T02:39:23.780186Z","steps":["trace[1087339839] 'process raft request' (duration: 112.187018ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T02:39:24.648933Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.405521ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-03T02:39:24.649021Z","caller":"traceutil/trace.go:171","msg":"trace[1960720209] transaction","detail":"{read_only:false; response_revision:1036; number_of_response:1; }","duration":"189.047424ms","start":"2026-06-03T02:39:24.45996Z","end":"2026-06-03T02:39:24.649007Z","steps":["trace[1960720209] 'process raft request' (duration: 74.505808ms)","trace[1960720209] 'compare' (duration: 114.326659ms)"],"step_count":2} {"level":"info","ts":"2026-06-03T02:39:26.187513Z","caller":"traceutil/trace.go:171","msg":"trace[1694220123] linearizableReadLoop","detail":"{readStateIndex:1083; appliedIndex:1082; }","duration":"300.373757ms","start":"2026-06-03T02:39:25.887119Z","end":"2026-06-03T02:39:26.187493Z","steps":["trace[1694220123] 'read index received' (duration: 300.267173ms)","trace[1694220123] 'applied index is now lower than readState.Index' (duration: 105.794µs)"],"step_count":2} {"level":"info","ts":"2026-06-03T02:39:26.187608Z","caller":"traceutil/trace.go:171","msg":"trace[2058637767] transaction","detail":"{read_only:false; response_revision:1041; number_of_response:1; }","duration":"300.75643ms","start":"2026-06-03T02:39:25.886813Z","end":"2026-06-03T02:39:26.187569Z","steps":["trace[2058637767] 'process raft request' (duration: 300.583694ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T02:39:26.18771Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.577184ms","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-06-03T02:39:26.187742Z","caller":"traceutil/trace.go:171","msg":"trace[387373128] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1041; }","duration":"300.647816ms","start":"2026-06-03T02:39:25.887087Z","end":"2026-06-03T02:39:26.187735Z","steps":["trace[387373128] 'agreement among raft nodes before linearized reading' (duration: 300.47963ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T02:39:26.187752Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T02:39:25.886787Z","time spent":"300.891134ms","remote":"127.0.0.1:53098","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-06-03T02:39:26.187768Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T02:39:25.887075Z","time spent":"300.684767ms","remote":"127.0.0.1:53098","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-06-03T02:39:31.788073Z","caller":"traceutil/trace.go:171","msg":"trace[683862576] transaction","detail":"{read_only:false; response_revision:1059; number_of_response:1; }","duration":"177.879178ms","start":"2026-06-03T02:39:31.610161Z","end":"2026-06-03T02:39:31.788041Z","steps":["trace[683862576] 'process raft request' (duration: 91.060603ms)","trace[683862576] 'compare' (duration: 86.692561ms)"],"step_count":2} {"level":"warn","ts":"2026-06-03T02:40:28.629581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"385.014263ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-03T02:40:28.62967Z","caller":"traceutil/trace.go:171","msg":"trace[1095221446] range","detail":"{range_begin:/registry/endpointslices/; range_end:/registry/endpointslices0; response_count:0; response_revision:1275; }","duration":"385.166658ms","start":"2026-06-03T02:40:28.244485Z","end":"2026-06-03T02:40:28.629651Z","steps":["trace[1095221446] 'count revisions from in-memory index tree' (duration: 384.932951ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T02:40:28.629713Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T02:40:28.244465Z","time spent":"385.23699ms","remote":"127.0.0.1:53102","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":3,"response size":30,"request content":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true "} {"level":"info","ts":"2026-06-03T02:40:28.62992Z","caller":"traceutil/trace.go:171","msg":"trace[1087355630] linearizableReadLoop","detail":"{readStateIndex:1332; appliedIndex:1331; }","duration":"282.226088ms","start":"2026-06-03T02:40:28.347663Z","end":"2026-06-03T02:40:28.629889Z","steps":["trace[1087355630] 'read index received' (duration: 190.497509ms)","trace[1087355630] 'applied index is now lower than readState.Index' (duration: 91.726799ms)"],"step_count":2} {"level":"info","ts":"2026-06-03T02:40:28.630083Z","caller":"traceutil/trace.go:171","msg":"trace[715318287] transaction","detail":"{read_only:false; response_revision:1276; number_of_response:1; }","duration":"369.729706ms","start":"2026-06-03T02:40:28.260329Z","end":"2026-06-03T02:40:28.630059Z","steps":["trace[715318287] 'process raft request' (duration: 277.774921ms)","trace[715318287] 'compare' (duration: 90.952476ms)"],"step_count":2} {"level":"warn","ts":"2026-06-03T02:40:28.630255Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T02:40:28.260307Z","time spent":"369.834928ms","remote":"127.0.0.1:53098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-03T02:40:28.630327Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.65287ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-06-03T02:40:28.630318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.249414ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-03T02:40:28.630379Z","caller":"traceutil/trace.go:171","msg":"trace[1641777828] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1276; }","duration":"282.736383ms","start":"2026-06-03T02:40:28.347626Z","end":"2026-06-03T02:40:28.630363Z","steps":["trace[1641777828] 'agreement among raft nodes before linearized reading' (duration: 282.504736ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T02:40:28.630391Z","caller":"traceutil/trace.go:171","msg":"trace[1162580834] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:1276; }","duration":"181.398529ms","start":"2026-06-03T02:40:28.448975Z","end":"2026-06-03T02:40:28.630373Z","steps":["trace[1162580834] 'agreement among raft nodes before linearized reading' (duration: 181.173152ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T02:40:36.260135Z","caller":"traceutil/trace.go:171","msg":"trace[1861185281] transaction","detail":"{read_only:false; response_revision:1308; number_of_response:1; }","duration":"128.485215ms","start":"2026-06-03T02:40:36.131626Z","end":"2026-06-03T02:40:36.260111Z","steps":["trace[1861185281] 'process raft request' (duration: 128.327511ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T02:40:36.773499Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.195293ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-06-03T02:40:36.773511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.269771ms","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-06-03T02:40:36.773594Z","caller":"traceutil/trace.go:171","msg":"trace[1516804299] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1308; }","duration":"105.333157ms","start":"2026-06-03T02:40:36.668239Z","end":"2026-06-03T02:40:36.773572Z","steps":["trace[1516804299] 'range keys from in-memory index tree' (duration: 104.970616ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T02:40:36.773607Z","caller":"traceutil/trace.go:171","msg":"trace[1833206689] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1308; }","duration":"102.408865ms","start":"2026-06-03T02:40:36.671179Z","end":"2026-06-03T02:40:36.773588Z","steps":["trace[1833206689] 'range keys from in-memory index tree' (duration: 102.084816ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T02:40:37.994902Z","caller":"traceutil/trace.go:171","msg":"trace[65750248] transaction","detail":"{read_only:false; response_revision:1312; number_of_response:1; }","duration":"663.007825ms","start":"2026-06-03T02:40:37.331861Z","end":"2026-06-03T02:40:37.994869Z","steps":["trace[65750248] 'process raft request' (duration: 662.81158ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T02:40:37.995079Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T02:40:37.331835Z","time spent":"663.15715ms","remote":"127.0.0.1:53098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-03T02:40:38.150566Z","caller":"traceutil/trace.go:171","msg":"trace[32695406] transaction","detail":"{read_only:false; response_revision:1313; number_of_response:1; }","duration":"151.546096ms","start":"2026-06-03T02:40:37.998992Z","end":"2026-06-03T02:40:38.150538Z","steps":["trace[32695406] 'process raft request' (duration: 111.355648ms)","trace[32695406] 'compare' (duration: 40.078945ms)"],"step_count":2}