{"level":"warn","ts":"2026-07-25T06:32:04.710308Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-25T06:32:04.710432Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.20: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.20:2380","--initial-cluster=instance=https://199.19.213.20:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.20:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.20: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-07-25T06:32:04.710535Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-25T06:32:04.710553Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.20:2380"]} {"level":"info","ts":"2026-07-25T06:32:04.710597Z","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-07-25T06:32:04.711466Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.20:2379"]} {"level":"info","ts":"2026-07-25T06:32:04.711606Z","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.20:2380"],"listen-peer-urls":["https://199.19.213.20:2380"],"advertise-client-urls":["https://199.19.213.20:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.20:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.20: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-07-25T06:32:04.718437Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.496122ms"} {"level":"info","ts":"2026-07-25T06:32:04.731852Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"185293d8d40ffce0","cluster-id":"cc857afa6e1fa648"} {"level":"info","ts":"2026-07-25T06:32:04.731949Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"185293d8d40ffce0 switched to configuration voters=()"} {"level":"info","ts":"2026-07-25T06:32:04.731979Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"185293d8d40ffce0 became follower at term 0"} {"level":"info","ts":"2026-07-25T06:32:04.732011Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 185293d8d40ffce0 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-25T06:32:04.732032Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"185293d8d40ffce0 became follower at term 1"} {"level":"info","ts":"2026-07-25T06:32:04.73211Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"185293d8d40ffce0 switched to configuration voters=(1752625764480580832)"} {"level":"warn","ts":"2026-07-25T06:32:04.741991Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-25T06:32:04.744582Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-25T06:32:04.746532Z","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-07-25T06:32:04.750138Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"185293d8d40ffce0","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-25T06:32:04.750213Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"185293d8d40ffce0","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-25T06:32:04.75052Z","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-07-25T06:32:04.751178Z","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-07-25T06:32:04.751541Z","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-07-25T06:32:04.753341Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"185293d8d40ffce0 switched to configuration voters=(1752625764480580832)"} {"level":"info","ts":"2026-07-25T06:32:04.759119Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"cc857afa6e1fa648","local-member-id":"185293d8d40ffce0","added-peer-id":"185293d8d40ffce0","added-peer-peer-urls":["https://199.19.213.20:2380"]} {"level":"info","ts":"2026-07-25T06:32:04.760335Z","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-07-25T06:32:04.760619Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.20:2380"} {"level":"info","ts":"2026-07-25T06:32:04.760697Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.20:2380"} {"level":"info","ts":"2026-07-25T06:32:04.760789Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"185293d8d40ffce0","initial-advertise-peer-urls":["https://199.19.213.20:2380"],"listen-peer-urls":["https://199.19.213.20:2380"],"advertise-client-urls":["https://199.19.213.20:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.20:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-25T06:32:04.760853Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-25T06:32:05.333234Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"185293d8d40ffce0 is starting a new election at term 1"} {"level":"info","ts":"2026-07-25T06:32:05.333317Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"185293d8d40ffce0 became pre-candidate at term 1"} {"level":"info","ts":"2026-07-25T06:32:05.333358Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"185293d8d40ffce0 received MsgPreVoteResp from 185293d8d40ffce0 at term 1"} {"level":"info","ts":"2026-07-25T06:32:05.33338Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"185293d8d40ffce0 became candidate at term 2"} {"level":"info","ts":"2026-07-25T06:32:05.333395Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"185293d8d40ffce0 received MsgVoteResp from 185293d8d40ffce0 at term 2"} {"level":"info","ts":"2026-07-25T06:32:05.333409Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"185293d8d40ffce0 became leader at term 2"} {"level":"info","ts":"2026-07-25T06:32:05.333428Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 185293d8d40ffce0 elected leader 185293d8d40ffce0 at term 2"} {"level":"info","ts":"2026-07-25T06:32:05.335187Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-25T06:32:05.335832Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-25T06:32:05.335841Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"185293d8d40ffce0","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.20:2379]}","request-path":"/0/members/185293d8d40ffce0/attributes","cluster-id":"cc857afa6e1fa648","publish-timeout":"7s"} {"level":"info","ts":"2026-07-25T06:32:05.33608Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-25T06:32:05.336073Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"cc857afa6e1fa648","local-member-id":"185293d8d40ffce0","cluster-version":"3.5"} {"level":"info","ts":"2026-07-25T06:32:05.336255Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-25T06:32:05.336226Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-25T06:32:05.336315Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-25T06:32:05.33632Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-25T06:32:05.339016Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-25T06:32:05.341779Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.20:2379"} {"level":"info","ts":"2026-07-25T06:32:30.367556Z","caller":"traceutil/trace.go:171","msg":"trace[2132144156] linearizableReadLoop","detail":"{readStateIndex:412; appliedIndex:411; }","duration":"388.082516ms","start":"2026-07-25T06:32:29.979449Z","end":"2026-07-25T06:32:30.367532Z","steps":["trace[2132144156] 'read index received' (duration: 387.885644ms)","trace[2132144156] 'applied index is now lower than readState.Index' (duration: 196.042µs)"],"step_count":2} {"level":"warn","ts":"2026-07-25T06:32:30.367732Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"388.264887ms","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-07-25T06:32:30.367827Z","caller":"traceutil/trace.go:171","msg":"trace[1496736037] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:395; }","duration":"388.408067ms","start":"2026-07-25T06:32:29.979398Z","end":"2026-07-25T06:32:30.367806Z","steps":["trace[1496736037] 'agreement among raft nodes before linearized reading' (duration: 388.228986ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:32:30.367878Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:32:29.979375Z","time spent":"388.492569ms","remote":"127.0.0.1:47966","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-07-25T06:32:30.368257Z","caller":"traceutil/trace.go:171","msg":"trace[1287652710] transaction","detail":"{read_only:false; response_revision:395; number_of_response:1; }","duration":"390.845843ms","start":"2026-07-25T06:32:29.977393Z","end":"2026-07-25T06:32:30.368238Z","steps":["trace[1287652710] 'process raft request' (duration: 389.991868ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:32:30.368745Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:32:29.977373Z","time spent":"390.926413ms","remote":"127.0.0.1:47966","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-25T06:32:30.975443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.235408ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-25T06:32:30.975874Z","caller":"traceutil/trace.go:171","msg":"trace[1181617287] transaction","detail":"{read_only:false; response_revision:412; number_of_response:1; }","duration":"119.332836ms","start":"2026-07-25T06:32:30.85652Z","end":"2026-07-25T06:32:30.975853Z","steps":["trace[1181617287] 'process raft request' (duration: 119.265276ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:32:30.975884Z","caller":"traceutil/trace.go:171","msg":"trace[1410396172] transaction","detail":"{read_only:false; response_revision:411; number_of_response:1; }","duration":"229.876055ms","start":"2026-07-25T06:32:30.745968Z","end":"2026-07-25T06:32:30.975844Z","steps":["trace[1410396172] 'process raft request' (duration: 229.710004ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:32:30.976052Z","caller":"traceutil/trace.go:171","msg":"trace[943035673] transaction","detail":"{read_only:false; response_revision:410; number_of_response:1; }","duration":"255.903835ms","start":"2026-07-25T06:32:30.720036Z","end":"2026-07-25T06:32:30.97594Z","steps":["trace[943035673] 'process raft request' (duration: 255.492063ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:32:30.976115Z","caller":"traceutil/trace.go:171","msg":"trace[30772012] transaction","detail":"{read_only:false; number_of_response:1; response_revision:410; }","duration":"234.611666ms","start":"2026-07-25T06:32:30.741494Z","end":"2026-07-25T06:32:30.976106Z","steps":["trace[30772012] 'process raft request' (duration: 234.090493ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:32:30.976322Z","caller":"traceutil/trace.go:171","msg":"trace[1334885752] transaction","detail":"{read_only:false; number_of_response:1; response_revision:411; }","duration":"224.5387ms","start":"2026-07-25T06:32:30.751775Z","end":"2026-07-25T06:32:30.976314Z","steps":["trace[1334885752] 'process raft request' (duration: 223.957797ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:32:30.976355Z","caller":"traceutil/trace.go:171","msg":"trace[1428466554] transaction","detail":"{read_only:false; response_revision:409; number_of_response:1; }","duration":"256.660849ms","start":"2026-07-25T06:32:30.719677Z","end":"2026-07-25T06:32:30.976338Z","steps":["trace[1428466554] 'process raft request' (duration: 85.328305ms)","trace[1428466554] 'compare' (duration: 170.113257ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T06:32:31.151547Z","caller":"traceutil/trace.go:171","msg":"trace[551484714] transaction","detail":"{read_only:false; response_revision:415; number_of_response:1; }","duration":"167.270048ms","start":"2026-07-25T06:32:30.984244Z","end":"2026-07-25T06:32:31.151514Z","steps":["trace[551484714] 'process raft request' (duration: 167.186227ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:32:31.151631Z","caller":"traceutil/trace.go:171","msg":"trace[778409922] transaction","detail":"{read_only:false; response_revision:414; number_of_response:1; }","duration":"171.063744ms","start":"2026-07-25T06:32:30.980535Z","end":"2026-07-25T06:32:31.151599Z","steps":["trace[778409922] 'process raft request' (duration: 118.346861ms)","trace[778409922] 'compare' (duration: 52.36025ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T06:32:31.173298Z","caller":"traceutil/trace.go:171","msg":"trace[685343115] transaction","detail":"{read_only:false; response_revision:417; number_of_response:1; }","duration":"172.660882ms","start":"2026-07-25T06:32:31.000619Z","end":"2026-07-25T06:32:31.17328Z","steps":["trace[685343115] 'process raft request' (duration: 172.606812ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:32:31.173351Z","caller":"traceutil/trace.go:171","msg":"trace[1344120245] transaction","detail":"{read_only:false; response_revision:416; number_of_response:1; }","duration":"175.925885ms","start":"2026-07-25T06:32:30.99739Z","end":"2026-07-25T06:32:31.173316Z","steps":["trace[1344120245] 'process raft request' (duration: 175.712113ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:32:31.333598Z","caller":"traceutil/trace.go:171","msg":"trace[2119691214] transaction","detail":"{read_only:false; response_revision:426; number_of_response:1; }","duration":"100.198812ms","start":"2026-07-25T06:32:31.233364Z","end":"2026-07-25T06:32:31.333563Z","steps":["trace[2119691214] 'process raft request' (duration: 30.430789ms)","trace[2119691214] 'compare' (duration: 69.524511ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T06:32:33.367982Z","caller":"traceutil/trace.go:171","msg":"trace[959992242] transaction","detail":"{read_only:false; response_revision:432; number_of_response:1; }","duration":"203.361772ms","start":"2026-07-25T06:32:33.164598Z","end":"2026-07-25T06:32:33.36796Z","steps":["trace[959992242] 'process raft request' (duration: 203.247351ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:32:38.832271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"335.294914ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:40"} {"level":"warn","ts":"2026-07-25T06:32:38.832445Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:32:38.491998Z","time spent":"340.439468ms","remote":"127.0.0.1:47706","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-07-25T06:32:40.124413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"758.898319ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-25T06:32:40.124565Z","caller":"traceutil/trace.go:171","msg":"trace[730622795] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:442; }","duration":"759.07437ms","start":"2026-07-25T06:32:39.365472Z","end":"2026-07-25T06:32:40.124546Z","steps":["trace[730622795] 'range keys from in-memory index tree' (duration: 758.874089ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:32:40.124761Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.170173774s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-25T06:32:40.124979Z","caller":"traceutil/trace.go:171","msg":"trace[861062930] transaction","detail":"{read_only:false; response_revision:443; number_of_response:1; }","duration":"1.628924201s","start":"2026-07-25T06:32:38.496013Z","end":"2026-07-25T06:32:40.124937Z","steps":["trace[861062930] 'process raft request' (duration: 458.449224ms)","trace[861062930] 'compare' (duration: 1.170000353s)"],"step_count":2} {"level":"info","ts":"2026-07-25T06:32:40.125032Z","caller":"traceutil/trace.go:171","msg":"trace[761308739] transaction","detail":"{read_only:false; response_revision:444; number_of_response:1; }","duration":"1.290747098s","start":"2026-07-25T06:32:38.834261Z","end":"2026-07-25T06:32:40.125008Z","steps":["trace[761308739] 'process raft request' (duration: 1.290645837s)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:32:40.125044Z","caller":"traceutil/trace.go:171","msg":"trace[560067612] linearizableReadLoop","detail":"{readStateIndex:464; appliedIndex:463; }","duration":"1.511947972s","start":"2026-07-25T06:32:38.613081Z","end":"2026-07-25T06:32:40.125029Z","steps":["trace[560067612] 'read index received' (duration: 341.617485ms)","trace[560067612] 'applied index is now lower than readState.Index' (duration: 1.170328437s)"],"step_count":2} {"level":"warn","ts":"2026-07-25T06:32:40.125134Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:32:38.834231Z","time spent":"1.290853378s","remote":"127.0.0.1:47706","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":118,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-25T06:32:40.125168Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:32:38.495992Z","time spent":"1.629069442s","remote":"127.0.0.1:47966","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-25T06:32:40.12527Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.242405214s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-25T06:32:40.125309Z","caller":"traceutil/trace.go:171","msg":"trace[754066613] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:444; }","duration":"1.242448544s","start":"2026-07-25T06:32:38.88285Z","end":"2026-07-25T06:32:40.125299Z","steps":["trace[754066613] 'agreement among raft nodes before linearized reading' (duration: 1.242290813s)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:32:40.125348Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:32:38.882747Z","time spent":"1.242593436s","remote":"127.0.0.1:47680","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-25T06:32:40.125361Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"732.317977ms","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-07-25T06:32:40.125481Z","caller":"traceutil/trace.go:171","msg":"trace[498342235] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:444; }","duration":"732.532288ms","start":"2026-07-25T06:32:39.392926Z","end":"2026-07-25T06:32:40.125459Z","steps":["trace[498342235] 'agreement among raft nodes before linearized reading' (duration: 732.258157ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:32:40.125533Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:32:39.3929Z","time spent":"732.617479ms","remote":"127.0.0.1:47966","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-25T06:32:40.125389Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.512289334s","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-07-25T06:32:40.125701Z","caller":"traceutil/trace.go:171","msg":"trace[809172835] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:444; }","duration":"1.512653836s","start":"2026-07-25T06:32:38.613023Z","end":"2026-07-25T06:32:40.125677Z","steps":["trace[809172835] 'agreement among raft nodes before linearized reading' (duration: 1.512091072s)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:32:40.125756Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:32:38.613009Z","time spent":"1.512737387s","remote":"127.0.0.1:47966","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-25T06:32:41.353354Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.0247519s","expected-duration":"1s"} {"level":"warn","ts":"2026-07-25T06:32:41.387485Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:32:41.01614Z","time spent":"371.335405ms","remote":"127.0.0.1:59714","response type":"/etcdserverpb.Maintenance/Status","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-07-25T06:32:41.387871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.059122143s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-25T06:32:41.388086Z","caller":"traceutil/trace.go:171","msg":"trace[1467156628] transaction","detail":"{read_only:false; response_revision:446; number_of_response:1; }","duration":"1.256815084s","start":"2026-07-25T06:32:40.131253Z","end":"2026-07-25T06:32:41.388068Z","steps":["trace[1467156628] 'process raft request' (duration: 1.256731433s)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:32:41.388153Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:32:40.131235Z","time spent":"1.256883034s","remote":"127.0.0.1:47966","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-25T06:32:41.388106Z","caller":"traceutil/trace.go:171","msg":"trace[1873237354] linearizableReadLoop","detail":"{readStateIndex:466; appliedIndex:465; }","duration":"1.257688459s","start":"2026-07-25T06:32:40.130397Z","end":"2026-07-25T06:32:41.388085Z","steps":["trace[1873237354] 'read index received' (duration: 198.235704ms)","trace[1873237354] 'applied index is now lower than readState.Index' (duration: 1.059451135s)"],"step_count":2} {"level":"info","ts":"2026-07-25T06:32:41.388262Z","caller":"traceutil/trace.go:171","msg":"trace[1304794272] transaction","detail":"{read_only:false; response_revision:445; number_of_response:1; }","duration":"1.258208793s","start":"2026-07-25T06:32:40.130037Z","end":"2026-07-25T06:32:41.388246Z","steps":["trace[1304794272] 'process raft request' (duration: 198.607027ms)","trace[1304794272] 'compare' (duration: 1.05878508s)"],"step_count":2} {"level":"warn","ts":"2026-07-25T06:32:41.388374Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:32:40.130011Z","time spent":"1.258277993s","remote":"127.0.0.1:47966","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-25T06:32:41.388563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.258171792s","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-07-25T06:32:41.388595Z","caller":"traceutil/trace.go:171","msg":"trace[1137417212] range","detail":"{range_begin:/registry/masterleases/; range_end:/registry/masterleases0; response_count:1; response_revision:446; }","duration":"1.258240244s","start":"2026-07-25T06:32:40.130344Z","end":"2026-07-25T06:32:41.388585Z","steps":["trace[1137417212] 'agreement among raft nodes before linearized reading' (duration: 1.258162593s)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:32:41.388629Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:32:40.130321Z","time spent":"1.258301854s","remote":"127.0.0.1:47706","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/\" range_end:\"/registry/masterleases0\" "} {"level":"warn","ts":"2026-07-25T06:32:41.413255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"918.31016ms","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-07-25T06:32:41.413335Z","caller":"traceutil/trace.go:171","msg":"trace[683619499] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:447; }","duration":"918.43356ms","start":"2026-07-25T06:32:40.494882Z","end":"2026-07-25T06:32:41.413315Z","steps":["trace[683619499] 'agreement among raft nodes before linearized reading' (duration: 918.32733ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:32:41.413373Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:32:40.494858Z","time spent":"918.506942ms","remote":"127.0.0.1:47966","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-25T06:32:41.413507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.279868303s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-25T06:32:41.413545Z","caller":"traceutil/trace.go:171","msg":"trace[1969192406] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:447; }","duration":"1.279913253s","start":"2026-07-25T06:32:40.13362Z","end":"2026-07-25T06:32:41.413533Z","steps":["trace[1969192406] 'agreement among raft nodes before linearized reading' (duration: 1.279862813s)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:32:41.413574Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:32:40.133613Z","time spent":"1.279953634s","remote":"127.0.0.1:47680","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-07-25T06:32:46.39273Z","caller":"traceutil/trace.go:171","msg":"trace[239228603] transaction","detail":"{read_only:false; response_revision:492; number_of_response:1; }","duration":"175.775046ms","start":"2026-07-25T06:32:46.21693Z","end":"2026-07-25T06:32:46.392705Z","steps":["trace[239228603] 'process raft request' (duration: 175.641625ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:32:47.273716Z","caller":"traceutil/trace.go:171","msg":"trace[1352195577] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"533.131437ms","start":"2026-07-25T06:32:46.740563Z","end":"2026-07-25T06:32:47.273694Z","steps":["trace[1352195577] 'process raft request' (duration: 533.009786ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:32:47.273875Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:32:46.740533Z","time spent":"533.258628ms","remote":"127.0.0.1:47732","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-25T06:32:47.28335Z","caller":"traceutil/trace.go:171","msg":"trace[1938835559] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"533.38311ms","start":"2026-07-25T06:32:46.749908Z","end":"2026-07-25T06:32:47.283292Z","steps":["trace[1938835559] 'process raft request' (duration: 532.703016ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:32:47.284228Z","caller":"traceutil/trace.go:171","msg":"trace[1595690767] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"501.184931ms","start":"2026-07-25T06:32:46.783016Z","end":"2026-07-25T06:32:47.284201Z","steps":["trace[1595690767] 'process raft request' (duration: 500.319985ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:32:47.284311Z","caller":"traceutil/trace.go:171","msg":"trace[4015627] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"533.235779ms","start":"2026-07-25T06:32:46.751034Z","end":"2026-07-25T06:32:47.28427Z","steps":["trace[4015627] 'process raft request' (duration: 531.88779ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:32:47.284301Z","caller":"traceutil/trace.go:171","msg":"trace[387463750] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"493.124909ms","start":"2026-07-25T06:32:46.791123Z","end":"2026-07-25T06:32:47.284248Z","steps":["trace[387463750] 'process raft request' (duration: 492.802997ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:32:47.284467Z","caller":"traceutil/trace.go:171","msg":"trace[394880538] transaction","detail":"{read_only:false; response_revision:501; number_of_response:1; }","duration":"481.704795ms","start":"2026-07-25T06:32:46.802746Z","end":"2026-07-25T06:32:47.284451Z","steps":["trace[394880538] 'process raft request' (duration: 481.382223ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:32:47.284466Z","caller":"traceutil/trace.go:171","msg":"trace[892825052] transaction","detail":"{read_only:false; response_revision:500; number_of_response:1; }","duration":"493.26328ms","start":"2026-07-25T06:32:46.791184Z","end":"2026-07-25T06:32:47.284447Z","steps":["trace[892825052] 'process raft request' (duration: 492.827047ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:32:47.284521Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:32:46.802716Z","time spent":"481.783265ms","remote":"127.0.0.1:47732","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-25T06:32:47.284539Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:32:46.750997Z","time spent":"533.47943ms","remote":"127.0.0.1:47732","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-25T06:32:47.284588Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:32:46.791177Z","time spent":"493.33859ms","remote":"127.0.0.1:47732","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-25T06:32:47.284399Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:32:46.783002Z","time spent":"501.321572ms","remote":"127.0.0.1:47732","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-25T06:32:47.28485Z","caller":"traceutil/trace.go:171","msg":"trace[1675461873] transaction","detail":"{read_only:false; response_revision:502; number_of_response:1; }","duration":"479.613241ms","start":"2026-07-25T06:32:46.805222Z","end":"2026-07-25T06:32:47.284835Z","steps":["trace[1675461873] 'process raft request' (duration: 479.042358ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:32:47.284906Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:32:46.805207Z","time spent":"479.676181ms","remote":"127.0.0.1:47732","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-25T06:32:47.284952Z","caller":"traceutil/trace.go:171","msg":"trace[1407524975] transaction","detail":"{read_only:false; response_revision:503; number_of_response:1; }","duration":"458.927627ms","start":"2026-07-25T06:32:46.826005Z","end":"2026-07-25T06:32:47.284933Z","steps":["trace[1407524975] 'process raft request' (duration: 458.370703ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:32:47.284975Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:32:46.749882Z","time spent":"533.556551ms","remote":"127.0.0.1:47732","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-25T06:32:47.284772Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:32:46.791115Z","time spent":"493.529431ms","remote":"127.0.0.1:47732","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-25T06:32:47.285045Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:32:46.825985Z","time spent":"459.019039ms","remote":"127.0.0.1:47732","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-25T06:32:47.285061Z","caller":"traceutil/trace.go:171","msg":"trace[2036703798] linearizableReadLoop","detail":"{readStateIndex:526; appliedIndex:515; }","duration":"249.208471ms","start":"2026-07-25T06:32:47.035827Z","end":"2026-07-25T06:32:47.285035Z","steps":["trace[2036703798] 'read index received' (duration: 238.100669ms)","trace[2036703798] 'applied index is now lower than readState.Index' (duration: 11.104312ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T06:32:47.284049Z","caller":"traceutil/trace.go:171","msg":"trace[129962893] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"508.474598ms","start":"2026-07-25T06:32:46.775537Z","end":"2026-07-25T06:32:47.284012Z","steps":["trace[129962893] 'process raft request' (duration: 507.551052ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:32:47.285205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.357182ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-25T06:32:47.285234Z","caller":"traceutil/trace.go:171","msg":"trace[659917190] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:505; }","duration":"249.470684ms","start":"2026-07-25T06:32:47.035753Z","end":"2026-07-25T06:32:47.285224Z","steps":["trace[659917190] 'agreement among raft nodes before linearized reading' (duration: 249.357254ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:32:47.28522Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:32:46.775518Z","time spent":"509.634116ms","remote":"127.0.0.1:47732","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-25T06:32:47.284196Z","caller":"traceutil/trace.go:171","msg":"trace[653110935] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"501.05848ms","start":"2026-07-25T06:32:46.783107Z","end":"2026-07-25T06:32:47.284165Z","steps":["trace[653110935] 'process raft request' (duration: 500.605208ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:32:47.285053Z","caller":"traceutil/trace.go:171","msg":"trace[768275819] transaction","detail":"{read_only:false; response_revision:504; number_of_response:1; }","duration":"326.852124ms","start":"2026-07-25T06:32:46.958189Z","end":"2026-07-25T06:32:47.285041Z","steps":["trace[768275819] 'process raft request' (duration: 326.33968ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:32:47.285418Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:32:46.958148Z","time spent":"327.180206ms","remote":"127.0.0.1:47732","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-25T06:32:47.286423Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:32:46.783085Z","time spent":"502.66918ms","remote":"127.0.0.1:47732","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-25T06:32:50.860776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.569794ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-25T06:32:50.86085Z","caller":"traceutil/trace.go:171","msg":"trace[1908870008] range","detail":"{range_begin:/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:581; }","duration":"158.686075ms","start":"2026-07-25T06:32:50.702148Z","end":"2026-07-25T06:32:50.860834Z","steps":["trace[1908870008] 'range keys from in-memory index tree' (duration: 158.467974ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:32:54.013838Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":18221739567412248858,"retry-timeout":"500ms"} {"level":"info","ts":"2026-07-25T06:32:54.113626Z","caller":"traceutil/trace.go:171","msg":"trace[641632429] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"619.165109ms","start":"2026-07-25T06:32:53.494433Z","end":"2026-07-25T06:32:54.113598Z","steps":["trace[641632429] 'process raft request' (duration: 618.942587ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:32:54.114011Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:32:53.494416Z","time spent":"619.39412ms","remote":"127.0.0.1:47870","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-25T06:32:54.623807Z","caller":"traceutil/trace.go:171","msg":"trace[1248232428] transaction","detail":"{read_only:false; response_revision:601; number_of_response:1; }","duration":"882.570698ms","start":"2026-07-25T06:32:53.740782Z","end":"2026-07-25T06:32:54.623353Z","steps":["trace[1248232428] 'process raft request' (duration: 880.716585ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:32:54.624221Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:32:53.740726Z","time spent":"883.319313ms","remote":"127.0.0.1:47774","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036289,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-25T06:32:55.883502Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000596113s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-07-25T06:32:55.883646Z","caller":"traceutil/trace.go:171","msg":"trace[1796365596] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000787195s","start":"2026-07-25T06:32:53.882832Z","end":"2026-07-25T06:32:55.883619Z","steps":["trace[1796365596] 'agreement among raft nodes before linearized reading' (duration: 2.000629224s)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:32:55.883697Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:32:53.88281Z","time spent":"2.000877215s","remote":"127.0.0.1:47680","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/07/25 06:32:55 WARNING: [core] [Server #6] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-07-25T06:32:56.341625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.71843172s","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-07-25T06:32:56.34188Z","caller":"traceutil/trace.go:171","msg":"trace[736731293] linearizableReadLoop","detail":"{readStateIndex:627; appliedIndex:625; }","duration":"2.828849968s","start":"2026-07-25T06:32:53.512978Z","end":"2026-07-25T06:32:56.341828Z","steps":["trace[736731293] 'read index received' (duration: 600.639738ms)","trace[736731293] 'applied index is now lower than readState.Index' (duration: 2.22820902s)"],"step_count":2} {"level":"warn","ts":"2026-07-25T06:32:56.342086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.829104869s","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-07-25T06:32:56.342121Z","caller":"traceutil/trace.go:171","msg":"trace[158759305] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:601; }","duration":"2.829184561s","start":"2026-07-25T06:32:53.512928Z","end":"2026-07-25T06:32:56.342112Z","steps":["trace[158759305] 'agreement among raft nodes before linearized reading' (duration: 2.8290516s)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:32:56.342158Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:32:53.512906Z","time spent":"2.829244741s","remote":"127.0.0.1:47966","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-07-25T06:32:56.342676Z","caller":"traceutil/trace.go:171","msg":"trace[348386554] transaction","detail":"{read_only:false; response_revision:602; number_of_response:1; }","duration":"1.651941381s","start":"2026-07-25T06:32:54.69072Z","end":"2026-07-25T06:32:56.342661Z","steps":["trace[348386554] 'process raft request' (duration: 1.651017095s)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:32:56.342764Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:32:54.690694Z","time spent":"1.652021631s","remote":"127.0.0.1:48210","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-25T06:32:56.527861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"643.968615ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-25T06:32:56.527941Z","caller":"traceutil/trace.go:171","msg":"trace[2060356859] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:602; }","duration":"644.092326ms","start":"2026-07-25T06:32:55.883824Z","end":"2026-07-25T06:32:56.527917Z","steps":["trace[2060356859] 'agreement among raft nodes before linearized reading' (duration: 459.068392ms)","trace[2060356859] 'range keys from in-memory index tree' (duration: 184.910823ms)"],"step_count":2} {"level":"warn","ts":"2026-07-25T06:32:56.527981Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:32:55.883804Z","time spent":"644.169586ms","remote":"127.0.0.1:47674","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-25T06:32:56.528094Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.014029184s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-07-25T06:32:56.527861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.098112411s","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-07-25T06:32:56.528132Z","caller":"traceutil/trace.go:171","msg":"trace[1746394451] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:602; }","duration":"3.014061394s","start":"2026-07-25T06:32:53.514056Z","end":"2026-07-25T06:32:56.528117Z","steps":["trace[1746394451] 'agreement among raft nodes before linearized reading' (duration: 2.828589228s)","trace[1746394451] 'range keys from in-memory index tree' (duration: 185.364005ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T06:32:56.52814Z","caller":"traceutil/trace.go:171","msg":"trace[814133485] linearizableReadLoop","detail":"{readStateIndex:629; appliedIndex:628; }","duration":"174.557185ms","start":"2026-07-25T06:32:56.353566Z","end":"2026-07-25T06:32:56.528123Z","steps":["trace[814133485] 'read index received' (duration: 122.131508ms)","trace[814133485] 'applied index is now lower than readState.Index' (duration: 52.424817ms)"],"step_count":2} {"level":"warn","ts":"2026-07-25T06:32:56.528162Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:32:53.51403Z","time spent":"3.014125744s","remote":"127.0.0.1:47966","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-07-25T06:32:56.528162Z","caller":"traceutil/trace.go:171","msg":"trace[180215497] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:602; }","duration":"2.098466273s","start":"2026-07-25T06:32:54.429684Z","end":"2026-07-25T06:32:56.52815Z","steps":["trace[180215497] 'agreement among raft nodes before linearized reading' (duration: 1.913219838s)","trace[180215497] 'range keys from in-memory index tree' (duration: 184.912733ms)"],"step_count":2} {"level":"warn","ts":"2026-07-25T06:32:56.528195Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:32:54.429656Z","time spent":"2.098531563s","remote":"127.0.0.1:47966","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-25T06:32:56.52822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.647236ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-25T06:32:56.528251Z","caller":"traceutil/trace.go:171","msg":"trace[1166238742] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:603; }","duration":"174.680336ms","start":"2026-07-25T06:32:56.353558Z","end":"2026-07-25T06:32:56.528239Z","steps":["trace[1166238742] 'agreement among raft nodes before linearized reading' (duration: 174.616095ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:32:56.528526Z","caller":"traceutil/trace.go:171","msg":"trace[466094427] transaction","detail":"{read_only:false; response_revision:603; number_of_response:1; }","duration":"181.552371ms","start":"2026-07-25T06:32:56.346924Z","end":"2026-07-25T06:32:56.528476Z","steps":["trace[466094427] 'process raft request' (duration: 128.823452ms)","trace[466094427] 'compare' (duration: 52.191496ms)"],"step_count":2} {"level":"warn","ts":"2026-07-25T06:32:56.528731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.991058537s","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-07-25T06:32:56.528795Z","caller":"traceutil/trace.go:171","msg":"trace[1057830964] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:602; }","duration":"2.991140017s","start":"2026-07-25T06:32:53.537638Z","end":"2026-07-25T06:32:56.528778Z","steps":["trace[1057830964] 'agreement among raft nodes before linearized reading' (duration: 2.805273057s)","trace[1057830964] 'range keys from in-memory index tree' (duration: 184.860433ms)"],"step_count":2} {"level":"warn","ts":"2026-07-25T06:32:56.528825Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:32:53.537625Z","time spent":"2.991192427s","remote":"127.0.0.1:47966","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-25T06:32:58.131392Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.06257ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-25T06:32:58.131473Z","caller":"traceutil/trace.go:171","msg":"trace[731274613] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:618; }","duration":"248.196261ms","start":"2026-07-25T06:32:57.883258Z","end":"2026-07-25T06:32:58.131455Z","steps":["trace[731274613] 'range keys from in-memory index tree' (duration: 247.908769ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:33:01.808354Z","caller":"traceutil/trace.go:171","msg":"trace[1722337797] transaction","detail":"{read_only:false; response_revision:684; number_of_response:1; }","duration":"111.529538ms","start":"2026-07-25T06:33:01.696805Z","end":"2026-07-25T06:33:01.808335Z","steps":["trace[1722337797] 'process raft request' (duration: 111.383267ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:33:01.810691Z","caller":"traceutil/trace.go:171","msg":"trace[1665276200] transaction","detail":"{read_only:false; response_revision:685; number_of_response:1; }","duration":"110.18421ms","start":"2026-07-25T06:33:01.700486Z","end":"2026-07-25T06:33:01.81067Z","steps":["trace[1665276200] 'process raft request' (duration: 110.05172ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:33:08.729237Z","caller":"traceutil/trace.go:171","msg":"trace[969478805] linearizableReadLoop","detail":"{readStateIndex:779; appliedIndex:778; }","duration":"103.733409ms","start":"2026-07-25T06:33:08.625479Z","end":"2026-07-25T06:33:08.729212Z","steps":["trace[969478805] 'read index received' (duration: 78.109064ms)","trace[969478805] 'applied index is now lower than readState.Index' (duration: 25.623155ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T06:33:08.729359Z","caller":"traceutil/trace.go:171","msg":"trace[1805513777] transaction","detail":"{read_only:false; response_revision:749; number_of_response:1; }","duration":"106.909499ms","start":"2026-07-25T06:33:08.62241Z","end":"2026-07-25T06:33:08.72932Z","steps":["trace[1805513777] 'process raft request' (duration: 81.179853ms)","trace[1805513777] 'compare' (duration: 25.470104ms)"],"step_count":2} {"level":"warn","ts":"2026-07-25T06:33:08.729509Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.020011ms","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-07-25T06:33:08.729584Z","caller":"traceutil/trace.go:171","msg":"trace[2018551897] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:749; }","duration":"104.154542ms","start":"2026-07-25T06:33:08.625409Z","end":"2026-07-25T06:33:08.729564Z","steps":["trace[2018551897] 'agreement among raft nodes before linearized reading' (duration: 103.96381ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:33:08.747704Z","caller":"traceutil/trace.go:171","msg":"trace[903533265] transaction","detail":"{read_only:false; response_revision:750; number_of_response:1; }","duration":"117.299635ms","start":"2026-07-25T06:33:08.630388Z","end":"2026-07-25T06:33:08.747688Z","steps":["trace[903533265] 'process raft request' (duration: 117.113344ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:33:08.748503Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.34323ms","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-07-25T06:33:08.748612Z","caller":"traceutil/trace.go:171","msg":"trace[1398333743] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:750; }","duration":"116.52233ms","start":"2026-07-25T06:33:08.632063Z","end":"2026-07-25T06:33:08.748586Z","steps":["trace[1398333743] 'agreement among raft nodes before linearized reading' (duration: 115.574215ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:33:08.748789Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.195128ms","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-07-25T06:33:08.748928Z","caller":"traceutil/trace.go:171","msg":"trace[205825193] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:750; }","duration":"116.41775ms","start":"2026-07-25T06:33:08.632487Z","end":"2026-07-25T06:33:08.748904Z","steps":["trace[205825193] 'agreement among raft nodes before linearized reading' (duration: 115.223892ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:33:13.79986Z","caller":"traceutil/trace.go:171","msg":"trace[1455428293] transaction","detail":"{read_only:false; response_revision:772; number_of_response:1; }","duration":"981.287625ms","start":"2026-07-25T06:33:12.818534Z","end":"2026-07-25T06:33:13.799822Z","steps":["trace[1455428293] 'process raft request' (duration: 882.070756ms)","trace[1455428293] 'compare' (duration: 99.072668ms)"],"step_count":2} {"level":"warn","ts":"2026-07-25T06:33:13.800061Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:33:12.818509Z","time spent":"981.451966ms","remote":"127.0.0.1:47966","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-25T06:33:13.85331Z","caller":"traceutil/trace.go:171","msg":"trace[1325430087] transaction","detail":"{read_only:false; response_revision:774; number_of_response:1; }","duration":"1.032332284s","start":"2026-07-25T06:33:12.820882Z","end":"2026-07-25T06:33:13.853214Z","steps":["trace[1325430087] 'process raft request' (duration: 1.03172851s)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:33:13.852737Z","caller":"traceutil/trace.go:171","msg":"trace[549723119] transaction","detail":"{read_only:false; response_revision:773; number_of_response:1; }","duration":"1.033993195s","start":"2026-07-25T06:33:12.818708Z","end":"2026-07-25T06:33:13.852701Z","steps":["trace[549723119] 'process raft request' (duration: 1.033705733s)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:33:13.853518Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:33:12.820856Z","time spent":"1.032566925s","remote":"127.0.0.1:47966","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-25T06:33:13.853733Z","caller":"traceutil/trace.go:171","msg":"trace[2068054348] linearizableReadLoop","detail":"{readStateIndex:805; appliedIndex:802; }","duration":"523.991333ms","start":"2026-07-25T06:33:13.329697Z","end":"2026-07-25T06:33:13.853688Z","steps":["trace[2068054348] 'read index received' (duration: 370.870807ms)","trace[2068054348] 'applied index is now lower than readState.Index' (duration: 153.117286ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T06:33:13.853793Z","caller":"traceutil/trace.go:171","msg":"trace[523396725] transaction","detail":"{read_only:false; response_revision:775; number_of_response:1; }","duration":"230.322463ms","start":"2026-07-25T06:33:13.623445Z","end":"2026-07-25T06:33:13.853768Z","steps":["trace[523396725] 'process raft request' (duration: 229.508697ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:33:13.853927Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:33:12.818668Z","time spent":"1.034824309s","remote":"127.0.0.1:47966","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-25T06:33:13.853954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"524.349745ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-25T06:33:13.853998Z","caller":"traceutil/trace.go:171","msg":"trace[1393344493] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:775; }","duration":"524.471766ms","start":"2026-07-25T06:33:13.329515Z","end":"2026-07-25T06:33:13.853987Z","steps":["trace[1393344493] 'agreement among raft nodes before linearized reading' (duration: 524.296295ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:33:13.854038Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T06:33:13.329486Z","time spent":"524.538276ms","remote":"127.0.0.1:47870","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":12,"response size":30,"request content":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true "} {"level":"info","ts":"2026-07-25T06:33:44.166033Z","caller":"traceutil/trace.go:171","msg":"trace[21937892] linearizableReadLoop","detail":"{readStateIndex:1005; appliedIndex:1004; }","duration":"217.029244ms","start":"2026-07-25T06:33:43.948969Z","end":"2026-07-25T06:33:44.165999Z","steps":["trace[21937892] 'read index received' (duration: 214.507598ms)","trace[21937892] 'applied index is now lower than readState.Index' (duration: 2.519656ms)"],"step_count":2} {"level":"warn","ts":"2026-07-25T06:33:44.166282Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.281926ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-07-25T06:33:44.166354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.17656ms","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-07-25T06:33:44.166375Z","caller":"traceutil/trace.go:171","msg":"trace[1068248560] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:966; }","duration":"217.466477ms","start":"2026-07-25T06:33:43.94889Z","end":"2026-07-25T06:33:44.166357Z","steps":["trace[1068248560] 'agreement among raft nodes before linearized reading' (duration: 217.196825ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:33:44.166384Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.015419ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-07-25T06:33:44.166391Z","caller":"traceutil/trace.go:171","msg":"trace[966506124] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:966; }","duration":"129.267741ms","start":"2026-07-25T06:33:44.037113Z","end":"2026-07-25T06:33:44.16638Z","steps":["trace[966506124] 'agreement among raft nodes before linearized reading' (duration: 129.09167ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:33:44.166435Z","caller":"traceutil/trace.go:171","msg":"trace[129986608] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:966; }","duration":"129.122709ms","start":"2026-07-25T06:33:44.037299Z","end":"2026-07-25T06:33:44.166422Z","steps":["trace[129986608] 'agreement among raft nodes before linearized reading' (duration: 128.955118ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:33:51.286581Z","caller":"traceutil/trace.go:171","msg":"trace[1313174658] transaction","detail":"{read_only:false; response_revision:996; number_of_response:1; }","duration":"245.247444ms","start":"2026-07-25T06:33:51.041303Z","end":"2026-07-25T06:33:51.28655Z","steps":["trace[1313174658] 'process raft request' (duration: 245.063343ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:34:01.177694Z","caller":"traceutil/trace.go:171","msg":"trace[652987155] transaction","detail":"{read_only:false; response_revision:1028; number_of_response:1; }","duration":"200.165303ms","start":"2026-07-25T06:34:00.977496Z","end":"2026-07-25T06:34:01.177661Z","steps":["trace[652987155] 'process raft request' (duration: 185.514728ms)","trace[652987155] 'compare' (duration: 14.228871ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T06:34:02.435931Z","caller":"traceutil/trace.go:171","msg":"trace[878772202] transaction","detail":"{read_only:false; response_revision:1030; number_of_response:1; }","duration":"149.88718ms","start":"2026-07-25T06:34:02.286011Z","end":"2026-07-25T06:34:02.435898Z","steps":["trace[878772202] 'process raft request' (duration: 149.697169ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:34:06.701023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.210001ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-25T06:34:06.701228Z","caller":"traceutil/trace.go:171","msg":"trace[29071689] transaction","detail":"{read_only:false; response_revision:1044; number_of_response:1; }","duration":"191.684243ms","start":"2026-07-25T06:34:06.509458Z","end":"2026-07-25T06:34:06.701143Z","steps":["trace[29071689] 'process raft request' (duration: 83.238091ms)","trace[29071689] 'compare' (duration: 108.05064ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T06:34:06.719051Z","caller":"traceutil/trace.go:171","msg":"trace[372818178] transaction","detail":"{read_only:false; response_revision:1045; number_of_response:1; }","duration":"206.032941ms","start":"2026-07-25T06:34:06.512976Z","end":"2026-07-25T06:34:06.719009Z","steps":["trace[372818178] 'process raft request' (duration: 205.774029ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T06:34:19.246588Z","caller":"traceutil/trace.go:171","msg":"trace[970921878] linearizableReadLoop","detail":"{readStateIndex:1132; appliedIndex:1131; }","duration":"152.930647ms","start":"2026-07-25T06:34:19.093621Z","end":"2026-07-25T06:34:19.246552Z","steps":["trace[970921878] 'read index received' (duration: 152.739726ms)","trace[970921878] 'applied index is now lower than readState.Index' (duration: 189.921µs)"],"step_count":2} {"level":"info","ts":"2026-07-25T06:34:19.246669Z","caller":"traceutil/trace.go:171","msg":"trace[128224354] transaction","detail":"{read_only:false; response_revision:1086; number_of_response:1; }","duration":"166.739273ms","start":"2026-07-25T06:34:19.079902Z","end":"2026-07-25T06:34:19.246642Z","steps":["trace[128224354] 'process raft request' (duration: 166.43719ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:34:19.246897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.46956ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:controller:persistent-volume-binder\" ","response":"range_response_count:1 size:771"} {"level":"info","ts":"2026-07-25T06:34:19.246967Z","caller":"traceutil/trace.go:171","msg":"trace[353292239] range","detail":"{range_begin:/registry/clusterrolebindings/system:controller:persistent-volume-binder; range_end:; response_count:1; response_revision:1086; }","duration":"125.607171ms","start":"2026-07-25T06:34:19.121338Z","end":"2026-07-25T06:34:19.246946Z","steps":["trace[353292239] 'agreement among raft nodes before linearized reading' (duration: 125.42265ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T06:34:19.246929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.269ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:node\" ","response":"range_response_count:1 size:1486"} {"level":"info","ts":"2026-07-25T06:34:19.247043Z","caller":"traceutil/trace.go:171","msg":"trace[484300278] range","detail":"{range_begin:/registry/clusterroles/system:node; range_end:; response_count:1; response_revision:1086; }","duration":"153.433141ms","start":"2026-07-25T06:34:19.093584Z","end":"2026-07-25T06:34:19.247017Z","steps":["trace[484300278] 'agreement among raft nodes before linearized reading' (duration: 153.17285ms)"],"step_count":1}