{"level":"warn","ts":"2026-05-02T05:34:48.628284Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-02T05:34:48.628685Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.25:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.25:2380","--initial-cluster=instance=https://199.204.45.25:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.25:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.25:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-05-02T05:34:48.628798Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-02T05:34:48.628819Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.25:2380"]} {"level":"info","ts":"2026-05-02T05:34:48.628856Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-02T05:34:48.629771Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.25:2379"]} {"level":"info","ts":"2026-05-02T05:34:48.629927Z","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.204.45.25:2380"],"listen-peer-urls":["https://199.204.45.25:2380"],"advertise-client-urls":["https://199.204.45.25:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.25:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.25:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-05-02T05:34:48.635535Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.266868ms"} {"level":"info","ts":"2026-05-02T05:34:48.651438Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"ba52c55cf4193752","cluster-id":"4468ed52294bc271"} {"level":"info","ts":"2026-05-02T05:34:48.651541Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 switched to configuration voters=()"} {"level":"info","ts":"2026-05-02T05:34:48.651566Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 became follower at term 0"} {"level":"info","ts":"2026-05-02T05:34:48.651578Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft ba52c55cf4193752 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-02T05:34:48.65159Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 became follower at term 1"} {"level":"info","ts":"2026-05-02T05:34:48.651636Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 switched to configuration voters=(13426010442167826258)"} {"level":"warn","ts":"2026-05-02T05:34:48.65841Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-02T05:34:48.659953Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-02T05:34:48.661076Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-05-02T05:34:48.663551Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"ba52c55cf4193752","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-02T05:34:48.663742Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-02T05:34:48.666905Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"ba52c55cf4193752","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-02T05:34:48.667396Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-02T05:34:48.668052Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-02T05:34:48.668312Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 switched to configuration voters=(13426010442167826258)"} {"level":"info","ts":"2026-05-02T05:34:48.668628Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"4468ed52294bc271","local-member-id":"ba52c55cf4193752","added-peer-id":"ba52c55cf4193752","added-peer-peer-urls":["https://199.204.45.25:2380"]} {"level":"info","ts":"2026-05-02T05:34:48.676902Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-02T05:34:48.677064Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.25:2380"} {"level":"info","ts":"2026-05-02T05:34:48.677114Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.25:2380"} {"level":"info","ts":"2026-05-02T05:34:48.677533Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"ba52c55cf4193752","initial-advertise-peer-urls":["https://199.204.45.25:2380"],"listen-peer-urls":["https://199.204.45.25:2380"],"advertise-client-urls":["https://199.204.45.25:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.25:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-02T05:34:48.677599Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-02T05:34:49.452448Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 is starting a new election at term 1"} {"level":"info","ts":"2026-05-02T05:34:49.452538Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-02T05:34:49.452593Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 received MsgPreVoteResp from ba52c55cf4193752 at term 1"} {"level":"info","ts":"2026-05-02T05:34:49.452616Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 became candidate at term 2"} {"level":"info","ts":"2026-05-02T05:34:49.452628Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 received MsgVoteResp from ba52c55cf4193752 at term 2"} {"level":"info","ts":"2026-05-02T05:34:49.452652Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 became leader at term 2"} {"level":"info","ts":"2026-05-02T05:34:49.452669Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: ba52c55cf4193752 elected leader ba52c55cf4193752 at term 2"} {"level":"info","ts":"2026-05-02T05:34:49.453792Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-02T05:34:49.458736Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-02T05:34:49.458742Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"ba52c55cf4193752","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.25:2379]}","request-path":"/0/members/ba52c55cf4193752/attributes","cluster-id":"4468ed52294bc271","publish-timeout":"7s"} {"level":"info","ts":"2026-05-02T05:34:49.458768Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-02T05:34:49.459027Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"4468ed52294bc271","local-member-id":"ba52c55cf4193752","cluster-version":"3.5"} {"level":"info","ts":"2026-05-02T05:34:49.45914Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-02T05:34:49.459182Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-02T05:34:49.459254Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-02T05:34:49.459276Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-02T05:34:49.464245Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.25:2379"} {"level":"info","ts":"2026-05-02T05:34:49.465958Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-02T05:34:51.82384Z","caller":"traceutil/trace.go:171","msg":"trace[344547050] linearizableReadLoop","detail":"{readStateIndex:76; appliedIndex:75; }","duration":"105.664532ms","start":"2026-05-02T05:34:51.718148Z","end":"2026-05-02T05:34:51.823812Z","steps":["trace[344547050] 'read index received' (duration: 105.429279ms)","trace[344547050] 'applied index is now lower than readState.Index' (duration: 233.923µs)"],"step_count":2} {"level":"info","ts":"2026-05-02T05:34:51.823996Z","caller":"traceutil/trace.go:171","msg":"trace[312765644] transaction","detail":"{read_only:false; response_revision:72; number_of_response:1; }","duration":"106.463301ms","start":"2026-05-02T05:34:51.717501Z","end":"2026-05-02T05:34:51.823964Z","steps":["trace[312765644] 'process raft request' (duration: 106.115977ms)"],"step_count":1} {"level":"warn","ts":"2026-05-02T05:34:51.82414Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.945655ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:aggregate-to-admin\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-02T05:34:51.824215Z","caller":"traceutil/trace.go:171","msg":"trace[717298217] range","detail":"{range_begin:/registry/clusterroles/system:aggregate-to-admin; range_end:; response_count:0; response_revision:72; }","duration":"106.110757ms","start":"2026-05-02T05:34:51.718087Z","end":"2026-05-02T05:34:51.824198Z","steps":["trace[717298217] 'agreement among raft nodes before linearized reading' (duration: 105.928335ms)"],"step_count":1} {"level":"info","ts":"2026-05-02T05:34:51.952191Z","caller":"traceutil/trace.go:171","msg":"trace[949237328] linearizableReadLoop","detail":"{readStateIndex:77; appliedIndex:76; }","duration":"120.346333ms","start":"2026-05-02T05:34:51.831805Z","end":"2026-05-02T05:34:51.952152Z","steps":["trace[949237328] 'read index received' (duration: 78.83398ms)","trace[949237328] 'applied index is now lower than readState.Index' (duration: 41.511123ms)"],"step_count":2} {"level":"info","ts":"2026-05-02T05:34:51.952276Z","caller":"traceutil/trace.go:171","msg":"trace[1422389543] transaction","detail":"{read_only:false; response_revision:73; number_of_response:1; }","duration":"122.332455ms","start":"2026-05-02T05:34:51.829894Z","end":"2026-05-02T05:34:51.952226Z","steps":["trace[1422389543] 'process raft request' (duration: 80.826302ms)","trace[1422389543] 'compare' (duration: 41.2608ms)"],"step_count":2} {"level":"warn","ts":"2026-05-02T05:34:51.952404Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.565285ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:aggregate-to-view\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-02T05:34:51.952453Z","caller":"traceutil/trace.go:171","msg":"trace[1054873011] range","detail":"{range_begin:/registry/clusterroles/system:aggregate-to-view; range_end:; response_count:0; response_revision:73; }","duration":"120.657526ms","start":"2026-05-02T05:34:51.831785Z","end":"2026-05-02T05:34:51.952442Z","steps":["trace[1054873011] 'agreement among raft nodes before linearized reading' (duration: 120.501834ms)"],"step_count":1} {"level":"warn","ts":"2026-05-02T05:34:52.356294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.564791ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-05-02T05:34:52.356613Z","caller":"traceutil/trace.go:171","msg":"trace[1049975478] transaction","detail":"{read_only:false; response_revision:81; number_of_response:1; }","duration":"183.587074ms","start":"2026-05-02T05:34:52.172849Z","end":"2026-05-02T05:34:52.356436Z","steps":["trace[1049975478] 'process raft request' (duration: 25.84158ms)","trace[1049975478] 'compare' (duration: 156.396399ms)"],"step_count":2} {"level":"warn","ts":"2026-05-02T05:34:52.604892Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.885218ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-05-02T05:34:52.605047Z","caller":"traceutil/trace.go:171","msg":"trace[933998973] transaction","detail":"{read_only:false; response_revision:83; number_of_response:1; }","duration":"196.721477ms","start":"2026-05-02T05:34:52.408295Z","end":"2026-05-02T05:34:52.605017Z","steps":["trace[933998973] 'process raft request' (duration: 81.612596ms)","trace[933998973] 'compare' (duration: 114.683096ms)"],"step_count":2} {"level":"info","ts":"2026-05-02T05:34:52.611994Z","caller":"traceutil/trace.go:171","msg":"trace[2018184816] transaction","detail":"{read_only:false; response_revision:84; number_of_response:1; }","duration":"145.411019ms","start":"2026-05-02T05:34:52.466569Z","end":"2026-05-02T05:34:52.61198Z","steps":["trace[2018184816] 'process raft request' (duration: 145.145377ms)"],"step_count":1} {"level":"info","ts":"2026-05-02T05:34:52.832042Z","caller":"traceutil/trace.go:171","msg":"trace[291873679] transaction","detail":"{read_only:false; response_revision:87; number_of_response:1; }","duration":"140.356274ms","start":"2026-05-02T05:34:52.691656Z","end":"2026-05-02T05:34:52.832012Z","steps":["trace[291873679] 'process raft request' (duration: 129.841489ms)"],"step_count":1} {"level":"warn","ts":"2026-05-02T05:34:53.308837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"374.540255ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-05-02T05:34:53.309176Z","caller":"traceutil/trace.go:171","msg":"trace[1598918078] transaction","detail":"{read_only:false; response_revision:90; number_of_response:1; }","duration":"424.562199ms","start":"2026-05-02T05:34:52.884536Z","end":"2026-05-02T05:34:53.309098Z","steps":["trace[1598918078] 'process raft request' (duration: 49.618689ms)","trace[1598918078] 'compare' (duration: 374.275282ms)"],"step_count":2} {"level":"warn","ts":"2026-05-02T05:34:53.309308Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-02T05:34:52.884523Z","time spent":"424.73782ms","remote":"127.0.0.1:38218","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":620,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-02T05:34:53.309475Z","caller":"traceutil/trace.go:171","msg":"trace[823916381] transaction","detail":"{read_only:false; response_revision:91; number_of_response:1; }","duration":"282.151303ms","start":"2026-05-02T05:34:53.027301Z","end":"2026-05-02T05:34:53.309453Z","steps":["trace[823916381] 'process raft request' (duration: 281.909741ms)"],"step_count":1} {"level":"info","ts":"2026-05-02T05:34:53.509871Z","caller":"traceutil/trace.go:171","msg":"trace[403270963] transaction","detail":"{read_only:false; response_revision:93; number_of_response:1; }","duration":"133.489875ms","start":"2026-05-02T05:34:53.376359Z","end":"2026-05-02T05:34:53.509849Z","steps":["trace[403270963] 'process raft request' (duration: 133.440494ms)"],"step_count":1} {"level":"info","ts":"2026-05-02T05:34:53.509942Z","caller":"traceutil/trace.go:171","msg":"trace[1262649805] transaction","detail":"{read_only:false; response_revision:92; number_of_response:1; }","duration":"135.596757ms","start":"2026-05-02T05:34:53.374296Z","end":"2026-05-02T05:34:53.509892Z","steps":["trace[1262649805] 'process raft request' (duration: 56.261908ms)","trace[1262649805] 'compare' (duration: 79.077576ms)"],"step_count":2} {"level":"warn","ts":"2026-05-02T05:34:56.313174Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.431388ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-05-02T05:34:56.313306Z","caller":"traceutil/trace.go:171","msg":"trace[1411541704] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:284; }","duration":"120.631471ms","start":"2026-05-02T05:34:56.19265Z","end":"2026-05-02T05:34:56.313282Z","steps":["trace[1411541704] 'range keys from in-memory index tree' (duration: 120.279446ms)"],"step_count":1} {"level":"warn","ts":"2026-05-02T05:34:56.313303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.168915ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-05-02T05:34:56.313361Z","caller":"traceutil/trace.go:171","msg":"trace[1861901364] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:284; }","duration":"105.262436ms","start":"2026-05-02T05:34:56.208084Z","end":"2026-05-02T05:34:56.313346Z","steps":["trace[1861901364] 'range keys from in-memory index tree' (duration: 105.096124ms)"],"step_count":1} {"level":"warn","ts":"2026-05-02T05:34:56.313562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.863373ms","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-05-02T05:34:56.313584Z","caller":"traceutil/trace.go:171","msg":"trace[1905542602] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/bootstrap-signer; range_end:; response_count:0; response_revision:284; }","duration":"120.927904ms","start":"2026-05-02T05:34:56.19265Z","end":"2026-05-02T05:34:56.313578Z","steps":["trace[1905542602] 'range keys from in-memory index tree' (duration: 120.757362ms)"],"step_count":1} {"level":"warn","ts":"2026-05-02T05:35:00.50441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.424913ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-02T05:35:00.504679Z","caller":"traceutil/trace.go:171","msg":"trace[244930326] linearizableReadLoop","detail":"{readStateIndex:375; appliedIndex:373; }","duration":"262.523361ms","start":"2026-05-02T05:35:00.242135Z","end":"2026-05-02T05:35:00.504659Z","steps":["trace[244930326] 'read index received' (duration: 102.775795ms)","trace[244930326] 'applied index is now lower than readState.Index' (duration: 159.746286ms)"],"step_count":2} {"level":"info","ts":"2026-05-02T05:35:00.504784Z","caller":"traceutil/trace.go:171","msg":"trace[547055143] transaction","detail":"{read_only:false; response_revision:358; number_of_response:1; }","duration":"302.430153ms","start":"2026-05-02T05:35:00.202342Z","end":"2026-05-02T05:35:00.504772Z","steps":["trace[547055143] 'process raft request' (duration: 142.554545ms)","trace[547055143] 'compare' (duration: 159.111369ms)"],"step_count":2} {"level":"warn","ts":"2026-05-02T05:35:00.504838Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-02T05:35:00.202325Z","time spent":"302.487213ms","remote":"127.0.0.1:38078","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3378,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-02T05:35:00.505116Z","caller":"traceutil/trace.go:171","msg":"trace[246107789] transaction","detail":"{read_only:false; response_revision:359; number_of_response:1; }","duration":"302.042078ms","start":"2026-05-02T05:35:00.203061Z","end":"2026-05-02T05:35:00.505103Z","steps":["trace[246107789] 'process raft request' (duration: 301.513292ms)"],"step_count":1} {"level":"warn","ts":"2026-05-02T05:35:00.505171Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-02T05:35:00.203035Z","time spent":"302.111739ms","remote":"127.0.0.1:38088","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":156,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-02T05:35:00.505437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.41027ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-05-02T05:35:00.505477Z","caller":"traceutil/trace.go:171","msg":"trace[1152828939] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:359; }","duration":"155.474222ms","start":"2026-05-02T05:35:00.349991Z","end":"2026-05-02T05:35:00.505465Z","steps":["trace[1152828939] 'agreement among raft nodes before linearized reading' (duration: 155.354891ms)"],"step_count":1} {"level":"warn","ts":"2026-05-02T05:35:00.505533Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.557484ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" ","response":"range_response_count:1 size:214"} {"level":"warn","ts":"2026-05-02T05:35:00.505686Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.22921ms","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-05-02T05:35:00.505717Z","caller":"traceutil/trace.go:171","msg":"trace[1228546028] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslice-controller; range_end:; response_count:1; response_revision:359; }","duration":"213.806757ms","start":"2026-05-02T05:35:00.291876Z","end":"2026-05-02T05:35:00.505683Z","steps":["trace[1228546028] 'agreement among raft nodes before linearized reading' (duration: 213.491334ms)"],"step_count":1} {"level":"warn","ts":"2026-05-02T05:35:00.505742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.769619ms","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-05-02T05:35:00.505802Z","caller":"traceutil/trace.go:171","msg":"trace[2144323032] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpoint-controller; range_end:; response_count:1; response_revision:359; }","duration":"163.86238ms","start":"2026-05-02T05:35:00.341929Z","end":"2026-05-02T05:35:00.505792Z","steps":["trace[2144323032] 'agreement among raft nodes before linearized reading' (duration: 163.772949ms)"],"step_count":1} {"level":"info","ts":"2026-05-02T05:35:00.505826Z","caller":"traceutil/trace.go:171","msg":"trace[1154797788] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:359; }","duration":"156.409231ms","start":"2026-05-02T05:35:00.34938Z","end":"2026-05-02T05:35:00.505789Z","steps":["trace[1154797788] 'agreement among raft nodes before linearized reading' (duration: 156.146209ms)"],"step_count":1} {"level":"warn","ts":"2026-05-02T05:35:00.506446Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.144988ms","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-05-02T05:35:00.506608Z","caller":"traceutil/trace.go:171","msg":"trace[334727543] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/certificate-controller; range_end:; response_count:1; response_revision:359; }","duration":"264.448852ms","start":"2026-05-02T05:35:00.242056Z","end":"2026-05-02T05:35:00.506504Z","steps":["trace[334727543] 'agreement among raft nodes before linearized reading' (duration: 263.172938ms)"],"step_count":1} {"level":"warn","ts":"2026-05-02T05:35:00.506948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.346587ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-05-02T05:35:00.510034Z","caller":"traceutil/trace.go:171","msg":"trace[557487143] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/deployment-controller; range_end:; response_count:1; response_revision:359; }","duration":"117.46574ms","start":"2026-05-02T05:35:00.392541Z","end":"2026-05-02T05:35:00.510006Z","steps":["trace[557487143] 'agreement among raft nodes before linearized reading' (duration: 112.813191ms)"],"step_count":1} {"level":"info","ts":"2026-05-02T05:35:00.672903Z","caller":"traceutil/trace.go:171","msg":"trace[652734955] transaction","detail":"{read_only:false; response_revision:371; number_of_response:1; }","duration":"101.198888ms","start":"2026-05-02T05:35:00.571645Z","end":"2026-05-02T05:35:00.672844Z","steps":["trace[652734955] 'process raft request' (duration: 78.150395ms)","trace[652734955] 'compare' (duration: 22.82596ms)"],"step_count":2} {"level":"info","ts":"2026-05-02T05:35:00.672978Z","caller":"traceutil/trace.go:171","msg":"trace[1173459775] transaction","detail":"{read_only:false; response_revision:372; number_of_response:1; }","duration":"101.305529ms","start":"2026-05-02T05:35:00.571644Z","end":"2026-05-02T05:35:00.67295Z","steps":["trace[1173459775] 'process raft request' (duration: 101.128807ms)"],"step_count":1} {"level":"info","ts":"2026-05-02T05:35:00.673346Z","caller":"traceutil/trace.go:171","msg":"trace[1056246225] transaction","detail":"{read_only:false; response_revision:373; number_of_response:1; }","duration":"100.347129ms","start":"2026-05-02T05:35:00.57298Z","end":"2026-05-02T05:35:00.673327Z","steps":["trace[1056246225] 'process raft request' (duration: 99.837453ms)"],"step_count":1} {"level":"warn","ts":"2026-05-02T05:35:00.959409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.779466ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-02T05:35:00.960706Z","caller":"traceutil/trace.go:171","msg":"trace[743027219] transaction","detail":"{read_only:false; response_revision:379; number_of_response:1; }","duration":"207.961426ms","start":"2026-05-02T05:35:00.75231Z","end":"2026-05-02T05:35:00.960272Z","steps":["trace[743027219] 'process raft request' (duration: 46.450891ms)","trace[743027219] 'compare' (duration: 159.434063ms)"],"step_count":2} {"level":"info","ts":"2026-05-02T05:35:00.961113Z","caller":"traceutil/trace.go:171","msg":"trace[1954388789] transaction","detail":"{read_only:false; response_revision:380; number_of_response:1; }","duration":"208.501631ms","start":"2026-05-02T05:35:00.752528Z","end":"2026-05-02T05:35:00.961029Z","steps":["trace[1954388789] 'process raft request' (duration: 207.666672ms)"],"step_count":1} {"level":"info","ts":"2026-05-02T05:35:00.962075Z","caller":"traceutil/trace.go:171","msg":"trace[136409923] transaction","detail":"{read_only:false; response_revision:381; number_of_response:1; }","duration":"208.090376ms","start":"2026-05-02T05:35:00.753931Z","end":"2026-05-02T05:35:00.962022Z","steps":["trace[136409923] 'process raft request' (duration: 206.871553ms)"],"step_count":1} {"level":"info","ts":"2026-05-02T05:35:00.962726Z","caller":"traceutil/trace.go:171","msg":"trace[838135980] transaction","detail":"{read_only:false; response_revision:382; number_of_response:1; }","duration":"205.278427ms","start":"2026-05-02T05:35:00.757418Z","end":"2026-05-02T05:35:00.962696Z","steps":["trace[838135980] 'process raft request' (duration: 203.984493ms)"],"step_count":1} {"level":"info","ts":"2026-05-02T05:35:00.962723Z","caller":"traceutil/trace.go:171","msg":"trace[1094393381] transaction","detail":"{read_only:false; response_revision:383; number_of_response:1; }","duration":"204.910173ms","start":"2026-05-02T05:35:00.757786Z","end":"2026-05-02T05:35:00.962697Z","steps":["trace[1094393381] 'process raft request' (duration: 204.784922ms)"],"step_count":1} {"level":"warn","ts":"2026-05-02T05:35:01.187551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.352406ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-02T05:35:01.18776Z","caller":"traceutil/trace.go:171","msg":"trace[1833077532] transaction","detail":"{read_only:false; response_revision:389; number_of_response:1; }","duration":"161.800733ms","start":"2026-05-02T05:35:01.025942Z","end":"2026-05-02T05:35:01.187743Z","steps":["trace[1833077532] 'process raft request' (duration: 60.984072ms)","trace[1833077532] 'compare' (duration: 100.197624ms)"],"step_count":2} {"level":"info","ts":"2026-05-02T05:35:01.513811Z","caller":"traceutil/trace.go:171","msg":"trace[1196261976] transaction","detail":"{read_only:false; response_revision:390; number_of_response:1; }","duration":"316.642962ms","start":"2026-05-02T05:35:01.197128Z","end":"2026-05-02T05:35:01.513771Z","steps":["trace[1196261976] 'process raft request' (duration: 291.174594ms)","trace[1196261976] 'compare' (duration: 25.310217ms)"],"step_count":2} {"level":"warn","ts":"2026-05-02T05:35:01.514047Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-02T05:35:01.197095Z","time spent":"316.842734ms","remote":"127.0.0.1:38316","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4041,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-02T05:35:01.806583Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.126691ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-05-02T05:35:01.806696Z","caller":"traceutil/trace.go:171","msg":"trace[282848229] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:391; }","duration":"135.334044ms","start":"2026-05-02T05:35:01.671335Z","end":"2026-05-02T05:35:01.806669Z","steps":["trace[282848229] 'range keys from in-memory index tree' (duration: 135.006371ms)"],"step_count":1} {"level":"warn","ts":"2026-05-02T05:35:01.806682Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.435223ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-02T05:35:01.806791Z","caller":"traceutil/trace.go:171","msg":"trace[1736539241] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:391; }","duration":"189.571154ms","start":"2026-05-02T05:35:01.617193Z","end":"2026-05-02T05:35:01.806765Z","steps":["trace[1736539241] 'range keys from in-memory index tree' (duration: 189.274561ms)"],"step_count":1} {"level":"warn","ts":"2026-05-02T05:35:03.022239Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3986422236422295166,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-02T05:35:03.152679Z","caller":"traceutil/trace.go:171","msg":"trace[92596982] linearizableReadLoop","detail":"{readStateIndex:415; appliedIndex:414; }","duration":"631.277357ms","start":"2026-05-02T05:35:02.521371Z","end":"2026-05-02T05:35:03.152648Z","steps":["trace[92596982] 'read index received' (duration: 630.916364ms)","trace[92596982] 'applied index is now lower than readState.Index' (duration: 359.333µs)"],"step_count":2} {"level":"info","ts":"2026-05-02T05:35:03.152873Z","caller":"traceutil/trace.go:171","msg":"trace[818304557] transaction","detail":"{read_only:false; response_revision:398; number_of_response:1; }","duration":"777.703924ms","start":"2026-05-02T05:35:02.375153Z","end":"2026-05-02T05:35:03.152857Z","steps":["trace[818304557] 'process raft request' (duration: 777.139098ms)"],"step_count":1} {"level":"warn","ts":"2026-05-02T05:35:03.153042Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-02T05:35:02.375124Z","time spent":"777.793214ms","remote":"127.0.0.1:38078","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-02T05:35:03.153257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"631.902434ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-05-02T05:35:03.1533Z","caller":"traceutil/trace.go:171","msg":"trace[54809990] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:398; }","duration":"631.999425ms","start":"2026-05-02T05:35:02.52129Z","end":"2026-05-02T05:35:03.15329Z","steps":["trace[54809990] 'agreement among raft nodes before linearized reading' (duration: 631.913184ms)"],"step_count":1} {"level":"warn","ts":"2026-05-02T05:35:03.15333Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-02T05:35:02.521261Z","time spent":"632.062446ms","remote":"127.0.0.1:38130","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-02T05:35:03.153667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"581.436445ms","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-05-02T05:35:03.153782Z","caller":"traceutil/trace.go:171","msg":"trace[184717663] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:398; }","duration":"581.599806ms","start":"2026-05-02T05:35:02.57216Z","end":"2026-05-02T05:35:03.153759Z","steps":["trace[184717663] 'agreement among raft nodes before linearized reading' (duration: 581.145641ms)"],"step_count":1} {"level":"warn","ts":"2026-05-02T05:35:03.154024Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-02T05:35:02.572145Z","time spent":"581.840419ms","remote":"127.0.0.1:38130","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-02T05:35:04.255725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"474.126832ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-02T05:35:04.255855Z","caller":"traceutil/trace.go:171","msg":"trace[682546588] transaction","detail":"{read_only:false; response_revision:399; number_of_response:1; }","duration":"1.097187158s","start":"2026-05-02T05:35:03.158649Z","end":"2026-05-02T05:35:04.255836Z","steps":["trace[682546588] 'process raft request' (duration: 622.856704ms)","trace[682546588] 'compare' (duration: 473.97992ms)"],"step_count":2} {"level":"warn","ts":"2026-05-02T05:35:04.255914Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-02T05:35:03.158638Z","time spent":"1.097248738s","remote":"127.0.0.1:38130","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-02T05:35:04.898423Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.116908845s","expected-duration":"1s"} {"level":"info","ts":"2026-05-02T05:35:04.918084Z","caller":"traceutil/trace.go:171","msg":"trace[1255885631] transaction","detail":"{read_only:false; response_revision:400; number_of_response:1; }","duration":"1.758124931s","start":"2026-05-02T05:35:03.159913Z","end":"2026-05-02T05:35:04.918038Z","steps":["trace[1255885631] 'process raft request' (duration: 1.738774469s)","trace[1255885631] 'compare' (duration: 18.684775ms)"],"step_count":2} {"level":"warn","ts":"2026-05-02T05:35:04.918264Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-02T05:35:03.159899Z","time spent":"1.758254752s","remote":"127.0.0.1:38130","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-02T05:35:04.918718Z","caller":"traceutil/trace.go:171","msg":"trace[828936365] transaction","detail":"{read_only:false; response_revision:401; number_of_response:1; }","duration":"1.756331162s","start":"2026-05-02T05:35:03.162347Z","end":"2026-05-02T05:35:04.918678Z","steps":["trace[828936365] 'process raft request' (duration: 1.755654904s)"],"step_count":1} {"level":"warn","ts":"2026-05-02T05:35:04.918945Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-02T05:35:03.162338Z","time spent":"1.756465413s","remote":"127.0.0.1:38334","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2903,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-02T05:35:04.919241Z","caller":"traceutil/trace.go:171","msg":"trace[999718465] transaction","detail":"{read_only:false; response_revision:402; number_of_response:1; }","duration":"1.754838716s","start":"2026-05-02T05:35:03.164353Z","end":"2026-05-02T05:35:04.919192Z","steps":["trace[999718465] 'process raft request' (duration: 1.75430226s)"],"step_count":1} {"level":"info","ts":"2026-05-02T05:35:04.919311Z","caller":"traceutil/trace.go:171","msg":"trace[586718732] linearizableReadLoop","detail":"{readStateIndex:419; appliedIndex:415; }","duration":"1.610910781s","start":"2026-05-02T05:35:03.308256Z","end":"2026-05-02T05:35:04.919167Z","steps":["trace[586718732] 'read index received' (duration: 473.255479ms)","trace[586718732] 'applied index is now lower than readState.Index' (duration: 1.137653702s)"],"step_count":2} {"level":"warn","ts":"2026-05-02T05:35:04.919473Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.611224634s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-02T05:35:04.919476Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-02T05:35:03.164343Z","time spent":"1.755011588s","remote":"127.0.0.1:38078","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7087,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-02T05:35:04.920478Z","caller":"traceutil/trace.go:171","msg":"trace[683767976] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:402; }","duration":"1.612270935s","start":"2026-05-02T05:35:03.308188Z","end":"2026-05-02T05:35:04.920459Z","steps":["trace[683767976] 'agreement among raft nodes before linearized reading' (duration: 1.611237244s)"],"step_count":1} {"level":"warn","ts":"2026-05-02T05:35:04.920673Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-02T05:35:03.308154Z","time spent":"1.612504507s","remote":"127.0.0.1:37888","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-05-02T05:35:04.923254Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.101543834s","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-05-02T05:35:04.923263Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"397.153672ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.25\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-05-02T05:35:04.923304Z","caller":"traceutil/trace.go:171","msg":"trace[1577282842] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:402; }","duration":"1.101667395s","start":"2026-05-02T05:35:03.821624Z","end":"2026-05-02T05:35:04.923291Z","steps":["trace[1577282842] 'agreement among raft nodes before linearized reading' (duration: 1.101580105s)"],"step_count":1} {"level":"warn","ts":"2026-05-02T05:35:04.923328Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-02T05:35:03.821607Z","time spent":"1.101716146s","remote":"127.0.0.1:38130","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-05-02T05:35:04.923327Z","caller":"traceutil/trace.go:171","msg":"trace[364764197] range","detail":"{range_begin:/registry/masterleases/199.204.45.25; range_end:; response_count:1; response_revision:402; }","duration":"397.268443ms","start":"2026-05-02T05:35:04.52604Z","end":"2026-05-02T05:35:04.923308Z","steps":["trace[364764197] 'agreement among raft nodes before linearized reading' (duration: 397.135301ms)"],"step_count":1} {"level":"warn","ts":"2026-05-02T05:35:04.92337Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-02T05:35:04.526018Z","time spent":"397.343944ms","remote":"127.0.0.1:37912","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/199.204.45.25\" "} {"level":"warn","ts":"2026-05-02T05:35:04.923185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.719629ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-02T05:35:04.92346Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.10602663s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-05-02T05:35:04.923734Z","caller":"traceutil/trace.go:171","msg":"trace[1316900837] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:402; }","duration":"214.200074ms","start":"2026-05-02T05:35:04.709413Z","end":"2026-05-02T05:35:04.923613Z","steps":["trace[1316900837] 'agreement among raft nodes before linearized reading' (duration: 213.726229ms)"],"step_count":1} {"level":"info","ts":"2026-05-02T05:35:04.92412Z","caller":"traceutil/trace.go:171","msg":"trace[1425552031] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:402; }","duration":"1.106662138s","start":"2026-05-02T05:35:03.817313Z","end":"2026-05-02T05:35:04.923975Z","steps":["trace[1425552031] 'agreement among raft nodes before linearized reading' (duration: 1.105846539s)"],"step_count":1} {"level":"warn","ts":"2026-05-02T05:35:04.924855Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-02T05:35:03.817286Z","time spent":"1.107378115s","remote":"127.0.0.1:38130","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":"info","ts":"2026-05-02T05:35:05.950439Z","caller":"traceutil/trace.go:171","msg":"trace[1643115056] transaction","detail":"{read_only:false; response_revision:410; number_of_response:1; }","duration":"126.535686ms","start":"2026-05-02T05:35:05.823878Z","end":"2026-05-02T05:35:05.950414Z","steps":["trace[1643115056] 'process raft request' (duration: 126.391215ms)"],"step_count":1} {"level":"warn","ts":"2026-05-02T05:35:06.509297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.002956ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-vip-instance\" ","response":"range_response_count:1 size:4791"} {"level":"info","ts":"2026-05-02T05:35:06.509421Z","caller":"traceutil/trace.go:171","msg":"trace[866644401] range","detail":"{range_begin:/registry/pods/kube-system/kube-vip-instance; range_end:; response_count:1; response_revision:411; }","duration":"177.125817ms","start":"2026-05-02T05:35:06.332244Z","end":"2026-05-02T05:35:06.50937Z","steps":["trace[866644401] 'range keys from in-memory index tree' (duration: 176.848954ms)"],"step_count":1} {"level":"info","ts":"2026-05-02T05:35:06.524914Z","caller":"traceutil/trace.go:171","msg":"trace[182509152] transaction","detail":"{read_only:false; response_revision:412; number_of_response:1; }","duration":"128.746325ms","start":"2026-05-02T05:35:06.396138Z","end":"2026-05-02T05:35:06.524884Z","steps":["trace[182509152] 'process raft request' (duration: 128.624074ms)"],"step_count":1} {"level":"info","ts":"2026-05-02T05:35:26.42303Z","caller":"traceutil/trace.go:171","msg":"trace[1192803321] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"105.473976ms","start":"2026-05-02T05:35:26.317532Z","end":"2026-05-02T05:35:26.423006Z","steps":["trace[1192803321] 'process raft request' (duration: 104.856686ms)"],"step_count":1} {"level":"warn","ts":"2026-05-02T05:35:26.964892Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3986422236422295429,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-02T05:35:27.590599Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"553.927405ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-02T05:35:27.590855Z","caller":"traceutil/trace.go:171","msg":"trace[1350146858] transaction","detail":"{read_only:false; number_of_response:1; response_revision:535; }","duration":"1.187606821s","start":"2026-05-02T05:35:26.403232Z","end":"2026-05-02T05:35:27.590839Z","steps":["trace[1350146858] 'process raft request' (duration: 1.18756405s)"],"step_count":1} {"level":"warn","ts":"2026-05-02T05:35:27.590936Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-02T05:35:26.403224Z","time spent":"1.187662003s","remote":"127.0.0.1:37942","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":102,"response count":0,"response size":6937,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-02T05:35:27.591233Z","caller":"traceutil/trace.go:171","msg":"trace[885573746] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"1.188095737s","start":"2026-05-02T05:35:26.403089Z","end":"2026-05-02T05:35:27.591185Z","steps":["trace[885573746] 'process raft request' (duration: 1.187655753s)"],"step_count":1} {"level":"info","ts":"2026-05-02T05:35:27.59125Z","caller":"traceutil/trace.go:171","msg":"trace[779147604] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"1.193431278s","start":"2026-05-02T05:35:26.397739Z","end":"2026-05-02T05:35:27.59117Z","steps":["trace[779147604] 'process raft request' (duration: 638.521061ms)","trace[779147604] 'compare' (duration: 553.795781ms)"],"step_count":2} {"level":"warn","ts":"2026-05-02T05:35:27.591516Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-02T05:35:26.403077Z","time spent":"1.188287383s","remote":"127.0.0.1:37942","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6888,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-02T05:35:27.591577Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-02T05:35:26.397719Z","time spent":"1.193647895s","remote":"127.0.0.1:37942","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-05-02T05:35:27.591202Z","caller":"traceutil/trace.go:171","msg":"trace[1770730357] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"1.188889042s","start":"2026-05-02T05:35:26.402285Z","end":"2026-05-02T05:35:27.591174Z","steps":["trace[1770730357] 'process raft request' (duration: 1.188419797s)"],"step_count":1} {"level":"warn","ts":"2026-05-02T05:35:27.591681Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-02T05:35:26.402256Z","time spent":"1.189395388s","remote":"127.0.0.1:38382","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":995,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-02T05:35:27.607353Z","caller":"traceutil/trace.go:171","msg":"trace[616316073] linearizableReadLoop","detail":"{readStateIndex:570; appliedIndex:555; }","duration":"1.143493165s","start":"2026-05-02T05:35:26.46384Z","end":"2026-05-02T05:35:27.607333Z","steps":["trace[616316073] 'read index received' (duration: 572.493568ms)","trace[616316073] 'applied index is now lower than readState.Index' (duration: 570.998537ms)"],"step_count":2} {"level":"info","ts":"2026-05-02T05:35:27.607794Z","caller":"traceutil/trace.go:171","msg":"trace[808560952] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"1.185139587s","start":"2026-05-02T05:35:26.422645Z","end":"2026-05-02T05:35:27.607785Z","steps":["trace[808560952] 'process raft request' (duration: 1.184031792s)"],"step_count":1} {"level":"warn","ts":"2026-05-02T05:35:27.607913Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-02T05:35:26.422612Z","time spent":"1.185207509s","remote":"127.0.0.1:37942","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-05-02T05:35:27.608221Z","caller":"traceutil/trace.go:171","msg":"trace[1060318596] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"1.180056145s","start":"2026-05-02T05:35:26.428157Z","end":"2026-05-02T05:35:27.608213Z","steps":["trace[1060318596] 'process raft request' (duration: 1.17862327s)"],"step_count":1} {"level":"warn","ts":"2026-05-02T05:35:27.608267Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-02T05:35:26.428138Z","time spent":"1.180113526s","remote":"127.0.0.1:38382","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1004,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-02T05:35:27.60835Z","caller":"traceutil/trace.go:171","msg":"trace[1680549586] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"1.170008693s","start":"2026-05-02T05:35:26.438334Z","end":"2026-05-02T05:35:27.608343Z","steps":["trace[1680549586] 'process raft request' (duration: 1.168474724s)"],"step_count":1} {"level":"warn","ts":"2026-05-02T05:35:27.60838Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-02T05:35:26.438307Z","time spent":"1.170060125s","remote":"127.0.0.1:38382","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":998,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-02T05:35:27.608465Z","caller":"traceutil/trace.go:171","msg":"trace[1969928516] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"1.164902349s","start":"2026-05-02T05:35:26.443554Z","end":"2026-05-02T05:35:27.608456Z","steps":["trace[1969928516] 'process raft request' (duration: 1.163279498s)"],"step_count":1} {"level":"warn","ts":"2026-05-02T05:35:27.608526Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-02T05:35:26.443522Z","time spent":"1.164961141s","remote":"127.0.0.1:37942","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10063,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-02T05:35:27.608631Z","caller":"traceutil/trace.go:171","msg":"trace[326290007] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"686.209683ms","start":"2026-05-02T05:35:26.922414Z","end":"2026-05-02T05:35:27.608623Z","steps":["trace[326290007] 'process raft request' (duration: 684.877311ms)"],"step_count":1} {"level":"warn","ts":"2026-05-02T05:35:27.608677Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-02T05:35:26.922383Z","time spent":"686.270575ms","remote":"127.0.0.1:38130","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-02T05:35:27.608855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.145022354s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-05-02T05:35:27.608824Z","caller":"traceutil/trace.go:171","msg":"trace[1372237458] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"1.164833478s","start":"2026-05-02T05:35:26.443947Z","end":"2026-05-02T05:35:27.60878Z","steps":["trace[1372237458] 'process raft request' (duration: 1.162919507s)"],"step_count":1} {"level":"warn","ts":"2026-05-02T05:35:27.609039Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-02T05:35:26.443939Z","time spent":"1.165016983s","remote":"127.0.0.1:38382","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":980,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-02T05:35:27.609315Z","caller":"traceutil/trace.go:171","msg":"trace[1759035634] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"1.165289171s","start":"2026-05-02T05:35:26.444013Z","end":"2026-05-02T05:35:27.609303Z","steps":["trace[1759035634] 'process raft request' (duration: 1.162883515s)"],"step_count":1} {"level":"warn","ts":"2026-05-02T05:35:27.609447Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-02T05:35:26.444008Z","time spent":"1.165334673s","remote":"127.0.0.1:38382","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":998,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-02T05:35:27.608887Z","caller":"traceutil/trace.go:171","msg":"trace[1145917825] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:546; }","duration":"1.145108666s","start":"2026-05-02T05:35:26.463769Z","end":"2026-05-02T05:35:27.608878Z","steps":["trace[1145917825] 'agreement among raft nodes before linearized reading' (duration: 1.145038864s)"],"step_count":1} {"level":"info","ts":"2026-05-02T05:35:27.609628Z","caller":"traceutil/trace.go:171","msg":"trace[1167828883] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"1.164558108s","start":"2026-05-02T05:35:26.445058Z","end":"2026-05-02T05:35:27.609616Z","steps":["trace[1167828883] 'process raft request' (duration: 1.161874053s)"],"step_count":1} {"level":"warn","ts":"2026-05-02T05:35:27.609836Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-02T05:35:26.44505Z","time spent":"1.164719273s","remote":"127.0.0.1:37942","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30374,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-02T05:35:27.609639Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-02T05:35:26.463755Z","time spent":"1.14587382s","remote":"127.0.0.1:38130","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-05-02T05:35:27.609679Z","caller":"traceutil/trace.go:171","msg":"trace[1607939892] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"1.163062051s","start":"2026-05-02T05:35:26.446604Z","end":"2026-05-02T05:35:27.609666Z","steps":["trace[1607939892] 'process raft request' (duration: 1.160393336s)"],"step_count":1} {"level":"info","ts":"2026-05-02T05:35:27.609705Z","caller":"traceutil/trace.go:171","msg":"trace[1771649018] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"1.159675582s","start":"2026-05-02T05:35:26.450022Z","end":"2026-05-02T05:35:27.609697Z","steps":["trace[1771649018] 'process raft request' (duration: 1.157061829s)"],"step_count":1} {"level":"warn","ts":"2026-05-02T05:35:27.610051Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-02T05:35:26.446597Z","time spent":"1.16337474s","remote":"127.0.0.1:37942","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30393,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-02T05:35:27.610146Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-02T05:35:26.450008Z","time spent":"1.160063143s","remote":"127.0.0.1:37942","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28739,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-02T05:35:27.609726Z","caller":"traceutil/trace.go:171","msg":"trace[276482787] transaction","detail":"{read_only:false; response_revision:545; number_of_response:1; }","duration":"1.077774981s","start":"2026-05-02T05:35:26.531946Z","end":"2026-05-02T05:35:27.609721Z","steps":["trace[276482787] 'process raft request' (duration: 1.075261552s)"],"step_count":1} {"level":"warn","ts":"2026-05-02T05:35:27.610325Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-02T05:35:26.531907Z","time spent":"1.078341999s","remote":"127.0.0.1:37942","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-05-02T05:35:27.620622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"472.01682ms","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-05-02T05:35:27.6207Z","caller":"traceutil/trace.go:171","msg":"trace[392579520] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:547; }","duration":"472.159514ms","start":"2026-05-02T05:35:27.148524Z","end":"2026-05-02T05:35:27.620683Z","steps":["trace[392579520] 'agreement among raft nodes before linearized reading' (duration: 472.009479ms)"],"step_count":1} {"level":"warn","ts":"2026-05-02T05:35:27.620735Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-02T05:35:27.148503Z","time spent":"472.226896ms","remote":"127.0.0.1:38130","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-05-02T05:35:27.621159Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"525.736342ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-05-02T05:35:27.621188Z","caller":"traceutil/trace.go:171","msg":"trace[1188034245] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:547; }","duration":"525.822875ms","start":"2026-05-02T05:35:27.095358Z","end":"2026-05-02T05:35:27.621181Z","steps":["trace[1188034245] 'agreement among raft nodes before linearized reading' (duration: 524.687159ms)"],"step_count":1} {"level":"warn","ts":"2026-05-02T05:35:27.621208Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-02T05:35:27.095331Z","time spent":"525.872416ms","remote":"127.0.0.1:38130","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-02T05:35:27.621338Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"516.421896ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-05-02T05:35:27.62142Z","caller":"traceutil/trace.go:171","msg":"trace[1719893152] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:548; }","duration":"516.559321ms","start":"2026-05-02T05:35:27.104834Z","end":"2026-05-02T05:35:27.621393Z","steps":["trace[1719893152] 'agreement among raft nodes before linearized reading' (duration: 516.430947ms)"],"step_count":1} {"level":"warn","ts":"2026-05-02T05:35:27.621455Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-02T05:35:27.104798Z","time spent":"516.649934ms","remote":"127.0.0.1:38130","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-05-02T05:35:34.466602Z","caller":"traceutil/trace.go:171","msg":"trace[10726520] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"549.265718ms","start":"2026-05-02T05:35:33.917267Z","end":"2026-05-02T05:35:34.466533Z","steps":["trace[10726520] 'process raft request' (duration: 540.271461ms)"],"step_count":1} {"level":"warn","ts":"2026-05-02T05:35:34.466817Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-02T05:35:33.91723Z","time spent":"549.465394ms","remote":"127.0.0.1:37972","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036277,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-02T05:35:34.84554Z","caller":"traceutil/trace.go:171","msg":"trace[170230871] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"353.999957ms","start":"2026-05-02T05:35:34.491499Z","end":"2026-05-02T05:35:34.845499Z","steps":["trace[170230871] 'process raft request' (duration: 353.824892ms)"],"step_count":1} {"level":"info","ts":"2026-05-02T05:35:34.845639Z","caller":"traceutil/trace.go:171","msg":"trace[664909255] linearizableReadLoop","detail":"{readStateIndex:660; appliedIndex:660; }","duration":"318.187065ms","start":"2026-05-02T05:35:34.527407Z","end":"2026-05-02T05:35:34.845594Z","steps":["trace[664909255] 'read index received' (duration: 318.169625ms)","trace[664909255] 'applied index is now lower than readState.Index' (duration: 13.74µs)"],"step_count":2} {"level":"warn","ts":"2026-05-02T05:35:34.84574Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-02T05:35:34.491442Z","time spent":"354.204484ms","remote":"127.0.0.1:38078","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-02T05:35:34.845973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.477244ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.25\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-05-02T05:35:34.846717Z","caller":"traceutil/trace.go:171","msg":"trace[141090258] range","detail":"{range_begin:/registry/masterleases/199.204.45.25; range_end:; response_count:1; response_revision:635; }","duration":"319.318539ms","start":"2026-05-02T05:35:34.527371Z","end":"2026-05-02T05:35:34.846689Z","steps":["trace[141090258] 'agreement among raft nodes before linearized reading' (duration: 318.35271ms)"],"step_count":1} {"level":"warn","ts":"2026-05-02T05:35:34.846814Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-02T05:35:34.52735Z","time spent":"319.414101ms","remote":"127.0.0.1:37912","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/199.204.45.25\" "} {"level":"warn","ts":"2026-05-02T05:35:35.346021Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3986422236422295671,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-02T05:35:35.748761Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"394.313418ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-02T05:35:35.748933Z","caller":"traceutil/trace.go:171","msg":"trace[1510154081] linearizableReadLoop","detail":"{readStateIndex:662; appliedIndex:660; }","duration":"903.196948ms","start":"2026-05-02T05:35:34.845722Z","end":"2026-05-02T05:35:35.748919Z","steps":["trace[1510154081] 'read index received' (duration: 508.680435ms)","trace[1510154081] 'applied index is now lower than readState.Index' (duration: 394.515713ms)"],"step_count":2} {"level":"info","ts":"2026-05-02T05:35:35.749046Z","caller":"traceutil/trace.go:171","msg":"trace[95188931] transaction","detail":"{read_only:false; response_revision:636; number_of_response:1; }","duration":"1.211686926s","start":"2026-05-02T05:35:34.537317Z","end":"2026-05-02T05:35:35.749004Z","steps":["trace[95188931] 'process raft request' (duration: 817.051219ms)","trace[95188931] 'compare' (duration: 394.06285ms)"],"step_count":2} {"level":"warn","ts":"2026-05-02T05:35:35.749091Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-02T05:35:34.537278Z","time spent":"1.211793649s","remote":"127.0.0.1:38360","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-05-02T05:35:35.74926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.03968677s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-02T05:35:35.749294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"441.791954ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-02T05:35:35.749316Z","caller":"traceutil/trace.go:171","msg":"trace[978172133] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:636; }","duration":"1.039786323s","start":"2026-05-02T05:35:34.709515Z","end":"2026-05-02T05:35:35.749302Z","steps":["trace[978172133] 'agreement among raft nodes before linearized reading' (duration: 1.03970081s)"],"step_count":1} {"level":"warn","ts":"2026-05-02T05:35:35.749341Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-02T05:35:34.709491Z","time spent":"1.039845375s","remote":"127.0.0.1:37888","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-05-02T05:35:35.749461Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-02T05:35:34.848334Z","time spent":"901.125576ms","remote":"127.0.0.1:37912","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-05-02T05:35:35.749318Z","caller":"traceutil/trace.go:171","msg":"trace[137374889] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:636; }","duration":"441.866527ms","start":"2026-05-02T05:35:35.307441Z","end":"2026-05-02T05:35:35.749308Z","steps":["trace[137374889] 'agreement among raft nodes before linearized reading' (duration: 441.831656ms)"],"step_count":1} {"level":"warn","ts":"2026-05-02T05:35:35.749565Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-02T05:35:35.30741Z","time spent":"442.150585ms","remote":"127.0.0.1:37882","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-05-02T05:35:36.082117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.731891ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-02T05:35:36.082616Z","caller":"traceutil/trace.go:171","msg":"trace[1102558820] transaction","detail":"{read_only:false; response_revision:637; number_of_response:1; }","duration":"331.043446ms","start":"2026-05-02T05:35:35.751554Z","end":"2026-05-02T05:35:36.082597Z","steps":["trace[1102558820] 'process raft request' (duration: 126.735268ms)","trace[1102558820] 'compare' (duration: 203.575367ms)"],"step_count":2} {"level":"warn","ts":"2026-05-02T05:35:36.082684Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-02T05:35:35.751485Z","time spent":"331.1724ms","remote":"127.0.0.1:37912","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-05-02T05:35:36.909227Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.030953555s","expected-duration":"1s"} {"level":"warn","ts":"2026-05-02T05:35:37.364274Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"454.629628ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-02T05:35:37.364576Z","caller":"traceutil/trace.go:171","msg":"trace[557726576] transaction","detail":"{read_only:false; response_revision:638; number_of_response:1; }","duration":"1.609845428s","start":"2026-05-02T05:35:35.754692Z","end":"2026-05-02T05:35:37.364538Z","steps":["trace[557726576] 'process raft request' (duration: 1.154798728s)","trace[557726576] 'compare' (duration: 453.954179ms)"],"step_count":2} {"level":"info","ts":"2026-05-02T05:35:37.364615Z","caller":"traceutil/trace.go:171","msg":"trace[622816088] transaction","detail":"{read_only:false; response_revision:639; number_of_response:1; }","duration":"1.609248271s","start":"2026-05-02T05:35:35.755341Z","end":"2026-05-02T05:35:37.364589Z","steps":["trace[622816088] 'process raft request' (duration: 1.609088836s)"],"step_count":1} {"level":"warn","ts":"2026-05-02T05:35:37.364718Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-02T05:35:35.755326Z","time spent":"1.609350283s","remote":"127.0.0.1:38130","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-05-02T05:35:37.364744Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-02T05:35:35.754672Z","time spent":"1.609972761s","remote":"127.0.0.1:38130","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-05-02T05:35:37.364957Z","caller":"traceutil/trace.go:171","msg":"trace[763445050] transaction","detail":"{read_only:false; response_revision:640; number_of_response:1; }","duration":"1.609026843s","start":"2026-05-02T05:35:35.75587Z","end":"2026-05-02T05:35:37.364897Z","steps":["trace[763445050] 'process raft request' (duration: 1.608664543s)"],"step_count":1} {"level":"warn","ts":"2026-05-02T05:35:37.365148Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-02T05:35:35.755863Z","time spent":"1.609189808s","remote":"127.0.0.1:38130","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-02T05:35:37.365111Z","caller":"traceutil/trace.go:171","msg":"trace[421383907] linearizableReadLoop","detail":"{readStateIndex:667; appliedIndex:662; }","duration":"1.605049566s","start":"2026-05-02T05:35:35.760013Z","end":"2026-05-02T05:35:37.365063Z","steps":["trace[421383907] 'read index received' (duration: 118.253578ms)","trace[421383907] 'applied index is now lower than readState.Index' (duration: 1.486794208s)"],"step_count":2} {"level":"info","ts":"2026-05-02T05:35:37.365272Z","caller":"traceutil/trace.go:171","msg":"trace[1438308221] transaction","detail":"{read_only:false; response_revision:641; number_of_response:1; }","duration":"1.608308463s","start":"2026-05-02T05:35:35.756947Z","end":"2026-05-02T05:35:37.365255Z","steps":["trace[1438308221] 'process raft request' (duration: 1.607889441s)"],"step_count":1} {"level":"warn","ts":"2026-05-02T05:35:37.365357Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.280528552s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:421"} {"level":"info","ts":"2026-05-02T05:35:37.365401Z","caller":"traceutil/trace.go:171","msg":"trace[558971477] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:641; }","duration":"1.280600375s","start":"2026-05-02T05:35:36.084785Z","end":"2026-05-02T05:35:37.365385Z","steps":["trace[558971477] 'agreement among raft nodes before linearized reading' (duration: 1.280514662s)"],"step_count":1} {"level":"warn","ts":"2026-05-02T05:35:37.365435Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-02T05:35:36.084763Z","time spent":"1.280664167s","remote":"127.0.0.1:38066","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":444,"request content":"key:\"/registry/services/endpoints/default/kubernetes\" "} {"level":"warn","ts":"2026-05-02T05:35:37.365424Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-02T05:35:35.756935Z","time spent":"1.608375354s","remote":"127.0.0.1:38130","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-02T05:35:37.365474Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.605440378s","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-05-02T05:35:37.36557Z","caller":"traceutil/trace.go:171","msg":"trace[1950175826] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:641; }","duration":"1.605564411s","start":"2026-05-02T05:35:35.759979Z","end":"2026-05-02T05:35:37.365544Z","steps":["trace[1950175826] 'agreement among raft nodes before linearized reading' (duration: 1.605427707s)"],"step_count":1} {"level":"warn","ts":"2026-05-02T05:35:37.36562Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-02T05:35:35.759963Z","time spent":"1.605647534s","remote":"127.0.0.1:38118","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" "} {"level":"warn","ts":"2026-05-02T05:35:37.365644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.058731127s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-02T05:35:37.365677Z","caller":"traceutil/trace.go:171","msg":"trace[1734768227] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:641; }","duration":"1.058794269s","start":"2026-05-02T05:35:36.306872Z","end":"2026-05-02T05:35:37.365667Z","steps":["trace[1734768227] 'agreement among raft nodes before linearized reading' (duration: 1.058739327s)"],"step_count":1} {"level":"warn","ts":"2026-05-02T05:35:37.365703Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-02T05:35:36.306852Z","time spent":"1.058845661s","remote":"127.0.0.1:37888","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-05-02T05:35:58.488561Z","caller":"traceutil/trace.go:171","msg":"trace[466285785] transaction","detail":"{read_only:false; response_revision:820; number_of_response:1; }","duration":"157.150332ms","start":"2026-05-02T05:35:58.33139Z","end":"2026-05-02T05:35:58.48854Z","steps":["trace[466285785] 'process raft request' (duration: 156.982118ms)"],"step_count":1} {"level":"warn","ts":"2026-05-02T05:35:59.170486Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"540.003489ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-02T05:35:59.170591Z","caller":"traceutil/trace.go:171","msg":"trace[1959492704] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; response_count:0; response_revision:820; }","duration":"540.140353ms","start":"2026-05-02T05:35:58.630432Z","end":"2026-05-02T05:35:59.170573Z","steps":["trace[1959492704] 'count revisions from in-memory index tree' (duration: 539.946658ms)"],"step_count":1} {"level":"warn","ts":"2026-05-02T05:35:59.170593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"584.595071ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-lllt5\" ","response":"range_response_count:1 size:3964"} {"level":"warn","ts":"2026-05-02T05:35:59.170632Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-02T05:35:58.630423Z","time spent":"540.199664ms","remote":"127.0.0.1:38346","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":3,"response size":30,"request content":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true "} {"level":"info","ts":"2026-05-02T05:35:59.17071Z","caller":"traceutil/trace.go:171","msg":"trace[1758888895] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-lllt5; range_end:; response_count:1; response_revision:820; }","duration":"584.731545ms","start":"2026-05-02T05:35:58.585932Z","end":"2026-05-02T05:35:59.170664Z","steps":["trace[1758888895] 'range keys from in-memory index tree' (duration: 584.280704ms)"],"step_count":1} {"level":"warn","ts":"2026-05-02T05:35:59.170772Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-02T05:35:58.585918Z","time spent":"584.838867ms","remote":"127.0.0.1:38078","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3987,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-lllt5\" "} {"level":"info","ts":"2026-05-02T05:37:48.197514Z","caller":"traceutil/trace.go:171","msg":"trace[293478784] transaction","detail":"{read_only:false; response_revision:1350; number_of_response:1; }","duration":"116.069427ms","start":"2026-05-02T05:37:48.081418Z","end":"2026-05-02T05:37:48.197488Z","steps":["trace[293478784] 'process raft request' (duration: 115.891494ms)"],"step_count":1} {"level":"warn","ts":"2026-05-02T05:37:48.80874Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3986422236422297311,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-02T05:37:48.920231Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"657.749961ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-02T05:37:48.920376Z","caller":"traceutil/trace.go:171","msg":"trace[664747277] transaction","detail":"{read_only:false; response_revision:1351; number_of_response:1; }","duration":"717.891146ms","start":"2026-05-02T05:37:48.202459Z","end":"2026-05-02T05:37:48.92035Z","steps":["trace[664747277] 'process raft request' (duration: 59.903061ms)","trace[664747277] 'compare' (duration: 657.471547ms)"],"step_count":2} {"level":"warn","ts":"2026-05-02T05:37:48.920685Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-02T05:37:48.202439Z","time spent":"718.18796ms","remote":"127.0.0.1:38130","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-02T05:37:48.927075Z","caller":"traceutil/trace.go:171","msg":"trace[398206341] transaction","detail":"{read_only:false; response_revision:1352; number_of_response:1; }","duration":"724.502371ms","start":"2026-05-02T05:37:48.202545Z","end":"2026-05-02T05:37:48.927048Z","steps":["trace[398206341] 'process raft request' (duration: 724.344829ms)"],"step_count":1} {"level":"warn","ts":"2026-05-02T05:37:48.927222Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-02T05:37:48.202493Z","time spent":"724.655104ms","remote":"127.0.0.1:38130","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-02T05:37:48.927323Z","caller":"traceutil/trace.go:171","msg":"trace[1281286926] transaction","detail":"{read_only:false; response_revision:1353; number_of_response:1; }","duration":"724.657364ms","start":"2026-05-02T05:37:48.202639Z","end":"2026-05-02T05:37:48.927297Z","steps":["trace[1281286926] 'process raft request' (duration: 724.36958ms)"],"step_count":1} {"level":"warn","ts":"2026-05-02T05:37:48.927626Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-02T05:37:48.202606Z","time spent":"724.792456ms","remote":"127.0.0.1:38130","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-02T05:37:48.927615Z","caller":"traceutil/trace.go:171","msg":"trace[1634952502] linearizableReadLoop","detail":"{readStateIndex:1412; appliedIndex:1409; }","duration":"619.15404ms","start":"2026-05-02T05:37:48.30844Z","end":"2026-05-02T05:37:48.927594Z","steps":["trace[1634952502] 'read index received' (duration: 618.392499ms)","trace[1634952502] 'applied index is now lower than readState.Index' (duration: 760.301µs)"],"step_count":2} {"level":"warn","ts":"2026-05-02T05:37:48.927831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"619.378423ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-02T05:37:48.927881Z","caller":"traceutil/trace.go:171","msg":"trace[920229433] transaction","detail":"{read_only:false; response_revision:1354; number_of_response:1; }","duration":"724.734825ms","start":"2026-05-02T05:37:48.203118Z","end":"2026-05-02T05:37:48.927853Z","steps":["trace[920229433] 'process raft request' (duration: 724.296669ms)"],"step_count":1} {"level":"info","ts":"2026-05-02T05:37:48.927958Z","caller":"traceutil/trace.go:171","msg":"trace[2101643163] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1354; }","duration":"619.494395ms","start":"2026-05-02T05:37:48.308395Z","end":"2026-05-02T05:37:48.927889Z","steps":["trace[2101643163] 'agreement among raft nodes before linearized reading' (duration: 619.261342ms)"],"step_count":1} {"level":"warn","ts":"2026-05-02T05:37:48.928063Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-02T05:37:48.203106Z","time spent":"724.845216ms","remote":"127.0.0.1:38130","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-02T05:37:48.928098Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-02T05:37:48.308375Z","time spent":"619.704308ms","remote":"127.0.0.1:37888","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-05-02T05:37:50.078729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.480132ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-05-02T05:37:50.078846Z","caller":"traceutil/trace.go:171","msg":"trace[1286740460] linearizableReadLoop","detail":"{readStateIndex:1413; appliedIndex:1412; }","duration":"150.768214ms","start":"2026-05-02T05:37:49.928055Z","end":"2026-05-02T05:37:50.078824Z","steps":["trace[1286740460] 'read index received' (duration: 13.14177ms)","trace[1286740460] 'applied index is now lower than readState.Index' (duration: 137.624644ms)"],"step_count":2} {"level":"warn","ts":"2026-05-02T05:37:50.079106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.043969ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-05-02T05:37:50.079151Z","caller":"traceutil/trace.go:171","msg":"trace[1354942810] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1354; }","duration":"151.123519ms","start":"2026-05-02T05:37:49.928015Z","end":"2026-05-02T05:37:50.079139Z","steps":["trace[1354942810] 'agreement among raft nodes before linearized reading' (duration: 150.867706ms)"],"step_count":1}