{"level":"warn","ts":"2026-02-18T22:50:34.582184Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-02-18T22:50:34.582279Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.248: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.248:2380","--initial-cluster=instance=https://199.204.45.248:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.248:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.248:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-02-18T22:50:34.582375Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-02-18T22:50:34.582389Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.248:2380"]} {"level":"info","ts":"2026-02-18T22:50:34.58242Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-02-18T22:50:34.583202Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.248:2379"]} {"level":"info","ts":"2026-02-18T22:50:34.583287Z","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":2,"max-cpu-available":2,"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.248:2380"],"listen-peer-urls":["https://199.204.45.248:2380"],"advertise-client-urls":["https://199.204.45.248:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.248:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.248:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-02-18T22:50:34.588285Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.279365ms"} {"level":"info","ts":"2026-02-18T22:50:34.634593Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"39582465ceaa2f67","cluster-id":"87fd8ddedde3be45"} {"level":"info","ts":"2026-02-18T22:50:34.634652Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 switched to configuration voters=()"} {"level":"info","ts":"2026-02-18T22:50:34.63467Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became follower at term 0"} {"level":"info","ts":"2026-02-18T22:50:34.634683Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 39582465ceaa2f67 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-18T22:50:34.634689Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became follower at term 1"} {"level":"info","ts":"2026-02-18T22:50:34.634753Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 switched to configuration voters=(4132092677789986663)"} {"level":"warn","ts":"2026-02-18T22:50:34.642967Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-18T22:50:34.644461Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-18T22:50:34.658966Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-02-18T22:50:34.670344Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"39582465ceaa2f67","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-18T22:50:34.670785Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"39582465ceaa2f67","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-18T22:50:34.670883Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-02-18T22:50:34.686094Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-02-18T22:50:34.686126Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-02-18T22:50:34.673596Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 switched to configuration voters=(4132092677789986663)"} {"level":"info","ts":"2026-02-18T22:50:34.693648Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"87fd8ddedde3be45","local-member-id":"39582465ceaa2f67","added-peer-id":"39582465ceaa2f67","added-peer-peer-urls":["https://199.204.45.248:2380"]} {"level":"info","ts":"2026-02-18T22:50:34.69463Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-02-18T22:50:34.700187Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"39582465ceaa2f67","initial-advertise-peer-urls":["https://199.204.45.248:2380"],"listen-peer-urls":["https://199.204.45.248:2380"],"advertise-client-urls":["https://199.204.45.248:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.248:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-18T22:50:34.700333Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-18T22:50:34.694746Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.248:2380"} {"level":"info","ts":"2026-02-18T22:50:34.70081Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.248:2380"} {"level":"info","ts":"2026-02-18T22:50:35.036167Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 is starting a new election at term 1"} {"level":"info","ts":"2026-02-18T22:50:35.036206Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became pre-candidate at term 1"} {"level":"info","ts":"2026-02-18T22:50:35.036241Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 received MsgPreVoteResp from 39582465ceaa2f67 at term 1"} {"level":"info","ts":"2026-02-18T22:50:35.036254Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became candidate at term 2"} {"level":"info","ts":"2026-02-18T22:50:35.036263Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 received MsgVoteResp from 39582465ceaa2f67 at term 2"} {"level":"info","ts":"2026-02-18T22:50:35.036274Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became leader at term 2"} {"level":"info","ts":"2026-02-18T22:50:35.036285Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 39582465ceaa2f67 elected leader 39582465ceaa2f67 at term 2"} {"level":"info","ts":"2026-02-18T22:50:35.037612Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-18T22:50:35.037925Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-18T22:50:35.037573Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"39582465ceaa2f67","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.248:2379]}","request-path":"/0/members/39582465ceaa2f67/attributes","cluster-id":"87fd8ddedde3be45","publish-timeout":"7s"} {"level":"info","ts":"2026-02-18T22:50:35.039086Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-18T22:50:35.044911Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.248:2379"} {"level":"info","ts":"2026-02-18T22:50:35.045073Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"87fd8ddedde3be45","local-member-id":"39582465ceaa2f67","cluster-version":"3.5"} {"level":"info","ts":"2026-02-18T22:50:35.045315Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-18T22:50:35.045335Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-18T22:50:35.064379Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-02-18T22:50:35.066742Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-18T22:50:35.066759Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-18T22:50:44.270198Z","caller":"traceutil/trace.go:171","msg":"trace[569858130] transaction","detail":"{read_only:false; response_revision:330; number_of_response:1; }","duration":"169.806137ms","start":"2026-02-18T22:50:44.10037Z","end":"2026-02-18T22:50:44.270176Z","steps":["trace[569858130] 'process raft request' (duration: 128.378338ms)","trace[569858130] 'compare' (duration: 41.326618ms)"],"step_count":2} {"level":"info","ts":"2026-02-18T22:50:44.28295Z","caller":"traceutil/trace.go:171","msg":"trace[978208077] transaction","detail":"{read_only:false; response_revision:331; number_of_response:1; }","duration":"150.876147ms","start":"2026-02-18T22:50:44.132062Z","end":"2026-02-18T22:50:44.282938Z","steps":["trace[978208077] 'process raft request' (duration: 150.721695ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T22:50:47.589183Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.624897ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T22:50:47.589254Z","caller":"traceutil/trace.go:171","msg":"trace[856616490] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:394; }","duration":"248.726887ms","start":"2026-02-18T22:50:47.340517Z","end":"2026-02-18T22:50:47.589244Z","steps":["trace[856616490] 'range keys from in-memory index tree' (duration: 248.588137ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T22:50:47.589262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"408.421714ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-proxy-g28v9\" ","response":"range_response_count:1 size:4421"} {"level":"info","ts":"2026-02-18T22:50:47.589293Z","caller":"traceutil/trace.go:171","msg":"trace[610119561] range","detail":"{range_begin:/registry/pods/kube-system/kube-proxy-g28v9; range_end:; response_count:1; response_revision:394; }","duration":"408.470715ms","start":"2026-02-18T22:50:47.18081Z","end":"2026-02-18T22:50:47.589281Z","steps":["trace[610119561] 'range keys from in-memory index tree' (duration: 408.370254ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T22:50:47.589318Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T22:50:47.180797Z","time spent":"408.517315ms","remote":"127.0.0.1:34630","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":4444,"request content":"key:\"/registry/pods/kube-system/kube-proxy-g28v9\" "} {"level":"warn","ts":"2026-02-18T22:50:47.589179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"332.720992ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-02-18T22:50:47.589478Z","caller":"traceutil/trace.go:171","msg":"trace[891225959] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:394; }","duration":"333.076224ms","start":"2026-02-18T22:50:47.256395Z","end":"2026-02-18T22:50:47.589471Z","steps":["trace[891225959] 'range keys from in-memory index tree' (duration: 332.63667ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T22:50:47.5895Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T22:50:47.256377Z","time spent":"333.114854ms","remote":"127.0.0.1:34686","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-02-18T22:50:53.615856Z","caller":"traceutil/trace.go:171","msg":"trace[983800012] linearizableReadLoop","detail":"{readStateIndex:428; appliedIndex:427; }","duration":"425.323721ms","start":"2026-02-18T22:50:53.190506Z","end":"2026-02-18T22:50:53.61583Z","steps":["trace[983800012] 'read index received' (duration: 425.044658ms)","trace[983800012] 'applied index is now lower than readState.Index' (duration: 277.963µs)"],"step_count":2} {"level":"warn","ts":"2026-02-18T22:50:53.616017Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"425.493522ms","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-02-18T22:50:53.616061Z","caller":"traceutil/trace.go:171","msg":"trace[131723674] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:417; }","duration":"425.578463ms","start":"2026-02-18T22:50:53.190468Z","end":"2026-02-18T22:50:53.616046Z","steps":["trace[131723674] 'agreement among raft nodes before linearized reading' (duration: 425.465652ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T22:50:53.616106Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T22:50:53.19045Z","time spent":"425.644603ms","remote":"127.0.0.1:34686","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-02-18T22:50:53.617048Z","caller":"traceutil/trace.go:171","msg":"trace[679493179] transaction","detail":"{read_only:false; response_revision:417; number_of_response:1; }","duration":"585.536227ms","start":"2026-02-18T22:50:53.031493Z","end":"2026-02-18T22:50:53.61703Z","steps":["trace[679493179] 'process raft request' (duration: 584.208337ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T22:50:53.617723Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T22:50:53.03147Z","time spent":"585.621958ms","remote":"127.0.0.1:34686","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-18T22:50:54.142872Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3415870859895967402,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-18T22:50:54.331101Z","caller":"traceutil/trace.go:171","msg":"trace[941113325] transaction","detail":"{read_only:false; response_revision:418; number_of_response:1; }","duration":"709.536576ms","start":"2026-02-18T22:50:53.621537Z","end":"2026-02-18T22:50:54.331074Z","steps":["trace[941113325] 'process raft request' (duration: 635.096746ms)","trace[941113325] 'compare' (duration: 74.080648ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T22:50:54.331238Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T22:50:53.62152Z","time spent":"709.646557ms","remote":"127.0.0.1:34686","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-02-18T22:50:54.337594Z","caller":"traceutil/trace.go:171","msg":"trace[984402166] linearizableReadLoop","detail":"{readStateIndex:430; appliedIndex:428; }","duration":"694.880593ms","start":"2026-02-18T22:50:53.642697Z","end":"2026-02-18T22:50:54.337578Z","steps":["trace[984402166] 'read index received' (duration: 613.944967ms)","trace[984402166] 'applied index is now lower than readState.Index' (duration: 80.934386ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T22:50:54.338008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"695.308805ms","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-02-18T22:50:54.339203Z","caller":"traceutil/trace.go:171","msg":"trace[1123002655] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:418; }","duration":"696.538095ms","start":"2026-02-18T22:50:53.642657Z","end":"2026-02-18T22:50:54.339195Z","steps":["trace[1123002655] 'agreement among raft nodes before linearized reading' (duration: 695.310116ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T22:50:54.339404Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T22:50:53.642639Z","time spent":"696.755427ms","remote":"127.0.0.1:34686","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-02-18T22:50:54.339037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"331.194306ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T22:50:54.339672Z","caller":"traceutil/trace.go:171","msg":"trace[1270774947] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:418; }","duration":"331.859201ms","start":"2026-02-18T22:50:54.007803Z","end":"2026-02-18T22:50:54.339662Z","steps":["trace[1270774947] 'agreement among raft nodes before linearized reading' (duration: 330.528542ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T22:50:54.339785Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T22:50:54.007788Z","time spent":"331.988602ms","remote":"127.0.0.1:34426","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-18T22:50:54.3391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.963533ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/coredns\" ","response":"range_response_count:1 size:4034"} {"level":"info","ts":"2026-02-18T22:50:54.340153Z","caller":"traceutil/trace.go:171","msg":"trace[1856969134] range","detail":"{range_begin:/registry/deployments/kube-system/coredns; range_end:; response_count:1; response_revision:418; }","duration":"296.015149ms","start":"2026-02-18T22:50:54.04413Z","end":"2026-02-18T22:50:54.340145Z","steps":["trace[1856969134] 'agreement among raft nodes before linearized reading' (duration: 294.935212ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T22:51:03.773621Z","caller":"traceutil/trace.go:171","msg":"trace[966356629] transaction","detail":"{read_only:false; response_revision:470; number_of_response:1; }","duration":"115.24238ms","start":"2026-02-18T22:51:03.658359Z","end":"2026-02-18T22:51:03.773602Z","steps":["trace[966356629] 'process raft request' (duration: 115.14869ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T22:51:07.9278Z","caller":"traceutil/trace.go:171","msg":"trace[1403059884] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"133.173024ms","start":"2026-02-18T22:51:07.794604Z","end":"2026-02-18T22:51:07.927777Z","steps":["trace[1403059884] 'process raft request' (duration: 133.057363ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T22:51:14.129938Z","caller":"traceutil/trace.go:171","msg":"trace[40810952] linearizableReadLoop","detail":"{readStateIndex:566; appliedIndex:565; }","duration":"120.254036ms","start":"2026-02-18T22:51:14.009666Z","end":"2026-02-18T22:51:14.12992Z","steps":["trace[40810952] 'read index received' (duration: 120.100371ms)","trace[40810952] 'applied index is now lower than readState.Index' (duration: 153.035µs)"],"step_count":2} {"level":"warn","ts":"2026-02-18T22:51:14.130033Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.35084ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T22:51:14.130063Z","caller":"traceutil/trace.go:171","msg":"trace[831882005] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:550; }","duration":"120.412614ms","start":"2026-02-18T22:51:14.009643Z","end":"2026-02-18T22:51:14.130055Z","steps":["trace[831882005] 'agreement among raft nodes before linearized reading' (duration: 120.34619ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T22:51:14.130738Z","caller":"traceutil/trace.go:171","msg":"trace[1378176887] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"168.725809ms","start":"2026-02-18T22:51:13.962002Z","end":"2026-02-18T22:51:14.130728Z","steps":["trace[1378176887] 'process raft request' (duration: 167.804983ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T22:51:15.067767Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3415870859895967677,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-18T22:51:15.314901Z","caller":"traceutil/trace.go:171","msg":"trace[1553033341] linearizableReadLoop","detail":"{readStateIndex:572; appliedIndex:571; }","duration":"747.188641ms","start":"2026-02-18T22:51:14.567698Z","end":"2026-02-18T22:51:15.314887Z","steps":["trace[1553033341] 'read index received' (duration: 747.063346ms)","trace[1553033341] 'applied index is now lower than readState.Index' (duration: 124.735µs)"],"step_count":2} {"level":"warn","ts":"2026-02-18T22:51:15.315048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"747.331756ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-02-18T22:51:15.315066Z","caller":"traceutil/trace.go:171","msg":"trace[1047442808] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:556; }","duration":"747.396369ms","start":"2026-02-18T22:51:14.567662Z","end":"2026-02-18T22:51:15.315058Z","steps":["trace[1047442808] 'agreement among raft nodes before linearized reading' (duration: 747.276373ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T22:51:15.315085Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T22:51:14.567649Z","time spent":"747.431981ms","remote":"127.0.0.1:34686","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-02-18T22:51:15.315235Z","caller":"traceutil/trace.go:171","msg":"trace[95148902] transaction","detail":"{read_only:false; response_revision:556; number_of_response:1; }","duration":"835.725061ms","start":"2026-02-18T22:51:14.479504Z","end":"2026-02-18T22:51:15.315229Z","steps":["trace[95148902] 'process raft request' (duration: 835.300374ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T22:51:15.315281Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T22:51:14.479495Z","time spent":"835.752282ms","remote":"127.0.0.1:34686","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-18T22:51:16.452712Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.067139927s","expected-duration":"1s"} {"level":"info","ts":"2026-02-18T22:51:16.501031Z","caller":"traceutil/trace.go:171","msg":"trace[750767922] linearizableReadLoop","detail":"{readStateIndex:573; appliedIndex:572; }","duration":"492.859364ms","start":"2026-02-18T22:51:16.00815Z","end":"2026-02-18T22:51:16.501009Z","steps":["trace[750767922] 'read index received' (duration: 444.645666ms)","trace[750767922] 'applied index is now lower than readState.Index' (duration: 48.212628ms)"],"step_count":2} {"level":"info","ts":"2026-02-18T22:51:16.501268Z","caller":"traceutil/trace.go:171","msg":"trace[1110833818] transaction","detail":"{read_only:false; response_revision:557; number_of_response:1; }","duration":"1.182835305s","start":"2026-02-18T22:51:15.31842Z","end":"2026-02-18T22:51:16.501255Z","steps":["trace[1110833818] 'process raft request' (duration: 1.134417939s)","trace[1110833818] 'compare' (duration: 48.092764ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T22:51:16.501396Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T22:51:15.318408Z","time spent":"1.182888366s","remote":"127.0.0.1:34686","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-18T22:51:16.501563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"493.407194ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T22:51:16.501597Z","caller":"traceutil/trace.go:171","msg":"trace[771394031] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:557; }","duration":"493.465706ms","start":"2026-02-18T22:51:16.008117Z","end":"2026-02-18T22:51:16.501583Z","steps":["trace[771394031] 'agreement among raft nodes before linearized reading' (duration: 493.417654ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T22:51:16.501629Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T22:51:16.008101Z","time spent":"493.521528ms","remote":"127.0.0.1:34426","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-18T22:51:16.50185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"366.847607ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-02-18T22:51:16.501876Z","caller":"traceutil/trace.go:171","msg":"trace[568724163] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:557; }","duration":"366.901349ms","start":"2026-02-18T22:51:16.134967Z","end":"2026-02-18T22:51:16.501868Z","steps":["trace[568724163] 'agreement among raft nodes before linearized reading' (duration: 366.805796ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T22:51:16.501901Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T22:51:16.134952Z","time spent":"366.943351ms","remote":"127.0.0.1:34686","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-02-18T22:51:16.715705Z","caller":"traceutil/trace.go:171","msg":"trace[170501616] transaction","detail":"{read_only:false; response_revision:559; number_of_response:1; }","duration":"201.664643ms","start":"2026-02-18T22:51:16.514015Z","end":"2026-02-18T22:51:16.71568Z","steps":["trace[170501616] 'process raft request' (duration: 201.553869ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T22:51:16.71621Z","caller":"traceutil/trace.go:171","msg":"trace[1205487469] transaction","detail":"{read_only:false; response_revision:558; number_of_response:1; }","duration":"203.405249ms","start":"2026-02-18T22:51:16.51279Z","end":"2026-02-18T22:51:16.716195Z","steps":["trace[1205487469] 'process raft request' (duration: 169.808849ms)","trace[1205487469] 'compare' (duration: 32.237238ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T22:51:18.837363Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3415870859895967688,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-18T22:51:19.337671Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3415870859895967688,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-18T22:51:19.673956Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.534577387s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T22:51:19.674021Z","caller":"traceutil/trace.go:171","msg":"trace[410657161] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:559; }","duration":"2.534689692s","start":"2026-02-18T22:51:17.139315Z","end":"2026-02-18T22:51:19.674005Z","steps":["trace[410657161] 'range keys from in-memory index tree' (duration: 2.534532696s)"],"step_count":1} {"level":"warn","ts":"2026-02-18T22:51:19.674061Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T22:51:17.139301Z","time spent":"2.534750155s","remote":"127.0.0.1:34426","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-18T22:51:19.674265Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.356594311s","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-02-18T22:51:19.674293Z","caller":"traceutil/trace.go:171","msg":"trace[822466205] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:559; }","duration":"2.356655273s","start":"2026-02-18T22:51:17.317628Z","end":"2026-02-18T22:51:19.674284Z","steps":["trace[822466205] 'range keys from in-memory index tree' (duration: 2.356429935s)"],"step_count":1} {"level":"warn","ts":"2026-02-18T22:51:19.674318Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T22:51:17.317609Z","time spent":"2.356703015s","remote":"127.0.0.1:34686","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-02-18T22:51:19.740743Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.732746166s","expected-duration":"1s"} {"level":"info","ts":"2026-02-18T22:51:19.741114Z","caller":"traceutil/trace.go:171","msg":"trace[1709626318] transaction","detail":"{read_only:false; response_revision:560; number_of_response:1; }","duration":"1.733203492s","start":"2026-02-18T22:51:18.00789Z","end":"2026-02-18T22:51:19.741093Z","steps":["trace[1709626318] 'process raft request' (duration: 1.733077557s)"],"step_count":1} {"level":"warn","ts":"2026-02-18T22:51:19.741217Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T22:51:18.00786Z","time spent":"1.733290155s","remote":"127.0.0.1:34686","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-18T22:51:19.742666Z","caller":"traceutil/trace.go:171","msg":"trace[1899150967] linearizableReadLoop","detail":"{readStateIndex:576; appliedIndex:576; }","duration":"1.405680484s","start":"2026-02-18T22:51:18.336957Z","end":"2026-02-18T22:51:19.742638Z","steps":["trace[1899150967] 'read index received' (duration: 1.405674214s)","trace[1899150967] 'applied index is now lower than readState.Index' (duration: 5.16µs)"],"step_count":2} {"level":"warn","ts":"2026-02-18T22:51:19.742824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.405863041s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.248\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-02-18T22:51:19.742859Z","caller":"traceutil/trace.go:171","msg":"trace[2036369901] range","detail":"{range_begin:/registry/masterleases/199.204.45.248; range_end:; response_count:1; response_revision:560; }","duration":"1.405937864s","start":"2026-02-18T22:51:18.336912Z","end":"2026-02-18T22:51:19.74285Z","steps":["trace[2036369901] 'agreement among raft nodes before linearized reading' (duration: 1.40581123s)"],"step_count":1} {"level":"warn","ts":"2026-02-18T22:51:19.742894Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T22:51:18.336899Z","time spent":"1.405988525s","remote":"127.0.0.1:34452","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.204.45.248\" "} {"level":"info","ts":"2026-02-18T22:51:19.878178Z","caller":"traceutil/trace.go:171","msg":"trace[834497243] transaction","detail":"{read_only:false; response_revision:561; number_of_response:1; }","duration":"194.236763ms","start":"2026-02-18T22:51:19.683915Z","end":"2026-02-18T22:51:19.878152Z","steps":["trace[834497243] 'process raft request' (duration: 193.930782ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T22:51:19.87951Z","caller":"traceutil/trace.go:171","msg":"trace[1933411168] linearizableReadLoop","detail":"{readStateIndex:577; appliedIndex:578; }","duration":"136.787123ms","start":"2026-02-18T22:51:19.742704Z","end":"2026-02-18T22:51:19.879491Z","steps":["trace[1933411168] 'read index received' (duration: 136.778863ms)","trace[1933411168] 'applied index is now lower than readState.Index' (duration: 7.07µs)"],"step_count":2} {"level":"warn","ts":"2026-02-18T22:51:19.87971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.363166769s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-02-18T22:51:19.879763Z","caller":"traceutil/trace.go:171","msg":"trace[1708621057] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:561; }","duration":"1.363251972s","start":"2026-02-18T22:51:18.516496Z","end":"2026-02-18T22:51:19.879747Z","steps":["trace[1708621057] 'agreement among raft nodes before linearized reading' (duration: 1.363091776s)"],"step_count":1} {"level":"warn","ts":"2026-02-18T22:51:19.879811Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T22:51:18.51648Z","time spent":"1.363317984s","remote":"127.0.0.1:34686","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-18T22:51:19.879929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"740.031547ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T22:51:19.879974Z","caller":"traceutil/trace.go:171","msg":"trace[964070217] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:561; }","duration":"740.09536ms","start":"2026-02-18T22:51:19.139868Z","end":"2026-02-18T22:51:19.879963Z","steps":["trace[964070217] 'agreement among raft nodes before linearized reading' (duration: 740.034538ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T22:51:19.880012Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T22:51:19.139855Z","time spent":"740.147851ms","remote":"127.0.0.1:34440","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-18T22:51:19.880269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.156601551s","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-02-18T22:51:19.880297Z","caller":"traceutil/trace.go:171","msg":"trace[734212930] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:561; }","duration":"1.156633632s","start":"2026-02-18T22:51:18.723651Z","end":"2026-02-18T22:51:19.880284Z","steps":["trace[734212930] 'agreement among raft nodes before linearized reading' (duration: 1.15657674s)"],"step_count":1} {"level":"warn","ts":"2026-02-18T22:51:19.880312Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T22:51:18.723645Z","time spent":"1.156663603s","remote":"127.0.0.1:34686","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-02-18T22:51:19.880378Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.158116296s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-02-18T22:51:19.88039Z","caller":"traceutil/trace.go:171","msg":"trace[1809314471] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:561; }","duration":"1.158150557s","start":"2026-02-18T22:51:18.722236Z","end":"2026-02-18T22:51:19.880386Z","steps":["trace[1809314471] 'agreement among raft nodes before linearized reading' (duration: 1.158110466s)"],"step_count":1} {"level":"warn","ts":"2026-02-18T22:51:19.880401Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T22:51:18.722222Z","time spent":"1.158177018s","remote":"127.0.0.1:34686","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-02-18T22:51:21.723634Z","caller":"traceutil/trace.go:171","msg":"trace[398173035] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"198.593116ms","start":"2026-02-18T22:51:21.525021Z","end":"2026-02-18T22:51:21.723615Z","steps":["trace[398173035] 'process raft request' (duration: 191.108331ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T22:51:22.903738Z","caller":"traceutil/trace.go:171","msg":"trace[824494115] transaction","detail":"{read_only:false; response_revision:595; number_of_response:1; }","duration":"267.529157ms","start":"2026-02-18T22:51:22.635984Z","end":"2026-02-18T22:51:22.903513Z","steps":["trace[824494115] 'process raft request' (duration: 267.190065ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T22:51:22.911004Z","caller":"traceutil/trace.go:171","msg":"trace[1128816512] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"272.856294ms","start":"2026-02-18T22:51:22.638126Z","end":"2026-02-18T22:51:22.910982Z","steps":["trace[1128816512] 'process raft request' (duration: 272.038715ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T22:51:22.911533Z","caller":"traceutil/trace.go:171","msg":"trace[1726720572] transaction","detail":"{read_only:false; number_of_response:0; response_revision:596; }","duration":"273.057831ms","start":"2026-02-18T22:51:22.638456Z","end":"2026-02-18T22:51:22.911514Z","steps":["trace[1726720572] 'process raft request' (duration: 271.813078ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T22:51:22.913253Z","caller":"traceutil/trace.go:171","msg":"trace[1276537569] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"218.594366ms","start":"2026-02-18T22:51:22.694652Z","end":"2026-02-18T22:51:22.913246Z","steps":["trace[1276537569] 'process raft request' (duration: 216.816953ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T22:52:48.691407Z","caller":"traceutil/trace.go:171","msg":"trace[1567316980] linearizableReadLoop","detail":"{readStateIndex:1036; appliedIndex:1035; }","duration":"257.197117ms","start":"2026-02-18T22:52:48.434195Z","end":"2026-02-18T22:52:48.691392Z","steps":["trace[1567316980] 'read index received' (duration: 257.098826ms)","trace[1567316980] 'applied index is now lower than readState.Index' (duration: 97.581µs)"],"step_count":2} {"level":"warn","ts":"2026-02-18T22:52:48.691478Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T22:52:48.342097Z","time spent":"349.37867ms","remote":"127.0.0.1:34452","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-02-18T22:52:48.691683Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.477372ms","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-02-18T22:52:48.691702Z","caller":"traceutil/trace.go:171","msg":"trace[576176280] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:996; }","duration":"257.539533ms","start":"2026-02-18T22:52:48.434155Z","end":"2026-02-18T22:52:48.691695Z","steps":["trace[576176280] 'agreement among raft nodes before linearized reading' (duration: 257.454632ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T22:52:48.691803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.075453ms","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-02-18T22:52:48.691816Z","caller":"traceutil/trace.go:171","msg":"trace[284206667] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:996; }","duration":"158.120313ms","start":"2026-02-18T22:52:48.533691Z","end":"2026-02-18T22:52:48.691812Z","steps":["trace[284206667] 'agreement among raft nodes before linearized reading' (duration: 158.084742ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T22:52:48.809863Z","caller":"traceutil/trace.go:171","msg":"trace[365071916] transaction","detail":"{read_only:false; response_revision:997; number_of_response:1; }","duration":"115.206663ms","start":"2026-02-18T22:52:48.694634Z","end":"2026-02-18T22:52:48.809841Z","steps":["trace[365071916] 'process raft request' (duration: 115.085301ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T22:52:48.812367Z","caller":"traceutil/trace.go:171","msg":"trace[415461062] transaction","detail":"{read_only:false; response_revision:998; number_of_response:1; }","duration":"115.62677ms","start":"2026-02-18T22:52:48.696729Z","end":"2026-02-18T22:52:48.812356Z","steps":["trace[415461062] 'process raft request' (duration: 115.330665ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T22:52:48.812953Z","caller":"traceutil/trace.go:171","msg":"trace[1762680800] transaction","detail":"{read_only:false; response_revision:999; number_of_response:1; }","duration":"116.167618ms","start":"2026-02-18T22:52:48.696769Z","end":"2026-02-18T22:52:48.812937Z","steps":["trace[1762680800] 'process raft request' (duration: 115.343135ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T22:52:48.81323Z","caller":"traceutil/trace.go:171","msg":"trace[157099616] transaction","detail":"{read_only:false; response_revision:1000; number_of_response:1; }","duration":"114.520942ms","start":"2026-02-18T22:52:48.6987Z","end":"2026-02-18T22:52:48.813221Z","steps":["trace[157099616] 'process raft request' (duration: 113.436305ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T22:52:48.813507Z","caller":"traceutil/trace.go:171","msg":"trace[1152765637] transaction","detail":"{read_only:false; response_revision:1001; number_of_response:1; }","duration":"113.8158ms","start":"2026-02-18T22:52:48.699682Z","end":"2026-02-18T22:52:48.813498Z","steps":["trace[1152765637] 'process raft request' (duration: 112.472329ms)"],"step_count":1}