{"level":"warn","ts":"2026-05-19T18:26:24.741403Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-19T18:26:24.741498Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.25:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.25:2380","--initial-cluster=instance=https://199.19.213.25:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.25:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.25: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-05-19T18:26:24.741578Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-19T18:26:24.74159Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.25:2380"]} {"level":"info","ts":"2026-05-19T18:26:24.741614Z","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-05-19T18:26:24.742626Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.25:2379"]} {"level":"info","ts":"2026-05-19T18:26:24.742729Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.25:2380"],"listen-peer-urls":["https://199.19.213.25:2380"],"advertise-client-urls":["https://199.19.213.25:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.25:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.25: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-05-19T18:26:24.746897Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.894832ms"} {"level":"info","ts":"2026-05-19T18:26:24.754714Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"9bd4db28c48efaf1","cluster-id":"b621f59192c78404"} {"level":"info","ts":"2026-05-19T18:26:24.754868Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd4db28c48efaf1 switched to configuration voters=()"} {"level":"info","ts":"2026-05-19T18:26:24.754931Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd4db28c48efaf1 became follower at term 0"} {"level":"info","ts":"2026-05-19T18:26:24.754967Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 9bd4db28c48efaf1 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-19T18:26:24.755015Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd4db28c48efaf1 became follower at term 1"} {"level":"info","ts":"2026-05-19T18:26:24.755096Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd4db28c48efaf1 switched to configuration voters=(11228840739084368625)"} {"level":"warn","ts":"2026-05-19T18:26:24.76684Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-19T18:26:24.768124Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-19T18:26:24.769406Z","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-05-19T18:26:24.771138Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"9bd4db28c48efaf1","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-19T18:26:24.771308Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"9bd4db28c48efaf1","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-19T18:26:24.771468Z","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-05-19T18:26:24.771546Z","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-05-19T18:26:24.771565Z","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-05-19T18:26:24.773304Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd4db28c48efaf1 switched to configuration voters=(11228840739084368625)"} {"level":"info","ts":"2026-05-19T18:26:24.773522Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"b621f59192c78404","local-member-id":"9bd4db28c48efaf1","added-peer-id":"9bd4db28c48efaf1","added-peer-peer-urls":["https://199.19.213.25:2380"]} {"level":"info","ts":"2026-05-19T18:26:24.776166Z","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-05-19T18:26:24.776513Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.25:2380"} {"level":"info","ts":"2026-05-19T18:26:24.776562Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.25:2380"} {"level":"info","ts":"2026-05-19T18:26:24.776731Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"9bd4db28c48efaf1","initial-advertise-peer-urls":["https://199.19.213.25:2380"],"listen-peer-urls":["https://199.19.213.25:2380"],"advertise-client-urls":["https://199.19.213.25:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.25:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-19T18:26:24.776865Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-19T18:26:24.95571Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd4db28c48efaf1 is starting a new election at term 1"} {"level":"info","ts":"2026-05-19T18:26:24.955774Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd4db28c48efaf1 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-19T18:26:24.955823Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd4db28c48efaf1 received MsgPreVoteResp from 9bd4db28c48efaf1 at term 1"} {"level":"info","ts":"2026-05-19T18:26:24.955849Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd4db28c48efaf1 became candidate at term 2"} {"level":"info","ts":"2026-05-19T18:26:24.955865Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd4db28c48efaf1 received MsgVoteResp from 9bd4db28c48efaf1 at term 2"} {"level":"info","ts":"2026-05-19T18:26:24.955881Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd4db28c48efaf1 became leader at term 2"} {"level":"info","ts":"2026-05-19T18:26:24.955899Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 9bd4db28c48efaf1 elected leader 9bd4db28c48efaf1 at term 2"} {"level":"info","ts":"2026-05-19T18:26:24.957045Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"9bd4db28c48efaf1","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.25:2379]}","request-path":"/0/members/9bd4db28c48efaf1/attributes","cluster-id":"b621f59192c78404","publish-timeout":"7s"} {"level":"info","ts":"2026-05-19T18:26:24.957047Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-19T18:26:24.957091Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-19T18:26:24.957377Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-19T18:26:24.957764Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-19T18:26:24.957791Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-19T18:26:24.961001Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-19T18:26:24.961214Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.25:2379"} {"level":"info","ts":"2026-05-19T18:26:24.961808Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"b621f59192c78404","local-member-id":"9bd4db28c48efaf1","cluster-version":"3.5"} {"level":"info","ts":"2026-05-19T18:26:24.962066Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-19T18:26:24.962106Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-19T18:26:56.031905Z","caller":"traceutil/trace.go:171","msg":"trace[953100114] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"205.483304ms","start":"2026-05-19T18:26:55.826402Z","end":"2026-05-19T18:26:56.031885Z","steps":["trace[953100114] 'process raft request' (duration: 205.33676ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:26:56.077181Z","caller":"traceutil/trace.go:171","msg":"trace[1548128455] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"243.593184ms","start":"2026-05-19T18:26:55.833556Z","end":"2026-05-19T18:26:56.07715Z","steps":["trace[1548128455] 'process raft request' (duration: 240.321689ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:26:56.077288Z","caller":"traceutil/trace.go:171","msg":"trace[2008276660] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"241.195534ms","start":"2026-05-19T18:26:55.836001Z","end":"2026-05-19T18:26:56.077197Z","steps":["trace[2008276660] 'process raft request' (duration: 241.06458ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:26:56.077379Z","caller":"traceutil/trace.go:171","msg":"trace[1944755431] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"230.173132ms","start":"2026-05-19T18:26:55.847194Z","end":"2026-05-19T18:26:56.077367Z","steps":["trace[1944755431] 'process raft request' (duration: 230.063069ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:26:56.077399Z","caller":"traceutil/trace.go:171","msg":"trace[430768387] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"230.819652ms","start":"2026-05-19T18:26:55.846528Z","end":"2026-05-19T18:26:56.077347Z","steps":["trace[430768387] 'process raft request' (duration: 230.700588ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:26:56.077501Z","caller":"traceutil/trace.go:171","msg":"trace[713600807] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"229.308148ms","start":"2026-05-19T18:26:55.84818Z","end":"2026-05-19T18:26:56.077488Z","steps":["trace[713600807] 'process raft request' (duration: 229.122782ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:26:56.077503Z","caller":"traceutil/trace.go:171","msg":"trace[1208231710] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"232.426528ms","start":"2026-05-19T18:26:55.845056Z","end":"2026-05-19T18:26:56.077483Z","steps":["trace[1208231710] 'process raft request' (duration: 232.039317ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:26:56.077596Z","caller":"traceutil/trace.go:171","msg":"trace[2037240912] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"217.469022ms","start":"2026-05-19T18:26:55.860103Z","end":"2026-05-19T18:26:56.077572Z","steps":["trace[2037240912] 'process raft request' (duration: 217.237445ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:26:56.077599Z","caller":"traceutil/trace.go:171","msg":"trace[472735324] linearizableReadLoop","detail":"{readStateIndex:533; appliedIndex:523; }","duration":"126.665608ms","start":"2026-05-19T18:26:55.950922Z","end":"2026-05-19T18:26:56.077587Z","steps":["trace[472735324] 'read index received' (duration: 80.958318ms)","trace[472735324] 'applied index is now lower than readState.Index' (duration: 45.70668ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T18:26:56.077383Z","caller":"traceutil/trace.go:171","msg":"trace[1392382571] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"231.257704ms","start":"2026-05-19T18:26:55.846072Z","end":"2026-05-19T18:26:56.077329Z","steps":["trace[1392382571] 'process raft request' (duration: 231.076189ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:26:56.077617Z","caller":"traceutil/trace.go:171","msg":"trace[1033106730] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"175.300614ms","start":"2026-05-19T18:26:55.902308Z","end":"2026-05-19T18:26:56.077608Z","steps":["trace[1033106730] 'process raft request' (duration: 175.117569ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:26:56.077673Z","caller":"traceutil/trace.go:171","msg":"trace[1504713010] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"215.043292ms","start":"2026-05-19T18:26:55.862624Z","end":"2026-05-19T18:26:56.077667Z","steps":["trace[1504713010] 'process raft request' (duration: 214.755353ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:26:56.077679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.745211ms","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-05-19T18:26:56.077731Z","caller":"traceutil/trace.go:171","msg":"trace[2146454794] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:518; }","duration":"126.843503ms","start":"2026-05-19T18:26:55.950881Z","end":"2026-05-19T18:26:56.077725Z","steps":["trace[2146454794] 'agreement among raft nodes before linearized reading' (duration: 126.743041ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:26:56.575677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.827293ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-19T18:26:56.576056Z","caller":"traceutil/trace.go:171","msg":"trace[16383338] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"349.766975ms","start":"2026-05-19T18:26:56.226255Z","end":"2026-05-19T18:26:56.576022Z","steps":["trace[16383338] 'process raft request' (duration: 231.78364ms)","trace[16383338] 'compare' (duration: 116.627726ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T18:26:56.57625Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:26:56.226234Z","time spent":"349.966282ms","remote":"127.0.0.1:51400","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":23057,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T18:26:56.576955Z","caller":"traceutil/trace.go:171","msg":"trace[762572592] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"348.382436ms","start":"2026-05-19T18:26:56.22855Z","end":"2026-05-19T18:26:56.576933Z","steps":["trace[762572592] 'process raft request' (duration: 348.057755ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:26:56.577075Z","caller":"traceutil/trace.go:171","msg":"trace[669402697] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"309.168103ms","start":"2026-05-19T18:26:56.267899Z","end":"2026-05-19T18:26:56.577067Z","steps":["trace[669402697] 'process raft request' (duration: 309.023079ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:26:56.577084Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:26:56.228531Z","time spent":"348.477319ms","remote":"127.0.0.1:51400","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":31111,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T18:26:56.577123Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:26:56.267866Z","time spent":"309.237765ms","remote":"127.0.0.1:51400","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":97665,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-19T18:27:02.689826Z","caller":"traceutil/trace.go:171","msg":"trace[2064131587] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"147.507436ms","start":"2026-05-19T18:27:02.542287Z","end":"2026-05-19T18:27:02.689795Z","steps":["trace[2064131587] 'process raft request' (duration: 147.287779ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:27:02.940839Z","caller":"traceutil/trace.go:171","msg":"trace[555499894] linearizableReadLoop","detail":"{readStateIndex:639; appliedIndex:637; }","duration":"303.91475ms","start":"2026-05-19T18:27:02.636865Z","end":"2026-05-19T18:27:02.94078Z","steps":["trace[555499894] 'read index received' (duration: 52.830479ms)","trace[555499894] 'applied index is now lower than readState.Index' (duration: 251.083151ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T18:27:02.940915Z","caller":"traceutil/trace.go:171","msg":"trace[1420755405] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"339.525767ms","start":"2026-05-19T18:27:02.601354Z","end":"2026-05-19T18:27:02.940879Z","steps":["trace[1420755405] 'process raft request' (duration: 333.42854ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:27:02.94104Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.188747ms","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-05-19T18:27:02.941077Z","caller":"traceutil/trace.go:171","msg":"trace[748060018] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:616; }","duration":"304.28532ms","start":"2026-05-19T18:27:02.63678Z","end":"2026-05-19T18:27:02.941065Z","steps":["trace[748060018] 'agreement among raft nodes before linearized reading' (duration: 304.139246ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:27:02.941112Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:27:02.636756Z","time spent":"304.347122ms","remote":"127.0.0.1:51620","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-19T18:27:02.941336Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:27:02.601326Z","time spent":"339.666201ms","remote":"127.0.0.1:51446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036297,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T18:27:03.633824Z","caller":"traceutil/trace.go:171","msg":"trace[2027218512] linearizableReadLoop","detail":"{readStateIndex:642; appliedIndex:641; }","duration":"438.448069ms","start":"2026-05-19T18:27:03.195348Z","end":"2026-05-19T18:27:03.633796Z","steps":["trace[2027218512] 'read index received' (duration: 438.365446ms)","trace[2027218512] 'applied index is now lower than readState.Index' (duration: 81.613µs)"],"step_count":2} {"level":"info","ts":"2026-05-19T18:27:03.633883Z","caller":"traceutil/trace.go:171","msg":"trace[1028025250] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"641.759419ms","start":"2026-05-19T18:27:02.992097Z","end":"2026-05-19T18:27:03.633856Z","steps":["trace[1028025250] 'process raft request' (duration: 641.566673ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:27:03.634006Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"438.652695ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-19T18:27:03.634018Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:27:02.992071Z","time spent":"641.885982ms","remote":"127.0.0.1:51854","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-19T18:27:03.634065Z","caller":"traceutil/trace.go:171","msg":"trace[1672674940] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:619; }","duration":"438.773658ms","start":"2026-05-19T18:27:03.195273Z","end":"2026-05-19T18:27:03.634047Z","steps":["trace[1672674940] 'agreement among raft nodes before linearized reading' (duration: 438.660495ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:27:03.634108Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:27:03.195239Z","time spent":"438.85777ms","remote":"127.0.0.1:51360","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-19T18:27:03.634179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"428.55449ms","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-05-19T18:27:03.634274Z","caller":"traceutil/trace.go:171","msg":"trace[728012173] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:619; }","duration":"428.697164ms","start":"2026-05-19T18:27:03.205555Z","end":"2026-05-19T18:27:03.634252Z","steps":["trace[728012173] 'agreement among raft nodes before linearized reading' (duration: 428.425706ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:27:03.634327Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:27:03.205532Z","time spent":"428.785017ms","remote":"127.0.0.1:51620","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-05-19T18:27:24.923934Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.44059ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-19T18:27:24.924082Z","caller":"traceutil/trace.go:171","msg":"trace[121528778] transaction","detail":"{read_only:false; response_revision:784; number_of_response:1; }","duration":"186.387508ms","start":"2026-05-19T18:27:24.737675Z","end":"2026-05-19T18:27:24.924063Z","steps":["trace[121528778] 'process raft request' (duration: 79.333539ms)","trace[121528778] 'compare' (duration: 106.266695ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T18:27:24.949868Z","caller":"traceutil/trace.go:171","msg":"trace[320980835] transaction","detail":"{read_only:false; response_revision:785; number_of_response:1; }","duration":"211.726895ms","start":"2026-05-19T18:27:24.738024Z","end":"2026-05-19T18:27:24.94975Z","steps":["trace[320980835] 'process raft request' (duration: 211.471408ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:27:24.949964Z","caller":"traceutil/trace.go:171","msg":"trace[353097035] transaction","detail":"{read_only:false; response_revision:786; number_of_response:1; }","duration":"211.458568ms","start":"2026-05-19T18:27:24.738483Z","end":"2026-05-19T18:27:24.949942Z","steps":["trace[353097035] 'process raft request' (duration: 211.166179ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:27:28.493936Z","caller":"traceutil/trace.go:171","msg":"trace[1278100348] linearizableReadLoop","detail":"{readStateIndex:838; appliedIndex:837; }","duration":"172.135114ms","start":"2026-05-19T18:27:28.321768Z","end":"2026-05-19T18:27:28.493903Z","steps":["trace[1278100348] 'read index received' (duration: 171.853886ms)","trace[1278100348] 'applied index is now lower than readState.Index' (duration: 280.158µs)"],"step_count":2} {"level":"info","ts":"2026-05-19T18:27:28.493979Z","caller":"traceutil/trace.go:171","msg":"trace[504751060] transaction","detail":"{read_only:false; response_revision:807; number_of_response:1; }","duration":"193.837994ms","start":"2026-05-19T18:27:28.300106Z","end":"2026-05-19T18:27:28.493944Z","steps":["trace[504751060] 'process raft request' (duration: 193.643968ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:27:28.494177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.396051ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.25\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-05-19T18:27:28.494222Z","caller":"traceutil/trace.go:171","msg":"trace[1114120830] range","detail":"{range_begin:/registry/masterleases/199.19.213.25; range_end:; response_count:1; response_revision:807; }","duration":"172.459133ms","start":"2026-05-19T18:27:28.32175Z","end":"2026-05-19T18:27:28.494209Z","steps":["trace[1114120830] 'agreement among raft nodes before linearized reading' (duration: 172.299548ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:27:37.992852Z","caller":"traceutil/trace.go:171","msg":"trace[1352420955] transaction","detail":"{read_only:false; response_revision:907; number_of_response:1; }","duration":"165.810551ms","start":"2026-05-19T18:27:37.827012Z","end":"2026-05-19T18:27:37.992823Z","steps":["trace[1352420955] 'process raft request' (duration: 164.185383ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:27:38.012682Z","caller":"traceutil/trace.go:171","msg":"trace[1861260929] transaction","detail":"{read_only:false; response_revision:908; number_of_response:1; }","duration":"154.668236ms","start":"2026-05-19T18:27:37.857989Z","end":"2026-05-19T18:27:38.012658Z","steps":["trace[1861260929] 'process raft request' (duration: 154.344487ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:27:38.184529Z","caller":"traceutil/trace.go:171","msg":"trace[741747641] transaction","detail":"{read_only:false; response_revision:909; number_of_response:1; }","duration":"185.152635ms","start":"2026-05-19T18:27:37.999352Z","end":"2026-05-19T18:27:38.184504Z","steps":["trace[741747641] 'process raft request' (duration: 184.658221ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:27:38.184564Z","caller":"traceutil/trace.go:171","msg":"trace[1741042343] transaction","detail":"{read_only:false; response_revision:911; number_of_response:1; }","duration":"183.475425ms","start":"2026-05-19T18:27:38.001067Z","end":"2026-05-19T18:27:38.184543Z","steps":["trace[1741042343] 'process raft request' (duration: 183.411933ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:27:38.18466Z","caller":"traceutil/trace.go:171","msg":"trace[1998058333] transaction","detail":"{read_only:false; response_revision:910; number_of_response:1; }","duration":"184.474375ms","start":"2026-05-19T18:27:38.000133Z","end":"2026-05-19T18:27:38.184607Z","steps":["trace[1998058333] 'process raft request' (duration: 184.28903ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:27:38.189238Z","caller":"traceutil/trace.go:171","msg":"trace[1447237802] linearizableReadLoop","detail":"{readStateIndex:946; appliedIndex:942; }","duration":"171.982411ms","start":"2026-05-19T18:27:38.017236Z","end":"2026-05-19T18:27:38.189218Z","steps":["trace[1447237802] 'read index received' (duration: 166.737488ms)","trace[1447237802] 'applied index is now lower than readState.Index' (duration: 5.244043ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T18:27:38.1894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.146416ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-7c96b6546b-lhzpx\" ","response":"range_response_count:1 size:4871"} {"level":"info","ts":"2026-05-19T18:27:38.189425Z","caller":"traceutil/trace.go:171","msg":"trace[959462487] range","detail":"{range_begin:/registry/pods/kube-system/coredns-7c96b6546b-lhzpx; range_end:; response_count:1; response_revision:914; }","duration":"172.212488ms","start":"2026-05-19T18:27:38.017204Z","end":"2026-05-19T18:27:38.189417Z","steps":["trace[959462487] 'agreement among raft nodes before linearized reading' (duration: 172.091614ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:27:38.189411Z","caller":"traceutil/trace.go:171","msg":"trace[1941373056] transaction","detail":"{read_only:false; response_revision:913; number_of_response:1; }","duration":"170.280221ms","start":"2026-05-19T18:27:38.019121Z","end":"2026-05-19T18:27:38.189401Z","steps":["trace[1941373056] 'process raft request' (duration: 169.996923ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:27:38.189599Z","caller":"traceutil/trace.go:171","msg":"trace[124196661] transaction","detail":"{read_only:false; response_revision:914; number_of_response:1; }","duration":"169.079557ms","start":"2026-05-19T18:27:38.020512Z","end":"2026-05-19T18:27:38.189592Z","steps":["trace[124196661] 'process raft request' (duration: 168.672125ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:27:38.18925Z","caller":"traceutil/trace.go:171","msg":"trace[2103571722] transaction","detail":"{read_only:false; response_revision:912; number_of_response:1; }","duration":"172.803794ms","start":"2026-05-19T18:27:38.016426Z","end":"2026-05-19T18:27:38.18923Z","steps":["trace[2103571722] 'process raft request' (duration: 172.601548ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:27:38.365997Z","caller":"traceutil/trace.go:171","msg":"trace[741924104] transaction","detail":"{read_only:false; response_revision:916; number_of_response:1; }","duration":"168.117418ms","start":"2026-05-19T18:27:38.197857Z","end":"2026-05-19T18:27:38.365974Z","steps":["trace[741924104] 'process raft request' (duration: 166.634764ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:27:38.40491Z","caller":"traceutil/trace.go:171","msg":"trace[219973714] linearizableReadLoop","detail":"{readStateIndex:951; appliedIndex:949; }","duration":"195.258431ms","start":"2026-05-19T18:27:38.209637Z","end":"2026-05-19T18:27:38.404895Z","steps":["trace[219973714] 'read index received' (duration: 154.850651ms)","trace[219973714] 'applied index is now lower than readState.Index' (duration: 40.40725ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T18:27:38.404916Z","caller":"traceutil/trace.go:171","msg":"trace[668779663] transaction","detail":"{read_only:false; response_revision:918; number_of_response:1; }","duration":"195.202249ms","start":"2026-05-19T18:27:38.209656Z","end":"2026-05-19T18:27:38.404859Z","steps":["trace[668779663] 'process raft request' (duration: 195.072705ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:27:38.404907Z","caller":"traceutil/trace.go:171","msg":"trace[270748553] transaction","detail":"{read_only:false; response_revision:917; number_of_response:1; }","duration":"195.323173ms","start":"2026-05-19T18:27:38.209558Z","end":"2026-05-19T18:27:38.404881Z","steps":["trace[270748553] 'process raft request' (duration: 195.090716ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:27:38.40521Z","caller":"traceutil/trace.go:171","msg":"trace[938774820] transaction","detail":"{read_only:false; response_revision:919; number_of_response:1; }","duration":"195.486027ms","start":"2026-05-19T18:27:38.209716Z","end":"2026-05-19T18:27:38.405202Z","steps":["trace[938774820] 'process raft request' (duration: 195.044914ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:27:38.405346Z","caller":"traceutil/trace.go:171","msg":"trace[1612937509] transaction","detail":"{read_only:false; response_revision:921; number_of_response:1; }","duration":"193.742826ms","start":"2026-05-19T18:27:38.21159Z","end":"2026-05-19T18:27:38.405332Z","steps":["trace[1612937509] 'process raft request' (duration: 193.222481ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:27:38.404964Z","caller":"traceutil/trace.go:171","msg":"trace[325019958] transaction","detail":"{read_only:false; response_revision:920; number_of_response:1; }","duration":"195.215759ms","start":"2026-05-19T18:27:38.209742Z","end":"2026-05-19T18:27:38.404957Z","steps":["trace[325019958] 'process raft request' (duration: 195.050544ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:27:38.405535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.883559ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-7c96b6546b-lhzpx\" ","response":"range_response_count:1 size:4883"} {"level":"info","ts":"2026-05-19T18:27:38.405592Z","caller":"traceutil/trace.go:171","msg":"trace[1214907325] range","detail":"{range_begin:/registry/pods/kube-system/coredns-7c96b6546b-lhzpx; range_end:; response_count:1; response_revision:921; }","duration":"195.986932ms","start":"2026-05-19T18:27:38.209591Z","end":"2026-05-19T18:27:38.405578Z","steps":["trace[1214907325] 'agreement among raft nodes before linearized reading' (duration: 195.832097ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:27:58.827517Z","caller":"traceutil/trace.go:171","msg":"trace[1393193665] transaction","detail":"{read_only:false; response_revision:1002; number_of_response:1; }","duration":"154.476809ms","start":"2026-05-19T18:27:58.673014Z","end":"2026-05-19T18:27:58.827491Z","steps":["trace[1393193665] 'process raft request' (duration: 154.286824ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:28:09.069288Z","caller":"traceutil/trace.go:171","msg":"trace[652856464] transaction","detail":"{read_only:false; response_revision:1039; number_of_response:1; }","duration":"107.956942ms","start":"2026-05-19T18:28:08.961304Z","end":"2026-05-19T18:28:09.069261Z","steps":["trace[652856464] 'process raft request' (duration: 107.743016ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:28:30.537519Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.834754ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-19T18:28:30.537543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.554497ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-19T18:28:30.537585Z","caller":"traceutil/trace.go:171","msg":"trace[247967440] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:1110; }","duration":"261.956977ms","start":"2026-05-19T18:28:30.275613Z","end":"2026-05-19T18:28:30.53757Z","steps":["trace[247967440] 'count revisions from in-memory index tree' (duration: 261.75059ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:28:30.537607Z","caller":"traceutil/trace.go:171","msg":"trace[574119174] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:1110; }","duration":"159.6572ms","start":"2026-05-19T18:28:30.377928Z","end":"2026-05-19T18:28:30.537585Z","steps":["trace[574119174] 'count revisions from in-memory index tree' (duration: 159.475195ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:28:31.550143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.541804ms","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-05-19T18:28:31.55023Z","caller":"traceutil/trace.go:171","msg":"trace[1355375045] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1112; }","duration":"114.672538ms","start":"2026-05-19T18:28:31.435541Z","end":"2026-05-19T18:28:31.550213Z","steps":["trace[1355375045] 'range keys from in-memory index tree' (duration: 114.413319ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:28:31.72649Z","caller":"traceutil/trace.go:171","msg":"trace[1033634292] transaction","detail":"{read_only:false; response_revision:1114; number_of_response:1; }","duration":"172.010072ms","start":"2026-05-19T18:28:31.554432Z","end":"2026-05-19T18:28:31.726442Z","steps":["trace[1033634292] 'process raft request' (duration: 171.486706ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:28:47.772951Z","caller":"traceutil/trace.go:171","msg":"trace[1049937381] transaction","detail":"{read_only:false; response_revision:1221; number_of_response:1; }","duration":"388.860393ms","start":"2026-05-19T18:28:47.384064Z","end":"2026-05-19T18:28:47.772924Z","steps":["trace[1049937381] 'process raft request' (duration: 388.469542ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:28:47.774062Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:28:47.384047Z","time spent":"389.942475ms","remote":"127.0.0.1:51620","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T18:29:07.979166Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"394.934821ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-19T18:29:07.979985Z","caller":"traceutil/trace.go:171","msg":"trace[586855654] transaction","detail":"{read_only:false; response_revision:1311; number_of_response:1; }","duration":"848.288419ms","start":"2026-05-19T18:29:07.131678Z","end":"2026-05-19T18:29:07.979966Z","steps":["trace[586855654] 'process raft request' (duration: 452.478194ms)","trace[586855654] 'compare' (duration: 394.452485ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T18:29:07.980045Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:29:07.131647Z","time spent":"848.368301ms","remote":"127.0.0.1:51522","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":914,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T18:29:08.037287Z","caller":"traceutil/trace.go:171","msg":"trace[211501630] transaction","detail":"{read_only:false; response_revision:1313; number_of_response:1; }","duration":"901.142224ms","start":"2026-05-19T18:29:07.136134Z","end":"2026-05-19T18:29:08.037276Z","steps":["trace[211501630] 'process raft request' (duration: 901.00948ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:29:08.037392Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:29:07.136117Z","time spent":"901.214155ms","remote":"127.0.0.1:51810","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9375,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T18:29:08.03747Z","caller":"traceutil/trace.go:171","msg":"trace[1805443498] transaction","detail":"{read_only:false; response_revision:1312; number_of_response:1; }","duration":"905.521492ms","start":"2026-05-19T18:29:07.131939Z","end":"2026-05-19T18:29:08.037461Z","steps":["trace[1805443498] 'process raft request' (duration: 905.10107ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:29:08.037512Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:29:07.13191Z","time spent":"905.580864ms","remote":"127.0.0.1:51628","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1507,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T18:29:08.037675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"842.038435ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T18:29:08.037751Z","caller":"traceutil/trace.go:171","msg":"trace[1530355989] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1313; }","duration":"842.1675ms","start":"2026-05-19T18:29:07.195566Z","end":"2026-05-19T18:29:08.037733Z","steps":["trace[1530355989] 'agreement among raft nodes before linearized reading' (duration: 842.040015ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:29:08.037209Z","caller":"traceutil/trace.go:171","msg":"trace[101356209] linearizableReadLoop","detail":"{readStateIndex:1368; appliedIndex:1365; }","duration":"841.577152ms","start":"2026-05-19T18:29:07.195615Z","end":"2026-05-19T18:29:08.037192Z","steps":["trace[101356209] 'read index received' (duration: 388.629756ms)","trace[101356209] 'applied index is now lower than readState.Index' (duration: 452.946716ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T18:29:08.038012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.304612ms","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-05-19T18:29:08.038046Z","caller":"traceutil/trace.go:171","msg":"trace[422770796] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1313; }","duration":"156.363873ms","start":"2026-05-19T18:29:07.881664Z","end":"2026-05-19T18:29:08.038028Z","steps":["trace[422770796] 'agreement among raft nodes before linearized reading' (duration: 156.272561ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:29:08.037864Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:29:07.195545Z","time spent":"842.309574ms","remote":"127.0.0.1:51360","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-19T18:29:08.146055Z","caller":"traceutil/trace.go:171","msg":"trace[1740296546] transaction","detail":"{read_only:false; response_revision:1314; number_of_response:1; }","duration":"103.948209ms","start":"2026-05-19T18:29:08.042083Z","end":"2026-05-19T18:29:08.146032Z","steps":["trace[1740296546] 'process raft request' (duration: 103.28749ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:29:08.204633Z","caller":"traceutil/trace.go:171","msg":"trace[1364095786] transaction","detail":"{read_only:false; response_revision:1315; number_of_response:1; }","duration":"161.230855ms","start":"2026-05-19T18:29:08.04338Z","end":"2026-05-19T18:29:08.204611Z","steps":["trace[1364095786] 'process raft request' (duration: 160.595747ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:29:08.204826Z","caller":"traceutil/trace.go:171","msg":"trace[735375654] transaction","detail":"{read_only:false; response_revision:1316; number_of_response:1; }","duration":"161.276816ms","start":"2026-05-19T18:29:08.043536Z","end":"2026-05-19T18:29:08.204813Z","steps":["trace[735375654] 'process raft request' (duration: 160.557585ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:29:08.205009Z","caller":"traceutil/trace.go:171","msg":"trace[2063262818] transaction","detail":"{read_only:false; response_revision:1317; number_of_response:1; }","duration":"160.233026ms","start":"2026-05-19T18:29:08.044765Z","end":"2026-05-19T18:29:08.204998Z","steps":["trace[2063262818] 'process raft request' (duration: 159.362291ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:29:08.997012Z","caller":"traceutil/trace.go:171","msg":"trace[544202746] transaction","detail":"{read_only:false; response_revision:1320; number_of_response:1; }","duration":"199.588037ms","start":"2026-05-19T18:29:08.797406Z","end":"2026-05-19T18:29:08.996994Z","steps":["trace[544202746] 'process raft request' (duration: 199.482374ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:29:10.186359Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.097704ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T18:29:10.18652Z","caller":"traceutil/trace.go:171","msg":"trace[1297618113] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:0; response_revision:1322; }","duration":"302.469736ms","start":"2026-05-19T18:29:09.883983Z","end":"2026-05-19T18:29:10.186452Z","steps":["trace[1297618113] 'range keys from in-memory index tree' (duration: 301.975691ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:29:10.186594Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:29:09.883962Z","time spent":"302.619011ms","remote":"127.0.0.1:51620","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":0,"response size":29,"request content":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" "} {"level":"info","ts":"2026-05-19T18:29:10.369567Z","caller":"traceutil/trace.go:171","msg":"trace[1655126361] linearizableReadLoop","detail":"{readStateIndex:1383; appliedIndex:1382; }","duration":"114.500238ms","start":"2026-05-19T18:29:10.255046Z","end":"2026-05-19T18:29:10.369547Z","steps":["trace[1655126361] 'read index received' (duration: 88.798297ms)","trace[1655126361] 'applied index is now lower than readState.Index' (duration: 25.701061ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T18:29:10.369649Z","caller":"traceutil/trace.go:171","msg":"trace[598112752] transaction","detail":"{read_only:false; response_revision:1327; number_of_response:1; }","duration":"124.741199ms","start":"2026-05-19T18:29:10.244865Z","end":"2026-05-19T18:29:10.369606Z","steps":["trace[598112752] 'process raft request' (duration: 98.963565ms)","trace[598112752] 'compare' (duration: 25.576498ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T18:29:10.369693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.467849ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T18:29:10.369735Z","caller":"traceutil/trace.go:171","msg":"trace[1840581170] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1327; }","duration":"127.570351ms","start":"2026-05-19T18:29:10.242154Z","end":"2026-05-19T18:29:10.369724Z","steps":["trace[1840581170] 'agreement among raft nodes before linearized reading' (duration: 127.477249ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:29:10.386262Z","caller":"traceutil/trace.go:171","msg":"trace[1931675789] transaction","detail":"{read_only:false; response_revision:1328; number_of_response:1; }","duration":"127.029794ms","start":"2026-05-19T18:29:10.259209Z","end":"2026-05-19T18:29:10.386239Z","steps":["trace[1931675789] 'process raft request' (duration: 126.412017ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:29:10.386523Z","caller":"traceutil/trace.go:171","msg":"trace[1816894286] transaction","detail":"{read_only:false; response_revision:1329; number_of_response:1; }","duration":"127.21713ms","start":"2026-05-19T18:29:10.259291Z","end":"2026-05-19T18:29:10.386508Z","steps":["trace[1816894286] 'process raft request' (duration: 126.448938ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:29:10.3868Z","caller":"traceutil/trace.go:171","msg":"trace[866778323] transaction","detail":"{read_only:false; response_revision:1330; number_of_response:1; }","duration":"127.450127ms","start":"2026-05-19T18:29:10.259339Z","end":"2026-05-19T18:29:10.386789Z","steps":["trace[866778323] 'process raft request' (duration: 126.436478ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:29:10.38727Z","caller":"traceutil/trace.go:171","msg":"trace[334488064] transaction","detail":"{read_only:false; response_revision:1331; number_of_response:1; }","duration":"126.805249ms","start":"2026-05-19T18:29:10.260453Z","end":"2026-05-19T18:29:10.387258Z","steps":["trace[334488064] 'process raft request' (duration: 125.353477ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:29:19.660045Z","caller":"traceutil/trace.go:171","msg":"trace[1530411723] transaction","detail":"{read_only:false; response_revision:1391; number_of_response:1; }","duration":"125.587783ms","start":"2026-05-19T18:29:19.534427Z","end":"2026-05-19T18:29:19.660014Z","steps":["trace[1530411723] 'process raft request' (duration: 125.415498ms)"],"step_count":1}