{"level":"warn","ts":"2026-02-25T15:03:05.799293Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-02-25T15:03:05.799388Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.50: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.50:2380","--initial-cluster=instance=https://199.19.213.50:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.50:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.50:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-02-25T15:03:05.799471Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-02-25T15:03:05.799487Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.50:2380"]} {"level":"info","ts":"2026-02-25T15:03:05.799506Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-02-25T15:03:05.800499Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.50:2379"]} {"level":"info","ts":"2026-02-25T15:03:05.800589Z","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.50:2380"],"listen-peer-urls":["https://199.19.213.50:2380"],"advertise-client-urls":["https://199.19.213.50:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.50:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.50:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-02-25T15:03:05.805402Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.550288ms"} {"level":"info","ts":"2026-02-25T15:03:05.81576Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"bad013de7b9e37eb","cluster-id":"39d8802c0029e2bb"} {"level":"info","ts":"2026-02-25T15:03:05.815871Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bad013de7b9e37eb switched to configuration voters=()"} {"level":"info","ts":"2026-02-25T15:03:05.8159Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bad013de7b9e37eb became follower at term 0"} {"level":"info","ts":"2026-02-25T15:03:05.815909Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft bad013de7b9e37eb [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-25T15:03:05.815917Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bad013de7b9e37eb became follower at term 1"} {"level":"info","ts":"2026-02-25T15:03:05.815955Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bad013de7b9e37eb switched to configuration voters=(13461281132488046571)"} {"level":"warn","ts":"2026-02-25T15:03:05.824712Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-25T15:03:05.826606Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-25T15:03:05.828804Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-02-25T15:03:05.830956Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"bad013de7b9e37eb","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-25T15:03:05.831753Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-02-25T15:03:05.831856Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-02-25T15:03:05.831864Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"bad013de7b9e37eb","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-25T15:03:05.833168Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-02-25T15:03:05.833897Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bad013de7b9e37eb switched to configuration voters=(13461281132488046571)"} {"level":"info","ts":"2026-02-25T15:03:05.834033Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"39d8802c0029e2bb","local-member-id":"bad013de7b9e37eb","added-peer-id":"bad013de7b9e37eb","added-peer-peer-urls":["https://199.19.213.50:2380"]} {"level":"info","ts":"2026-02-25T15:03:05.835255Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-02-25T15:03:05.835507Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"bad013de7b9e37eb","initial-advertise-peer-urls":["https://199.19.213.50:2380"],"listen-peer-urls":["https://199.19.213.50:2380"],"advertise-client-urls":["https://199.19.213.50:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.50:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-25T15:03:05.835548Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-25T15:03:05.836583Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.50:2380"} {"level":"info","ts":"2026-02-25T15:03:05.836635Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.50:2380"} {"level":"info","ts":"2026-02-25T15:03:06.416711Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bad013de7b9e37eb is starting a new election at term 1"} {"level":"info","ts":"2026-02-25T15:03:06.41679Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bad013de7b9e37eb became pre-candidate at term 1"} {"level":"info","ts":"2026-02-25T15:03:06.416819Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bad013de7b9e37eb received MsgPreVoteResp from bad013de7b9e37eb at term 1"} {"level":"info","ts":"2026-02-25T15:03:06.416859Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bad013de7b9e37eb became candidate at term 2"} {"level":"info","ts":"2026-02-25T15:03:06.416877Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bad013de7b9e37eb received MsgVoteResp from bad013de7b9e37eb at term 2"} {"level":"info","ts":"2026-02-25T15:03:06.416918Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bad013de7b9e37eb became leader at term 2"} {"level":"info","ts":"2026-02-25T15:03:06.416944Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: bad013de7b9e37eb elected leader bad013de7b9e37eb at term 2"} {"level":"info","ts":"2026-02-25T15:03:06.418028Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-25T15:03:06.418998Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-25T15:03:06.418996Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"bad013de7b9e37eb","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.50:2379]}","request-path":"/0/members/bad013de7b9e37eb/attributes","cluster-id":"39d8802c0029e2bb","publish-timeout":"7s"} {"level":"info","ts":"2026-02-25T15:03:06.419063Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-25T15:03:06.419415Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"39d8802c0029e2bb","local-member-id":"bad013de7b9e37eb","cluster-version":"3.5"} {"level":"info","ts":"2026-02-25T15:03:06.41955Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-25T15:03:06.419591Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-25T15:03:06.41977Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-25T15:03:06.419853Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-25T15:03:06.422931Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-02-25T15:03:06.422943Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.50:2379"} {"level":"warn","ts":"2026-02-25T15:03:10.551848Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4029486456773499383,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-25T15:03:10.608623Z","caller":"traceutil/trace.go:171","msg":"trace[1426500347] transaction","detail":"{read_only:false; response_revision:208; number_of_response:1; }","duration":"676.417326ms","start":"2026-02-25T15:03:09.932176Z","end":"2026-02-25T15:03:10.608594Z","steps":["trace[1426500347] 'process raft request' (duration: 676.271151ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:03:10.609197Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:03:09.93215Z","time spent":"676.557201ms","remote":"127.0.0.1:59534","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-25T15:03:10.626322Z","caller":"traceutil/trace.go:171","msg":"trace[1029782553] linearizableReadLoop","detail":"{readStateIndex:213; appliedIndex:211; }","duration":"574.911827ms","start":"2026-02-25T15:03:10.051386Z","end":"2026-02-25T15:03:10.626298Z","steps":["trace[1029782553] 'read index received' (duration: 557.013283ms)","trace[1029782553] 'applied index is now lower than readState.Index' (duration: 17.897294ms)"],"step_count":2} {"level":"warn","ts":"2026-02-25T15:03:10.62648Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"575.048643ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3181"} {"level":"info","ts":"2026-02-25T15:03:10.626534Z","caller":"traceutil/trace.go:171","msg":"trace[419835011] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:209; }","duration":"575.16903ms","start":"2026-02-25T15:03:10.051351Z","end":"2026-02-25T15:03:10.62652Z","steps":["trace[419835011] 'agreement among raft nodes before linearized reading' (duration: 575.040193ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:03:10.626574Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:03:10.051299Z","time spent":"575.26684ms","remote":"127.0.0.1:59446","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":3204,"request content":"key:\"/registry/minions/instance\" "} {"level":"info","ts":"2026-02-25T15:03:10.626662Z","caller":"traceutil/trace.go:171","msg":"trace[1533867345] transaction","detail":"{read_only:false; response_revision:209; number_of_response:1; }","duration":"692.110316ms","start":"2026-02-25T15:03:09.934355Z","end":"2026-02-25T15:03:10.626465Z","steps":["trace[1533867345] 'process raft request' (duration: 691.747774ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:03:10.62694Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:03:09.934342Z","time spent":"692.424743ms","remote":"127.0.0.1:59534","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-25T15:03:10.981716Z","caller":"traceutil/trace.go:171","msg":"trace[1550938905] transaction","detail":"{read_only:false; response_revision:210; number_of_response:1; }","duration":"347.172359ms","start":"2026-02-25T15:03:10.634514Z","end":"2026-02-25T15:03:10.981686Z","steps":["trace[1550938905] 'process raft request' (duration: 347.022275ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:03:10.981854Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:03:10.634491Z","time spent":"347.290677ms","remote":"127.0.0.1:59446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3384,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-25T15:03:13.295611Z","caller":"traceutil/trace.go:171","msg":"trace[1644188799] transaction","detail":"{read_only:false; number_of_response:0; response_revision:279; }","duration":"137.85021ms","start":"2026-02-25T15:03:13.157734Z","end":"2026-02-25T15:03:13.295585Z","steps":["trace[1644188799] 'process raft request' (duration: 136.088113ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T15:03:13.386171Z","caller":"traceutil/trace.go:171","msg":"trace[1015866444] linearizableReadLoop","detail":"{readStateIndex:288; appliedIndex:286; }","duration":"194.789384ms","start":"2026-02-25T15:03:13.191357Z","end":"2026-02-25T15:03:13.386147Z","steps":["trace[1015866444] 'read index received' (duration: 102.461856ms)","trace[1015866444] 'applied index is now lower than readState.Index' (duration: 92.326579ms)"],"step_count":2} {"level":"info","ts":"2026-02-25T15:03:13.386298Z","caller":"traceutil/trace.go:171","msg":"trace[828420583] transaction","detail":"{read_only:false; response_revision:280; number_of_response:1; }","duration":"199.461726ms","start":"2026-02-25T15:03:13.186824Z","end":"2026-02-25T15:03:13.386286Z","steps":["trace[828420583] 'process raft request' (duration: 199.192872ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:03:13.386473Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.102394ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T15:03:13.386504Z","caller":"traceutil/trace.go:171","msg":"trace[909450670] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/bootstrap-signer; range_end:; response_count:0; response_revision:280; }","duration":"195.194614ms","start":"2026-02-25T15:03:13.191302Z","end":"2026-02-25T15:03:13.386497Z","steps":["trace[909450670] 'agreement among raft nodes before linearized reading' (duration: 195.121701ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T15:03:13.74874Z","caller":"traceutil/trace.go:171","msg":"trace[869836797] transaction","detail":"{read_only:false; response_revision:286; number_of_response:1; }","duration":"113.807065ms","start":"2026-02-25T15:03:13.634898Z","end":"2026-02-25T15:03:13.748705Z","steps":["trace[869836797] 'process raft request' (duration: 113.610244ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T15:03:15.72096Z","caller":"traceutil/trace.go:171","msg":"trace[1080116540] linearizableReadLoop","detail":"{readStateIndex:311; appliedIndex:310; }","duration":"128.875258ms","start":"2026-02-25T15:03:15.592056Z","end":"2026-02-25T15:03:15.720931Z","steps":["trace[1080116540] 'read index received' (duration: 111.579066ms)","trace[1080116540] 'applied index is now lower than readState.Index' (duration: 17.295052ms)"],"step_count":2} {"level":"info","ts":"2026-02-25T15:03:15.721033Z","caller":"traceutil/trace.go:171","msg":"trace[1894433029] transaction","detail":"{read_only:false; response_revision:303; number_of_response:1; }","duration":"152.654754ms","start":"2026-02-25T15:03:15.56834Z","end":"2026-02-25T15:03:15.720994Z","steps":["trace[1894433029] 'process raft request' (duration: 135.38171ms)","trace[1894433029] 'compare' (duration: 17.063014ms)"],"step_count":2} {"level":"warn","ts":"2026-02-25T15:03:15.721212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.107956ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-02-25T15:03:15.721262Z","caller":"traceutil/trace.go:171","msg":"trace[853256272] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-controller; range_end:; response_count:1; response_revision:303; }","duration":"129.263981ms","start":"2026-02-25T15:03:15.591985Z","end":"2026-02-25T15:03:15.721249Z","steps":["trace[853256272] 'agreement among raft nodes before linearized reading' (duration: 129.090738ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:03:16.678988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"687.85483ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-25T15:03:16.679129Z","caller":"traceutil/trace.go:171","msg":"trace[1215321900] linearizableReadLoop","detail":"{readStateIndex:313; appliedIndex:311; }","duration":"938.075081ms","start":"2026-02-25T15:03:15.741033Z","end":"2026-02-25T15:03:16.679108Z","steps":["trace[1215321900] 'read index received' (duration: 18.801722ms)","trace[1215321900] 'applied index is now lower than readState.Index' (duration: 919.27162ms)"],"step_count":2} {"level":"info","ts":"2026-02-25T15:03:16.679189Z","caller":"traceutil/trace.go:171","msg":"trace[745752576] transaction","detail":"{read_only:false; response_revision:305; number_of_response:1; }","duration":"951.443621ms","start":"2026-02-25T15:03:15.727699Z","end":"2026-02-25T15:03:16.679143Z","steps":["trace[745752576] 'process raft request' (duration: 263.100746ms)","trace[745752576] 'compare' (duration: 687.689515ms)"],"step_count":2} {"level":"warn","ts":"2026-02-25T15:03:16.679272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"938.240936ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" ","response":"range_response_count:1 size:214"} {"level":"info","ts":"2026-02-25T15:03:16.679306Z","caller":"traceutil/trace.go:171","msg":"trace[669687673] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslice-controller; range_end:; response_count:1; response_revision:305; }","duration":"938.30098ms","start":"2026-02-25T15:03:15.740995Z","end":"2026-02-25T15:03:16.679296Z","steps":["trace[669687673] 'agreement among raft nodes before linearized reading' (duration: 938.225277ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:03:16.6794Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:03:15.740963Z","time spent":"938.425809ms","remote":"127.0.0.1:59460","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":237,"request content":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" "} {"level":"warn","ts":"2026-02-25T15:03:16.679445Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:03:15.727652Z","time spent":"951.636834ms","remote":"127.0.0.1:59718","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3669,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-25T15:03:16.679545Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"888.637075ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/node-controller\" ","response":"range_response_count:1 size:195"} {"level":"warn","ts":"2026-02-25T15:03:16.67962Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"798.152208ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-02-25T15:03:16.679694Z","caller":"traceutil/trace.go:171","msg":"trace[1056556194] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/node-controller; range_end:; response_count:1; response_revision:305; }","duration":"888.809749ms","start":"2026-02-25T15:03:15.790837Z","end":"2026-02-25T15:03:16.679647Z","steps":["trace[1056556194] 'agreement among raft nodes before linearized reading' (duration: 888.5833ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T15:03:16.679734Z","caller":"traceutil/trace.go:171","msg":"trace[1740013686] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:305; }","duration":"798.296584ms","start":"2026-02-25T15:03:15.881417Z","end":"2026-02-25T15:03:16.679713Z","steps":["trace[1740013686] 'agreement among raft nodes before linearized reading' (duration: 798.091603ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:03:16.679758Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:03:15.79082Z","time spent":"888.928449ms","remote":"127.0.0.1:59460","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":218,"request content":"key:\"/registry/serviceaccounts/kube-system/node-controller\" "} {"level":"warn","ts":"2026-02-25T15:03:16.679782Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:03:15.881403Z","time spent":"798.369688ms","remote":"127.0.0.1:59534","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-25T15:03:16.67983Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"884.255736ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" ","response":"range_response_count:1 size:6894"} {"level":"info","ts":"2026-02-25T15:03:16.679883Z","caller":"traceutil/trace.go:171","msg":"trace[1719402621] range","detail":"{range_begin:/registry/pods/kube-system/kube-controller-manager-instance; range_end:; response_count:1; response_revision:305; }","duration":"884.31843ms","start":"2026-02-25T15:03:15.79555Z","end":"2026-02-25T15:03:16.679868Z","steps":["trace[1719402621] 'agreement among raft nodes before linearized reading' (duration: 884.195041ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:03:16.679925Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:03:15.795544Z","time spent":"884.371845ms","remote":"127.0.0.1:59452","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":6917,"request content":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" "} {"level":"warn","ts":"2026-02-25T15:03:16.67999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"586.58125ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-02-25T15:03:16.680031Z","caller":"traceutil/trace.go:171","msg":"trace[1993501016] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/certificate-controller; range_end:; response_count:1; response_revision:305; }","duration":"586.681151ms","start":"2026-02-25T15:03:16.093338Z","end":"2026-02-25T15:03:16.68002Z","steps":["trace[1993501016] 'agreement among raft nodes before linearized reading' (duration: 586.556942ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:03:16.680073Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:03:16.093303Z","time spent":"586.759343ms","remote":"127.0.0.1:59460","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":232,"request content":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" "} {"level":"warn","ts":"2026-02-25T15:03:16.680087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"788.530228ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" ","response":"range_response_count:1 size:207"} {"level":"warn","ts":"2026-02-25T15:03:16.680125Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"884.632451ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3842"} {"level":"warn","ts":"2026-02-25T15:03:16.680111Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"736.622733ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/root-ca-cert-publisher\" ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-02-25T15:03:16.68016Z","caller":"traceutil/trace.go:171","msg":"trace[922527521] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:305; }","duration":"884.687466ms","start":"2026-02-25T15:03:15.795462Z","end":"2026-02-25T15:03:16.68015Z","steps":["trace[922527521] 'agreement among raft nodes before linearized reading' (duration: 884.630331ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:03:16.680191Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:03:15.795449Z","time spent":"884.735551ms","remote":"127.0.0.1:59446","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":3865,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-02-25T15:03:16.680213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"488.781405ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-02-25T15:03:16.680209Z","caller":"traceutil/trace.go:171","msg":"trace[188630767] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/root-ca-cert-publisher; range_end:; response_count:1; response_revision:305; }","duration":"736.770268ms","start":"2026-02-25T15:03:15.9434Z","end":"2026-02-25T15:03:16.680171Z","steps":["trace[188630767] 'agreement among raft nodes before linearized reading' (duration: 736.606013ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:03:16.680205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"837.407687ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" ","response":"range_response_count:1 size:203"} {"level":"info","ts":"2026-02-25T15:03:16.680237Z","caller":"traceutil/trace.go:171","msg":"trace[943056496] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replicaset-controller; range_end:; response_count:1; response_revision:305; }","duration":"488.853639ms","start":"2026-02-25T15:03:16.191376Z","end":"2026-02-25T15:03:16.68023Z","steps":["trace[943056496] 'agreement among raft nodes before linearized reading' (duration: 488.804903ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:03:16.680263Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:03:16.191341Z","time spent":"488.917452ms","remote":"127.0.0.1:59460","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":230,"request content":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" "} {"level":"info","ts":"2026-02-25T15:03:16.680264Z","caller":"traceutil/trace.go:171","msg":"trace[521565867] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpoint-controller; range_end:; response_count:1; response_revision:305; }","duration":"837.484111ms","start":"2026-02-25T15:03:15.842768Z","end":"2026-02-25T15:03:16.680252Z","steps":["trace[521565867] 'agreement among raft nodes before linearized reading' (duration: 837.389689ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:03:16.680309Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:03:15.842758Z","time spent":"837.542845ms","remote":"127.0.0.1:59460","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":226,"request content":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" "} {"level":"info","ts":"2026-02-25T15:03:16.680124Z","caller":"traceutil/trace.go:171","msg":"trace[1472427007] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:1; response_revision:305; }","duration":"788.62313ms","start":"2026-02-25T15:03:15.891489Z","end":"2026-02-25T15:03:16.680113Z","steps":["trace[1472427007] 'agreement among raft nodes before linearized reading' (duration: 788.552186ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:03:16.680342Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"885.145243ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/bootstrap-token-k3z8vp\" ","response":"range_response_count:1 size:540"} {"level":"warn","ts":"2026-02-25T15:03:16.680352Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"688.446388ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" ","response":"range_response_count:1 size:218"} {"level":"warn","ts":"2026-02-25T15:03:16.680382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"514.910859ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/etcd-instance\" ","response":"range_response_count:1 size:5260"} {"level":"info","ts":"2026-02-25T15:03:16.680387Z","caller":"traceutil/trace.go:171","msg":"trace[1305070529] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/service-account-controller; range_end:; response_count:1; response_revision:305; }","duration":"688.52842ms","start":"2026-02-25T15:03:15.991849Z","end":"2026-02-25T15:03:16.680378Z","steps":["trace[1305070529] 'agreement among raft nodes before linearized reading' (duration: 688.480085ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:03:16.680387Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:03:15.891458Z","time spent":"788.916233ms","remote":"127.0.0.1:59460","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":230,"request content":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" "} {"level":"warn","ts":"2026-02-25T15:03:16.680419Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:03:15.991819Z","time spent":"688.591674ms","remote":"127.0.0.1:59460","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":1,"response size":241,"request content":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" "} {"level":"info","ts":"2026-02-25T15:03:16.680451Z","caller":"traceutil/trace.go:171","msg":"trace[1381142506] range","detail":"{range_begin:/registry/pods/kube-system/etcd-instance; range_end:; response_count:1; response_revision:305; }","duration":"514.99828ms","start":"2026-02-25T15:03:16.165405Z","end":"2026-02-25T15:03:16.680404Z","steps":["trace[1381142506] 'agreement among raft nodes before linearized reading' (duration: 514.948755ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:03:16.680427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"885.662625ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"range_response_count:1 size:4256"} {"level":"warn","ts":"2026-02-25T15:03:16.680475Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:03:16.165372Z","time spent":"515.097331ms","remote":"127.0.0.1:59452","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":1,"response size":5283,"request content":"key:\"/registry/pods/kube-system/etcd-instance\" "} {"level":"info","ts":"2026-02-25T15:03:16.680479Z","caller":"traceutil/trace.go:171","msg":"trace[408060492] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:305; }","duration":"885.761336ms","start":"2026-02-25T15:03:15.794711Z","end":"2026-02-25T15:03:16.680472Z","steps":["trace[408060492] 'agreement among raft nodes before linearized reading' (duration: 885.687443ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:03:16.680508Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:03:15.794686Z","time spent":"885.815181ms","remote":"127.0.0.1:59452","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":4279,"request content":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" "} {"level":"warn","ts":"2026-02-25T15:03:16.680526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"884.64774ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" ","response":"range_response_count:1 size:7228"} {"level":"info","ts":"2026-02-25T15:03:16.680563Z","caller":"traceutil/trace.go:171","msg":"trace[12666737] range","detail":"{range_begin:/registry/pods/kube-system/kube-apiserver-instance; range_end:; response_count:1; response_revision:305; }","duration":"884.709124ms","start":"2026-02-25T15:03:15.795844Z","end":"2026-02-25T15:03:16.680553Z","steps":["trace[12666737] 'agreement among raft nodes before linearized reading' (duration: 884.630822ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:03:16.680255Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:03:15.943367Z","time spent":"736.879358ms","remote":"127.0.0.1:59460","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":232,"request content":"key:\"/registry/serviceaccounts/kube-system/root-ca-cert-publisher\" "} {"level":"warn","ts":"2026-02-25T15:03:16.680603Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:03:15.795837Z","time spent":"884.75954ms","remote":"127.0.0.1:59452","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":7251,"request content":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" "} {"level":"warn","ts":"2026-02-25T15:03:16.68007Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"884.53103ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/etcd-instance\" ","response":"range_response_count:1 size:5260"} {"level":"info","ts":"2026-02-25T15:03:16.680662Z","caller":"traceutil/trace.go:171","msg":"trace[1376262586] range","detail":"{range_begin:/registry/pods/kube-system/etcd-instance; range_end:; response_count:1; response_revision:305; }","duration":"885.135705ms","start":"2026-02-25T15:03:15.795515Z","end":"2026-02-25T15:03:16.680651Z","steps":["trace[1376262586] 'agreement among raft nodes before linearized reading' (duration: 884.501752ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:03:16.680709Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:03:15.795508Z","time spent":"885.1902ms","remote":"127.0.0.1:59452","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":1,"response size":5283,"request content":"key:\"/registry/pods/kube-system/etcd-instance\" "} {"level":"warn","ts":"2026-02-25T15:03:16.680728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"885.146824ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-vip-instance\" ","response":"range_response_count:1 size:4593"} {"level":"info","ts":"2026-02-25T15:03:16.680806Z","caller":"traceutil/trace.go:171","msg":"trace[1178708814] range","detail":"{range_begin:/registry/pods/kube-system/kube-vip-instance; range_end:; response_count:1; response_revision:305; }","duration":"885.205909ms","start":"2026-02-25T15:03:15.795554Z","end":"2026-02-25T15:03:16.68076Z","steps":["trace[1178708814] 'agreement among raft nodes before linearized reading' (duration: 885.135745ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:03:16.680842Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:03:15.795542Z","time spent":"885.294191ms","remote":"127.0.0.1:59452","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":4616,"request content":"key:\"/registry/pods/kube-system/kube-vip-instance\" "} {"level":"warn","ts":"2026-02-25T15:03:16.680311Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"638.477659ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-02-25T15:03:16.680922Z","caller":"traceutil/trace.go:171","msg":"trace[652355026] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-controller; range_end:; response_count:1; response_revision:305; }","duration":"639.142788ms","start":"2026-02-25T15:03:16.041767Z","end":"2026-02-25T15:03:16.68091Z","steps":["trace[652355026] 'agreement among raft nodes before linearized reading' (duration: 638.512735ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:03:16.68088Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"537.789438ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" ","response":"range_response_count:1 size:234"} {"level":"info","ts":"2026-02-25T15:03:16.681026Z","caller":"traceutil/trace.go:171","msg":"trace[818149465] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller; range_end:; response_count:1; response_revision:305; }","duration":"538.028276ms","start":"2026-02-25T15:03:16.142974Z","end":"2026-02-25T15:03:16.681003Z","steps":["trace[818149465] 'agreement among raft nodes before linearized reading' (duration: 537.616264ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T15:03:16.68038Z","caller":"traceutil/trace.go:171","msg":"trace[529060579] range","detail":"{range_begin:/registry/secrets/kube-system/bootstrap-token-k3z8vp; range_end:; response_count:1; response_revision:305; }","duration":"885.204738ms","start":"2026-02-25T15:03:15.795166Z","end":"2026-02-25T15:03:16.680371Z","steps":["trace[529060579] 'agreement among raft nodes before linearized reading' (duration: 885.136324ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:03:16.681089Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:03:16.142937Z","time spent":"538.138316ms","remote":"127.0.0.1:59460","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":257,"request content":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" "} {"level":"warn","ts":"2026-02-25T15:03:16.681115Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:03:15.795157Z","time spent":"885.933561ms","remote":"127.0.0.1:59354","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":563,"request content":"key:\"/registry/secrets/kube-system/bootstrap-token-k3z8vp\" "} {"level":"warn","ts":"2026-02-25T15:03:16.680962Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:03:16.041737Z","time spent":"639.215921ms","remote":"127.0.0.1:59460","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":216,"request content":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" "} {"level":"info","ts":"2026-02-25T15:03:27.407044Z","caller":"traceutil/trace.go:171","msg":"trace[1400296976] transaction","detail":"{read_only:false; response_revision:417; number_of_response:1; }","duration":"250.365256ms","start":"2026-02-25T15:03:27.156658Z","end":"2026-02-25T15:03:27.407023Z","steps":["trace[1400296976] 'process raft request' (duration: 250.234835ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T15:03:32.708003Z","caller":"traceutil/trace.go:171","msg":"trace[1804172268] transaction","detail":"{read_only:false; response_revision:428; number_of_response:1; }","duration":"288.758555ms","start":"2026-02-25T15:03:32.419228Z","end":"2026-02-25T15:03:32.707987Z","steps":["trace[1804172268] 'process raft request' (duration: 288.651961ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:03:32.974491Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.396108ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-02-25T15:03:32.974543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.641657ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-02-25T15:03:32.974574Z","caller":"traceutil/trace.go:171","msg":"trace[1634858130] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:428; }","duration":"161.52523ms","start":"2026-02-25T15:03:32.813025Z","end":"2026-02-25T15:03:32.974551Z","steps":["trace[1634858130] 'range keys from in-memory index tree' (duration: 161.294003ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T15:03:32.974617Z","caller":"traceutil/trace.go:171","msg":"trace[770812756] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:428; }","duration":"157.736581ms","start":"2026-02-25T15:03:32.816861Z","end":"2026-02-25T15:03:32.974598Z","steps":["trace[770812756] 'range keys from in-memory index tree' (duration: 157.549043ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:03:32.974654Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.639567ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-02-25T15:03:32.97473Z","caller":"traceutil/trace.go:171","msg":"trace[1327444022] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:428; }","duration":"157.739111ms","start":"2026-02-25T15:03:32.816971Z","end":"2026-02-25T15:03:32.97471Z","steps":["trace[1327444022] 'range keys from in-memory index tree' (duration: 157.572641ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T15:03:35.388508Z","caller":"traceutil/trace.go:171","msg":"trace[813043917] linearizableReadLoop","detail":"{readStateIndex:446; appliedIndex:445; }","duration":"403.47696ms","start":"2026-02-25T15:03:34.984999Z","end":"2026-02-25T15:03:35.388476Z","steps":["trace[813043917] 'read index received' (duration: 396.725369ms)","trace[813043917] 'applied index is now lower than readState.Index' (duration: 6.749651ms)"],"step_count":2} {"level":"warn","ts":"2026-02-25T15:03:35.388777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"398.841408ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-02-25T15:03:35.388826Z","caller":"traceutil/trace.go:171","msg":"trace[1975425953] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:432; }","duration":"398.951772ms","start":"2026-02-25T15:03:34.989858Z","end":"2026-02-25T15:03:35.38881Z","steps":["trace[1975425953] 'agreement among raft nodes before linearized reading' (duration: 398.80466ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:03:35.38881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"403.769464ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-02-25T15:03:35.388838Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"398.911545ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-02-25T15:03:35.388871Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:03:34.989836Z","time spent":"399.024998ms","remote":"127.0.0.1:59534","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-02-25T15:03:35.388911Z","caller":"traceutil/trace.go:171","msg":"trace[46819739] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:432; }","duration":"403.956303ms","start":"2026-02-25T15:03:34.984929Z","end":"2026-02-25T15:03:35.388885Z","steps":["trace[46819739] 'agreement among raft nodes before linearized reading' (duration: 403.723366ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T15:03:35.388916Z","caller":"traceutil/trace.go:171","msg":"trace[1549615995] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:432; }","duration":"399.019078ms","start":"2026-02-25T15:03:34.989878Z","end":"2026-02-25T15:03:35.388897Z","steps":["trace[1549615995] 'agreement among raft nodes before linearized reading' (duration: 398.873616ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:03:35.388839Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.309272ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" ","response":"range_response_count:3 size:12669"} {"level":"warn","ts":"2026-02-25T15:03:35.388967Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:03:34.989866Z","time spent":"399.093094ms","remote":"127.0.0.1:59534","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-25T15:03:35.388969Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:03:34.984894Z","time spent":"404.064156ms","remote":"127.0.0.1:59534","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-02-25T15:03:35.389001Z","caller":"traceutil/trace.go:171","msg":"trace[507890392] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:3; response_revision:432; }","duration":"345.533099ms","start":"2026-02-25T15:03:35.04345Z","end":"2026-02-25T15:03:35.388983Z","steps":["trace[507890392] 'agreement among raft nodes before linearized reading' (duration: 345.255825ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:03:35.38904Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:03:35.043428Z","time spent":"345.600716ms","remote":"127.0.0.1:59354","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":3,"response size":12692,"request content":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" "} {"level":"info","ts":"2026-02-25T15:03:39.061003Z","caller":"traceutil/trace.go:171","msg":"trace[1359197089] transaction","detail":"{read_only:false; response_revision:477; number_of_response:1; }","duration":"517.006073ms","start":"2026-02-25T15:03:38.543931Z","end":"2026-02-25T15:03:39.060937Z","steps":["trace[1359197089] 'process raft request' (duration: 516.751106ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:03:39.061173Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:03:38.54391Z","time spent":"517.179665ms","remote":"127.0.0.1:59446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4212,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-25T15:03:45.676365Z","caller":"traceutil/trace.go:171","msg":"trace[345984028] linearizableReadLoop","detail":"{readStateIndex:533; appliedIndex:532; }","duration":"237.508749ms","start":"2026-02-25T15:03:45.438824Z","end":"2026-02-25T15:03:45.676332Z","steps":["trace[345984028] 'read index received' (duration: 237.191912ms)","trace[345984028] 'applied index is now lower than readState.Index' (duration: 315.617µs)"],"step_count":2} {"level":"info","ts":"2026-02-25T15:03:45.67647Z","caller":"traceutil/trace.go:171","msg":"trace[1341104000] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"397.46843ms","start":"2026-02-25T15:03:45.278976Z","end":"2026-02-25T15:03:45.676445Z","steps":["trace[1341104000] 'process raft request' (duration: 397.155833ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:03:45.676702Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.856924ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-02-25T15:03:45.676771Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.622347ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-02-25T15:03:45.676806Z","caller":"traceutil/trace.go:171","msg":"trace[1976653011] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:517; }","duration":"177.693815ms","start":"2026-02-25T15:03:45.499103Z","end":"2026-02-25T15:03:45.676797Z","steps":["trace[1976653011] 'agreement among raft nodes before linearized reading' (duration: 177.538551ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T15:03:45.676792Z","caller":"traceutil/trace.go:171","msg":"trace[884459705] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:517; }","duration":"237.993569ms","start":"2026-02-25T15:03:45.438777Z","end":"2026-02-25T15:03:45.676771Z","steps":["trace[884459705] 'agreement among raft nodes before linearized reading' (duration: 237.72286ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:03:45.676779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.48644ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-02-25T15:03:45.676868Z","caller":"traceutil/trace.go:171","msg":"trace[528751629] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:517; }","duration":"237.597295ms","start":"2026-02-25T15:03:45.439246Z","end":"2026-02-25T15:03:45.676844Z","steps":["trace[528751629] 'agreement among raft nodes before linearized reading' (duration: 237.346425ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:03:45.676919Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.299325ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-02-25T15:03:45.676982Z","caller":"traceutil/trace.go:171","msg":"trace[1198931412] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:517; }","duration":"232.391941ms","start":"2026-02-25T15:03:45.444571Z","end":"2026-02-25T15:03:45.676963Z","steps":["trace[1198931412] 'agreement among raft nodes before linearized reading' (duration: 232.16653ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:03:45.677198Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:03:45.278942Z","time spent":"397.595475ms","remote":"127.0.0.1:59452","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":16799,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-25T15:03:46.159265Z","caller":"traceutil/trace.go:171","msg":"trace[1597823229] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"477.140827ms","start":"2026-02-25T15:03:45.682082Z","end":"2026-02-25T15:03:46.159223Z","steps":["trace[1597823229] 'process raft request' (duration: 476.779302ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:03:46.159545Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:03:45.682052Z","time spent":"477.340539ms","remote":"127.0.0.1:59534","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-02-25T15:03:46.159513Z","caller":"traceutil/trace.go:171","msg":"trace[1387627949] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"476.907027ms","start":"2026-02-25T15:03:45.682565Z","end":"2026-02-25T15:03:46.159472Z","steps":["trace[1387627949] 'process raft request' (duration: 476.58675ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T15:03:46.159723Z","caller":"traceutil/trace.go:171","msg":"trace[431871589] linearizableReadLoop","detail":"{readStateIndex:537; appliedIndex:534; }","duration":"150.211989ms","start":"2026-02-25T15:03:46.009496Z","end":"2026-02-25T15:03:46.159708Z","steps":["trace[431871589] 'read index received' (duration: 149.280656ms)","trace[431871589] 'applied index is now lower than readState.Index' (duration: 875.855µs)"],"step_count":2} {"level":"info","ts":"2026-02-25T15:03:46.159783Z","caller":"traceutil/trace.go:171","msg":"trace[2061357913] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"476.965905ms","start":"2026-02-25T15:03:45.682784Z","end":"2026-02-25T15:03:46.15975Z","steps":["trace[2061357913] 'process raft request' (duration: 476.60555ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:03:46.159836Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.331803ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T15:03:46.159927Z","caller":"traceutil/trace.go:171","msg":"trace[2113399938] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:521; }","duration":"150.469698ms","start":"2026-02-25T15:03:46.009446Z","end":"2026-02-25T15:03:46.159916Z","steps":["trace[2113399938] 'agreement among raft nodes before linearized reading' (duration: 150.344763ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:03:46.15994Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:03:45.682758Z","time spent":"477.09939ms","remote":"127.0.0.1:59534","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-02-25T15:03:46.159878Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:03:45.682536Z","time spent":"477.187906ms","remote":"127.0.0.1:59534","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-25T15:03:48.480376Z","caller":"traceutil/trace.go:171","msg":"trace[446430173] linearizableReadLoop","detail":"{readStateIndex:538; appliedIndex:537; }","duration":"470.339718ms","start":"2026-02-25T15:03:48.010017Z","end":"2026-02-25T15:03:48.480357Z","steps":["trace[446430173] 'read index received' (duration: 470.245872ms)","trace[446430173] 'applied index is now lower than readState.Index' (duration: 93.086µs)"],"step_count":2} {"level":"info","ts":"2026-02-25T15:03:48.480412Z","caller":"traceutil/trace.go:171","msg":"trace[844754562] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"765.619982ms","start":"2026-02-25T15:03:47.714781Z","end":"2026-02-25T15:03:48.480401Z","steps":["trace[844754562] 'process raft request' (duration: 765.449408ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:03:48.480481Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"470.459864ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T15:03:48.480501Z","caller":"traceutil/trace.go:171","msg":"trace[1634582805] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:522; }","duration":"470.525651ms","start":"2026-02-25T15:03:48.00997Z","end":"2026-02-25T15:03:48.480496Z","steps":["trace[1634582805] 'agreement among raft nodes before linearized reading' (duration: 470.474193ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:03:48.480517Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:03:48.00995Z","time spent":"470.5635ms","remote":"127.0.0.1:59238","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-25T15:03:48.480552Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:03:47.714767Z","time spent":"765.720107ms","remote":"127.0.0.1:59534","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-02-25T15:03:48.818478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.764855ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-25T15:03:48.818591Z","caller":"traceutil/trace.go:171","msg":"trace[131990666] linearizableReadLoop","detail":"{readStateIndex:539; appliedIndex:538; }","duration":"338.123789ms","start":"2026-02-25T15:03:48.480451Z","end":"2026-02-25T15:03:48.818575Z","steps":["trace[131990666] 'read index received' (duration: 198.113562ms)","trace[131990666] 'applied index is now lower than readState.Index' (duration: 140.008957ms)"],"step_count":2} {"level":"info","ts":"2026-02-25T15:03:48.818599Z","caller":"traceutil/trace.go:171","msg":"trace[1366189887] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"349.464492ms","start":"2026-02-25T15:03:48.469118Z","end":"2026-02-25T15:03:48.818583Z","steps":["trace[1366189887] 'process raft request' (duration: 209.488145ms)","trace[1366189887] 'compare' (duration: 139.64021ms)"],"step_count":2} {"level":"warn","ts":"2026-02-25T15:03:48.818665Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:03:48.4691Z","time spent":"349.534929ms","remote":"127.0.0.1:59534","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-25T15:03:48.818766Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"654.058292ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-02-25T15:03:48.818804Z","caller":"traceutil/trace.go:171","msg":"trace[531622327] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:523; }","duration":"654.135199ms","start":"2026-02-25T15:03:48.16466Z","end":"2026-02-25T15:03:48.818795Z","steps":["trace[531622327] 'agreement among raft nodes before linearized reading' (duration: 654.003084ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:03:48.818841Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:03:48.16464Z","time spent":"654.193207ms","remote":"127.0.0.1:59534","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-02-25T15:03:48.818894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"654.169968ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-02-25T15:03:48.818942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"337.312259ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T15:03:48.818969Z","caller":"traceutil/trace.go:171","msg":"trace[1801473004] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:523; }","duration":"337.338108ms","start":"2026-02-25T15:03:48.481623Z","end":"2026-02-25T15:03:48.818961Z","steps":["trace[1801473004] 'agreement among raft nodes before linearized reading' (duration: 337.29793ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T15:03:48.818976Z","caller":"traceutil/trace.go:171","msg":"trace[925046213] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:523; }","duration":"654.305522ms","start":"2026-02-25T15:03:48.164654Z","end":"2026-02-25T15:03:48.818959Z","steps":["trace[925046213] 'agreement among raft nodes before linearized reading' (duration: 654.063091ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:03:48.819Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:03:48.481532Z","time spent":"337.461114ms","remote":"127.0.0.1:59236","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-25T15:03:48.819022Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:03:48.164629Z","time spent":"654.384219ms","remote":"127.0.0.1:59534","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-25T15:03:48.819239Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"654.727967ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-02-25T15:03:48.819325Z","caller":"traceutil/trace.go:171","msg":"trace[1089325512] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:523; }","duration":"654.856722ms","start":"2026-02-25T15:03:48.164451Z","end":"2026-02-25T15:03:48.819308Z","steps":["trace[1089325512] 'agreement among raft nodes before linearized reading' (duration: 654.242805ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:03:48.81937Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:03:48.164431Z","time spent":"654.930489ms","remote":"127.0.0.1:59534","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-25T15:03:50.756552Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.482914ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-02-25T15:03:50.75668Z","caller":"traceutil/trace.go:171","msg":"trace[554768171] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:535; }","duration":"271.644709ms","start":"2026-02-25T15:03:50.484996Z","end":"2026-02-25T15:03:50.756641Z","steps":["trace[554768171] 'range keys from in-memory index tree' (duration: 271.271202ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T15:05:17.517899Z","caller":"traceutil/trace.go:171","msg":"trace[899030876] linearizableReadLoop","detail":"{readStateIndex:991; appliedIndex:990; }","duration":"160.630926ms","start":"2026-02-25T15:05:17.357234Z","end":"2026-02-25T15:05:17.517865Z","steps":["trace[899030876] 'read index received' (duration: 160.38537ms)","trace[899030876] 'applied index is now lower than readState.Index' (duration: 244.556µs)"],"step_count":2} {"level":"info","ts":"2026-02-25T15:05:17.518456Z","caller":"traceutil/trace.go:171","msg":"trace[290325146] transaction","detail":"{read_only:false; response_revision:953; number_of_response:1; }","duration":"252.861882ms","start":"2026-02-25T15:05:17.265545Z","end":"2026-02-25T15:05:17.518407Z","steps":["trace[290325146] 'process raft request' (duration: 252.161405ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:05:17.518559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.293922ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-02-25T15:05:17.51871Z","caller":"traceutil/trace.go:171","msg":"trace[1715417517] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:953; }","duration":"161.477966ms","start":"2026-02-25T15:05:17.357166Z","end":"2026-02-25T15:05:17.518644Z","steps":["trace[1715417517] 'agreement among raft nodes before linearized reading' (duration: 161.146868ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T15:05:23.867905Z","caller":"traceutil/trace.go:171","msg":"trace[1759106196] transaction","detail":"{read_only:false; response_revision:976; number_of_response:1; }","duration":"309.975912ms","start":"2026-02-25T15:05:23.557878Z","end":"2026-02-25T15:05:23.867854Z","steps":["trace[1759106196] 'process raft request' (duration: 309.811098ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:05:23.86811Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:05:23.55786Z","time spent":"310.129525ms","remote":"127.0.0.1:59534","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-02-25T15:05:23.898335Z","caller":"traceutil/trace.go:171","msg":"trace[1169851105] transaction","detail":"{read_only:false; response_revision:977; number_of_response:1; }","duration":"339.962474ms","start":"2026-02-25T15:05:23.558338Z","end":"2026-02-25T15:05:23.898301Z","steps":["trace[1169851105] 'process raft request' (duration: 339.745028ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:05:23.898543Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:05:23.558327Z","time spent":"340.104587ms","remote":"127.0.0.1:59534","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-25T15:05:23.898679Z","caller":"traceutil/trace.go:171","msg":"trace[878387708] transaction","detail":"{read_only:false; response_revision:978; number_of_response:1; }","duration":"339.483041ms","start":"2026-02-25T15:05:23.559174Z","end":"2026-02-25T15:05:23.898657Z","steps":["trace[878387708] 'process raft request' (duration: 339.071161ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:05:23.898811Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:05:23.559163Z","time spent":"339.581223ms","remote":"127.0.0.1:59534","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-25T15:05:23.899206Z","caller":"traceutil/trace.go:171","msg":"trace[1179181912] linearizableReadLoop","detail":"{readStateIndex:1018; appliedIndex:1014; }","duration":"322.698424ms","start":"2026-02-25T15:05:23.576488Z","end":"2026-02-25T15:05:23.899186Z","steps":["trace[1179181912] 'read index received' (duration: 291.159341ms)","trace[1179181912] 'applied index is now lower than readState.Index' (duration: 31.537893ms)"],"step_count":2} {"level":"info","ts":"2026-02-25T15:05:23.899289Z","caller":"traceutil/trace.go:171","msg":"trace[864106817] transaction","detail":"{read_only:false; response_revision:979; number_of_response:1; }","duration":"338.6715ms","start":"2026-02-25T15:05:23.560573Z","end":"2026-02-25T15:05:23.899245Z","steps":["trace[864106817] 'process raft request' (duration: 337.973232ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:05:23.899476Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:05:23.560551Z","time spent":"338.823144ms","remote":"127.0.0.1:59534","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-02-25T15:05:23.899486Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"322.994141ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-02-25T15:05:23.899546Z","caller":"traceutil/trace.go:171","msg":"trace[1520996245] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:979; }","duration":"323.055453ms","start":"2026-02-25T15:05:23.576473Z","end":"2026-02-25T15:05:23.899529Z","steps":["trace[1520996245] 'agreement among raft nodes before linearized reading' (duration: 322.839297ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:05:23.899597Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:05:23.576426Z","time spent":"323.156775ms","remote":"127.0.0.1:59534","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}