{"level":"warn","ts":"2026-10-09T02:14:49.435855Z","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-09T02:14:49.43595Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.75: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.75:2380","--initial-cluster=instance=https://162.253.55.75:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.75:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.75: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-09T02:14:49.436008Z","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-09T02:14:49.436021Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.75:2380"]} {"level":"info","ts":"2026-10-09T02:14:49.436046Z","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-09T02:14:49.436921Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.75:2379"]} {"level":"info","ts":"2026-10-09T02:14:49.437Z","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.75:2380"],"listen-peer-urls":["https://162.253.55.75:2380"],"advertise-client-urls":["https://162.253.55.75:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.75:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.75: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-09T02:14:49.442313Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.063728ms"} {"level":"info","ts":"2026-10-09T02:14:49.454458Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"871515da6373d131","cluster-id":"1ca87f0850671e76"} {"level":"info","ts":"2026-10-09T02:14:49.454524Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"871515da6373d131 switched to configuration voters=()"} {"level":"info","ts":"2026-10-09T02:14:49.454539Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"871515da6373d131 became follower at term 0"} {"level":"info","ts":"2026-10-09T02:14:49.454553Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 871515da6373d131 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-10-09T02:14:49.454561Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"871515da6373d131 became follower at term 1"} {"level":"info","ts":"2026-10-09T02:14:49.454591Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"871515da6373d131 switched to configuration voters=(9733710197346783537)"} {"level":"warn","ts":"2026-10-09T02:14:49.465307Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-10-09T02:14:49.468924Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-10-09T02:14:49.472819Z","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-09T02:14:49.474717Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"871515da6373d131","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-10-09T02:14:49.477104Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"871515da6373d131","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-10-09T02:14:49.477162Z","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-09T02:14:49.477205Z","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-09T02:14:49.477213Z","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-09T02:14:49.47776Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"871515da6373d131 switched to configuration voters=(9733710197346783537)"} {"level":"info","ts":"2026-10-09T02:14:49.478066Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"1ca87f0850671e76","local-member-id":"871515da6373d131","added-peer-id":"871515da6373d131","added-peer-peer-urls":["https://162.253.55.75:2380"]} {"level":"info","ts":"2026-10-09T02:14:49.487329Z","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-09T02:14:49.487425Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.75:2380"} {"level":"info","ts":"2026-10-09T02:14:49.487471Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.75:2380"} {"level":"info","ts":"2026-10-09T02:14:49.487611Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"871515da6373d131","initial-advertise-peer-urls":["https://162.253.55.75:2380"],"listen-peer-urls":["https://162.253.55.75:2380"],"advertise-client-urls":["https://162.253.55.75:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.75:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-10-09T02:14:49.487657Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-10-09T02:14:49.556367Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"871515da6373d131 is starting a new election at term 1"} {"level":"info","ts":"2026-10-09T02:14:49.556421Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"871515da6373d131 became pre-candidate at term 1"} {"level":"info","ts":"2026-10-09T02:14:49.556462Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"871515da6373d131 received MsgPreVoteResp from 871515da6373d131 at term 1"} {"level":"info","ts":"2026-10-09T02:14:49.556481Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"871515da6373d131 became candidate at term 2"} {"level":"info","ts":"2026-10-09T02:14:49.556499Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"871515da6373d131 received MsgVoteResp from 871515da6373d131 at term 2"} {"level":"info","ts":"2026-10-09T02:14:49.556515Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"871515da6373d131 became leader at term 2"} {"level":"info","ts":"2026-10-09T02:14:49.556535Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 871515da6373d131 elected leader 871515da6373d131 at term 2"} {"level":"info","ts":"2026-10-09T02:14:49.557774Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-10-09T02:14:49.558923Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"871515da6373d131","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.75:2379]}","request-path":"/0/members/871515da6373d131/attributes","cluster-id":"1ca87f0850671e76","publish-timeout":"7s"} {"level":"info","ts":"2026-10-09T02:14:49.559078Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-09T02:14:49.559245Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-09T02:14:49.559635Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"1ca87f0850671e76","local-member-id":"871515da6373d131","cluster-version":"3.5"} {"level":"info","ts":"2026-10-09T02:14:49.55977Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-10-09T02:14:49.559816Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-10-09T02:14:49.559917Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-10-09T02:14:49.560036Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-10-09T02:14:49.563424Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-10-09T02:14:49.563735Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.75:2379"} {"level":"warn","ts":"2026-10-09T02:14:54.138805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"373.369038ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/replication-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-09T02:14:54.138991Z","caller":"traceutil/trace.go:171","msg":"trace[1322991081] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replication-controller; range_end:; response_count:0; response_revision:222; }","duration":"373.605433ms","start":"2026-10-09T02:14:53.765354Z","end":"2026-10-09T02:14:54.13896Z","steps":["trace[1322991081] 'range keys from in-memory index tree' (duration: 373.193553ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:14:54.139068Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:14:53.765341Z","time spent":"373.711926ms","remote":"127.0.0.1:36596","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":0,"response size":28,"request content":"key:\"/registry/serviceaccounts/kube-system/replication-controller\" "} {"level":"warn","ts":"2026-10-09T02:14:54.139964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.04559ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-10-09T02:14:54.140416Z","caller":"traceutil/trace.go:171","msg":"trace[528643355] transaction","detail":"{read_only:false; response_revision:223; number_of_response:1; }","duration":"338.835742ms","start":"2026-10-09T02:14:53.801525Z","end":"2026-10-09T02:14:54.140361Z","steps":["trace[528643355] 'process raft request' (duration: 161.227445ms)","trace[528643355] 'compare' (duration: 175.848926ms)"],"step_count":2} {"level":"warn","ts":"2026-10-09T02:14:54.140682Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:14:53.801494Z","time spent":"339.047517ms","remote":"127.0.0.1:36486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":592,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-09T02:14:54.497147Z","caller":"traceutil/trace.go:171","msg":"trace[1930419831] transaction","detail":"{read_only:false; response_revision:224; number_of_response:1; }","duration":"351.287882ms","start":"2026-10-09T02:14:54.14583Z","end":"2026-10-09T02:14:54.497118Z","steps":["trace[1930419831] 'process raft request' (duration: 260.792819ms)","trace[1930419831] 'compare' (duration: 90.350529ms)"],"step_count":2} {"level":"warn","ts":"2026-10-09T02:14:54.49732Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:14:54.14581Z","time spent":"351.433915ms","remote":"127.0.0.1:36486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":625,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-09T02:14:54.601401Z","caller":"traceutil/trace.go:171","msg":"trace[1043618087] transaction","detail":"{read_only:false; response_revision:225; number_of_response:1; }","duration":"455.243989ms","start":"2026-10-09T02:14:54.146114Z","end":"2026-10-09T02:14:54.601358Z","steps":["trace[1043618087] 'process raft request' (duration: 454.715757ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:14:54.601548Z","caller":"traceutil/trace.go:171","msg":"trace[404254798] transaction","detail":"{read_only:false; response_revision:226; number_of_response:1; }","duration":"452.307131ms","start":"2026-10-09T02:14:54.149165Z","end":"2026-10-09T02:14:54.601472Z","steps":["trace[404254798] 'process raft request' (duration: 452.066885ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:14:54.601643Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:14:54.146083Z","time spent":"455.420823ms","remote":"127.0.0.1:36596","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":194,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-09T02:14:54.601672Z","caller":"traceutil/trace.go:171","msg":"trace[332249383] transaction","detail":"{read_only:false; response_revision:227; number_of_response:1; }","duration":"407.141896ms","start":"2026-10-09T02:14:54.194511Z","end":"2026-10-09T02:14:54.601653Z","steps":["trace[332249383] 'process raft request' (duration: 406.858919ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:14:54.601766Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:14:54.194496Z","time spent":"407.228258ms","remote":"127.0.0.1:36592","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2905,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-09T02:14:54.602083Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:14:54.14914Z","time spent":"452.540975ms","remote":"127.0.0.1:36588","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4002,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-09T02:14:54.624473Z","caller":"traceutil/trace.go:171","msg":"trace[1471722540] transaction","detail":"{read_only:false; response_revision:228; number_of_response:1; }","duration":"122.673664ms","start":"2026-10-09T02:14:54.501752Z","end":"2026-10-09T02:14:54.624426Z","steps":["trace[1471722540] 'process raft request' (duration: 122.49191ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:15:35.153243Z","caller":"traceutil/trace.go:171","msg":"trace[1332412521] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"134.46403ms","start":"2026-10-09T02:15:35.018755Z","end":"2026-10-09T02:15:35.153219Z","steps":["trace[1332412521] 'process raft request' (duration: 134.330616ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:15:35.159915Z","caller":"traceutil/trace.go:171","msg":"trace[294288535] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"135.76596ms","start":"2026-10-09T02:15:35.024124Z","end":"2026-10-09T02:15:35.15989Z","steps":["trace[294288535] 'process raft request' (duration: 134.702866ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:15:35.160153Z","caller":"traceutil/trace.go:171","msg":"trace[430860863] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"119.006548ms","start":"2026-10-09T02:15:35.041132Z","end":"2026-10-09T02:15:35.160139Z","steps":["trace[430860863] 'process raft request' (duration: 117.80085ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:15:35.16029Z","caller":"traceutil/trace.go:171","msg":"trace[1647847439] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"118.62123ms","start":"2026-10-09T02:15:35.041659Z","end":"2026-10-09T02:15:35.160281Z","steps":["trace[1647847439] 'process raft request' (duration: 117.310129ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:15:35.160458Z","caller":"traceutil/trace.go:171","msg":"trace[1766131784] transaction","detail":"{read_only:false; response_revision:553; number_of_response:1; }","duration":"109.835995ms","start":"2026-10-09T02:15:35.050593Z","end":"2026-10-09T02:15:35.160429Z","steps":["trace[1766131784] 'process raft request' (duration: 108.410402ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:15:35.160568Z","caller":"traceutil/trace.go:171","msg":"trace[2055836449] transaction","detail":"{read_only:false; response_revision:554; number_of_response:1; }","duration":"109.441806ms","start":"2026-10-09T02:15:35.051119Z","end":"2026-10-09T02:15:35.160561Z","steps":["trace[2055836449] 'process raft request' (duration: 107.921911ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:15:41.689679Z","caller":"traceutil/trace.go:171","msg":"trace[808033668] linearizableReadLoop","detail":"{readStateIndex:681; appliedIndex:680; }","duration":"154.556953ms","start":"2026-10-09T02:15:41.535094Z","end":"2026-10-09T02:15:41.689651Z","steps":["trace[808033668] 'read index received' (duration: 154.344698ms)","trace[808033668] 'applied index is now lower than readState.Index' (duration: 210.805µs)"],"step_count":2} {"level":"info","ts":"2026-10-09T02:15:41.689715Z","caller":"traceutil/trace.go:171","msg":"trace[356681384] transaction","detail":"{read_only:false; response_revision:654; number_of_response:1; }","duration":"315.690784ms","start":"2026-10-09T02:15:41.373989Z","end":"2026-10-09T02:15:41.68968Z","steps":["trace[356681384] 'process raft request' (duration: 315.481769ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:15:41.689966Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.86181ms","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-09T02:15:41.690007Z","caller":"traceutil/trace.go:171","msg":"trace[1229970798] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:654; }","duration":"154.985543ms","start":"2026-10-09T02:15:41.53501Z","end":"2026-10-09T02:15:41.689995Z","steps":["trace[1229970798] 'agreement among raft nodes before linearized reading' (duration: 154.789578ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:15:41.690171Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:15:41.373939Z","time spent":"316.013771ms","remote":"127.0.0.1:36592","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-09T02:15:41.690332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.054133ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-10-09T02:15:41.690411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.538051ms","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-09T02:15:41.690639Z","caller":"traceutil/trace.go:171","msg":"trace[1219158457] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:654; }","duration":"152.474723ms","start":"2026-10-09T02:15:41.538108Z","end":"2026-10-09T02:15:41.690583Z","steps":["trace[1219158457] 'agreement among raft nodes before linearized reading' (duration: 151.860688ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:15:41.690689Z","caller":"traceutil/trace.go:171","msg":"trace[1139920388] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:654; }","duration":"108.833837ms","start":"2026-10-09T02:15:41.581836Z","end":"2026-10-09T02:15:41.69067Z","steps":["trace[1139920388] 'agreement among raft nodes before linearized reading' (duration: 108.50926ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:15:42.289422Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15074006579903951996,"retry-timeout":"500ms"} {"level":"info","ts":"2026-10-09T02:15:42.348848Z","caller":"traceutil/trace.go:171","msg":"trace[130338841] linearizableReadLoop","detail":"{readStateIndex:685; appliedIndex:684; }","duration":"560.222482ms","start":"2026-10-09T02:15:41.788599Z","end":"2026-10-09T02:15:42.348821Z","steps":["trace[130338841] 'read index received' (duration: 559.328531ms)","trace[130338841] 'applied index is now lower than readState.Index' (duration: 892.681µs)"],"step_count":2} {"level":"warn","ts":"2026-10-09T02:15:42.349063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"560.456827ms","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-10-09T02:15:42.349104Z","caller":"traceutil/trace.go:171","msg":"trace[1975341125] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:658; }","duration":"560.5711ms","start":"2026-10-09T02:15:41.78852Z","end":"2026-10-09T02:15:42.349092Z","steps":["trace[1975341125] 'agreement among raft nodes before linearized reading' (duration: 560.393646ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:15:42.34914Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:15:41.78849Z","time spent":"560.641501ms","remote":"127.0.0.1:36662","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-10-09T02:15:42.349095Z","caller":"traceutil/trace.go:171","msg":"trace[1880815024] transaction","detail":"{read_only:false; response_revision:658; number_of_response:1; }","duration":"642.332569ms","start":"2026-10-09T02:15:41.7066Z","end":"2026-10-09T02:15:42.348933Z","steps":["trace[1880815024] 'process raft request' (duration: 641.57136ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:15:42.349358Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:15:41.70659Z","time spent":"642.638696ms","remote":"127.0.0.1:36498","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036289,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-09T02:16:40.328365Z","caller":"traceutil/trace.go:171","msg":"trace[228972284] transaction","detail":"{read_only:false; response_revision:1111; number_of_response:1; }","duration":"300.575471ms","start":"2026-10-09T02:16:40.027764Z","end":"2026-10-09T02:16:40.328339Z","steps":["trace[228972284] 'process raft request' (duration: 300.421577ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:16:40.328391Z","caller":"traceutil/trace.go:171","msg":"trace[1980869880] linearizableReadLoop","detail":"{readStateIndex:1155; appliedIndex:1155; }","duration":"238.526414ms","start":"2026-10-09T02:16:40.089825Z","end":"2026-10-09T02:16:40.328351Z","steps":["trace[1980869880] 'read index received' (duration: 238.507094ms)","trace[1980869880] 'applied index is now lower than readState.Index' (duration: 16.67µs)"],"step_count":2} {"level":"warn","ts":"2026-10-09T02:16:40.328515Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:16:40.027741Z","time spent":"300.701904ms","remote":"127.0.0.1:36662","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-10-09T02:16:40.328699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.845133ms","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-10-09T02:16:40.328742Z","caller":"traceutil/trace.go:171","msg":"trace[1606103208] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1111; }","duration":"238.954165ms","start":"2026-10-09T02:16:40.089776Z","end":"2026-10-09T02:16:40.32873Z","steps":["trace[1606103208] 'agreement among raft nodes before linearized reading' (duration: 238.716989ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:16:40.330786Z","caller":"traceutil/trace.go:171","msg":"trace[496810422] transaction","detail":"{read_only:false; response_revision:1112; number_of_response:1; }","duration":"103.970791ms","start":"2026-10-09T02:16:40.226797Z","end":"2026-10-09T02:16:40.330768Z","steps":["trace[496810422] 'process raft request' (duration: 103.806727ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:16:40.330878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.117701ms","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-09T02:16:40.330931Z","caller":"traceutil/trace.go:171","msg":"trace[841032895] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1112; }","duration":"237.202793ms","start":"2026-10-09T02:16:40.093715Z","end":"2026-10-09T02:16:40.330918Z","steps":["trace[841032895] 'agreement among raft nodes before linearized reading' (duration: 237.003498ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:16:40.331075Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.043836ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-10-09T02:16:40.331132Z","caller":"traceutil/trace.go:171","msg":"trace[1226121812] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1112; }","duration":"115.138989ms","start":"2026-10-09T02:16:40.215979Z","end":"2026-10-09T02:16:40.331118Z","steps":["trace[1226121812] 'agreement among raft nodes before linearized reading' (duration: 115.001475ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:16:56.93706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.125483ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-09T02:16:56.937175Z","caller":"traceutil/trace.go:171","msg":"trace[1446207085] transaction","detail":"{read_only:false; response_revision:1179; number_of_response:1; }","duration":"185.764569ms","start":"2026-10-09T02:16:56.751388Z","end":"2026-10-09T02:16:56.937153Z","steps":["trace[1446207085] 'process raft request' (duration: 62.455352ms)","trace[1446207085] 'compare' (duration: 122.946509ms)"],"step_count":2} {"level":"info","ts":"2026-10-09T02:20:03.470599Z","caller":"traceutil/trace.go:171","msg":"trace[315185373] transaction","detail":"{read_only:false; response_revision:2073; number_of_response:1; }","duration":"178.56243ms","start":"2026-10-09T02:20:03.291994Z","end":"2026-10-09T02:20:03.470556Z","steps":["trace[315185373] 'process raft request' (duration: 125.342514ms)","trace[315185373] 'compare' (duration: 53.054123ms)"],"step_count":2} {"level":"info","ts":"2026-10-09T02:20:03.653339Z","caller":"traceutil/trace.go:171","msg":"trace[2035543016] transaction","detail":"{read_only:false; response_revision:2074; number_of_response:1; }","duration":"142.891761ms","start":"2026-10-09T02:20:03.510415Z","end":"2026-10-09T02:20:03.653306Z","steps":["trace[2035543016] 'process raft request' (duration: 77.830023ms)","trace[2035543016] 'compare' (duration: 64.809292ms)"],"step_count":2} {"level":"info","ts":"2026-10-09T02:20:03.653419Z","caller":"traceutil/trace.go:171","msg":"trace[267856857] transaction","detail":"{read_only:false; response_revision:2075; number_of_response:1; }","duration":"138.560458ms","start":"2026-10-09T02:20:03.514841Z","end":"2026-10-09T02:20:03.653401Z","steps":["trace[267856857] 'process raft request' (duration: 138.352693ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:20:03.65336Z","caller":"traceutil/trace.go:171","msg":"trace[1775106361] linearizableReadLoop","detail":"{readStateIndex:2162; appliedIndex:2159; }","duration":"100.905332ms","start":"2026-10-09T02:20:03.552434Z","end":"2026-10-09T02:20:03.65334Z","steps":["trace[1775106361] 'read index received' (duration: 35.7223ms)","trace[1775106361] 'applied index is now lower than readState.Index' (duration: 65.182252ms)"],"step_count":2} {"level":"info","ts":"2026-10-09T02:20:03.653563Z","caller":"traceutil/trace.go:171","msg":"trace[23605584] transaction","detail":"{read_only:false; response_revision:2076; number_of_response:1; }","duration":"138.004895ms","start":"2026-10-09T02:20:03.515498Z","end":"2026-10-09T02:20:03.653503Z","steps":["trace[23605584] 'process raft request' (duration: 137.772889ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:20:03.653758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.302651ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-10-09T02:20:03.653863Z","caller":"traceutil/trace.go:171","msg":"trace[560120538] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2076; }","duration":"101.453775ms","start":"2026-10-09T02:20:03.552385Z","end":"2026-10-09T02:20:03.653838Z","steps":["trace[560120538] 'agreement among raft nodes before linearized reading' (duration: 101.191118ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:20:05.774116Z","caller":"traceutil/trace.go:171","msg":"trace[1088812276] transaction","detail":"{read_only:false; response_revision:2083; number_of_response:1; }","duration":"112.076556ms","start":"2026-10-09T02:20:05.661999Z","end":"2026-10-09T02:20:05.774075Z","steps":["trace[1088812276] 'process raft request' (duration: 61.276058ms)","trace[1088812276] 'compare' (duration: 50.652055ms)"],"step_count":2} {"level":"info","ts":"2026-10-09T02:20:05.798344Z","caller":"traceutil/trace.go:171","msg":"trace[1053429693] linearizableReadLoop","detail":"{readStateIndex:2171; appliedIndex:2168; }","duration":"111.021582ms","start":"2026-10-09T02:20:05.687305Z","end":"2026-10-09T02:20:05.798326Z","steps":["trace[1053429693] 'read index received' (duration: 35.966806ms)","trace[1053429693] 'applied index is now lower than readState.Index' (duration: 75.053406ms)"],"step_count":2} {"level":"warn","ts":"2026-10-09T02:20:05.798538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.215926ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-10-09T02:20:05.798582Z","caller":"traceutil/trace.go:171","msg":"trace[195937551] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2085; }","duration":"111.37626ms","start":"2026-10-09T02:20:05.687191Z","end":"2026-10-09T02:20:05.798567Z","steps":["trace[195937551] 'agreement among raft nodes before linearized reading' (duration: 111.197316ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:20:05.798734Z","caller":"traceutil/trace.go:171","msg":"trace[1950309111] transaction","detail":"{read_only:false; response_revision:2084; number_of_response:1; }","duration":"135.399832ms","start":"2026-10-09T02:20:05.663321Z","end":"2026-10-09T02:20:05.79872Z","steps":["trace[1950309111] 'process raft request' (duration: 134.859269ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:20:05.798837Z","caller":"traceutil/trace.go:171","msg":"trace[1693665918] transaction","detail":"{read_only:false; response_revision:2085; number_of_response:1; }","duration":"134.993662ms","start":"2026-10-09T02:20:05.663832Z","end":"2026-10-09T02:20:05.798826Z","steps":["trace[1693665918] 'process raft request' (duration: 134.45221ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:20:05.94084Z","caller":"traceutil/trace.go:171","msg":"trace[318198493] transaction","detail":"{read_only:false; response_revision:2086; number_of_response:1; }","duration":"136.55014ms","start":"2026-10-09T02:20:05.80425Z","end":"2026-10-09T02:20:05.9408Z","steps":["trace[318198493] 'process raft request' (duration: 99.391886ms)","trace[318198493] 'compare' (duration: 37.017911ms)"],"step_count":2} {"level":"warn","ts":"2026-10-09T02:20:07.699068Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.802456ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:531"} {"level":"info","ts":"2026-10-09T02:20:07.699253Z","caller":"traceutil/trace.go:171","msg":"trace[1829640958] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:2090; }","duration":"116.036933ms","start":"2026-10-09T02:20:07.583145Z","end":"2026-10-09T02:20:07.699182Z","steps":["trace[1829640958] 'range keys from in-memory index tree' (duration: 115.601782ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:20:07.90364Z","caller":"traceutil/trace.go:171","msg":"trace[930739746] linearizableReadLoop","detail":"{readStateIndex:2178; appliedIndex:2177; }","duration":"100.730898ms","start":"2026-10-09T02:20:07.802876Z","end":"2026-10-09T02:20:07.903607Z","steps":["trace[930739746] 'read index received' (duration: 1.365003ms)","trace[930739746] 'applied index is now lower than readState.Index' (duration: 99.364495ms)"],"step_count":2} {"level":"info","ts":"2026-10-09T02:20:07.903789Z","caller":"traceutil/trace.go:171","msg":"trace[414123774] transaction","detail":"{read_only:false; response_revision:2092; number_of_response:1; }","duration":"121.766187ms","start":"2026-10-09T02:20:07.781988Z","end":"2026-10-09T02:20:07.903755Z","steps":["trace[414123774] 'process raft request' (duration: 22.335551ms)","trace[414123774] 'compare' (duration: 99.117219ms)"],"step_count":2} {"level":"warn","ts":"2026-10-09T02:20:07.904109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.688696ms","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-09T02:20:07.904191Z","caller":"traceutil/trace.go:171","msg":"trace[2127098381] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2092; }","duration":"100.803109ms","start":"2026-10-09T02:20:07.803368Z","end":"2026-10-09T02:20:07.904171Z","steps":["trace[2127098381] 'agreement among raft nodes before linearized reading' (duration: 100.608115ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:20:07.904202Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.060285ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-10-09T02:20:07.904294Z","caller":"traceutil/trace.go:171","msg":"trace[1242788120] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2092; }","duration":"101.469285ms","start":"2026-10-09T02:20:07.802804Z","end":"2026-10-09T02:20:07.904273Z","steps":["trace[1242788120] 'agreement among raft nodes before linearized reading' (duration: 100.993473ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:20:08.255364Z","caller":"traceutil/trace.go:171","msg":"trace[117802263] transaction","detail":"{read_only:false; response_revision:2097; number_of_response:1; }","duration":"145.900843ms","start":"2026-10-09T02:20:08.109416Z","end":"2026-10-09T02:20:08.255317Z","steps":["trace[117802263] 'process raft request' (duration: 106.773862ms)","trace[117802263] 'compare' (duration: 38.939707ms)"],"step_count":2} {"level":"info","ts":"2026-10-09T02:20:09.716072Z","caller":"traceutil/trace.go:171","msg":"trace[851141158] transaction","detail":"{read_only:false; response_revision:2099; number_of_response:1; }","duration":"105.04232ms","start":"2026-10-09T02:20:09.611007Z","end":"2026-10-09T02:20:09.716049Z","steps":["trace[851141158] 'process raft request' (duration: 104.900056ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:20:09.907533Z","caller":"traceutil/trace.go:171","msg":"trace[471764750] linearizableReadLoop","detail":"{readStateIndex:2187; appliedIndex:2186; }","duration":"159.954297ms","start":"2026-10-09T02:20:09.747534Z","end":"2026-10-09T02:20:09.907489Z","steps":["trace[471764750] 'read index received' (duration: 60.149362ms)","trace[471764750] 'applied index is now lower than readState.Index' (duration: 99.803525ms)"],"step_count":2} {"level":"warn","ts":"2026-10-09T02:20:09.907808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.253754ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:531"} {"level":"info","ts":"2026-10-09T02:20:09.907849Z","caller":"traceutil/trace.go:171","msg":"trace[1641346352] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:2100; }","duration":"160.372907ms","start":"2026-10-09T02:20:09.747464Z","end":"2026-10-09T02:20:09.907837Z","steps":["trace[1641346352] 'agreement among raft nodes before linearized reading' (duration: 160.153882ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:20:09.908247Z","caller":"traceutil/trace.go:171","msg":"trace[1530363192] transaction","detail":"{read_only:false; response_revision:2100; number_of_response:1; }","duration":"181.0674ms","start":"2026-10-09T02:20:09.727111Z","end":"2026-10-09T02:20:09.908178Z","steps":["trace[1530363192] 'process raft request' (duration: 80.451065ms)","trace[1530363192] 'compare' (duration: 99.775125ms)"],"step_count":2} {"level":"info","ts":"2026-10-09T02:20:10.097508Z","caller":"traceutil/trace.go:171","msg":"trace[1347837940] linearizableReadLoop","detail":"{readStateIndex:2189; appliedIndex:2187; }","duration":"118.168213ms","start":"2026-10-09T02:20:09.979307Z","end":"2026-10-09T02:20:10.097475Z","steps":["trace[1347837940] 'read index received' (duration: 24.314979ms)","trace[1347837940] 'applied index is now lower than readState.Index' (duration: 93.851924ms)"],"step_count":2} {"level":"info","ts":"2026-10-09T02:20:10.097572Z","caller":"traceutil/trace.go:171","msg":"trace[1766197146] transaction","detail":"{read_only:false; response_revision:2102; number_of_response:1; }","duration":"183.534608ms","start":"2026-10-09T02:20:09.913998Z","end":"2026-10-09T02:20:10.097532Z","steps":["trace[1766197146] 'process raft request' (duration: 183.314723ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:20:10.097816Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.49212ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-10-09T02:20:10.09786Z","caller":"traceutil/trace.go:171","msg":"trace[469984686] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2102; }","duration":"118.584773ms","start":"2026-10-09T02:20:09.979268Z","end":"2026-10-09T02:20:10.097853Z","steps":["trace[469984686] 'agreement among raft nodes before linearized reading' (duration: 118.367828ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:20:10.273971Z","caller":"traceutil/trace.go:171","msg":"trace[1369181908] transaction","detail":"{read_only:false; response_revision:2104; number_of_response:1; }","duration":"169.784331ms","start":"2026-10-09T02:20:10.104155Z","end":"2026-10-09T02:20:10.27394Z","steps":["trace[1369181908] 'process raft request' (duration: 90.33372ms)","trace[1369181908] 'compare' (duration: 79.272497ms)"],"step_count":2} {"level":"info","ts":"2026-10-09T02:20:10.274108Z","caller":"traceutil/trace.go:171","msg":"trace[421116638] linearizableReadLoop","detail":"{readStateIndex:2192; appliedIndex:2189; }","duration":"151.548167ms","start":"2026-10-09T02:20:10.122526Z","end":"2026-10-09T02:20:10.274074Z","steps":["trace[421116638] 'read index received' (duration: 38.888486ms)","trace[421116638] 'applied index is now lower than readState.Index' (duration: 112.657281ms)"],"step_count":2} {"level":"info","ts":"2026-10-09T02:20:10.274291Z","caller":"traceutil/trace.go:171","msg":"trace[1343709471] transaction","detail":"{read_only:false; response_revision:2105; number_of_response:1; }","duration":"169.665067ms","start":"2026-10-09T02:20:10.104595Z","end":"2026-10-09T02:20:10.27426Z","steps":["trace[1343709471] 'process raft request' (duration: 169.300579ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:20:10.274368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.823573ms","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-09T02:20:10.274403Z","caller":"traceutil/trace.go:171","msg":"trace[1046264705] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/; range_end:/registry/mutatingwebhookconfigurations0; response_count:0; response_revision:2105; }","duration":"151.923135ms","start":"2026-10-09T02:20:10.122464Z","end":"2026-10-09T02:20:10.274387Z","steps":["trace[1046264705] 'agreement among raft nodes before linearized reading' (duration: 151.823443ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:20:11.710074Z","caller":"traceutil/trace.go:171","msg":"trace[1311164258] linearizableReadLoop","detail":"{readStateIndex:2196; appliedIndex:2195; }","duration":"106.257049ms","start":"2026-10-09T02:20:11.603784Z","end":"2026-10-09T02:20:11.710041Z","steps":["trace[1311164258] 'read index received' (duration: 25.467646ms)","trace[1311164258] 'applied index is now lower than readState.Index' (duration: 80.788183ms)"],"step_count":2} {"level":"warn","ts":"2026-10-09T02:20:11.710259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.458214ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-09T02:20:11.71029Z","caller":"traceutil/trace.go:171","msg":"trace[1620213080] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2109; }","duration":"106.565796ms","start":"2026-10-09T02:20:11.603712Z","end":"2026-10-09T02:20:11.710278Z","steps":["trace[1620213080] 'agreement among raft nodes before linearized reading' (duration: 106.474754ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:20:11.710286Z","caller":"traceutil/trace.go:171","msg":"trace[984000739] transaction","detail":"{read_only:false; response_revision:2109; number_of_response:1; }","duration":"171.139713ms","start":"2026-10-09T02:20:11.539103Z","end":"2026-10-09T02:20:11.710243Z","steps":["trace[984000739] 'process raft request' (duration: 90.291019ms)","trace[984000739] 'compare' (duration: 80.277711ms)"],"step_count":2} {"level":"warn","ts":"2026-10-09T02:20:12.40143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.027704ms","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-10-09T02:20:12.401515Z","caller":"traceutil/trace.go:171","msg":"trace[1967419914] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2112; }","duration":"101.159288ms","start":"2026-10-09T02:20:12.300335Z","end":"2026-10-09T02:20:12.401494Z","steps":["trace[1967419914] 'range keys from in-memory index tree' (duration: 100.84384ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:20:12.401574Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.097609ms","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-09T02:20:12.401678Z","caller":"traceutil/trace.go:171","msg":"trace[1220312722] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2112; }","duration":"123.250213ms","start":"2026-10-09T02:20:12.278403Z","end":"2026-10-09T02:20:12.401653Z","steps":["trace[1220312722] 'range keys from in-memory index tree' (duration: 122.912545ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:20:12.401574Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.469588ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-10-09T02:20:12.401828Z","caller":"traceutil/trace.go:171","msg":"trace[810165257] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2112; }","duration":"123.775415ms","start":"2026-10-09T02:20:12.278003Z","end":"2026-10-09T02:20:12.401779Z","steps":["trace[810165257] 'range keys from in-memory index tree' (duration: 123.250813ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:20:12.673109Z","caller":"traceutil/trace.go:171","msg":"trace[1310193777] transaction","detail":"{read_only:false; response_revision:2113; number_of_response:1; }","duration":"267.302432ms","start":"2026-10-09T02:20:12.405766Z","end":"2026-10-09T02:20:12.673069Z","steps":["trace[1310193777] 'process raft request' (duration: 267.087037ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:20:12.682258Z","caller":"traceutil/trace.go:171","msg":"trace[1891396549] transaction","detail":"{read_only:false; response_revision:2114; number_of_response:1; }","duration":"276.06072ms","start":"2026-10-09T02:20:12.406171Z","end":"2026-10-09T02:20:12.682232Z","steps":["trace[1891396549] 'process raft request' (duration: 275.835125ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:20:12.68244Z","caller":"traceutil/trace.go:171","msg":"trace[2018289954] transaction","detail":"{read_only:false; response_revision:2115; number_of_response:1; }","duration":"276.071751ms","start":"2026-10-09T02:20:12.406337Z","end":"2026-10-09T02:20:12.682409Z","steps":["trace[2018289954] 'process raft request' (duration: 275.834185ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:20:13.166643Z","caller":"traceutil/trace.go:171","msg":"trace[1278664270] transaction","detail":"{read_only:false; response_revision:2117; number_of_response:1; }","duration":"101.981037ms","start":"2026-10-09T02:20:13.064646Z","end":"2026-10-09T02:20:13.166627Z","steps":["trace[1278664270] 'process raft request' (duration: 99.539089ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:20:13.16695Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.649159ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/\" range_end:\"/registry/masterleases0\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-10-09T02:20:13.167031Z","caller":"traceutil/trace.go:171","msg":"trace[209913274] range","detail":"{range_begin:/registry/masterleases/; range_end:/registry/masterleases0; response_count:1; response_revision:2117; }","duration":"101.740092ms","start":"2026-10-09T02:20:13.065271Z","end":"2026-10-09T02:20:13.167011Z","steps":["trace[209913274] 'agreement among raft nodes before linearized reading' (duration: 101.574058ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:20:13.16655Z","caller":"traceutil/trace.go:171","msg":"trace[1863965637] linearizableReadLoop","detail":"{readStateIndex:2205; appliedIndex:2204; }","duration":"101.227059ms","start":"2026-10-09T02:20:13.065289Z","end":"2026-10-09T02:20:13.166516Z","steps":["trace[1863965637] 'read index received' (duration: 98.830182ms)","trace[1863965637] 'applied index is now lower than readState.Index' (duration: 2.395347ms)"],"step_count":2} {"level":"info","ts":"2026-10-09T02:20:14.460134Z","caller":"traceutil/trace.go:171","msg":"trace[1174963765] transaction","detail":"{read_only:false; response_revision:2121; number_of_response:1; }","duration":"175.693492ms","start":"2026-10-09T02:20:14.28442Z","end":"2026-10-09T02:20:14.460114Z","steps":["trace[1174963765] 'process raft request' (duration: 136.54037ms)","trace[1174963765] 'compare' (duration: 39.044339ms)"],"step_count":2} {"level":"warn","ts":"2026-10-09T02:20:14.890488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.357164ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-09T02:20:14.890705Z","caller":"traceutil/trace.go:171","msg":"trace[39559942] linearizableReadLoop","detail":"{readStateIndex:2212; appliedIndex:2210; }","duration":"170.947628ms","start":"2026-10-09T02:20:14.719734Z","end":"2026-10-09T02:20:14.890681Z","steps":["trace[39559942] 'read index received' (duration: 58.257727ms)","trace[39559942] 'applied index is now lower than readState.Index' (duration: 112.688391ms)"],"step_count":2} {"level":"info","ts":"2026-10-09T02:20:14.890818Z","caller":"traceutil/trace.go:171","msg":"trace[1971457415] transaction","detail":"{read_only:false; response_revision:2123; number_of_response:1; }","duration":"187.137064ms","start":"2026-10-09T02:20:14.703656Z","end":"2026-10-09T02:20:14.890793Z","steps":["trace[1971457415] 'process raft request' (duration: 74.382381ms)","trace[1971457415] 'compare' (duration: 112.137978ms)"],"step_count":2} {"level":"warn","ts":"2026-10-09T02:20:14.890895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.157583ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:525"} {"level":"info","ts":"2026-10-09T02:20:14.890927Z","caller":"traceutil/trace.go:171","msg":"trace[916228758] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2124; }","duration":"171.198685ms","start":"2026-10-09T02:20:14.719714Z","end":"2026-10-09T02:20:14.890912Z","steps":["trace[916228758] 'agreement among raft nodes before linearized reading' (duration: 171.032851ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:20:14.89102Z","caller":"traceutil/trace.go:171","msg":"trace[35522689] transaction","detail":"{read_only:false; response_revision:2124; number_of_response:1; }","duration":"186.770285ms","start":"2026-10-09T02:20:14.704243Z","end":"2026-10-09T02:20:14.891013Z","steps":["trace[35522689] 'process raft request' (duration: 186.381986ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:20:15.07759Z","caller":"traceutil/trace.go:171","msg":"trace[541096136] linearizableReadLoop","detail":"{readStateIndex:2213; appliedIndex:2212; }","duration":"165.12505ms","start":"2026-10-09T02:20:14.912443Z","end":"2026-10-09T02:20:15.077568Z","steps":["trace[541096136] 'read index received' (duration: 90.130235ms)","trace[541096136] 'applied index is now lower than readState.Index' (duration: 74.993645ms)"],"step_count":2} {"level":"info","ts":"2026-10-09T02:20:15.077655Z","caller":"traceutil/trace.go:171","msg":"trace[688427545] transaction","detail":"{read_only:false; response_revision:2125; number_of_response:1; }","duration":"181.578352ms","start":"2026-10-09T02:20:14.896026Z","end":"2026-10-09T02:20:15.077604Z","steps":["trace[688427545] 'process raft request' (duration: 106.681289ms)","trace[688427545] 'compare' (duration: 74.76309ms)"],"step_count":2} {"level":"warn","ts":"2026-10-09T02:20:15.077812Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.341506ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:473"} {"level":"info","ts":"2026-10-09T02:20:15.078282Z","caller":"traceutil/trace.go:171","msg":"trace[637998943] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2125; }","duration":"165.859988ms","start":"2026-10-09T02:20:14.912389Z","end":"2026-10-09T02:20:15.078249Z","steps":["trace[637998943] 'agreement among raft nodes before linearized reading' (duration: 165.236613ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:20:15.747991Z","caller":"traceutil/trace.go:171","msg":"trace[1942051565] transaction","detail":"{read_only:false; response_revision:2127; number_of_response:1; }","duration":"131.799437ms","start":"2026-10-09T02:20:15.616162Z","end":"2026-10-09T02:20:15.747961Z","steps":["trace[1942051565] 'process raft request' (duration: 131.545611ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:20:16.898356Z","caller":"traceutil/trace.go:171","msg":"trace[1354902306] transaction","detail":"{read_only:false; response_revision:2131; number_of_response:1; }","duration":"153.244557ms","start":"2026-10-09T02:20:16.745087Z","end":"2026-10-09T02:20:16.898332Z","steps":["trace[1354902306] 'process raft request' (duration: 153.084204ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:20:17.16407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.521247ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-09T02:20:17.164207Z","caller":"traceutil/trace.go:171","msg":"trace[1342972561] linearizableReadLoop","detail":"{readStateIndex:2220; appliedIndex:2218; }","duration":"268.164833ms","start":"2026-10-09T02:20:16.896016Z","end":"2026-10-09T02:20:17.164181Z","steps":["trace[1342972561] 'read index received' (duration: 2.189062ms)","trace[1342972561] 'applied index is now lower than readState.Index' (duration: 265.973841ms)"],"step_count":2} {"level":"info","ts":"2026-10-09T02:20:17.164361Z","caller":"traceutil/trace.go:171","msg":"trace[1089555839] transaction","detail":"{read_only:false; response_revision:2132; number_of_response:1; }","duration":"417.977258ms","start":"2026-10-09T02:20:16.746342Z","end":"2026-10-09T02:20:17.164319Z","steps":["trace[1089555839] 'process raft request' (duration: 237.061402ms)","trace[1089555839] 'compare' (duration: 180.327642ms)"],"step_count":2} {"level":"warn","ts":"2026-10-09T02:20:17.164449Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.403929ms","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-09T02:20:17.164534Z","caller":"traceutil/trace.go:171","msg":"trace[1446068332] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2132; }","duration":"268.526941ms","start":"2026-10-09T02:20:16.895986Z","end":"2026-10-09T02:20:17.164513Z","steps":["trace[1446068332] 'agreement among raft nodes before linearized reading' (duration: 268.297566ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:20:17.164656Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.633654ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-10-09T02:20:17.164694Z","caller":"traceutil/trace.go:171","msg":"trace[68419275] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2132; }","duration":"268.724966ms","start":"2026-10-09T02:20:16.895957Z","end":"2026-10-09T02:20:17.164682Z","steps":["trace[68419275] 'agreement among raft nodes before linearized reading' (duration: 268.354207ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:20:17.164555Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:20:16.746315Z","time spent":"418.128572ms","remote":"127.0.0.1:36662","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":494,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-09T02:20:17.408805Z","caller":"traceutil/trace.go:171","msg":"trace[570273086] transaction","detail":"{read_only:false; response_revision:2134; number_of_response:1; }","duration":"238.921016ms","start":"2026-10-09T02:20:17.169851Z","end":"2026-10-09T02:20:17.408772Z","steps":["trace[570273086] 'process raft request' (duration: 187.171665ms)","trace[570273086] 'compare' (duration: 51.635429ms)"],"step_count":2} {"level":"info","ts":"2026-10-09T02:20:18.04474Z","caller":"traceutil/trace.go:171","msg":"trace[1966474019] transaction","detail":"{read_only:false; response_revision:2136; number_of_response:1; }","duration":"114.375352ms","start":"2026-10-09T02:20:17.930333Z","end":"2026-10-09T02:20:18.044708Z","steps":["trace[1966474019] 'process raft request' (duration: 114.201528ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:20:19.399955Z","caller":"traceutil/trace.go:171","msg":"trace[1161989940] linearizableReadLoop","detail":"{readStateIndex:2231; appliedIndex:2230; }","duration":"116.452972ms","start":"2026-10-09T02:20:19.28348Z","end":"2026-10-09T02:20:19.399933Z","steps":["trace[1161989940] 'read index received' (duration: 116.304808ms)","trace[1161989940] 'applied index is now lower than readState.Index' (duration: 147.014µs)"],"step_count":2} {"level":"warn","ts":"2026-10-09T02:20:19.400083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.571665ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-09T02:20:19.400116Z","caller":"traceutil/trace.go:171","msg":"trace[1934445795] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:2142; }","duration":"116.652527ms","start":"2026-10-09T02:20:19.283452Z","end":"2026-10-09T02:20:19.400104Z","steps":["trace[1934445795] 'agreement among raft nodes before linearized reading' (duration: 116.574215ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:20:19.400195Z","caller":"traceutil/trace.go:171","msg":"trace[1161375148] transaction","detail":"{read_only:false; response_revision:2142; number_of_response:1; }","duration":"147.633534ms","start":"2026-10-09T02:20:19.252521Z","end":"2026-10-09T02:20:19.400154Z","steps":["trace[1161375148] 'process raft request' (duration: 147.270676ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:20:20.27766Z","caller":"traceutil/trace.go:171","msg":"trace[1249918339] transaction","detail":"{read_only:false; response_revision:2146; number_of_response:1; }","duration":"102.213343ms","start":"2026-10-09T02:20:20.17542Z","end":"2026-10-09T02:20:20.277634Z","steps":["trace[1249918339] 'process raft request' (duration: 80.562728ms)","trace[1249918339] 'compare' (duration: 21.559533ms)"],"step_count":2} {"level":"info","ts":"2026-10-09T02:20:20.44382Z","caller":"traceutil/trace.go:171","msg":"trace[1058840918] transaction","detail":"{read_only:false; response_revision:2147; number_of_response:1; }","duration":"121.692857ms","start":"2026-10-09T02:20:20.322094Z","end":"2026-10-09T02:20:20.443787Z","steps":["trace[1058840918] 'process raft request' (duration: 71.241426ms)","trace[1058840918] 'compare' (duration: 50.342088ms)"],"step_count":2} {"level":"info","ts":"2026-10-09T02:20:21.618877Z","caller":"traceutil/trace.go:171","msg":"trace[181223470] transaction","detail":"{read_only:false; response_revision:2153; number_of_response:1; }","duration":"113.304397ms","start":"2026-10-09T02:20:21.505532Z","end":"2026-10-09T02:20:21.618837Z","steps":["trace[181223470] 'process raft request' (duration: 113.113112ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:20:22.190878Z","caller":"traceutil/trace.go:171","msg":"trace[795473422] transaction","detail":"{read_only:false; response_revision:2154; number_of_response:1; }","duration":"333.739473ms","start":"2026-10-09T02:20:21.857105Z","end":"2026-10-09T02:20:22.190844Z","steps":["trace[795473422] 'process raft request' (duration: 333.410525ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:20:22.191059Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:20:21.857064Z","time spent":"333.888217ms","remote":"127.0.0.1:36662","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-09T02:20:22.658813Z","caller":"traceutil/trace.go:171","msg":"trace[681345532] linearizableReadLoop","detail":"{readStateIndex:2244; appliedIndex:2243; }","duration":"209.336612ms","start":"2026-10-09T02:20:22.449445Z","end":"2026-10-09T02:20:22.658781Z","steps":["trace[681345532] 'read index received' (duration: 186.673453ms)","trace[681345532] 'applied index is now lower than readState.Index' (duration: 22.661819ms)"],"step_count":2} {"level":"info","ts":"2026-10-09T02:20:22.65896Z","caller":"traceutil/trace.go:171","msg":"trace[983395799] transaction","detail":"{read_only:false; response_revision:2155; number_of_response:1; }","duration":"462.515138ms","start":"2026-10-09T02:20:22.196429Z","end":"2026-10-09T02:20:22.658945Z","steps":["trace[983395799] 'process raft request' (duration: 439.658694ms)","trace[983395799] 'compare' (duration: 22.209349ms)"],"step_count":2} {"level":"warn","ts":"2026-10-09T02:20:22.659105Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:20:22.196375Z","time spent":"462.6111ms","remote":"127.0.0.1:36662","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":493,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-09T02:20:22.659388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.919336ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:531"} {"level":"info","ts":"2026-10-09T02:20:22.659493Z","caller":"traceutil/trace.go:171","msg":"trace[152019979] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:2155; }","duration":"210.06543ms","start":"2026-10-09T02:20:22.449401Z","end":"2026-10-09T02:20:22.659466Z","steps":["trace[152019979] 'agreement among raft nodes before linearized reading' (duration: 209.753402ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:20:23.125056Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.287775ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-10-09T02:20:23.125168Z","caller":"traceutil/trace.go:171","msg":"trace[2141368246] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2158; }","duration":"131.421278ms","start":"2026-10-09T02:20:22.993713Z","end":"2026-10-09T02:20:23.125134Z","steps":["trace[2141368246] 'range keys from in-memory index tree' (duration: 131.014848ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:20:23.125169Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.264856ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.75\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-10-09T02:20:23.125251Z","caller":"traceutil/trace.go:171","msg":"trace[821224758] range","detail":"{range_begin:/registry/masterleases/162.253.55.75; range_end:; response_count:1; response_revision:2158; }","duration":"163.402079ms","start":"2026-10-09T02:20:22.961833Z","end":"2026-10-09T02:20:23.125235Z","steps":["trace[821224758] 'range keys from in-memory index tree' (duration: 163.088221ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:20:23.309625Z","caller":"traceutil/trace.go:171","msg":"trace[1944082771] transaction","detail":"{read_only:false; response_revision:2159; number_of_response:1; }","duration":"179.267317ms","start":"2026-10-09T02:20:23.130323Z","end":"2026-10-09T02:20:23.309591Z","steps":["trace[1944082771] 'process raft request' (duration: 179.077753ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:20:23.40232Z","caller":"traceutil/trace.go:171","msg":"trace[135099971] transaction","detail":"{read_only:false; response_revision:2160; number_of_response:1; }","duration":"162.963968ms","start":"2026-10-09T02:20:23.239315Z","end":"2026-10-09T02:20:23.402279Z","steps":["trace[135099971] 'process raft request' (duration: 162.655781ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:20:23.580017Z","caller":"traceutil/trace.go:171","msg":"trace[590925076] linearizableReadLoop","detail":"{readStateIndex:2251; appliedIndex:2250; }","duration":"174.667487ms","start":"2026-10-09T02:20:23.405318Z","end":"2026-10-09T02:20:23.579985Z","steps":["trace[590925076] 'read index received' (duration: 106.191317ms)","trace[590925076] 'applied index is now lower than readState.Index' (duration: 68.4745ms)"],"step_count":2} {"level":"info","ts":"2026-10-09T02:20:23.580091Z","caller":"traceutil/trace.go:171","msg":"trace[1646449525] transaction","detail":"{read_only:false; response_revision:2161; number_of_response:1; }","duration":"265.1136ms","start":"2026-10-09T02:20:23.314937Z","end":"2026-10-09T02:20:23.580051Z","steps":["trace[1646449525] 'process raft request' (duration: 196.64617ms)","trace[1646449525] 'compare' (duration: 68.260825ms)"],"step_count":2} {"level":"warn","ts":"2026-10-09T02:20:23.580261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.879242ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:421"} {"level":"info","ts":"2026-10-09T02:20:23.580311Z","caller":"traceutil/trace.go:171","msg":"trace[1703974663] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:2161; }","duration":"174.980475ms","start":"2026-10-09T02:20:23.405314Z","end":"2026-10-09T02:20:23.580294Z","steps":["trace[1703974663] 'agreement among raft nodes before linearized reading' (duration: 174.840302ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:20:23.580417Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.105293ms","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-09T02:20:23.580522Z","caller":"traceutil/trace.go:171","msg":"trace[643047632] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2161; }","duration":"129.288277ms","start":"2026-10-09T02:20:23.451208Z","end":"2026-10-09T02:20:23.580496Z","steps":["trace[643047632] 'agreement among raft nodes before linearized reading' (duration: 129.00252ms)"],"step_count":1}