{"level":"warn","ts":"2026-02-11T02:19:51.399378Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-02-11T02:19:51.399543Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.140: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.140:2380","--initial-cluster=instance=https://162.253.55.140:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.140:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.140: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-02-11T02:19:51.399723Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-02-11T02:19:51.400209Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.140:2380"]} {"level":"info","ts":"2026-02-11T02:19:51.400235Z","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-02-11T02:19:51.400884Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.140:2379"]} {"level":"info","ts":"2026-02-11T02:19:51.401882Z","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":2,"max-cpu-available":2,"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.140:2380"],"listen-peer-urls":["https://162.253.55.140:2380"],"advertise-client-urls":["https://162.253.55.140:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.140:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.140: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-02-11T02:19:51.407679Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.66956ms"} {"level":"info","ts":"2026-02-11T02:19:51.426804Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"cf809824ab95ac81","cluster-id":"6f89f5fbef18dc61"} {"level":"info","ts":"2026-02-11T02:19:51.426919Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 switched to configuration voters=()"} {"level":"info","ts":"2026-02-11T02:19:51.426954Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 became follower at term 0"} {"level":"info","ts":"2026-02-11T02:19:51.427003Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft cf809824ab95ac81 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-11T02:19:51.427054Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 became follower at term 1"} {"level":"info","ts":"2026-02-11T02:19:51.427119Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 switched to configuration voters=(14952118046135004289)"} {"level":"warn","ts":"2026-02-11T02:19:51.434227Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-11T02:19:51.436372Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-11T02:19:51.440631Z","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-02-11T02:19:51.444564Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"cf809824ab95ac81","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-11T02:19:51.453449Z","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-02-11T02:19:51.454593Z","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-02-11T02:19:51.454656Z","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-02-11T02:19:51.454723Z","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-02-11T02:19:51.454878Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"cf809824ab95ac81","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-11T02:19:51.458028Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 switched to configuration voters=(14952118046135004289)"} {"level":"info","ts":"2026-02-11T02:19:51.458317Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"6f89f5fbef18dc61","local-member-id":"cf809824ab95ac81","added-peer-id":"cf809824ab95ac81","added-peer-peer-urls":["https://162.253.55.140:2380"]} {"level":"info","ts":"2026-02-11T02:19:51.468984Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.140:2380"} {"level":"info","ts":"2026-02-11T02:19:51.469011Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.140:2380"} {"level":"info","ts":"2026-02-11T02:19:51.480659Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-11T02:19:51.459321Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"cf809824ab95ac81","initial-advertise-peer-urls":["https://162.253.55.140:2380"],"listen-peer-urls":["https://162.253.55.140:2380"],"advertise-client-urls":["https://162.253.55.140:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.140:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-11T02:19:51.527755Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 is starting a new election at term 1"} {"level":"info","ts":"2026-02-11T02:19:51.527794Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 became pre-candidate at term 1"} {"level":"info","ts":"2026-02-11T02:19:51.527809Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 received MsgPreVoteResp from cf809824ab95ac81 at term 1"} {"level":"info","ts":"2026-02-11T02:19:51.527852Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 became candidate at term 2"} {"level":"info","ts":"2026-02-11T02:19:51.527861Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 received MsgVoteResp from cf809824ab95ac81 at term 2"} {"level":"info","ts":"2026-02-11T02:19:51.52787Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 became leader at term 2"} {"level":"info","ts":"2026-02-11T02:19:51.527877Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: cf809824ab95ac81 elected leader cf809824ab95ac81 at term 2"} {"level":"info","ts":"2026-02-11T02:19:51.565454Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-11T02:19:51.57281Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"6f89f5fbef18dc61","local-member-id":"cf809824ab95ac81","cluster-version":"3.5"} {"level":"info","ts":"2026-02-11T02:19:51.572875Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"cf809824ab95ac81","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.140:2379]}","request-path":"/0/members/cf809824ab95ac81/attributes","cluster-id":"6f89f5fbef18dc61","publish-timeout":"7s"} {"level":"info","ts":"2026-02-11T02:19:51.572894Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-11T02:19:51.57321Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-11T02:19:51.57323Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-11T02:19:51.573239Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-11T02:19:51.577494Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-02-11T02:19:51.584916Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-11T02:19:51.584933Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-11T02:19:51.65926Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.140:2379"} {"level":"warn","ts":"2026-02-11T02:20:02.132121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.481561ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-02-11T02:20:02.132181Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.897957ms","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-02-11T02:20:02.132221Z","caller":"traceutil/trace.go:171","msg":"trace[2075918079] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:348; }","duration":"209.632873ms","start":"2026-02-11T02:20:01.922574Z","end":"2026-02-11T02:20:02.132207Z","steps":["trace[2075918079] 'range keys from in-memory index tree' (duration: 209.390689ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T02:20:02.132284Z","caller":"traceutil/trace.go:171","msg":"trace[840884513] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:348; }","duration":"155.067808ms","start":"2026-02-11T02:20:01.977198Z","end":"2026-02-11T02:20:02.132266Z","steps":["trace[840884513] 'range keys from in-memory index tree' (duration: 154.752565ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T02:20:04.672017Z","caller":"traceutil/trace.go:171","msg":"trace[1119470964] transaction","detail":"{read_only:false; response_revision:362; number_of_response:1; }","duration":"424.401946ms","start":"2026-02-11T02:20:04.247592Z","end":"2026-02-11T02:20:04.671994Z","steps":["trace[1119470964] 'process raft request' (duration: 415.319688ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:20:04.672611Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:20:04.24757Z","time spent":"424.504607ms","remote":"127.0.0.1:57090","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-11T02:20:06.023697Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.137429ms","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-02-11T02:20:06.02378Z","caller":"traceutil/trace.go:171","msg":"trace[889055855] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:366; }","duration":"162.238149ms","start":"2026-02-11T02:20:05.861523Z","end":"2026-02-11T02:20:06.023762Z","steps":["trace[889055855] 'range keys from in-memory index tree' (duration: 162.024558ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T02:20:08.307233Z","caller":"traceutil/trace.go:171","msg":"trace[1517209357] transaction","detail":"{read_only:false; response_revision:377; number_of_response:1; }","duration":"157.58019ms","start":"2026-02-11T02:20:08.149627Z","end":"2026-02-11T02:20:08.307207Z","steps":["trace[1517209357] 'process raft request' (duration: 100.962745ms)","trace[1517209357] 'compare' (duration: 56.535064ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T02:20:09.808936Z","caller":"traceutil/trace.go:171","msg":"trace[795696984] transaction","detail":"{read_only:false; response_revision:381; number_of_response:1; }","duration":"184.168966ms","start":"2026-02-11T02:20:09.624752Z","end":"2026-02-11T02:20:09.808921Z","steps":["trace[795696984] 'process raft request' (duration: 183.899194ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:20:10.116232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.139774ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-11T02:20:10.116333Z","caller":"traceutil/trace.go:171","msg":"trace[654530413] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:381; }","duration":"158.247825ms","start":"2026-02-11T02:20:09.958068Z","end":"2026-02-11T02:20:10.116316Z","steps":["trace[654530413] 'range keys from in-memory index tree' (duration: 158.129554ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:20:10.636087Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":12430388290298775158,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-11T02:20:10.92006Z","caller":"traceutil/trace.go:171","msg":"trace[1444095351] transaction","detail":"{read_only:false; response_revision:382; number_of_response:1; }","duration":"800.328786ms","start":"2026-02-11T02:20:10.119717Z","end":"2026-02-11T02:20:10.920045Z","steps":["trace[1444095351] 'process raft request' (duration: 800.235606ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:20:10.920306Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:20:10.119696Z","time spent":"800.409248ms","remote":"127.0.0.1:57090","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-11T02:20:12.746942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.994468367s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-02-11T02:20:12.747035Z","caller":"traceutil/trace.go:171","msg":"trace[370808677] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"1.995127781s","start":"2026-02-11T02:20:10.751884Z","end":"2026-02-11T02:20:12.747012Z","steps":["trace[370808677] 'agreement among raft nodes before linearized reading' (duration: 1.994493277s)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:20:12.747087Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:20:10.751859Z","time spent":"1.995218712s","remote":"127.0.0.1:56838","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/02/11 02:20:12 WARNING: [core] [Server #6] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-02-11T02:20:14.047692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.648047422s","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-02-11T02:20:14.047814Z","caller":"traceutil/trace.go:171","msg":"trace[193708030] linearizableReadLoop","detail":"{readStateIndex:397; appliedIndex:396; }","duration":"3.912161127s","start":"2026-02-11T02:20:10.135628Z","end":"2026-02-11T02:20:14.047789Z","steps":["trace[193708030] 'read index received' (duration: 784.742228ms)","trace[193708030] 'applied index is now lower than readState.Index' (duration: 3.127417079s)"],"step_count":2} {"level":"warn","ts":"2026-02-11T02:20:14.048728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.913083584s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-02-11T02:20:14.048772Z","caller":"traceutil/trace.go:171","msg":"trace[157484688] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:382; }","duration":"3.913163725s","start":"2026-02-11T02:20:10.135591Z","end":"2026-02-11T02:20:14.048755Z","steps":["trace[157484688] 'agreement among raft nodes before linearized reading' (duration: 3.913066224s)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:20:14.048808Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:20:10.135576Z","time spent":"3.913222206s","remote":"127.0.0.1:57090","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-11T02:20:14.048844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.673213877s","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-02-11T02:20:14.048949Z","caller":"traceutil/trace.go:171","msg":"trace[935014167] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:382; }","duration":"3.673364018s","start":"2026-02-11T02:20:10.375555Z","end":"2026-02-11T02:20:14.048919Z","steps":["trace[935014167] 'agreement among raft nodes before linearized reading' (duration: 3.673158296s)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:20:14.049004Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:20:10.375537Z","time spent":"3.673454168s","remote":"127.0.0.1:57090","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-11T02:20:14.049201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.124466378s","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-02-11T02:20:14.049246Z","caller":"traceutil/trace.go:171","msg":"trace[1761207203] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:382; }","duration":"1.124550289s","start":"2026-02-11T02:20:12.924685Z","end":"2026-02-11T02:20:14.049235Z","steps":["trace[1761207203] 'agreement among raft nodes before linearized reading' (duration: 1.124407607s)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:20:14.049275Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:20:12.924662Z","time spent":"1.12460682s","remote":"127.0.0.1:57090","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-02-11T02:20:14.049299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.302829411s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-11T02:20:14.049343Z","caller":"traceutil/trace.go:171","msg":"trace[212267125] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:382; }","duration":"1.302904553s","start":"2026-02-11T02:20:12.746422Z","end":"2026-02-11T02:20:14.049327Z","steps":["trace[212267125] 'agreement among raft nodes before linearized reading' (duration: 1.302841442s)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:20:14.049376Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:20:12.746403Z","time spent":"1.302967523s","remote":"127.0.0.1:56848","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-02-11T02:20:14.049533Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.854938726s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-11T02:20:14.049543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.353077689s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-02-11T02:20:14.049561Z","caller":"traceutil/trace.go:171","msg":"trace[1770710124] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:382; }","duration":"1.854988037s","start":"2026-02-11T02:20:12.194563Z","end":"2026-02-11T02:20:14.049551Z","steps":["trace[1770710124] 'agreement among raft nodes before linearized reading' (duration: 1.854944906s)"],"step_count":1} {"level":"info","ts":"2026-02-11T02:20:14.049576Z","caller":"traceutil/trace.go:171","msg":"trace[801556599] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:382; }","duration":"3.35310973s","start":"2026-02-11T02:20:10.696457Z","end":"2026-02-11T02:20:14.049567Z","steps":["trace[801556599] 'agreement among raft nodes before linearized reading' (duration: 3.353052109s)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:20:14.049592Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:20:12.19455Z","time spent":"1.855036797s","remote":"127.0.0.1:56838","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-02-11T02:20:14.049608Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:20:10.696404Z","time spent":"3.35319928s","remote":"127.0.0.1:57090","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-11T02:20:14.049739Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.201296408s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/coredns\" ","response":"range_response_count:1 size:4034"} {"level":"info","ts":"2026-02-11T02:20:14.049764Z","caller":"traceutil/trace.go:171","msg":"trace[555869548] range","detail":"{range_begin:/registry/deployments/kube-system/coredns; range_end:; response_count:1; response_revision:382; }","duration":"3.201321968s","start":"2026-02-11T02:20:10.848434Z","end":"2026-02-11T02:20:14.049756Z","steps":["trace[555869548] 'agreement among raft nodes before linearized reading' (duration: 3.201274838s)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:20:14.049792Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:20:10.848394Z","time spent":"3.201390849s","remote":"127.0.0.1:57252","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":4057,"request content":"key:\"/registry/deployments/kube-system/coredns\" "} {"level":"info","ts":"2026-02-11T02:20:14.364998Z","caller":"traceutil/trace.go:171","msg":"trace[1695840172] transaction","detail":"{read_only:false; response_revision:383; number_of_response:1; }","duration":"300.381117ms","start":"2026-02-11T02:20:14.064595Z","end":"2026-02-11T02:20:14.364976Z","steps":["trace[1695840172] 'process raft request' (duration: 300.243825ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T02:20:14.365166Z","caller":"traceutil/trace.go:171","msg":"trace[845164267] linearizableReadLoop","detail":"{readStateIndex:398; appliedIndex:398; }","duration":"299.318568ms","start":"2026-02-11T02:20:14.065803Z","end":"2026-02-11T02:20:14.365122Z","steps":["trace[845164267] 'read index received' (duration: 299.311958ms)","trace[845164267] 'applied index is now lower than readState.Index' (duration: 5.31µs)"],"step_count":2} {"level":"warn","ts":"2026-02-11T02:20:14.365364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.53886ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-11T02:20:14.366151Z","caller":"traceutil/trace.go:171","msg":"trace[660780116] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:383; }","duration":"300.347618ms","start":"2026-02-11T02:20:14.065766Z","end":"2026-02-11T02:20:14.366114Z","steps":["trace[660780116] 'agreement among raft nodes before linearized reading' (duration: 299.50179ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:20:14.366207Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:20:14.064565Z","time spent":"301.444016ms","remote":"127.0.0.1:56904","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":759,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-11T02:20:14.366335Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:20:14.065757Z","time spent":"300.510169ms","remote":"127.0.0.1:56838","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-02-11T02:20:14.52415Z","caller":"traceutil/trace.go:171","msg":"trace[1049591620] transaction","detail":"{read_only:false; response_revision:384; number_of_response:1; }","duration":"457.307025ms","start":"2026-02-11T02:20:14.066824Z","end":"2026-02-11T02:20:14.524131Z","steps":["trace[1049591620] 'process raft request' (duration: 455.095435ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:20:14.524427Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:20:14.066816Z","time spent":"457.541607ms","remote":"127.0.0.1:57252","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4158,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-11T02:20:14.524725Z","caller":"traceutil/trace.go:171","msg":"trace[2084023360] transaction","detail":"{read_only:false; response_revision:385; number_of_response:1; }","duration":"455.198365ms","start":"2026-02-11T02:20:14.069516Z","end":"2026-02-11T02:20:14.524715Z","steps":["trace[2084023360] 'process raft request' (duration: 453.969685ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:20:14.524881Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:20:14.069509Z","time spent":"455.346747ms","remote":"127.0.0.1:57090","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-02-11T02:20:14.525352Z","caller":"traceutil/trace.go:171","msg":"trace[1833226427] transaction","detail":"{read_only:false; response_revision:386; number_of_response:1; }","duration":"455.776081ms","start":"2026-02-11T02:20:14.069559Z","end":"2026-02-11T02:20:14.525335Z","steps":["trace[1833226427] 'process raft request' (duration: 454.45451ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:20:14.525552Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:20:14.069554Z","time spent":"455.927673ms","remote":"127.0.0.1:57090","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-11T02:20:14.526141Z","caller":"traceutil/trace.go:171","msg":"trace[219263877] transaction","detail":"{read_only:false; response_revision:389; number_of_response:1; }","duration":"141.186621ms","start":"2026-02-11T02:20:14.384941Z","end":"2026-02-11T02:20:14.526128Z","steps":["trace[219263877] 'process raft request' (duration: 141.154261ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T02:20:14.526325Z","caller":"traceutil/trace.go:171","msg":"trace[656161389] transaction","detail":"{read_only:false; response_revision:387; number_of_response:1; }","duration":"456.266255ms","start":"2026-02-11T02:20:14.070036Z","end":"2026-02-11T02:20:14.526302Z","steps":["trace[656161389] 'process raft request' (duration: 454.002655ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T02:20:14.526513Z","caller":"traceutil/trace.go:171","msg":"trace[1762878606] transaction","detail":"{read_only:false; response_revision:388; number_of_response:1; }","duration":"455.904062ms","start":"2026-02-11T02:20:14.070596Z","end":"2026-02-11T02:20:14.5265Z","steps":["trace[1762878606] 'process raft request' (duration: 455.400387ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:20:14.52665Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:20:14.07059Z","time spent":"455.992853ms","remote":"127.0.0.1:57090","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-11T02:20:14.526894Z","caller":"traceutil/trace.go:171","msg":"trace[576316060] linearizableReadLoop","detail":"{readStateIndex:403; appliedIndex:398; }","duration":"158.795324ms","start":"2026-02-11T02:20:14.368086Z","end":"2026-02-11T02:20:14.526882Z","steps":["trace[576316060] 'read index received' (duration: 153.765649ms)","trace[576316060] 'applied index is now lower than readState.Index' (duration: 5.025935ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T02:20:14.527064Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.972676ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-11T02:20:14.527113Z","caller":"traceutil/trace.go:171","msg":"trace[499910681] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:389; }","duration":"159.051707ms","start":"2026-02-11T02:20:14.368054Z","end":"2026-02-11T02:20:14.527106Z","steps":["trace[499910681] 'agreement among raft nodes before linearized reading' (duration: 158.922946ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:20:14.527084Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:20:14.07003Z","time spent":"456.353947ms","remote":"127.0.0.1:57090","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-02-11T02:20:15.293684Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"366.989715ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-11T02:20:15.293863Z","caller":"traceutil/trace.go:171","msg":"trace[834966092] transaction","detail":"{read_only:false; response_revision:393; number_of_response:1; }","duration":"683.479283ms","start":"2026-02-11T02:20:14.610366Z","end":"2026-02-11T02:20:15.293845Z","steps":["trace[834966092] 'process raft request' (duration: 683.397213ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:20:15.293999Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:20:14.61036Z","time spent":"683.579714ms","remote":"127.0.0.1:57252","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4158,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-11T02:20:15.294211Z","caller":"traceutil/trace.go:171","msg":"trace[614810879] transaction","detail":"{read_only:false; response_revision:392; number_of_response:1; }","duration":"684.774085ms","start":"2026-02-11T02:20:14.60942Z","end":"2026-02-11T02:20:15.294194Z","steps":["trace[614810879] 'process raft request' (duration: 317.217514ms)","trace[614810879] 'compare' (duration: 366.563511ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T02:20:15.29428Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:20:14.609402Z","time spent":"684.847355ms","remote":"127.0.0.1:57002","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3541,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-11T02:20:15.810705Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":12430388290298775171,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-11T02:20:16.032441Z","caller":"traceutil/trace.go:171","msg":"trace[559433342] transaction","detail":"{read_only:false; response_revision:394; number_of_response:1; }","duration":"725.011737ms","start":"2026-02-11T02:20:15.307412Z","end":"2026-02-11T02:20:16.032423Z","steps":["trace[559433342] 'process raft request' (duration: 654.236151ms)","trace[559433342] 'compare' (duration: 70.687905ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T02:20:16.032548Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:20:15.307382Z","time spent":"725.126208ms","remote":"127.0.0.1:56904","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":830,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-11T02:20:16.032975Z","caller":"traceutil/trace.go:171","msg":"trace[1801115829] linearizableReadLoop","detail":"{readStateIndex:413; appliedIndex:408; }","duration":"722.350933ms","start":"2026-02-11T02:20:15.310617Z","end":"2026-02-11T02:20:16.032968Z","steps":["trace[1801115829] 'read index received' (duration: 651.064622ms)","trace[1801115829] 'applied index is now lower than readState.Index' (duration: 71.285821ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T02:20:16.033085Z","caller":"traceutil/trace.go:171","msg":"trace[1719018794] transaction","detail":"{read_only:false; response_revision:395; number_of_response:1; }","duration":"725.308099ms","start":"2026-02-11T02:20:15.307773Z","end":"2026-02-11T02:20:16.033081Z","steps":["trace[1719018794] 'process raft request' (duration: 725.101717ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:20:16.033119Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:20:15.307762Z","time spent":"725.334301ms","remote":"127.0.0.1:57002","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4015,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-11T02:20:16.033176Z","caller":"traceutil/trace.go:171","msg":"trace[1658757795] transaction","detail":"{read_only:false; response_revision:396; number_of_response:1; }","duration":"725.286649ms","start":"2026-02-11T02:20:15.307886Z","end":"2026-02-11T02:20:16.033172Z","steps":["trace[1658757795] 'process raft request' (duration: 725.028167ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:20:16.033196Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:20:15.307878Z","time spent":"725.308259ms","remote":"127.0.0.1:56904","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":704,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-11T02:20:16.033294Z","caller":"traceutil/trace.go:171","msg":"trace[2119991408] transaction","detail":"{read_only:false; response_revision:397; number_of_response:1; }","duration":"723.509934ms","start":"2026-02-11T02:20:15.30978Z","end":"2026-02-11T02:20:16.03329Z","steps":["trace[2119991408] 'process raft request' (duration: 723.150561ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:20:16.033318Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:20:15.309769Z","time spent":"723.535504ms","remote":"127.0.0.1:57274","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3773,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-11T02:20:16.033371Z","caller":"traceutil/trace.go:171","msg":"trace[145917436] transaction","detail":"{read_only:false; response_revision:398; number_of_response:1; }","duration":"722.574464ms","start":"2026-02-11T02:20:15.310792Z","end":"2026-02-11T02:20:16.033367Z","steps":["trace[145917436] 'process raft request' (duration: 722.159741ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:20:16.033391Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:20:15.310783Z","time spent":"722.596894ms","remote":"127.0.0.1:57274","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3782,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-11T02:20:16.033466Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"722.846507ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.140\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-02-11T02:20:16.03348Z","caller":"traceutil/trace.go:171","msg":"trace[84665535] range","detail":"{range_begin:/registry/masterleases/162.253.55.140; range_end:; response_count:1; response_revision:398; }","duration":"722.882207ms","start":"2026-02-11T02:20:15.310593Z","end":"2026-02-11T02:20:16.033476Z","steps":["trace[84665535] 'agreement among raft nodes before linearized reading' (duration: 722.852917ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:20:16.033493Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:20:15.310584Z","time spent":"722.905297ms","remote":"127.0.0.1:56866","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/162.253.55.140\" "} {"level":"warn","ts":"2026-02-11T02:20:16.033567Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.797674ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-11T02:20:16.033578Z","caller":"traceutil/trace.go:171","msg":"trace[1377469223] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:398; }","duration":"290.809434ms","start":"2026-02-11T02:20:15.742765Z","end":"2026-02-11T02:20:16.033575Z","steps":["trace[1377469223] 'agreement among raft nodes before linearized reading' (duration: 290.790214ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T02:20:16.295197Z","caller":"traceutil/trace.go:171","msg":"trace[1839303247] linearizableReadLoop","detail":"{readStateIndex:416; appliedIndex:415; }","duration":"243.760594ms","start":"2026-02-11T02:20:16.051416Z","end":"2026-02-11T02:20:16.295177Z","steps":["trace[1839303247] 'read index received' (duration: 32.731762ms)","trace[1839303247] 'applied index is now lower than readState.Index' (duration: 211.027972ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T02:20:16.295618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.40556ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/coredns\" ","response":"range_response_count:1 size:4173"} {"level":"info","ts":"2026-02-11T02:20:16.295796Z","caller":"traceutil/trace.go:171","msg":"trace[306735431] range","detail":"{range_begin:/registry/deployments/kube-system/coredns; range_end:; response_count:1; response_revision:402; }","duration":"244.474281ms","start":"2026-02-11T02:20:16.051175Z","end":"2026-02-11T02:20:16.295649Z","steps":["trace[306735431] 'agreement among raft nodes before linearized reading' (duration: 244.084477ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T02:20:16.296297Z","caller":"traceutil/trace.go:171","msg":"trace[78033263] transaction","detail":"{read_only:false; response_revision:400; number_of_response:1; }","duration":"245.091126ms","start":"2026-02-11T02:20:16.051191Z","end":"2026-02-11T02:20:16.296282Z","steps":["trace[78033263] 'process raft request' (duration: 174.544694ms)","trace[78033263] 'compare' (duration: 69.25647ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T02:20:16.296873Z","caller":"traceutil/trace.go:171","msg":"trace[25637239] transaction","detail":"{read_only:false; response_revision:401; number_of_response:1; }","duration":"244.821083ms","start":"2026-02-11T02:20:16.052038Z","end":"2026-02-11T02:20:16.296859Z","steps":["trace[25637239] 'process raft request' (duration: 243.046517ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T02:20:16.297348Z","caller":"traceutil/trace.go:171","msg":"trace[894809125] transaction","detail":"{read_only:false; response_revision:402; number_of_response:1; }","duration":"245.109916ms","start":"2026-02-11T02:20:16.052226Z","end":"2026-02-11T02:20:16.297336Z","steps":["trace[894809125] 'process raft request' (duration: 242.906695ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:20:16.582098Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.572495ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/\" range_end:\"/registry/masterleases0\" ","response":"range_response_count:1 size:135"} {"level":"warn","ts":"2026-02-11T02:20:16.582108Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.183605ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/kube-system/coredns-77cccfdc44\" ","response":"range_response_count:1 size:3833"} {"level":"info","ts":"2026-02-11T02:20:16.582153Z","caller":"traceutil/trace.go:171","msg":"trace[1351982066] range","detail":"{range_begin:/registry/masterleases/; range_end:/registry/masterleases0; response_count:1; response_revision:404; }","duration":"212.667017ms","start":"2026-02-11T02:20:16.369473Z","end":"2026-02-11T02:20:16.58214Z","steps":["trace[1351982066] 'agreement among raft nodes before linearized reading' (duration: 26.103599ms)","trace[1351982066] 'range keys from in-memory index tree' (duration: 186.463497ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T02:20:16.582182Z","caller":"traceutil/trace.go:171","msg":"trace[1986981200] range","detail":"{range_begin:/registry/replicasets/kube-system/coredns-77cccfdc44; range_end:; response_count:1; response_revision:404; }","duration":"269.272476ms","start":"2026-02-11T02:20:16.31289Z","end":"2026-02-11T02:20:16.582163Z","steps":["trace[1986981200] 'agreement among raft nodes before linearized reading' (duration: 82.766549ms)","trace[1986981200] 'range keys from in-memory index tree' (duration: 186.374776ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T02:20:16.584357Z","caller":"traceutil/trace.go:171","msg":"trace[311430928] transaction","detail":"{read_only:false; response_revision:405; number_of_response:1; }","duration":"181.704062ms","start":"2026-02-11T02:20:16.402637Z","end":"2026-02-11T02:20:16.584341Z","steps":["trace[311430928] 'process raft request' (duration: 181.585271ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T02:20:16.674883Z","caller":"traceutil/trace.go:171","msg":"trace[917391978] linearizableReadLoop","detail":"{readStateIndex:423; appliedIndex:421; }","duration":"139.961014ms","start":"2026-02-11T02:20:16.534756Z","end":"2026-02-11T02:20:16.674717Z","steps":["trace[917391978] 'read index received' (duration: 49.419271ms)","trace[917391978] 'applied index is now lower than readState.Index' (duration: 90.538683ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T02:20:16.674921Z","caller":"traceutil/trace.go:171","msg":"trace[1127659290] transaction","detail":"{read_only:false; response_revision:406; number_of_response:1; }","duration":"271.893482ms","start":"2026-02-11T02:20:16.402998Z","end":"2026-02-11T02:20:16.674892Z","steps":["trace[1127659290] 'process raft request' (duration: 271.596169ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:20:16.675122Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.343868ms","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-02-11T02:20:16.675157Z","caller":"traceutil/trace.go:171","msg":"trace[1790859204] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:406; }","duration":"140.427799ms","start":"2026-02-11T02:20:16.534718Z","end":"2026-02-11T02:20:16.675146Z","steps":["trace[1790859204] 'agreement among raft nodes before linearized reading' (duration: 140.257588ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T02:20:16.752437Z","caller":"traceutil/trace.go:171","msg":"trace[1666696125] transaction","detail":"{read_only:false; response_revision:407; number_of_response:1; }","duration":"164.62622ms","start":"2026-02-11T02:20:16.587785Z","end":"2026-02-11T02:20:16.752411Z","steps":["trace[1666696125] 'process raft request' (duration: 121.150365ms)","trace[1666696125] 'compare' (duration: 43.333674ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T02:20:16.752577Z","caller":"traceutil/trace.go:171","msg":"trace[2140878156] transaction","detail":"{read_only:false; response_revision:408; number_of_response:1; }","duration":"161.475ms","start":"2026-02-11T02:20:16.591084Z","end":"2026-02-11T02:20:16.752559Z","steps":["trace[2140878156] 'process raft request' (duration: 161.270628ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:20:16.752716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.086772ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-02-11T02:20:16.752738Z","caller":"traceutil/trace.go:171","msg":"trace[1664142977] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:409; }","duration":"212.134072ms","start":"2026-02-11T02:20:16.540598Z","end":"2026-02-11T02:20:16.752732Z","steps":["trace[1664142977] 'agreement among raft nodes before linearized reading' (duration: 212.081332ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:20:16.752869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.165913ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-02-11T02:20:16.752882Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.133543ms","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-02-11T02:20:16.752905Z","caller":"traceutil/trace.go:171","msg":"trace[520521485] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:409; }","duration":"209.178164ms","start":"2026-02-11T02:20:16.543721Z","end":"2026-02-11T02:20:16.752899Z","steps":["trace[520521485] 'agreement among raft nodes before linearized reading' (duration: 209.124154ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:20:16.752988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.610597ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-02-11T02:20:16.753003Z","caller":"traceutil/trace.go:171","msg":"trace[827757548] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:409; }","duration":"169.642587ms","start":"2026-02-11T02:20:16.583356Z","end":"2026-02-11T02:20:16.752998Z","steps":["trace[827757548] 'agreement among raft nodes before linearized reading' (duration: 169.615607ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T02:20:16.752886Z","caller":"traceutil/trace.go:171","msg":"trace[1431154383] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:409; }","duration":"210.192003ms","start":"2026-02-11T02:20:16.542689Z","end":"2026-02-11T02:20:16.752881Z","steps":["trace[1431154383] 'agreement among raft nodes before linearized reading' (duration: 210.163693ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T02:20:16.996719Z","caller":"traceutil/trace.go:171","msg":"trace[250894306] transaction","detail":"{read_only:false; response_revision:416; number_of_response:1; }","duration":"179.698092ms","start":"2026-02-11T02:20:16.816987Z","end":"2026-02-11T02:20:16.996685Z","steps":["trace[250894306] 'process raft request' (duration: 100.973131ms)","trace[250894306] 'compare' (duration: 78.559759ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T02:20:16.996785Z","caller":"traceutil/trace.go:171","msg":"trace[487252769] transaction","detail":"{read_only:false; response_revision:417; number_of_response:1; }","duration":"178.227089ms","start":"2026-02-11T02:20:16.818543Z","end":"2026-02-11T02:20:16.99677Z","steps":["trace[487252769] 'process raft request' (duration: 178.079267ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T02:20:16.996967Z","caller":"traceutil/trace.go:171","msg":"trace[1379211142] transaction","detail":"{read_only:false; response_revision:418; number_of_response:1; }","duration":"178.36606ms","start":"2026-02-11T02:20:16.818596Z","end":"2026-02-11T02:20:16.996962Z","steps":["trace[1379211142] 'process raft request' (duration: 178.053716ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T02:20:16.997099Z","caller":"traceutil/trace.go:171","msg":"trace[1718083221] transaction","detail":"{read_only:false; response_revision:419; number_of_response:1; }","duration":"178.471591ms","start":"2026-02-11T02:20:16.818623Z","end":"2026-02-11T02:20:16.997095Z","steps":["trace[1718083221] 'process raft request' (duration: 178.044357ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T02:20:16.996737Z","caller":"traceutil/trace.go:171","msg":"trace[605710064] transaction","detail":"{read_only:false; response_revision:420; number_of_response:1; }","duration":"174.458152ms","start":"2026-02-11T02:20:16.822264Z","end":"2026-02-11T02:20:16.996722Z","steps":["trace[605710064] 'process raft request' (duration: 174.426852ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T02:20:31.045508Z","caller":"traceutil/trace.go:171","msg":"trace[229454595] linearizableReadLoop","detail":"{readStateIndex:527; appliedIndex:526; }","duration":"158.651318ms","start":"2026-02-11T02:20:30.886841Z","end":"2026-02-11T02:20:31.045493Z","steps":["trace[229454595] 'read index received' (duration: 158.546086ms)","trace[229454595] 'applied index is now lower than readState.Index' (duration: 104.562µs)"],"step_count":2} {"level":"info","ts":"2026-02-11T02:20:31.045585Z","caller":"traceutil/trace.go:171","msg":"trace[499687339] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"184.400414ms","start":"2026-02-11T02:20:30.861179Z","end":"2026-02-11T02:20:31.045579Z","steps":["trace[499687339] 'process raft request' (duration: 184.217401ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:20:31.045766Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.029638ms","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-02-11T02:20:31.045819Z","caller":"traceutil/trace.go:171","msg":"trace[1766225985] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:508; }","duration":"138.109279ms","start":"2026-02-11T02:20:30.907696Z","end":"2026-02-11T02:20:31.045805Z","steps":["trace[1766225985] 'agreement among raft nodes before linearized reading' (duration: 137.979417ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:20:31.045846Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.992443ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-02-11T02:20:31.04587Z","caller":"traceutil/trace.go:171","msg":"trace[1573007839] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:508; }","duration":"159.043113ms","start":"2026-02-11T02:20:30.886818Z","end":"2026-02-11T02:20:31.045861Z","steps":["trace[1573007839] 'agreement among raft nodes before linearized reading' (duration: 158.961202ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:20:31.045935Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.18059ms","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-02-11T02:20:31.045947Z","caller":"traceutil/trace.go:171","msg":"trace[1434683305] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:508; }","duration":"138.20643ms","start":"2026-02-11T02:20:30.907737Z","end":"2026-02-11T02:20:31.045944Z","steps":["trace[1434683305] 'agreement among raft nodes before linearized reading' (duration: 138.166809ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:20:35.243801Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":12430388290298775417,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-11T02:20:35.325857Z","caller":"traceutil/trace.go:171","msg":"trace[1676746899] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"971.20308ms","start":"2026-02-11T02:20:34.354639Z","end":"2026-02-11T02:20:35.325842Z","steps":["trace[1676746899] 'process raft request' (duration: 970.825104ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:20:35.325964Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:20:34.354627Z","time spent":"971.273641ms","remote":"127.0.0.1:57002","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":16803,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-11T02:20:35.409953Z","caller":"traceutil/trace.go:171","msg":"trace[1261354075] linearizableReadLoop","detail":"{readStateIndex:540; appliedIndex:538; }","duration":"666.568676ms","start":"2026-02-11T02:20:34.743364Z","end":"2026-02-11T02:20:35.409933Z","steps":["trace[1261354075] 'read index received' (duration: 582.146853ms)","trace[1261354075] 'applied index is now lower than readState.Index' (duration: 84.421073ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T02:20:35.410244Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"355.045814ms","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-02-11T02:20:35.410295Z","caller":"traceutil/trace.go:171","msg":"trace[225479672] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:520; }","duration":"355.130935ms","start":"2026-02-11T02:20:35.055148Z","end":"2026-02-11T02:20:35.410279Z","steps":["trace[225479672] 'agreement among raft nodes before linearized reading' (duration: 354.986753ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:20:35.410319Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:20:35.055134Z","time spent":"355.180856ms","remote":"127.0.0.1:57090","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-02-11T02:20:35.410317Z","caller":"traceutil/trace.go:171","msg":"trace[1075002432] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"327.039622ms","start":"2026-02-11T02:20:35.083267Z","end":"2026-02-11T02:20:35.410307Z","steps":["trace[1075002432] 'process raft request' (duration: 307.71656ms)","trace[1075002432] 'compare' (duration: 18.866894ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T02:20:35.41039Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:20:35.083256Z","time spent":"327.082292ms","remote":"127.0.0.1:57090","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-11T02:20:35.410458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"667.093405ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-11T02:20:35.410476Z","caller":"traceutil/trace.go:171","msg":"trace[1717472022] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:520; }","duration":"667.133406ms","start":"2026-02-11T02:20:34.743337Z","end":"2026-02-11T02:20:35.41047Z","steps":["trace[1717472022] 'agreement among raft nodes before linearized reading' (duration: 667.104636ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:20:35.410493Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:20:34.743321Z","time spent":"667.167547ms","remote":"127.0.0.1:56838","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-02-11T02:20:35.410519Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.110873ms","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-02-11T02:20:35.410537Z","caller":"traceutil/trace.go:171","msg":"trace[327439029] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:520; }","duration":"327.137473ms","start":"2026-02-11T02:20:35.083395Z","end":"2026-02-11T02:20:35.410532Z","steps":["trace[327439029] 'agreement among raft nodes before linearized reading' (duration: 327.088722ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:20:35.41055Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:20:35.083391Z","time spent":"327.155634ms","remote":"127.0.0.1:57090","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-02-11T02:20:35.410631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.296946ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-02-11T02:20:35.410645Z","caller":"traceutil/trace.go:171","msg":"trace[1803384615] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:520; }","duration":"327.310246ms","start":"2026-02-11T02:20:35.083331Z","end":"2026-02-11T02:20:35.410641Z","steps":["trace[1803384615] 'agreement among raft nodes before linearized reading' (duration: 327.270905ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:20:35.410658Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:20:35.083316Z","time spent":"327.338826ms","remote":"127.0.0.1:57090","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-11T02:20:35.410784Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.199627ms","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-02-11T02:20:35.410809Z","caller":"traceutil/trace.go:171","msg":"trace[2815753] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:520; }","duration":"329.245718ms","start":"2026-02-11T02:20:35.081557Z","end":"2026-02-11T02:20:35.410803Z","steps":["trace[2815753] 'agreement among raft nodes before linearized reading' (duration: 329.140036ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:20:35.410827Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:20:35.081546Z","time spent":"329.277359ms","remote":"127.0.0.1:57090","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-02-11T02:20:36.920121Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:20:36.078846Z","time spent":"841.270868ms","remote":"127.0.0.1:51094","response type":"/etcdserverpb.Maintenance/Status","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-02-11T02:20:36.920427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.400803196s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-11T02:20:36.920605Z","caller":"traceutil/trace.go:171","msg":"trace[203538204] linearizableReadLoop","detail":"{readStateIndex:546; appliedIndex:541; }","duration":"175.942464ms","start":"2026-02-11T02:20:36.744652Z","end":"2026-02-11T02:20:36.920594Z","steps":["trace[203538204] 'read index received' (duration: 33.43µs)","trace[203538204] 'applied index is now lower than readState.Index' (duration: 175.908514ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T02:20:36.920655Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.003105ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-11T02:20:36.920666Z","caller":"traceutil/trace.go:171","msg":"trace[908006348] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:525; }","duration":"176.048026ms","start":"2026-02-11T02:20:36.744614Z","end":"2026-02-11T02:20:36.920662Z","steps":["trace[908006348] 'agreement among raft nodes before linearized reading' (duration: 176.007415ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T02:20:36.920816Z","caller":"traceutil/trace.go:171","msg":"trace[1965797563] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"1.504117324s","start":"2026-02-11T02:20:35.416692Z","end":"2026-02-11T02:20:36.92081Z","steps":["trace[1965797563] 'process raft request' (duration: 102.878431ms)","trace[1965797563] 'compare' (duration: 1.400133845s)"],"step_count":2} {"level":"warn","ts":"2026-02-11T02:20:36.920843Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:20:35.416683Z","time spent":"1.504145814s","remote":"127.0.0.1:57090","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-11T02:20:36.920899Z","caller":"traceutil/trace.go:171","msg":"trace[501788388] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"1.501604683s","start":"2026-02-11T02:20:35.41929Z","end":"2026-02-11T02:20:36.920894Z","steps":["trace[501788388] 'process raft request' (duration: 1.501197827s)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:20:36.920921Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:20:35.419283Z","time spent":"1.501624733s","remote":"127.0.0.1:57090","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-02-11T02:20:36.920975Z","caller":"traceutil/trace.go:171","msg":"trace[2069763818] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"1.500440635s","start":"2026-02-11T02:20:35.420529Z","end":"2026-02-11T02:20:36.92097Z","steps":["trace[2069763818] 'process raft request' (duration: 1.500007288s)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:20:36.920995Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:20:35.420523Z","time spent":"1.500461186s","remote":"127.0.0.1:56866","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-11T02:20:36.921051Z","caller":"traceutil/trace.go:171","msg":"trace[1615125730] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"1.500478576s","start":"2026-02-11T02:20:35.420568Z","end":"2026-02-11T02:20:36.921047Z","steps":["trace[1615125730] 'process raft request' (duration: 1.499990377s)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:20:36.921072Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:20:35.420565Z","time spent":"1.500495476s","remote":"127.0.0.1:57090","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-02-11T02:20:36.92112Z","caller":"traceutil/trace.go:171","msg":"trace[1375472862] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"1.498740837s","start":"2026-02-11T02:20:35.422375Z","end":"2026-02-11T02:20:36.921116Z","steps":["trace[1375472862] 'process raft request' (duration: 1.498199728s)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:20:36.921141Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:20:35.422369Z","time spent":"1.498759637s","remote":"127.0.0.1:57090","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-02-11T02:20:38.882382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.254449ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-11T02:20:38.882439Z","caller":"traceutil/trace.go:171","msg":"trace[1179094639] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:535; }","duration":"140.34423ms","start":"2026-02-11T02:20:38.742083Z","end":"2026-02-11T02:20:38.882427Z","steps":["trace[1179094639] 'range keys from in-memory index tree' (duration: 140.214077ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T02:20:42.518309Z","caller":"traceutil/trace.go:171","msg":"trace[253554578] linearizableReadLoop","detail":"{readStateIndex:615; appliedIndex:614; }","duration":"111.009952ms","start":"2026-02-11T02:20:42.407255Z","end":"2026-02-11T02:20:42.518265Z","steps":["trace[253554578] 'read index received' (duration: 69.081002ms)","trace[253554578] 'applied index is now lower than readState.Index' (duration: 41.9282ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T02:20:42.518387Z","caller":"traceutil/trace.go:171","msg":"trace[1798802057] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"111.252077ms","start":"2026-02-11T02:20:42.407129Z","end":"2026-02-11T02:20:42.518381Z","steps":["trace[1798802057] 'process raft request' (duration: 110.811028ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:20:42.518675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.40663ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-lfrgn\" ","response":"range_response_count:1 size:17918"} {"level":"info","ts":"2026-02-11T02:20:42.5187Z","caller":"traceutil/trace.go:171","msg":"trace[36112599] range","detail":"{range_begin:/registry/pods/kube-system/cilium-lfrgn; range_end:; response_count:1; response_revision:593; }","duration":"111.4565ms","start":"2026-02-11T02:20:42.407238Z","end":"2026-02-11T02:20:42.518694Z","steps":["trace[36112599] 'agreement among raft nodes before linearized reading' (duration: 111.327748ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T02:20:48.171273Z","caller":"traceutil/trace.go:171","msg":"trace[300620219] transaction","detail":"{read_only:false; response_revision:653; number_of_response:1; }","duration":"148.02918ms","start":"2026-02-11T02:20:48.023218Z","end":"2026-02-11T02:20:48.171247Z","steps":["trace[300620219] 'process raft request' (duration: 147.856907ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T02:20:48.492034Z","caller":"traceutil/trace.go:171","msg":"trace[1281129459] transaction","detail":"{read_only:false; response_revision:655; number_of_response:1; }","duration":"176.573362ms","start":"2026-02-11T02:20:48.315447Z","end":"2026-02-11T02:20:48.49202Z","steps":["trace[1281129459] 'process raft request' (duration: 176.50182ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T02:21:09.398695Z","caller":"traceutil/trace.go:171","msg":"trace[2076890613] linearizableReadLoop","detail":"{readStateIndex:805; appliedIndex:804; }","duration":"110.941944ms","start":"2026-02-11T02:21:09.287732Z","end":"2026-02-11T02:21:09.398674Z","steps":["trace[2076890613] 'read index received' (duration: 21.115896ms)","trace[2076890613] 'applied index is now lower than readState.Index' (duration: 89.825288ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T02:21:09.398831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.075237ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-11T02:21:09.398853Z","caller":"traceutil/trace.go:171","msg":"trace[109108000] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:776; }","duration":"111.135189ms","start":"2026-02-11T02:21:09.287712Z","end":"2026-02-11T02:21:09.398847Z","steps":["trace[109108000] 'agreement among raft nodes before linearized reading' (duration: 111.055087ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T02:21:09.399028Z","caller":"traceutil/trace.go:171","msg":"trace[904194920] transaction","detail":"{read_only:false; response_revision:776; number_of_response:1; }","duration":"131.17535ms","start":"2026-02-11T02:21:09.267846Z","end":"2026-02-11T02:21:09.399021Z","steps":["trace[904194920] 'process raft request' (duration: 130.165506ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T02:21:21.290702Z","caller":"traceutil/trace.go:171","msg":"trace[1295131447] transaction","detail":"{read_only:false; response_revision:806; number_of_response:1; }","duration":"105.018892ms","start":"2026-02-11T02:21:21.185667Z","end":"2026-02-11T02:21:21.290686Z","steps":["trace[1295131447] 'process raft request' (duration: 104.752176ms)"],"step_count":1}