{"level":"warn","ts":"2026-10-04T01:27:09.504284Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-04T01:27:09.50446Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.27: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://162.253.55.27:2380","--initial-cluster=instance=https://162.253.55.27:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.27:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.27:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-10-04T01:27:09.504559Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-04T01:27:09.504605Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.27:2380"]} {"level":"info","ts":"2026-10-04T01:27:09.504637Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-10-04T01:27:09.505336Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.27:2379"]} {"level":"info","ts":"2026-10-04T01:27:09.505482Z","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://162.253.55.27:2380"],"listen-peer-urls":["https://162.253.55.27:2380"],"advertise-client-urls":["https://162.253.55.27:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.27:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.27:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-10-04T01:27:09.508Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.200989ms"} {"level":"info","ts":"2026-10-04T01:27:09.516164Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"d9b565cb482924cf","cluster-id":"5bc3f8d4cf836b6c"} {"level":"info","ts":"2026-10-04T01:27:09.516254Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d9b565cb482924cf switched to configuration voters=()"} {"level":"info","ts":"2026-10-04T01:27:09.516276Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d9b565cb482924cf became follower at term 0"} {"level":"info","ts":"2026-10-04T01:27:09.516284Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft d9b565cb482924cf [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-10-04T01:27:09.516296Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d9b565cb482924cf became follower at term 1"} {"level":"info","ts":"2026-10-04T01:27:09.516363Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d9b565cb482924cf switched to configuration voters=(15687556800778413263)"} {"level":"warn","ts":"2026-10-04T01:27:09.521954Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-10-04T01:27:09.523387Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-10-04T01:27:09.524783Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-10-04T01:27:09.526961Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"d9b565cb482924cf","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-10-04T01:27:09.527222Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"d9b565cb482924cf","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-10-04T01:27:09.527239Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-10-04T01:27:09.527421Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-10-04T01:27:09.527445Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-10-04T01:27:09.528138Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d9b565cb482924cf switched to configuration voters=(15687556800778413263)"} {"level":"info","ts":"2026-10-04T01:27:09.528502Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"5bc3f8d4cf836b6c","local-member-id":"d9b565cb482924cf","added-peer-id":"d9b565cb482924cf","added-peer-peer-urls":["https://162.253.55.27:2380"]} {"level":"info","ts":"2026-10-04T01:27:09.530875Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-10-04T01:27:09.531008Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.27:2380"} {"level":"info","ts":"2026-10-04T01:27:09.531052Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.27:2380"} {"level":"info","ts":"2026-10-04T01:27:09.531392Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"d9b565cb482924cf","initial-advertise-peer-urls":["https://162.253.55.27:2380"],"listen-peer-urls":["https://162.253.55.27:2380"],"advertise-client-urls":["https://162.253.55.27:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.27:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-10-04T01:27:09.531449Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-10-04T01:27:10.317228Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d9b565cb482924cf is starting a new election at term 1"} {"level":"info","ts":"2026-10-04T01:27:10.317286Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d9b565cb482924cf became pre-candidate at term 1"} {"level":"info","ts":"2026-10-04T01:27:10.317341Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d9b565cb482924cf received MsgPreVoteResp from d9b565cb482924cf at term 1"} {"level":"info","ts":"2026-10-04T01:27:10.31737Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d9b565cb482924cf became candidate at term 2"} {"level":"info","ts":"2026-10-04T01:27:10.317386Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d9b565cb482924cf received MsgVoteResp from d9b565cb482924cf at term 2"} {"level":"info","ts":"2026-10-04T01:27:10.317401Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d9b565cb482924cf became leader at term 2"} {"level":"info","ts":"2026-10-04T01:27:10.317418Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: d9b565cb482924cf elected leader d9b565cb482924cf at term 2"} {"level":"info","ts":"2026-10-04T01:27:10.318745Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"d9b565cb482924cf","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.27:2379]}","request-path":"/0/members/d9b565cb482924cf/attributes","cluster-id":"5bc3f8d4cf836b6c","publish-timeout":"7s"} {"level":"info","ts":"2026-10-04T01:27:10.318781Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-10-04T01:27:10.319Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-04T01:27:10.31907Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-04T01:27:10.319414Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-10-04T01:27:10.319503Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-10-04T01:27:10.320783Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"5bc3f8d4cf836b6c","local-member-id":"d9b565cb482924cf","cluster-version":"3.5"} {"level":"info","ts":"2026-10-04T01:27:10.320933Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-10-04T01:27:10.32097Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-10-04T01:27:10.322868Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-10-04T01:27:10.323428Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.27:2379"} {"level":"warn","ts":"2026-10-04T01:27:17.637062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"607.309915ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-04T01:27:17.637156Z","caller":"traceutil/trace.go:171","msg":"trace[1695259972] linearizableReadLoop","detail":"{readStateIndex:288; appliedIndex:287; }","duration":"979.229443ms","start":"2026-10-04T01:27:16.657913Z","end":"2026-10-04T01:27:17.637142Z","steps":["trace[1695259972] 'read index received' (duration: 371.207513ms)","trace[1695259972] 'applied index is now lower than readState.Index' (duration: 608.02052ms)"],"step_count":2} {"level":"info","ts":"2026-10-04T01:27:17.637399Z","caller":"traceutil/trace.go:171","msg":"trace[1658544374] transaction","detail":"{read_only:false; response_revision:275; number_of_response:1; }","duration":"1.026868104s","start":"2026-10-04T01:27:16.610519Z","end":"2026-10-04T01:27:17.637387Z","steps":["trace[1658544374] 'process raft request' (duration: 418.62254ms)","trace[1658544374] 'compare' (duration: 607.213612ms)"],"step_count":2} {"level":"warn","ts":"2026-10-04T01:27:17.637463Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T01:27:16.610504Z","time spent":"1.026926826s","remote":"127.0.0.1:50014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6736,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-04T01:27:17.637638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"979.730105ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-10-04T01:27:17.637663Z","caller":"traceutil/trace.go:171","msg":"trace[227352185] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:275; }","duration":"979.784016ms","start":"2026-10-04T01:27:16.65787Z","end":"2026-10-04T01:27:17.637654Z","steps":["trace[227352185] 'agreement among raft nodes before linearized reading' (duration: 979.736195ms)"],"step_count":1} {"level":"warn","ts":"2026-10-04T01:27:17.637687Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T01:27:16.657855Z","time spent":"979.826577ms","remote":"127.0.0.1:49952","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":374,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-10-04T01:27:17.637832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"771.216418ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-10-04T01:27:17.637856Z","caller":"traceutil/trace.go:171","msg":"trace[1589453932] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:275; }","duration":"771.273099ms","start":"2026-10-04T01:27:16.866575Z","end":"2026-10-04T01:27:17.637848Z","steps":["trace[1589453932] 'agreement among raft nodes before linearized reading' (duration: 771.232269ms)"],"step_count":1} {"level":"warn","ts":"2026-10-04T01:27:17.637878Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T01:27:16.866552Z","time spent":"771.32065ms","remote":"127.0.0.1:50102","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-10-04T01:27:18.822293Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"782.547061ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-10-04T01:27:18.82257Z","caller":"traceutil/trace.go:171","msg":"trace[1620936138] transaction","detail":"{read_only:false; response_revision:277; number_of_response:1; }","duration":"1.178860593s","start":"2026-10-04T01:27:17.643692Z","end":"2026-10-04T01:27:18.822553Z","steps":["trace[1620936138] 'process raft request' (duration: 1.178697859s)"],"step_count":1} {"level":"info","ts":"2026-10-04T01:27:18.82263Z","caller":"traceutil/trace.go:171","msg":"trace[922737612] transaction","detail":"{read_only:false; response_revision:276; number_of_response:1; }","duration":"1.180997491s","start":"2026-10-04T01:27:17.64159Z","end":"2026-10-04T01:27:18.822587Z","steps":["trace[922737612] 'process raft request' (duration: 398.087573ms)","trace[922737612] 'compare' (duration: 782.418147ms)"],"step_count":2} {"level":"info","ts":"2026-10-04T01:27:18.822665Z","caller":"traceutil/trace.go:171","msg":"trace[1021654449] transaction","detail":"{read_only:false; response_revision:278; number_of_response:1; }","duration":"1.178712309s","start":"2026-10-04T01:27:17.643878Z","end":"2026-10-04T01:27:18.822591Z","steps":["trace[1021654449] 'process raft request' (duration: 1.178566386s)"],"step_count":1} {"level":"warn","ts":"2026-10-04T01:27:18.823115Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T01:27:17.643871Z","time spent":"1.179144839s","remote":"127.0.0.1:50102","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-04T01:27:18.822797Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T01:27:17.64157Z","time spent":"1.181151273s","remote":"127.0.0.1:50034","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":199,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-04T01:27:18.822672Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T01:27:17.64367Z","time spent":"1.178962125s","remote":"127.0.0.1:50102","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-10-04T01:27:18.823422Z","caller":"traceutil/trace.go:171","msg":"trace[322891138] linearizableReadLoop","detail":"{readStateIndex:292; appliedIndex:288; }","duration":"943.933787ms","start":"2026-10-04T01:27:17.879474Z","end":"2026-10-04T01:27:18.823408Z","steps":["trace[322891138] 'read index received' (duration: 160.332313ms)","trace[322891138] 'applied index is now lower than readState.Index' (duration: 783.600454ms)"],"step_count":2} {"level":"warn","ts":"2026-10-04T01:27:18.823523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"944.04645ms","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-10-04T01:27:18.824174Z","caller":"traceutil/trace.go:171","msg":"trace[1914256623] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:279; }","duration":"944.719414ms","start":"2026-10-04T01:27:17.87944Z","end":"2026-10-04T01:27:18.824159Z","steps":["trace[1914256623] 'agreement among raft nodes before linearized reading' (duration: 944.009139ms)"],"step_count":1} {"level":"warn","ts":"2026-10-04T01:27:18.824216Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T01:27:17.879425Z","time spent":"944.779065ms","remote":"127.0.0.1:50102","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-10-04T01:27:18.823497Z","caller":"traceutil/trace.go:171","msg":"trace[1419826397] transaction","detail":"{read_only:false; response_revision:279; number_of_response:1; }","duration":"1.174843054s","start":"2026-10-04T01:27:17.648627Z","end":"2026-10-04T01:27:18.82347Z","steps":["trace[1419826397] 'process raft request' (duration: 1.173880162s)"],"step_count":1} {"level":"warn","ts":"2026-10-04T01:27:18.824364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"638.9918ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"warn","ts":"2026-10-04T01:27:18.824443Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T01:27:17.648609Z","time spent":"1.175768103s","remote":"127.0.0.1:50014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7087,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-04T01:27:18.824493Z","caller":"traceutil/trace.go:171","msg":"trace[1881041094] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:279; }","duration":"639.096993ms","start":"2026-10-04T01:27:18.185303Z","end":"2026-10-04T01:27:18.8244Z","steps":["trace[1881041094] 'agreement among raft nodes before linearized reading' (duration: 638.874948ms)"],"step_count":1} {"level":"warn","ts":"2026-10-04T01:27:18.824632Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T01:27:18.185283Z","time spent":"639.336217ms","remote":"127.0.0.1:50102","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-10-04T01:27:47.178415Z","caller":"traceutil/trace.go:171","msg":"trace[1929496282] linearizableReadLoop","detail":"{readStateIndex:502; appliedIndex:501; }","duration":"207.639967ms","start":"2026-10-04T01:27:46.970751Z","end":"2026-10-04T01:27:47.178391Z","steps":["trace[1929496282] 'read index received' (duration: 207.420802ms)","trace[1929496282] 'applied index is now lower than readState.Index' (duration: 218.405µs)"],"step_count":2} {"level":"info","ts":"2026-10-04T01:27:47.17848Z","caller":"traceutil/trace.go:171","msg":"trace[178234861] transaction","detail":"{read_only:false; response_revision:483; number_of_response:1; }","duration":"220.888793ms","start":"2026-10-04T01:27:46.95756Z","end":"2026-10-04T01:27:47.178449Z","steps":["trace[178234861] 'process raft request' (duration: 220.662348ms)"],"step_count":1} {"level":"warn","ts":"2026-10-04T01:27:47.178599Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.836782ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-10-04T01:27:47.178639Z","caller":"traceutil/trace.go:171","msg":"trace[1113826746] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:483; }","duration":"207.941444ms","start":"2026-10-04T01:27:46.970687Z","end":"2026-10-04T01:27:47.178628Z","steps":["trace[1113826746] 'agreement among raft nodes before linearized reading' (duration: 207.843502ms)"],"step_count":1} {"level":"warn","ts":"2026-10-04T01:27:47.179409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.18072ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-10-04T01:27:47.17948Z","caller":"traceutil/trace.go:171","msg":"trace[1108686983] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:483; }","duration":"204.260322ms","start":"2026-10-04T01:27:46.975181Z","end":"2026-10-04T01:27:47.179442Z","steps":["trace[1108686983] 'agreement among raft nodes before linearized reading' (duration: 204.15284ms)"],"step_count":1} {"level":"warn","ts":"2026-10-04T01:27:47.179763Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.024732ms","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-10-04T01:27:47.179854Z","caller":"traceutil/trace.go:171","msg":"trace[2130652513] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:483; }","duration":"202.149345ms","start":"2026-10-04T01:27:46.977695Z","end":"2026-10-04T01:27:47.179845Z","steps":["trace[2130652513] 'agreement among raft nodes before linearized reading' (duration: 201.90483ms)"],"step_count":1} {"level":"warn","ts":"2026-10-04T01:27:47.461824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.991092ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-04T01:27:47.461922Z","caller":"traceutil/trace.go:171","msg":"trace[575521905] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:0; response_revision:486; }","duration":"185.152717ms","start":"2026-10-04T01:27:47.276748Z","end":"2026-10-04T01:27:47.461901Z","steps":["trace[575521905] 'range keys from in-memory index tree' (duration: 184.91216ms)"],"step_count":1} {"level":"info","ts":"2026-10-04T01:27:47.806645Z","caller":"traceutil/trace.go:171","msg":"trace[1410927769] transaction","detail":"{read_only:false; response_revision:487; number_of_response:1; }","duration":"109.663662ms","start":"2026-10-04T01:27:47.69696Z","end":"2026-10-04T01:27:47.806624Z","steps":["trace[1410927769] 'process raft request' (duration: 109.499388ms)"],"step_count":1} {"level":"info","ts":"2026-10-04T01:27:47.875876Z","caller":"traceutil/trace.go:171","msg":"trace[1356882855] transaction","detail":"{read_only:false; response_revision:488; number_of_response:1; }","duration":"176.776755ms","start":"2026-10-04T01:27:47.699076Z","end":"2026-10-04T01:27:47.875853Z","steps":["trace[1356882855] 'process raft request' (duration: 175.658529ms)"],"step_count":1} {"level":"info","ts":"2026-10-04T01:27:47.875917Z","caller":"traceutil/trace.go:171","msg":"trace[1839222529] transaction","detail":"{read_only:false; response_revision:490; number_of_response:1; }","duration":"157.972556ms","start":"2026-10-04T01:27:47.717918Z","end":"2026-10-04T01:27:47.87589Z","steps":["trace[1839222529] 'process raft request' (duration: 157.896545ms)"],"step_count":1} {"level":"info","ts":"2026-10-04T01:27:47.876103Z","caller":"traceutil/trace.go:171","msg":"trace[134064137] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"157.064926ms","start":"2026-10-04T01:27:47.719032Z","end":"2026-10-04T01:27:47.876097Z","steps":["trace[134064137] 'process raft request' (duration: 156.922223ms)"],"step_count":1} {"level":"info","ts":"2026-10-04T01:27:47.876131Z","caller":"traceutil/trace.go:171","msg":"trace[356578722] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"114.637891ms","start":"2026-10-04T01:27:47.761477Z","end":"2026-10-04T01:27:47.876115Z","steps":["trace[356578722] 'process raft request' (duration: 114.608041ms)"],"step_count":1} {"level":"info","ts":"2026-10-04T01:27:47.875892Z","caller":"traceutil/trace.go:171","msg":"trace[1186796243] transaction","detail":"{read_only:false; response_revision:489; number_of_response:1; }","duration":"167.007708ms","start":"2026-10-04T01:27:47.708855Z","end":"2026-10-04T01:27:47.875862Z","steps":["trace[1186796243] 'process raft request' (duration: 166.938586ms)"],"step_count":1} {"level":"info","ts":"2026-10-04T01:27:47.876216Z","caller":"traceutil/trace.go:171","msg":"trace[1589622322] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"158.142629ms","start":"2026-10-04T01:27:47.71806Z","end":"2026-10-04T01:27:47.876202Z","steps":["trace[1589622322] 'process raft request' (duration: 157.799372ms)"],"step_count":1} {"level":"info","ts":"2026-10-04T01:27:47.876268Z","caller":"traceutil/trace.go:171","msg":"trace[1810757449] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"124.198675ms","start":"2026-10-04T01:27:47.752064Z","end":"2026-10-04T01:27:47.876263Z","steps":["trace[1810757449] 'process raft request' (duration: 123.98539ms)"],"step_count":1} {"level":"info","ts":"2026-10-04T01:27:47.876268Z","caller":"traceutil/trace.go:171","msg":"trace[742829493] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"142.899311ms","start":"2026-10-04T01:27:47.733357Z","end":"2026-10-04T01:27:47.876256Z","steps":["trace[742829493] 'process raft request' (duration: 142.660646ms)"],"step_count":1} {"level":"info","ts":"2026-10-04T01:27:47.876252Z","caller":"traceutil/trace.go:171","msg":"trace[620496242] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"153.000466ms","start":"2026-10-04T01:27:47.723245Z","end":"2026-10-04T01:27:47.876245Z","steps":["trace[620496242] 'process raft request' (duration: 152.746971ms)"],"step_count":1} {"level":"info","ts":"2026-10-04T01:27:47.876304Z","caller":"traceutil/trace.go:171","msg":"trace[2057738420] transaction","detail":"{read_only:false; response_revision:492; number_of_response:1; }","duration":"158.258844ms","start":"2026-10-04T01:27:47.718039Z","end":"2026-10-04T01:27:47.876298Z","steps":["trace[2057738420] 'process raft request' (duration: 157.856665ms)"],"step_count":1} {"level":"info","ts":"2026-10-04T01:27:53.856249Z","caller":"traceutil/trace.go:171","msg":"trace[676761005] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"590.371962ms","start":"2026-10-04T01:27:53.265836Z","end":"2026-10-04T01:27:53.856208Z","steps":["trace[676761005] 'process raft request' (duration: 586.619639ms)"],"step_count":1} {"level":"warn","ts":"2026-10-04T01:27:53.856506Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T01:27:53.265808Z","time spent":"590.526176ms","remote":"127.0.0.1:50102","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-10-04T01:27:53.869817Z","caller":"traceutil/trace.go:171","msg":"trace[1948260678] transaction","detail":"{read_only:false; response_revision:584; number_of_response:1; }","duration":"603.842552ms","start":"2026-10-04T01:27:53.265947Z","end":"2026-10-04T01:27:53.869789Z","steps":["trace[1948260678] 'process raft request' (duration: 603.358822ms)"],"step_count":1} {"level":"warn","ts":"2026-10-04T01:27:53.870041Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T01:27:53.265927Z","time spent":"603.953364ms","remote":"127.0.0.1:50102","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-10-04T01:27:53.870379Z","caller":"traceutil/trace.go:171","msg":"trace[2084208462] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"604.209411ms","start":"2026-10-04T01:27:53.266063Z","end":"2026-10-04T01:27:53.870273Z","steps":["trace[2084208462] 'process raft request' (duration: 603.424163ms)"],"step_count":1} {"level":"info","ts":"2026-10-04T01:27:53.870592Z","caller":"traceutil/trace.go:171","msg":"trace[1024864360] transaction","detail":"{read_only:false; response_revision:586; number_of_response:1; }","duration":"604.352064ms","start":"2026-10-04T01:27:53.266205Z","end":"2026-10-04T01:27:53.870557Z","steps":["trace[1024864360] 'process raft request' (duration: 603.699619ms)"],"step_count":1} {"level":"warn","ts":"2026-10-04T01:27:53.870711Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T01:27:53.266137Z","time spent":"604.525258ms","remote":"127.0.0.1:50102","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-04T01:27:53.870755Z","caller":"traceutil/trace.go:171","msg":"trace[494722636] linearizableReadLoop","detail":"{readStateIndex:612; appliedIndex:607; }","duration":"340.305356ms","start":"2026-10-04T01:27:53.530392Z","end":"2026-10-04T01:27:53.870698Z","steps":["trace[494722636] 'read index received' (duration: 322.135871ms)","trace[494722636] 'applied index is now lower than readState.Index' (duration: 18.168565ms)"],"step_count":2} {"level":"warn","ts":"2026-10-04T01:27:53.870864Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T01:27:53.266048Z","time spent":"604.420606ms","remote":"127.0.0.1:50102","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-04T01:27:53.870879Z","caller":"traceutil/trace.go:171","msg":"trace[812244194] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"600.984498ms","start":"2026-10-04T01:27:53.269876Z","end":"2026-10-04T01:27:53.870861Z","steps":["trace[812244194] 'process raft request' (duration: 600.293342ms)"],"step_count":1} {"level":"warn","ts":"2026-10-04T01:27:53.871083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.693374ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.27\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-10-04T01:27:53.871135Z","caller":"traceutil/trace.go:171","msg":"trace[791188908] range","detail":"{range_begin:/registry/masterleases/162.253.55.27; range_end:; response_count:1; response_revision:587; }","duration":"340.786996ms","start":"2026-10-04T01:27:53.530332Z","end":"2026-10-04T01:27:53.871119Z","steps":["trace[791188908] 'agreement among raft nodes before linearized reading' (duration: 340.572071ms)"],"step_count":1} {"level":"warn","ts":"2026-10-04T01:27:53.871154Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.127519ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-04T01:27:53.871184Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T01:27:53.53031Z","time spent":"340.862958ms","remote":"127.0.0.1:49872","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/162.253.55.27\" "} {"level":"info","ts":"2026-10-04T01:27:53.871394Z","caller":"traceutil/trace.go:171","msg":"trace[865872264] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:587; }","duration":"215.310153ms","start":"2026-10-04T01:27:53.655961Z","end":"2026-10-04T01:27:53.871271Z","steps":["trace[865872264] 'agreement among raft nodes before linearized reading' (duration: 215.14895ms)"],"step_count":1} {"level":"warn","ts":"2026-10-04T01:27:53.871407Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T01:27:53.269859Z","time spent":"601.256355ms","remote":"127.0.0.1:49938","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036257,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-04T01:27:54.931383Z","caller":"traceutil/trace.go:171","msg":"trace[1907413406] linearizableReadLoop","detail":"{readStateIndex:619; appliedIndex:618; }","duration":"359.658337ms","start":"2026-10-04T01:27:54.5717Z","end":"2026-10-04T01:27:54.931358Z","steps":["trace[1907413406] 'read index received' (duration: 358.802629ms)","trace[1907413406] 'applied index is now lower than readState.Index' (duration: 854.738µs)"],"step_count":2} {"level":"warn","ts":"2026-10-04T01:27:54.931562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"359.840701ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-ldz5x\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-10-04T01:27:54.931593Z","caller":"traceutil/trace.go:171","msg":"trace[1197870720] range","detail":"{range_begin:/registry/pods/kube-system/cilium-ldz5x; range_end:; response_count:1; response_revision:593; }","duration":"359.922853ms","start":"2026-10-04T01:27:54.571661Z","end":"2026-10-04T01:27:54.931584Z","steps":["trace[1197870720] 'agreement among raft nodes before linearized reading' (duration: 359.785089ms)"],"step_count":1} {"level":"warn","ts":"2026-10-04T01:27:54.931623Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T01:27:54.571643Z","time spent":"359.973365ms","remote":"127.0.0.1:50014","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16984,"request content":"key:\"/registry/pods/kube-system/cilium-ldz5x\" "} {"level":"info","ts":"2026-10-04T01:27:54.93177Z","caller":"traceutil/trace.go:171","msg":"trace[883123581] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"523.204708ms","start":"2026-10-04T01:27:54.408519Z","end":"2026-10-04T01:27:54.931724Z","steps":["trace[883123581] 'process raft request' (duration: 522.220166ms)"],"step_count":1} {"level":"warn","ts":"2026-10-04T01:27:54.931953Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T01:27:54.40849Z","time spent":"523.369841ms","remote":"127.0.0.1:49938","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036289,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-04T01:27:55.779328Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"761.549653ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-04T01:27:55.779437Z","caller":"traceutil/trace.go:171","msg":"trace[243029346] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"831.319727ms","start":"2026-10-04T01:27:54.948094Z","end":"2026-10-04T01:27:55.779414Z","steps":["trace[243029346] 'process raft request' (duration: 69.61044ms)","trace[243029346] 'compare' (duration: 761.40495ms)"],"step_count":2} {"level":"warn","ts":"2026-10-04T01:27:55.779515Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T01:27:54.948067Z","time spent":"831.411799ms","remote":"127.0.0.1:50014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-04T01:27:56.064229Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.046470526s","expected-duration":"1s"} {"level":"warn","ts":"2026-10-04T01:27:56.487355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"422.728931ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-10-04T01:27:56.488348Z","caller":"traceutil/trace.go:171","msg":"trace[528581399] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"332.830309ms","start":"2026-10-04T01:27:56.1555Z","end":"2026-10-04T01:27:56.488331Z","steps":["trace[528581399] 'process raft request' (duration: 332.733097ms)"],"step_count":1} {"level":"info","ts":"2026-10-04T01:27:56.488379Z","caller":"traceutil/trace.go:171","msg":"trace[600742659] linearizableReadLoop","detail":"{readStateIndex:621; appliedIndex:620; }","duration":"832.402211ms","start":"2026-10-04T01:27:55.655948Z","end":"2026-10-04T01:27:56.48835Z","steps":["trace[600742659] 'read index received' (duration: 408.481204ms)","trace[600742659] 'applied index is now lower than readState.Index' (duration: 423.918827ms)"],"step_count":2} {"level":"info","ts":"2026-10-04T01:27:56.488402Z","caller":"traceutil/trace.go:171","msg":"trace[2117737407] transaction","detail":"{read_only:false; response_revision:595; number_of_response:1; }","duration":"1.4950047s","start":"2026-10-04T01:27:54.993369Z","end":"2026-10-04T01:27:56.488374Z","steps":["trace[2117737407] 'process raft request' (duration: 1.071193366s)","trace[2117737407] 'compare' (duration: 422.492315ms)"],"step_count":2} {"level":"warn","ts":"2026-10-04T01:27:56.48856Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T01:27:54.99334Z","time spent":"1.495143723s","remote":"127.0.0.1:50352","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-10-04T01:27:56.48857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"832.618796ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-04T01:27:56.488713Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"702.277974ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-ldz5x\" ","response":"range_response_count:1 size:17145"} {"level":"info","ts":"2026-10-04T01:27:56.488678Z","caller":"traceutil/trace.go:171","msg":"trace[1423183970] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:596; }","duration":"832.769979ms","start":"2026-10-04T01:27:55.655888Z","end":"2026-10-04T01:27:56.488658Z","steps":["trace[1423183970] 'agreement among raft nodes before linearized reading' (duration: 832.628066ms)"],"step_count":1} {"level":"warn","ts":"2026-10-04T01:27:56.488753Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"613.374215ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-10-04T01:27:56.488786Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T01:27:55.655868Z","time spent":"832.900353ms","remote":"127.0.0.1:49822","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-10-04T01:27:56.48881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"625.648908ms","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-10-04T01:27:56.488833Z","caller":"traceutil/trace.go:171","msg":"trace[381389265] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:596; }","duration":"625.71309ms","start":"2026-10-04T01:27:55.863112Z","end":"2026-10-04T01:27:56.488825Z","steps":["trace[381389265] 'agreement among raft nodes before linearized reading' (duration: 625.644638ms)"],"step_count":1} {"level":"info","ts":"2026-10-04T01:27:56.488838Z","caller":"traceutil/trace.go:171","msg":"trace[35306972] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:596; }","duration":"613.472477ms","start":"2026-10-04T01:27:55.875321Z","end":"2026-10-04T01:27:56.488794Z","steps":["trace[35306972] 'agreement among raft nodes before linearized reading' (duration: 613.291813ms)"],"step_count":1} {"level":"warn","ts":"2026-10-04T01:27:56.488857Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T01:27:55.86309Z","time spent":"625.76066ms","remote":"127.0.0.1:50102","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-10-04T01:27:56.488742Z","caller":"traceutil/trace.go:171","msg":"trace[1328876216] range","detail":"{range_begin:/registry/pods/kube-system/cilium-ldz5x; range_end:; response_count:1; response_revision:596; }","duration":"702.338646ms","start":"2026-10-04T01:27:55.786393Z","end":"2026-10-04T01:27:56.488732Z","steps":["trace[1328876216] 'agreement among raft nodes before linearized reading' (duration: 702.215353ms)"],"step_count":1} {"level":"warn","ts":"2026-10-04T01:27:56.488859Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"615.253827ms","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-10-04T01:27:56.488885Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T01:27:55.875304Z","time spent":"613.568049ms","remote":"127.0.0.1:50102","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-10-04T01:27:56.488928Z","caller":"traceutil/trace.go:171","msg":"trace[576037008] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:596; }","duration":"615.34751ms","start":"2026-10-04T01:27:55.87356Z","end":"2026-10-04T01:27:56.488907Z","steps":["trace[576037008] 'agreement among raft nodes before linearized reading' (duration: 615.160206ms)"],"step_count":1} {"level":"warn","ts":"2026-10-04T01:27:56.488921Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T01:27:55.786374Z","time spent":"702.526109ms","remote":"127.0.0.1:50014","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":17168,"request content":"key:\"/registry/pods/kube-system/cilium-ldz5x\" "} {"level":"warn","ts":"2026-10-04T01:27:56.489066Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"613.200511ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-10-04T01:27:56.489099Z","caller":"traceutil/trace.go:171","msg":"trace[58169944] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:596; }","duration":"613.252513ms","start":"2026-10-04T01:27:55.875837Z","end":"2026-10-04T01:27:56.48909Z","steps":["trace[58169944] 'agreement among raft nodes before linearized reading' (duration: 612.827403ms)"],"step_count":1} {"level":"warn","ts":"2026-10-04T01:27:56.489126Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T01:27:55.875825Z","time spent":"613.293413ms","remote":"127.0.0.1:50102","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-10-04T01:27:56.489377Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T01:27:55.873548Z","time spent":"615.81906ms","remote":"127.0.0.1:50102","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-10-04T01:27:56.48843Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T01:27:56.155466Z","time spent":"332.91758ms","remote":"127.0.0.1:50102","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-04T01:27:58.156078Z","caller":"traceutil/trace.go:171","msg":"trace[1083532769] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"359.718817ms","start":"2026-10-04T01:27:57.796336Z","end":"2026-10-04T01:27:58.156055Z","steps":["trace[1083532769] 'process raft request' (duration: 359.550373ms)"],"step_count":1} {"level":"warn","ts":"2026-10-04T01:27:58.156217Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T01:27:57.796315Z","time spent":"359.83921ms","remote":"127.0.0.1:49912","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":763,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-04T01:28:11.390587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"734.776758ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-04T01:28:11.390673Z","caller":"traceutil/trace.go:171","msg":"trace[172015467] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:747; }","duration":"734.89978ms","start":"2026-10-04T01:28:10.655753Z","end":"2026-10-04T01:28:11.390653Z","steps":["trace[172015467] 'range keys from in-memory index tree' (duration: 734.706296ms)"],"step_count":1} {"level":"warn","ts":"2026-10-04T01:28:11.39077Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T01:28:10.65574Z","time spent":"735.016312ms","remote":"127.0.0.1:49822","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-10-04T01:28:11.39084Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"721.423379ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-rgn2r\" ","response":"range_response_count:1 size:3964"} {"level":"info","ts":"2026-10-04T01:28:11.390907Z","caller":"traceutil/trace.go:171","msg":"trace[2115763395] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-rgn2r; range_end:; response_count:1; response_revision:747; }","duration":"721.523772ms","start":"2026-10-04T01:28:10.669365Z","end":"2026-10-04T01:28:11.390889Z","steps":["trace[2115763395] 'range keys from in-memory index tree' (duration: 721.280986ms)"],"step_count":1} {"level":"warn","ts":"2026-10-04T01:28:11.390946Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T01:28:10.66935Z","time spent":"721.586603ms","remote":"127.0.0.1:50014","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3987,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-rgn2r\" "} {"level":"warn","ts":"2026-10-04T01:28:11.390929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"809.682474ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-10-04T01:28:11.391048Z","caller":"traceutil/trace.go:171","msg":"trace[1690613145] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:747; }","duration":"809.830628ms","start":"2026-10-04T01:28:10.581178Z","end":"2026-10-04T01:28:11.391008Z","steps":["trace[1690613145] 'range keys from in-memory index tree' (duration: 809.52226ms)"],"step_count":1} {"level":"warn","ts":"2026-10-04T01:28:11.391062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"832.529694ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-10-04T01:28:11.391159Z","caller":"traceutil/trace.go:171","msg":"trace[1226665111] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:747; }","duration":"832.683617ms","start":"2026-10-04T01:28:10.558453Z","end":"2026-10-04T01:28:11.391137Z","steps":["trace[1226665111] 'range keys from in-memory index tree' (duration: 832.307508ms)"],"step_count":1} {"level":"warn","ts":"2026-10-04T01:28:11.391203Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T01:28:10.558433Z","time spent":"832.761389ms","remote":"127.0.0.1:50102","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-10-04T01:28:11.391262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"824.437883ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-10-04T01:28:11.391292Z","caller":"traceutil/trace.go:171","msg":"trace[1863049912] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:747; }","duration":"824.487675ms","start":"2026-10-04T01:28:10.566795Z","end":"2026-10-04T01:28:11.391283Z","steps":["trace[1863049912] 'range keys from in-memory index tree' (duration: 824.342421ms)"],"step_count":1} {"level":"warn","ts":"2026-10-04T01:28:11.391317Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T01:28:10.566785Z","time spent":"824.526575ms","remote":"127.0.0.1:50102","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-10-04T01:28:11.391095Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T01:28:10.581167Z","time spent":"809.912519ms","remote":"127.0.0.1:50102","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-10-04T01:28:11.391747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"829.343502ms","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-10-04T01:28:11.391807Z","caller":"traceutil/trace.go:171","msg":"trace[348652228] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:747; }","duration":"829.942846ms","start":"2026-10-04T01:28:10.561833Z","end":"2026-10-04T01:28:11.391775Z","steps":["trace[348652228] 'range keys from in-memory index tree' (duration: 829.181168ms)"],"step_count":1} {"level":"warn","ts":"2026-10-04T01:28:11.391846Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T01:28:10.561819Z","time spent":"830.016057ms","remote":"127.0.0.1:50102","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-10-04T01:28:55.241774Z","caller":"traceutil/trace.go:171","msg":"trace[1233734868] linearizableReadLoop","detail":"{readStateIndex:1099; appliedIndex:1098; }","duration":"289.269829ms","start":"2026-10-04T01:28:54.952479Z","end":"2026-10-04T01:28:55.241749Z","steps":["trace[1233734868] 'read index received' (duration: 289.073515ms)","trace[1233734868] 'applied index is now lower than readState.Index' (duration: 195.254µs)"],"step_count":2} {"level":"warn","ts":"2026-10-04T01:28:55.241935Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.439383ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-04T01:28:55.241972Z","caller":"traceutil/trace.go:171","msg":"trace[726194856] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:1057; }","duration":"289.518275ms","start":"2026-10-04T01:28:54.952442Z","end":"2026-10-04T01:28:55.241961Z","steps":["trace[726194856] 'agreement among raft nodes before linearized reading' (duration: 289.422623ms)"],"step_count":1} {"level":"info","ts":"2026-10-04T01:28:55.242306Z","caller":"traceutil/trace.go:171","msg":"trace[244805916] transaction","detail":"{read_only:false; response_revision:1057; number_of_response:1; }","duration":"586.248789ms","start":"2026-10-04T01:28:54.656046Z","end":"2026-10-04T01:28:55.242295Z","steps":["trace[244805916] 'process raft request' (duration: 585.579735ms)"],"step_count":1} {"level":"warn","ts":"2026-10-04T01:28:55.242406Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T01:28:54.65603Z","time spent":"586.30777ms","remote":"127.0.0.1:50102","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-04T01:28:55.741794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.057155ms","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-10-04T01:28:55.741876Z","caller":"traceutil/trace.go:171","msg":"trace[1768609310] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1057; }","duration":"128.180227ms","start":"2026-10-04T01:28:55.613678Z","end":"2026-10-04T01:28:55.741858Z","steps":["trace[1768609310] 'range keys from in-memory index tree' (duration: 127.826869ms)"],"step_count":1} {"level":"warn","ts":"2026-10-04T01:28:55.741942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.837163ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-10-04T01:28:55.742007Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.706933ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-10-04T01:28:55.742044Z","caller":"traceutil/trace.go:171","msg":"trace[1213740188] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1057; }","duration":"124.979966ms","start":"2026-10-04T01:28:55.617044Z","end":"2026-10-04T01:28:55.742024Z","steps":["trace[1213740188] 'range keys from in-memory index tree' (duration: 124.683429ms)"],"step_count":1} {"level":"info","ts":"2026-10-04T01:28:55.742061Z","caller":"traceutil/trace.go:171","msg":"trace[1016950072] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1057; }","duration":"108.797255ms","start":"2026-10-04T01:28:55.633248Z","end":"2026-10-04T01:28:55.742046Z","steps":["trace[1016950072] 'range keys from in-memory index tree' (duration: 108.595791ms)"],"step_count":1} {"level":"warn","ts":"2026-10-04T01:28:55.742053Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.537014ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-10-04T01:28:55.742096Z","caller":"traceutil/trace.go:171","msg":"trace[1257632879] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1057; }","duration":"123.596166ms","start":"2026-10-04T01:28:55.618486Z","end":"2026-10-04T01:28:55.742082Z","steps":["trace[1257632879] 'range keys from in-memory index tree' (duration: 123.397391ms)"],"step_count":1} {"level":"warn","ts":"2026-10-04T01:29:08.141615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.50976ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-04T01:29:08.141706Z","caller":"traceutil/trace.go:171","msg":"trace[531977489] linearizableReadLoop","detail":"{readStateIndex:1142; appliedIndex:1141; }","duration":"295.994669ms","start":"2026-10-04T01:29:07.845696Z","end":"2026-10-04T01:29:08.14169Z","steps":["trace[531977489] 'read index received' (duration: 25.257073ms)","trace[531977489] 'applied index is now lower than readState.Index' (duration: 270.736526ms)"],"step_count":2} {"level":"info","ts":"2026-10-04T01:29:08.141776Z","caller":"traceutil/trace.go:171","msg":"trace[1669740254] transaction","detail":"{read_only:false; response_revision:1098; number_of_response:1; }","duration":"297.758398ms","start":"2026-10-04T01:29:07.843981Z","end":"2026-10-04T01:29:08.141739Z","steps":["trace[1669740254] 'process raft request' (duration: 27.050483ms)","trace[1669740254] 'compare' (duration: 270.378618ms)"],"step_count":2} {"level":"warn","ts":"2026-10-04T01:29:08.141898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.188003ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-10-04T01:29:08.141972Z","caller":"traceutil/trace.go:171","msg":"trace[923623874] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1098; }","duration":"296.292425ms","start":"2026-10-04T01:29:07.845658Z","end":"2026-10-04T01:29:08.14195Z","steps":["trace[923623874] 'agreement among raft nodes before linearized reading' (duration: 296.094541ms)"],"step_count":1} {"level":"warn","ts":"2026-10-04T01:29:08.14234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.07193ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-04T01:29:08.142334Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.12489ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-10-04T01:29:08.142375Z","caller":"traceutil/trace.go:171","msg":"trace[1612700650] range","detail":"{range_begin:/registry/validatingwebhookconfigurations/; range_end:/registry/validatingwebhookconfigurations0; response_count:0; response_revision:1099; }","duration":"130.143981ms","start":"2026-10-04T01:29:08.01222Z","end":"2026-10-04T01:29:08.142364Z","steps":["trace[1612700650] 'agreement among raft nodes before linearized reading' (duration: 130.07854ms)"],"step_count":1} {"level":"info","ts":"2026-10-04T01:29:08.142404Z","caller":"traceutil/trace.go:171","msg":"trace[1066250770] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1099; }","duration":"295.217182ms","start":"2026-10-04T01:29:07.847168Z","end":"2026-10-04T01:29:08.142385Z","steps":["trace[1066250770] 'agreement among raft nodes before linearized reading' (duration: 295.060178ms)"],"step_count":1} {"level":"warn","ts":"2026-10-04T01:29:08.142458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.138641ms","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-10-04T01:29:08.142461Z","caller":"traceutil/trace.go:171","msg":"trace[1554030738] transaction","detail":"{read_only:false; response_revision:1099; number_of_response:1; }","duration":"167.073565ms","start":"2026-10-04T01:29:07.975341Z","end":"2026-10-04T01:29:08.142415Z","steps":["trace[1554030738] 'process raft request' (duration: 166.786279ms)"],"step_count":1} {"level":"info","ts":"2026-10-04T01:29:08.142501Z","caller":"traceutil/trace.go:171","msg":"trace[1507826043] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1099; }","duration":"287.192713ms","start":"2026-10-04T01:29:07.855296Z","end":"2026-10-04T01:29:08.142489Z","steps":["trace[1507826043] 'agreement among raft nodes before linearized reading' (duration: 287.035219ms)"],"step_count":1} {"level":"warn","ts":"2026-10-04T01:29:08.14252Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.903169ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-04T01:29:08.142559Z","caller":"traceutil/trace.go:171","msg":"trace[1959507553] range","detail":"{range_begin:/registry/deployments/; range_end:/registry/deployments0; response_count:0; response_revision:1099; }","duration":"287.95766ms","start":"2026-10-04T01:29:07.85459Z","end":"2026-10-04T01:29:08.142548Z","steps":["trace[1959507553] 'agreement among raft nodes before linearized reading' (duration: 287.889439ms)"],"step_count":1} {"level":"warn","ts":"2026-10-04T01:29:12.551887Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.404782ms","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-10-04T01:29:12.551962Z","caller":"traceutil/trace.go:171","msg":"trace[1314716676] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:1134; }","duration":"119.526884ms","start":"2026-10-04T01:29:12.432419Z","end":"2026-10-04T01:29:12.551946Z","steps":["trace[1314716676] 'count revisions from in-memory index tree' (duration: 119.280219ms)"],"step_count":1} {"level":"warn","ts":"2026-10-04T01:29:14.012949Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.211907ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-04T01:29:14.013048Z","caller":"traceutil/trace.go:171","msg":"trace[290108819] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:1137; }","duration":"110.367801ms","start":"2026-10-04T01:29:13.90266Z","end":"2026-10-04T01:29:14.013028Z","steps":["trace[290108819] 'count revisions from in-memory index tree' (duration: 110.131626ms)"],"step_count":1} {"level":"warn","ts":"2026-10-04T01:29:14.013175Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.910594ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-04T01:29:14.013243Z","caller":"traceutil/trace.go:171","msg":"trace[1938742718] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:1137; }","duration":"263.992306ms","start":"2026-10-04T01:29:13.749213Z","end":"2026-10-04T01:29:14.013205Z","steps":["trace[1938742718] 'count revisions from in-memory index tree' (duration: 263.827852ms)"],"step_count":1} {"level":"info","ts":"2026-10-04T01:29:14.451084Z","caller":"traceutil/trace.go:171","msg":"trace[631416909] transaction","detail":"{read_only:false; response_revision:1138; number_of_response:1; }","duration":"270.539613ms","start":"2026-10-04T01:29:14.180523Z","end":"2026-10-04T01:29:14.451063Z","steps":["trace[631416909] 'process raft request' (duration: 270.387348ms)"],"step_count":1} {"level":"info","ts":"2026-10-04T01:29:14.45166Z","caller":"traceutil/trace.go:171","msg":"trace[1767046562] linearizableReadLoop","detail":"{readStateIndex:1184; appliedIndex:1184; }","duration":"256.721993ms","start":"2026-10-04T01:29:14.194928Z","end":"2026-10-04T01:29:14.45165Z","steps":["trace[1767046562] 'read index received' (duration: 256.718393ms)","trace[1767046562] 'applied index is now lower than readState.Index' (duration: 2.95µs)"],"step_count":2} {"level":"warn","ts":"2026-10-04T01:29:14.451813Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.868026ms","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-10-04T01:29:14.45184Z","caller":"traceutil/trace.go:171","msg":"trace[284203166] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1138; }","duration":"256.923118ms","start":"2026-10-04T01:29:14.194909Z","end":"2026-10-04T01:29:14.451832Z","steps":["trace[284203166] 'agreement among raft nodes before linearized reading' (duration: 256.804376ms)"],"step_count":1} {"level":"warn","ts":"2026-10-04T01:29:14.451868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.233508ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-10-04T01:29:14.451907Z","caller":"traceutil/trace.go:171","msg":"trace[618269163] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1138; }","duration":"236.284409ms","start":"2026-10-04T01:29:14.215611Z","end":"2026-10-04T01:29:14.451895Z","steps":["trace[618269163] 'agreement among raft nodes before linearized reading' (duration: 236.172436ms)"],"step_count":1} {"level":"warn","ts":"2026-10-04T01:29:14.452052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.44515ms","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-10-04T01:29:14.452076Z","caller":"traceutil/trace.go:171","msg":"trace[302737636] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1138; }","duration":"235.47461ms","start":"2026-10-04T01:29:14.216593Z","end":"2026-10-04T01:29:14.452068Z","steps":["trace[302737636] 'agreement among raft nodes before linearized reading' (duration: 235.381638ms)"],"step_count":1} {"level":"warn","ts":"2026-10-04T01:29:14.4522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.000671ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-10-04T01:29:14.452225Z","caller":"traceutil/trace.go:171","msg":"trace[1920285642] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1138; }","duration":"236.031613ms","start":"2026-10-04T01:29:14.216186Z","end":"2026-10-04T01:29:14.452217Z","steps":["trace[1920285642] 'agreement among raft nodes before linearized reading' (duration: 235.966751ms)"],"step_count":1} {"level":"warn","ts":"2026-10-04T01:29:15.058472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.134185ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-04T01:29:15.058775Z","caller":"traceutil/trace.go:171","msg":"trace[329096896] transaction","detail":"{read_only:false; response_revision:1139; number_of_response:1; }","duration":"602.523983ms","start":"2026-10-04T01:29:14.456201Z","end":"2026-10-04T01:29:15.058725Z","steps":["trace[329096896] 'process raft request' (duration: 261.06099ms)","trace[329096896] 'compare' (duration: 340.962111ms)"],"step_count":2} {"level":"warn","ts":"2026-10-04T01:29:15.05891Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T01:29:14.456183Z","time spent":"602.651356ms","remote":"127.0.0.1:50102","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-04T01:29:15.058938Z","caller":"traceutil/trace.go:171","msg":"trace[1218257359] transaction","detail":"{read_only:false; response_revision:1142; number_of_response:1; }","duration":"601.345087ms","start":"2026-10-04T01:29:14.457575Z","end":"2026-10-04T01:29:15.058921Z","steps":["trace[1218257359] 'process raft request' (duration: 601.146463ms)"],"step_count":1} {"level":"info","ts":"2026-10-04T01:29:15.05898Z","caller":"traceutil/trace.go:171","msg":"trace[531225126] linearizableReadLoop","detail":"{readStateIndex:1188; appliedIndex:1184; }","duration":"579.160572ms","start":"2026-10-04T01:29:14.479803Z","end":"2026-10-04T01:29:15.058964Z","steps":["trace[531225126] 'read index received' (duration: 237.414573ms)","trace[531225126] 'applied index is now lower than readState.Index' (duration: 341.744629ms)"],"step_count":2} {"level":"warn","ts":"2026-10-04T01:29:15.059018Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T01:29:14.457564Z","time spent":"601.404178ms","remote":"127.0.0.1:50102","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-10-04T01:29:15.0591Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"579.281064ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-04T01:29:15.059109Z","caller":"traceutil/trace.go:171","msg":"trace[1016384942] transaction","detail":"{read_only:false; response_revision:1140; number_of_response:1; }","duration":"602.734188ms","start":"2026-10-04T01:29:14.456366Z","end":"2026-10-04T01:29:15.0591Z","steps":["trace[1016384942] 'process raft request' (duration: 602.202305ms)"],"step_count":1} {"level":"info","ts":"2026-10-04T01:29:15.059119Z","caller":"traceutil/trace.go:171","msg":"trace[670776553] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:1143; }","duration":"579.334186ms","start":"2026-10-04T01:29:14.479777Z","end":"2026-10-04T01:29:15.059112Z","steps":["trace[670776553] 'agreement among raft nodes before linearized reading' (duration: 579.285285ms)"],"step_count":1} {"level":"warn","ts":"2026-10-04T01:29:15.059111Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"402.289939ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-04T01:29:15.059139Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T01:29:14.479766Z","time spent":"579.367427ms","remote":"127.0.0.1:49996","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":5,"response size":30,"request content":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true "} {"level":"warn","ts":"2026-10-04T01:29:15.059153Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T01:29:14.456357Z","time spent":"602.769648ms","remote":"127.0.0.1:50102","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-10-04T01:29:15.059155Z","caller":"traceutil/trace.go:171","msg":"trace[46899825] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1143; }","duration":"402.373901ms","start":"2026-10-04T01:29:14.656769Z","end":"2026-10-04T01:29:15.059143Z","steps":["trace[46899825] 'agreement among raft nodes before linearized reading' (duration: 402.309619ms)"],"step_count":1} {"level":"warn","ts":"2026-10-04T01:29:15.059186Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T01:29:14.656748Z","time spent":"402.432093ms","remote":"127.0.0.1:49822","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-10-04T01:29:15.060167Z","caller":"traceutil/trace.go:171","msg":"trace[1122540312] transaction","detail":"{read_only:false; response_revision:1141; number_of_response:1; }","duration":"603.755891ms","start":"2026-10-04T01:29:14.456382Z","end":"2026-10-04T01:29:15.060138Z","steps":["trace[1122540312] 'process raft request' (duration: 602.269918ms)"],"step_count":1} {"level":"warn","ts":"2026-10-04T01:29:15.06031Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T01:29:14.456365Z","time spent":"603.871283ms","remote":"127.0.0.1:50102","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-04T01:29:15.228446Z","caller":"traceutil/trace.go:171","msg":"trace[1515467583] transaction","detail":"{read_only:false; response_revision:1144; number_of_response:1; }","duration":"156.342776ms","start":"2026-10-04T01:29:15.072077Z","end":"2026-10-04T01:29:15.22842Z","steps":["trace[1515467583] 'process raft request' (duration: 105.86368ms)","trace[1515467583] 'compare' (duration: 50.368853ms)"],"step_count":2} {"level":"info","ts":"2026-10-04T01:29:15.439828Z","caller":"traceutil/trace.go:171","msg":"trace[1480594837] transaction","detail":"{read_only:false; response_revision:1146; number_of_response:1; }","duration":"150.614058ms","start":"2026-10-04T01:29:15.289183Z","end":"2026-10-04T01:29:15.439798Z","steps":["trace[1480594837] 'process raft request' (duration: 57.726117ms)","trace[1480594837] 'compare' (duration: 92.589595ms)"],"step_count":2} {"level":"info","ts":"2026-10-04T01:29:15.634008Z","caller":"traceutil/trace.go:171","msg":"trace[21709459] linearizableReadLoop","detail":"{readStateIndex:1193; appliedIndex:1192; }","duration":"176.719189ms","start":"2026-10-04T01:29:15.457241Z","end":"2026-10-04T01:29:15.63396Z","steps":["trace[21709459] 'read index received' (duration: 118.924751ms)","trace[21709459] 'applied index is now lower than readState.Index' (duration: 57.793468ms)"],"step_count":2} {"level":"info","ts":"2026-10-04T01:29:15.634211Z","caller":"traceutil/trace.go:171","msg":"trace[1357233992] transaction","detail":"{read_only:false; response_revision:1147; number_of_response:1; }","duration":"190.244701ms","start":"2026-10-04T01:29:15.443953Z","end":"2026-10-04T01:29:15.634198Z","steps":["trace[1357233992] 'process raft request' (duration: 132.256558ms)","trace[1357233992] 'compare' (duration: 57.441761ms)"],"step_count":2} {"level":"warn","ts":"2026-10-04T01:29:15.634346Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.077348ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-04T01:29:15.634419Z","caller":"traceutil/trace.go:171","msg":"trace[1690600691] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/; range_end:/registry/mutatingwebhookconfigurations0; response_count:0; response_revision:1147; }","duration":"177.188401ms","start":"2026-10-04T01:29:15.457207Z","end":"2026-10-04T01:29:15.634396Z","steps":["trace[1690600691] 'agreement among raft nodes before linearized reading' (duration: 177.059378ms)"],"step_count":1} {"level":"warn","ts":"2026-10-04T01:29:16.872071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"380.434711ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-10-04T01:29:16.872344Z","caller":"traceutil/trace.go:171","msg":"trace[1792254248] linearizableReadLoop","detail":"{readStateIndex:1196; appliedIndex:1194; }","duration":"215.615897ms","start":"2026-10-04T01:29:16.656691Z","end":"2026-10-04T01:29:16.872307Z","steps":["trace[1792254248] 'read index received' (duration: 36.751µs)","trace[1792254248] 'applied index is now lower than readState.Index' (duration: 215.577816ms)"],"step_count":2} {"level":"warn","ts":"2026-10-04T01:29:16.87247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.77291ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-04T01:29:16.872529Z","caller":"traceutil/trace.go:171","msg":"trace[862234898] transaction","detail":"{read_only:false; response_revision:1148; number_of_response:1; }","duration":"427.607503ms","start":"2026-10-04T01:29:16.444904Z","end":"2026-10-04T01:29:16.872511Z","steps":["trace[862234898] 'process raft request' (duration: 46.62264ms)","trace[862234898] 'compare' (duration: 380.291447ms)"],"step_count":2} {"level":"info","ts":"2026-10-04T01:29:16.872519Z","caller":"traceutil/trace.go:171","msg":"trace[279366089] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1149; }","duration":"215.861532ms","start":"2026-10-04T01:29:16.656643Z","end":"2026-10-04T01:29:16.872505Z","steps":["trace[279366089] 'agreement among raft nodes before linearized reading' (duration: 215.75415ms)"],"step_count":1} {"level":"info","ts":"2026-10-04T01:29:16.872535Z","caller":"traceutil/trace.go:171","msg":"trace[1974752899] transaction","detail":"{read_only:false; response_revision:1149; number_of_response:1; }","duration":"415.640587ms","start":"2026-10-04T01:29:16.456867Z","end":"2026-10-04T01:29:16.872508Z","steps":["trace[1974752899] 'process raft request' (duration: 415.34408ms)"],"step_count":1} {"level":"warn","ts":"2026-10-04T01:29:16.872583Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T01:29:16.444879Z","time spent":"427.677394ms","remote":"127.0.0.1:49912","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":787,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-04T01:29:16.872682Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T01:29:16.456845Z","time spent":"415.746929ms","remote":"127.0.0.1:50102","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-04T01:29:22.992236Z","caller":"traceutil/trace.go:171","msg":"trace[1887553299] transaction","detail":"{read_only:false; response_revision:1205; number_of_response:1; }","duration":"252.545371ms","start":"2026-10-04T01:29:22.739668Z","end":"2026-10-04T01:29:22.992213Z","steps":["trace[1887553299] 'process raft request' (duration: 252.373777ms)"],"step_count":1} {"level":"warn","ts":"2026-10-04T01:29:23.472123Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.021004ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-04T01:29:23.472564Z","caller":"traceutil/trace.go:171","msg":"trace[743103766] transaction","detail":"{read_only:false; response_revision:1206; number_of_response:1; }","duration":"582.142229ms","start":"2026-10-04T01:29:22.890386Z","end":"2026-10-04T01:29:23.472528Z","steps":["trace[743103766] 'process raft request' (duration: 344.632153ms)","trace[743103766] 'compare' (duration: 236.753338ms)"],"step_count":2} {"level":"warn","ts":"2026-10-04T01:29:23.472749Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T01:29:22.890366Z","time spent":"582.283031ms","remote":"127.0.0.1:50102","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-04T01:29:23.472245Z","caller":"traceutil/trace.go:171","msg":"trace[1796927394] linearizableReadLoop","detail":"{readStateIndex:1254; appliedIndex:1253; }","duration":"374.0754ms","start":"2026-10-04T01:29:23.098153Z","end":"2026-10-04T01:29:23.472229Z","steps":["trace[1796927394] 'read index received' (duration: 136.77878ms)","trace[1796927394] 'applied index is now lower than readState.Index' (duration: 237.2953ms)"],"step_count":2} {"level":"warn","ts":"2026-10-04T01:29:23.473183Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"374.971369ms","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-10-04T01:29:23.473312Z","caller":"traceutil/trace.go:171","msg":"trace[719374329] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1206; }","duration":"375.176394ms","start":"2026-10-04T01:29:23.098112Z","end":"2026-10-04T01:29:23.473288Z","steps":["trace[719374329] 'agreement among raft nodes before linearized reading' (duration: 374.675463ms)"],"step_count":1} {"level":"warn","ts":"2026-10-04T01:29:23.473394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"374.632851ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-10-04T01:29:23.473467Z","caller":"traceutil/trace.go:171","msg":"trace[1317759141] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1206; }","duration":"374.720613ms","start":"2026-10-04T01:29:23.098729Z","end":"2026-10-04T01:29:23.473449Z","steps":["trace[1317759141] 'agreement among raft nodes before linearized reading' (duration: 374.56815ms)"],"step_count":1} {"level":"warn","ts":"2026-10-04T01:29:23.473724Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T01:29:23.098716Z","time spent":"374.98954ms","remote":"127.0.0.1:50102","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-10-04T01:29:23.473783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"375.158883ms","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-10-04T01:29:23.473809Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"375.087272ms","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-10-04T01:29:23.473834Z","caller":"traceutil/trace.go:171","msg":"trace[753415648] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1206; }","duration":"375.229405ms","start":"2026-10-04T01:29:23.09859Z","end":"2026-10-04T01:29:23.473819Z","steps":["trace[753415648] 'agreement among raft nodes before linearized reading' (duration: 374.525999ms)"],"step_count":1} {"level":"info","ts":"2026-10-04T01:29:23.473863Z","caller":"traceutil/trace.go:171","msg":"trace[1206953944] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1206; }","duration":"375.216225ms","start":"2026-10-04T01:29:23.098632Z","end":"2026-10-04T01:29:23.473848Z","steps":["trace[1206953944] 'agreement among raft nodes before linearized reading' (duration: 374.926639ms)"],"step_count":1} {"level":"warn","ts":"2026-10-04T01:29:23.473889Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T01:29:23.098581Z","time spent":"375.296137ms","remote":"127.0.0.1:50102","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-10-04T01:29:23.473425Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T01:29:23.098093Z","time spent":"375.314417ms","remote":"127.0.0.1:50102","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-10-04T01:29:23.473905Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T01:29:23.098612Z","time spent":"375.280576ms","remote":"127.0.0.1:50102","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-10-04T01:29:23.473256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.005727ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:621"} {"level":"info","ts":"2026-10-04T01:29:23.474078Z","caller":"traceutil/trace.go:171","msg":"trace[791623073] range","detail":"{range_begin:/registry/configmaps/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1206; }","duration":"234.810945ms","start":"2026-10-04T01:29:23.239235Z","end":"2026-10-04T01:29:23.474046Z","steps":["trace[791623073] 'agreement among raft nodes before linearized reading' (duration: 233.896885ms)"],"step_count":1} {"level":"info","ts":"2026-10-04T01:29:23.655463Z","caller":"traceutil/trace.go:171","msg":"trace[254483804] transaction","detail":"{read_only:false; response_revision:1209; number_of_response:1; }","duration":"176.189977ms","start":"2026-10-04T01:29:23.47925Z","end":"2026-10-04T01:29:23.65544Z","steps":["trace[254483804] 'process raft request' (duration: 176.125926ms)"],"step_count":1} {"level":"info","ts":"2026-10-04T01:29:23.65547Z","caller":"traceutil/trace.go:171","msg":"trace[676224666] transaction","detail":"{read_only:false; response_revision:1208; number_of_response:1; }","duration":"176.261429ms","start":"2026-10-04T01:29:23.47918Z","end":"2026-10-04T01:29:23.655442Z","steps":["trace[676224666] 'process raft request' (duration: 176.140697ms)"],"step_count":1} {"level":"info","ts":"2026-10-04T01:29:23.655517Z","caller":"traceutil/trace.go:171","msg":"trace[80147017] transaction","detail":"{read_only:false; response_revision:1207; number_of_response:1; }","duration":"177.14044ms","start":"2026-10-04T01:29:23.47836Z","end":"2026-10-04T01:29:23.6555Z","steps":["trace[80147017] 'process raft request' (duration: 171.786391ms)"],"step_count":1} {"level":"info","ts":"2026-10-04T01:29:23.656053Z","caller":"traceutil/trace.go:171","msg":"trace[1325787119] transaction","detail":"{read_only:false; response_revision:1210; number_of_response:1; }","duration":"176.72225ms","start":"2026-10-04T01:29:23.479316Z","end":"2026-10-04T01:29:23.656038Z","steps":["trace[1325787119] 'process raft request' (duration: 176.093985ms)"],"step_count":1} {"level":"info","ts":"2026-10-04T01:29:23.656471Z","caller":"traceutil/trace.go:171","msg":"trace[930104263] linearizableReadLoop","detail":"{readStateIndex:1259; appliedIndex:1254; }","duration":"121.290923ms","start":"2026-10-04T01:29:23.535168Z","end":"2026-10-04T01:29:23.656459Z","steps":["trace[930104263] 'read index received' (duration: 115.054465ms)","trace[930104263] 'applied index is now lower than readState.Index' (duration: 6.235458ms)"],"step_count":2} {"level":"info","ts":"2026-10-04T01:29:23.656724Z","caller":"traceutil/trace.go:171","msg":"trace[1082652415] transaction","detail":"{read_only:false; response_revision:1211; number_of_response:1; }","duration":"174.595121ms","start":"2026-10-04T01:29:23.482111Z","end":"2026-10-04T01:29:23.656706Z","steps":["trace[1082652415] 'process raft request' (duration: 174.261614ms)"],"step_count":1} {"level":"warn","ts":"2026-10-04T01:29:23.657252Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.068132ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.27\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-10-04T01:29:23.657298Z","caller":"traceutil/trace.go:171","msg":"trace[1083134548] range","detail":"{range_begin:/registry/masterleases/162.253.55.27; range_end:; response_count:1; response_revision:1211; }","duration":"122.123283ms","start":"2026-10-04T01:29:23.535163Z","end":"2026-10-04T01:29:23.657286Z","steps":["trace[1083134548] 'agreement among raft nodes before linearized reading' (duration: 121.342825ms)"],"step_count":1} {"level":"info","ts":"2026-10-04T01:33:51.28193Z","caller":"traceutil/trace.go:171","msg":"trace[1130025129] transaction","detail":"{read_only:false; response_revision:2594; number_of_response:1; }","duration":"103.32233ms","start":"2026-10-04T01:33:51.178586Z","end":"2026-10-04T01:33:51.281909Z","steps":["trace[1130025129] 'process raft request' (duration: 94.487514ms)"],"step_count":1} {"level":"info","ts":"2026-10-04T01:33:51.28212Z","caller":"traceutil/trace.go:171","msg":"trace[1177238466] transaction","detail":"{read_only:false; response_revision:2595; number_of_response:1; }","duration":"102.893392ms","start":"2026-10-04T01:33:51.179192Z","end":"2026-10-04T01:33:51.282085Z","steps":["trace[1177238466] 'process raft request' (duration: 102.658616ms)"],"step_count":1}