{"level":"warn","ts":"2026-04-20T14:30:24.218407Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-20T14:30:24.218503Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.19: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.19:2380","--initial-cluster=instance=https://199.204.45.19:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.19:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.19: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-04-20T14:30:24.218781Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-20T14:30:24.218813Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.19:2380"]} {"level":"info","ts":"2026-04-20T14:30:24.219173Z","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-04-20T14:30:24.220256Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.19:2379"]} {"level":"info","ts":"2026-04-20T14:30:24.220461Z","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.19:2380"],"listen-peer-urls":["https://199.204.45.19:2380"],"advertise-client-urls":["https://199.204.45.19:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.19:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.19: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-04-20T14:30:24.227995Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"7.185983ms"} {"level":"info","ts":"2026-04-20T14:30:24.23779Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"a847c2e9c7010db6","cluster-id":"2b11a68e27507b05"} {"level":"info","ts":"2026-04-20T14:30:24.237933Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 switched to configuration voters=()"} {"level":"info","ts":"2026-04-20T14:30:24.237962Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 became follower at term 0"} {"level":"info","ts":"2026-04-20T14:30:24.237983Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft a847c2e9c7010db6 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-20T14:30:24.237993Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 became follower at term 1"} {"level":"info","ts":"2026-04-20T14:30:24.238089Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 switched to configuration voters=(12125874831040253366)"} {"level":"warn","ts":"2026-04-20T14:30:24.248791Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-20T14:30:24.250724Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-20T14:30:24.253308Z","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-04-20T14:30:24.256512Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"a847c2e9c7010db6","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-20T14:30:24.256727Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"a847c2e9c7010db6","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-20T14:30:24.257319Z","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-04-20T14:30:24.257452Z","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-04-20T14:30:24.257467Z","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-04-20T14:30:24.258307Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 switched to configuration voters=(12125874831040253366)"} {"level":"info","ts":"2026-04-20T14:30:24.259015Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"2b11a68e27507b05","local-member-id":"a847c2e9c7010db6","added-peer-id":"a847c2e9c7010db6","added-peer-peer-urls":["https://199.204.45.19:2380"]} {"level":"info","ts":"2026-04-20T14:30:24.260886Z","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-04-20T14:30:24.261098Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.19:2380"} {"level":"info","ts":"2026-04-20T14:30:24.261133Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.19:2380"} {"level":"info","ts":"2026-04-20T14:30:24.261465Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"a847c2e9c7010db6","initial-advertise-peer-urls":["https://199.204.45.19:2380"],"listen-peer-urls":["https://199.204.45.19:2380"],"advertise-client-urls":["https://199.204.45.19:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.19:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-20T14:30:24.261514Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-20T14:30:25.239194Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 is starting a new election at term 1"} {"level":"info","ts":"2026-04-20T14:30:25.239263Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-20T14:30:25.239317Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 received MsgPreVoteResp from a847c2e9c7010db6 at term 1"} {"level":"info","ts":"2026-04-20T14:30:25.239338Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 became candidate at term 2"} {"level":"info","ts":"2026-04-20T14:30:25.23935Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 received MsgVoteResp from a847c2e9c7010db6 at term 2"} {"level":"info","ts":"2026-04-20T14:30:25.239366Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 became leader at term 2"} {"level":"info","ts":"2026-04-20T14:30:25.239381Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: a847c2e9c7010db6 elected leader a847c2e9c7010db6 at term 2"} {"level":"info","ts":"2026-04-20T14:30:25.24051Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T14:30:25.241395Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"a847c2e9c7010db6","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.19:2379]}","request-path":"/0/members/a847c2e9c7010db6/attributes","cluster-id":"2b11a68e27507b05","publish-timeout":"7s"} {"level":"info","ts":"2026-04-20T14:30:25.24163Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-20T14:30:25.241681Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-20T14:30:25.241712Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-20T14:30:25.241754Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-20T14:30:25.24503Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.19:2379"} {"level":"info","ts":"2026-04-20T14:30:25.245282Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-20T14:30:25.245931Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"2b11a68e27507b05","local-member-id":"a847c2e9c7010db6","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T14:30:25.248142Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T14:30:25.248333Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"warn","ts":"2026-04-20T14:30:40.696458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.007427ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T14:30:40.696665Z","caller":"traceutil/trace.go:171","msg":"trace[728450861] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:438; }","duration":"157.26118ms","start":"2026-04-20T14:30:40.539371Z","end":"2026-04-20T14:30:40.696633Z","steps":["trace[728450861] 'range keys from in-memory index tree' (duration: 156.907946ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:30:46.952658Z","caller":"traceutil/trace.go:171","msg":"trace[506818562] linearizableReadLoop","detail":"{readStateIndex:468; appliedIndex:467; }","duration":"115.336802ms","start":"2026-04-20T14:30:46.837297Z","end":"2026-04-20T14:30:46.952633Z","steps":["trace[506818562] 'read index received' (duration: 115.191461ms)","trace[506818562] 'applied index is now lower than readState.Index' (duration: 144.321µs)"],"step_count":2} {"level":"warn","ts":"2026-04-20T14:30:46.952787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.481103ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-20T14:30:46.952761Z","caller":"traceutil/trace.go:171","msg":"trace[539581228] transaction","detail":"{read_only:false; response_revision:453; number_of_response:1; }","duration":"450.932065ms","start":"2026-04-20T14:30:46.501791Z","end":"2026-04-20T14:30:46.952723Z","steps":["trace[539581228] 'process raft request' (duration: 450.716313ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:30:46.952834Z","caller":"traceutil/trace.go:171","msg":"trace[1155117507] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:453; }","duration":"115.577995ms","start":"2026-04-20T14:30:46.837244Z","end":"2026-04-20T14:30:46.952822Z","steps":["trace[1155117507] 'agreement among raft nodes before linearized reading' (duration: 115.489554ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:30:46.953509Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:30:46.501768Z","time spent":"451.109076ms","remote":"127.0.0.1:42848","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-04-20T14:30:51.38254Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.595189ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-20T14:30:51.382766Z","caller":"traceutil/trace.go:171","msg":"trace[2140490964] linearizableReadLoop","detail":"{readStateIndex:515; appliedIndex:514; }","duration":"339.893252ms","start":"2026-04-20T14:30:51.042845Z","end":"2026-04-20T14:30:51.382738Z","steps":["trace[2140490964] 'read index received' (duration: 9.620298ms)","trace[2140490964] 'applied index is now lower than readState.Index' (duration: 330.270354ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T14:30:51.382819Z","caller":"traceutil/trace.go:171","msg":"trace[1311077297] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"385.456055ms","start":"2026-04-20T14:30:50.997313Z","end":"2026-04-20T14:30:51.382769Z","steps":["trace[1311077297] 'process raft request' (duration: 55.16358ms)","trace[1311077297] 'compare' (duration: 329.203405ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T14:30:51.383006Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.098434ms","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-04-20T14:30:51.383098Z","caller":"traceutil/trace.go:171","msg":"trace[605009582] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:499; }","duration":"340.289175ms","start":"2026-04-20T14:30:51.042789Z","end":"2026-04-20T14:30:51.383078Z","steps":["trace[605009582] 'agreement among raft nodes before linearized reading' (duration: 340.051293ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:30:51.383132Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:30:50.997295Z","time spent":"385.688806ms","remote":"127.0.0.1:42848","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T14:30:51.383146Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:30:51.042762Z","time spent":"340.374506ms","remote":"127.0.0.1:42848","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-04-20T14:30:51.383176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.003975ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T14:30:51.383247Z","caller":"traceutil/trace.go:171","msg":"trace[1027415047] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:0; response_revision:499; }","duration":"252.128015ms","start":"2026-04-20T14:30:51.131096Z","end":"2026-04-20T14:30:51.383224Z","steps":["trace[1027415047] 'agreement among raft nodes before linearized reading' (duration: 252.001244ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:30:51.383884Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"334.732185ms","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-04-20T14:30:51.384109Z","caller":"traceutil/trace.go:171","msg":"trace[557688614] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:499; }","duration":"335.007408ms","start":"2026-04-20T14:30:51.049089Z","end":"2026-04-20T14:30:51.384096Z","steps":["trace[557688614] 'agreement among raft nodes before linearized reading' (duration: 333.959118ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:30:51.384176Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:30:51.049063Z","time spent":"335.095608ms","remote":"127.0.0.1:42848","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-04-20T14:30:52.627564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"675.590095ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-20T14:30:52.627766Z","caller":"traceutil/trace.go:171","msg":"trace[1160633793] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"715.705279ms","start":"2026-04-20T14:30:51.912019Z","end":"2026-04-20T14:30:52.627725Z","steps":["trace[1160633793] 'process raft request' (duration: 39.896932ms)","trace[1160633793] 'compare' (duration: 675.407124ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T14:30:52.627906Z","caller":"traceutil/trace.go:171","msg":"trace[985853025] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"683.670069ms","start":"2026-04-20T14:30:51.944222Z","end":"2026-04-20T14:30:52.627892Z","steps":["trace[985853025] 'process raft request' (duration: 683.607028ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:30:52.627929Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:30:51.911999Z","time spent":"715.85646ms","remote":"127.0.0.1:42640","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17062,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-20T14:30:52.62799Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:30:51.944203Z","time spent":"683.74562ms","remote":"127.0.0.1:42640","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":80688,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T14:30:52.628057Z","caller":"traceutil/trace.go:171","msg":"trace[1811523807] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"695.642628ms","start":"2026-04-20T14:30:51.932404Z","end":"2026-04-20T14:30:52.628046Z","steps":["trace[1811523807] 'process raft request' (duration: 695.279354ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:30:52.628124Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:30:51.932376Z","time spent":"695.708258ms","remote":"127.0.0.1:42640","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":65190,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T14:30:52.64011Z","caller":"traceutil/trace.go:171","msg":"trace[70890926] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"687.157291ms","start":"2026-04-20T14:30:51.952931Z","end":"2026-04-20T14:30:52.640088Z","steps":["trace[70890926] 'process raft request' (duration: 686.507626ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:30:52.640245Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:30:51.952912Z","time spent":"687.259852ms","remote":"127.0.0.1:42640","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":150480,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T14:30:57.812022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.526034ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T14:30:57.812117Z","caller":"traceutil/trace.go:171","msg":"trace[1109013323] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:605; }","duration":"273.661106ms","start":"2026-04-20T14:30:57.538439Z","end":"2026-04-20T14:30:57.8121Z","steps":["trace[1109013323] 'range keys from in-memory index tree' (duration: 273.466404ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:30:57.812159Z","caller":"traceutil/trace.go:171","msg":"trace[786713674] transaction","detail":"{read_only:false; response_revision:606; number_of_response:1; }","duration":"215.605879ms","start":"2026-04-20T14:30:57.596526Z","end":"2026-04-20T14:30:57.812132Z","steps":["trace[786713674] 'process raft request' (duration: 188.557489ms)","trace[786713674] 'compare' (duration: 26.906389ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T14:30:58.368795Z","caller":"traceutil/trace.go:171","msg":"trace[1463622284] linearizableReadLoop","detail":"{readStateIndex:630; appliedIndex:629; }","duration":"232.493604ms","start":"2026-04-20T14:30:58.136262Z","end":"2026-04-20T14:30:58.368755Z","steps":["trace[1463622284] 'read index received' (duration: 232.250842ms)","trace[1463622284] 'applied index is now lower than readState.Index' (duration: 241.602µs)"],"step_count":2} {"level":"info","ts":"2026-04-20T14:30:58.368915Z","caller":"traceutil/trace.go:171","msg":"trace[1429573464] transaction","detail":"{read_only:false; response_revision:608; number_of_response:1; }","duration":"410.748268ms","start":"2026-04-20T14:30:57.958155Z","end":"2026-04-20T14:30:58.368903Z","steps":["trace[1429573464] 'process raft request' (duration: 410.425975ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:30:58.369009Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:30:57.95813Z","time spent":"410.814608ms","remote":"127.0.0.1:43118","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-04-20T14:30:58.369209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.929278ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-2cmh8\" ","response":"range_response_count:1 size:16961"} {"level":"warn","ts":"2026-04-20T14:30:58.369227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.087026ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.19\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-04-20T14:30:58.369285Z","caller":"traceutil/trace.go:171","msg":"trace[1604027035] range","detail":"{range_begin:/registry/pods/kube-system/cilium-2cmh8; range_end:; response_count:1; response_revision:608; }","duration":"233.039729ms","start":"2026-04-20T14:30:58.136226Z","end":"2026-04-20T14:30:58.369265Z","steps":["trace[1604027035] 'agreement among raft nodes before linearized reading' (duration: 232.853787ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:30:58.369316Z","caller":"traceutil/trace.go:171","msg":"trace[969394828] range","detail":"{range_begin:/registry/masterleases/199.204.45.19; range_end:; response_count:1; response_revision:608; }","duration":"174.366958ms","start":"2026-04-20T14:30:58.194927Z","end":"2026-04-20T14:30:58.369294Z","steps":["trace[969394828] 'agreement among raft nodes before linearized reading' (duration: 174.054675ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:30:58.549645Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.99559ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:40"} {"level":"info","ts":"2026-04-20T14:30:58.549914Z","caller":"traceutil/trace.go:171","msg":"trace[1663285979] linearizableReadLoop","detail":"{readStateIndex:631; appliedIndex:630; }","duration":"170.724125ms","start":"2026-04-20T14:30:58.379175Z","end":"2026-04-20T14:30:58.549899Z","steps":["trace[1663285979] 'read index received' (duration: 18.475603ms)","trace[1663285979] 'applied index is now lower than readState.Index' (duration: 152.246922ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T14:30:58.550119Z","caller":"traceutil/trace.go:171","msg":"trace[1879373452] transaction","detail":"{read_only:false; response_revision:609; number_of_response:1; }","duration":"164.48414ms","start":"2026-04-20T14:30:58.385625Z","end":"2026-04-20T14:30:58.550109Z","steps":["trace[1879373452] 'process raft request' (duration: 164.110897ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:30:58.550049Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.834076ms","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-04-20T14:30:58.550378Z","caller":"traceutil/trace.go:171","msg":"trace[2098053318] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:608; }","duration":"171.21619ms","start":"2026-04-20T14:30:58.37915Z","end":"2026-04-20T14:30:58.550366Z","steps":["trace[2098053318] 'agreement among raft nodes before linearized reading' (duration: 170.835907ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:30:59.539812Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":988150527306298138,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-20T14:31:00.040704Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":988150527306298138,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-20T14:31:00.167588Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.184723263s","expected-duration":"1s"} {"level":"info","ts":"2026-04-20T14:31:00.168712Z","caller":"traceutil/trace.go:171","msg":"trace[1520798911] linearizableReadLoop","detail":"{readStateIndex:634; appliedIndex:633; }","duration":"1.129727126s","start":"2026-04-20T14:30:59.038957Z","end":"2026-04-20T14:31:00.168684Z","steps":["trace[1520798911] 'read index received' (duration: 1.128842899s)","trace[1520798911] 'applied index is now lower than readState.Index' (duration: 880.157µs)"],"step_count":2} {"level":"info","ts":"2026-04-20T14:31:00.168989Z","caller":"traceutil/trace.go:171","msg":"trace[1476032462] transaction","detail":"{read_only:false; response_revision:611; number_of_response:1; }","duration":"1.187090563s","start":"2026-04-20T14:30:58.981862Z","end":"2026-04-20T14:31:00.168953Z","steps":["trace[1476032462] 'process raft request' (duration: 1.186201516s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:31:00.169092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"741.693891ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-20T14:31:00.169132Z","caller":"traceutil/trace.go:171","msg":"trace[356944617] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:611; }","duration":"741.752262ms","start":"2026-04-20T14:30:59.427368Z","end":"2026-04-20T14:31:00.16912Z","steps":["trace[356944617] 'agreement among raft nodes before linearized reading' (duration: 741.68291ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:31:00.16917Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:30:59.427334Z","time spent":"741.826823ms","remote":"127.0.0.1:42848","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-20T14:31:00.169172Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:30:58.981836Z","time spent":"1.187225725s","remote":"127.0.0.1:42680","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036197,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T14:31:00.169377Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"628.666971ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T14:31:00.169404Z","caller":"traceutil/trace.go:171","msg":"trace[270012082] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:611; }","duration":"628.711871ms","start":"2026-04-20T14:30:59.540686Z","end":"2026-04-20T14:31:00.169398Z","steps":["trace[270012082] 'agreement among raft nodes before linearized reading' (duration: 628.672561ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:31:00.169422Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:30:59.540661Z","time spent":"628.757871ms","remote":"127.0.0.1:42564","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-04-20T14:31:00.169007Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.130034078s","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-04-20T14:31:00.169531Z","caller":"traceutil/trace.go:171","msg":"trace[1181159813] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:611; }","duration":"1.130596924s","start":"2026-04-20T14:30:59.038918Z","end":"2026-04-20T14:31:00.169515Z","steps":["trace[1181159813] 'agreement among raft nodes before linearized reading' (duration: 1.129951388s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:31:00.169555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"741.146476ms","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-04-20T14:31:00.169573Z","caller":"traceutil/trace.go:171","msg":"trace[1948939251] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:611; }","duration":"741.197367ms","start":"2026-04-20T14:30:59.42837Z","end":"2026-04-20T14:31:00.169567Z","steps":["trace[1948939251] 'agreement among raft nodes before linearized reading' (duration: 741.130537ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:31:00.169579Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:30:59.038902Z","time spent":"1.130663444s","remote":"127.0.0.1:42848","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-04-20T14:31:00.169638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"742.102275ms","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-04-20T14:31:00.16966Z","caller":"traceutil/trace.go:171","msg":"trace[1916838627] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:611; }","duration":"742.123735ms","start":"2026-04-20T14:30:59.427532Z","end":"2026-04-20T14:31:00.169655Z","steps":["trace[1916838627] 'agreement among raft nodes before linearized reading' (duration: 742.071725ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:31:00.169701Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:30:59.427468Z","time spent":"742.224486ms","remote":"127.0.0.1:42848","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-20T14:31:00.169593Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:30:59.428362Z","time spent":"741.227037ms","remote":"127.0.0.1:42848","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-04-20T14:31:00.303813Z","caller":"traceutil/trace.go:171","msg":"trace[1837775092] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"125.875121ms","start":"2026-04-20T14:31:00.177906Z","end":"2026-04-20T14:31:00.303781Z","steps":["trace[1837775092] 'process raft request' (duration: 123.912033ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:31:00.304272Z","caller":"traceutil/trace.go:171","msg":"trace[154504159] transaction","detail":"{read_only:false; response_revision:614; number_of_response:1; }","duration":"126.259974ms","start":"2026-04-20T14:31:00.177984Z","end":"2026-04-20T14:31:00.304244Z","steps":["trace[154504159] 'process raft request' (duration: 125.71246ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:31:00.304458Z","caller":"traceutil/trace.go:171","msg":"trace[1331291994] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"124.359997ms","start":"2026-04-20T14:31:00.180088Z","end":"2026-04-20T14:31:00.304448Z","steps":["trace[1331291994] 'process raft request' (duration: 123.999924ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:31:12.457108Z","caller":"traceutil/trace.go:171","msg":"trace[1973142309] transaction","detail":"{read_only:false; response_revision:750; number_of_response:1; }","duration":"159.041451ms","start":"2026-04-20T14:31:12.298039Z","end":"2026-04-20T14:31:12.457081Z","steps":["trace[1973142309] 'process raft request' (duration: 135.796422ms)","trace[1973142309] 'compare' (duration: 23.046978ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T14:31:12.79494Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.223024ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-20T14:31:12.795123Z","caller":"traceutil/trace.go:171","msg":"trace[456430662] linearizableReadLoop","detail":"{readStateIndex:777; appliedIndex:775; }","duration":"492.507811ms","start":"2026-04-20T14:31:12.302599Z","end":"2026-04-20T14:31:12.795106Z","steps":["trace[456430662] 'read index received' (duration: 131.249822ms)","trace[456430662] 'applied index is now lower than readState.Index' (duration: 361.257139ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T14:31:12.795365Z","caller":"traceutil/trace.go:171","msg":"trace[641741749] transaction","detail":"{read_only:false; response_revision:751; number_of_response:1; }","duration":"496.505526ms","start":"2026-04-20T14:31:12.298835Z","end":"2026-04-20T14:31:12.795341Z","steps":["trace[641741749] 'process raft request' (duration: 353.796307ms)","trace[641741749] 'compare' (duration: 141.996123ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T14:31:12.795494Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.492077ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T14:31:12.795746Z","caller":"traceutil/trace.go:171","msg":"trace[1287095992] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:752; }","duration":"253.848551ms","start":"2026-04-20T14:31:12.54188Z","end":"2026-04-20T14:31:12.795728Z","steps":["trace[1287095992] 'agreement among raft nodes before linearized reading' (duration: 253.551139ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:31:12.795485Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:31:12.298826Z","time spent":"496.606027ms","remote":"127.0.0.1:42758","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":781,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T14:31:12.79538Z","caller":"traceutil/trace.go:171","msg":"trace[378609202] transaction","detail":"{read_only:false; response_revision:752; number_of_response:1; }","duration":"492.576552ms","start":"2026-04-20T14:31:12.302788Z","end":"2026-04-20T14:31:12.795364Z","steps":["trace[378609202] 'process raft request' (duration: 492.251489ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:31:12.795916Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:31:12.302781Z","time spent":"493.073276ms","remote":"127.0.0.1:42772","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4856,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T14:31:12.79552Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"403.41166ms","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-04-20T14:31:12.796097Z","caller":"traceutil/trace.go:171","msg":"trace[1159973469] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:752; }","duration":"403.977875ms","start":"2026-04-20T14:31:12.392052Z","end":"2026-04-20T14:31:12.79603Z","steps":["trace[1159973469] 'agreement among raft nodes before linearized reading' (duration: 403.32806ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:31:12.795565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"390.869684ms","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-04-20T14:31:12.79623Z","caller":"traceutil/trace.go:171","msg":"trace[638157662] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:752; }","duration":"391.564469ms","start":"2026-04-20T14:31:12.404651Z","end":"2026-04-20T14:31:12.796216Z","steps":["trace[638157662] 'agreement among raft nodes before linearized reading' (duration: 390.788783ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:31:12.796271Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:31:12.404639Z","time spent":"391.62242ms","remote":"127.0.0.1:42848","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-20T14:31:12.796284Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:31:12.392035Z","time spent":"404.166157ms","remote":"127.0.0.1:42848","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-20T14:31:12.795643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"395.504843ms","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-04-20T14:31:12.796366Z","caller":"traceutil/trace.go:171","msg":"trace[1564076331] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:752; }","duration":"396.249698ms","start":"2026-04-20T14:31:12.400095Z","end":"2026-04-20T14:31:12.796345Z","steps":["trace[1564076331] 'agreement among raft nodes before linearized reading' (duration: 395.429672ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:31:12.796446Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:31:12.400081Z","time spent":"396.34951ms","remote":"127.0.0.1:42848","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-20T14:31:12.795684Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"493.079087ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-20T14:31:12.796546Z","caller":"traceutil/trace.go:171","msg":"trace[1922060870] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:752; }","duration":"493.960684ms","start":"2026-04-20T14:31:12.302575Z","end":"2026-04-20T14:31:12.796536Z","steps":["trace[1922060870] 'agreement among raft nodes before linearized reading' (duration: 493.014626ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:31:12.79658Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:31:12.302566Z","time spent":"494.006254ms","remote":"127.0.0.1:42848","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-20T14:31:13.131097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.234339ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-20T14:31:13.131197Z","caller":"traceutil/trace.go:171","msg":"trace[1018773293] transaction","detail":"{read_only:false; response_revision:753; number_of_response:1; }","duration":"330.582705ms","start":"2026-04-20T14:31:12.800592Z","end":"2026-04-20T14:31:13.131175Z","steps":["trace[1018773293] 'process raft request' (duration: 123.196924ms)","trace[1018773293] 'compare' (duration: 207.110748ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T14:31:13.131243Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:31:12.80057Z","time spent":"330.653216ms","remote":"127.0.0.1:42848","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T14:31:13.212512Z","caller":"traceutil/trace.go:171","msg":"trace[1255675562] transaction","detail":"{read_only:false; response_revision:755; number_of_response:1; }","duration":"411.765947ms","start":"2026-04-20T14:31:12.800729Z","end":"2026-04-20T14:31:13.212495Z","steps":["trace[1255675562] 'process raft request' (duration: 411.714167ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:31:13.212555Z","caller":"traceutil/trace.go:171","msg":"trace[836917588] transaction","detail":"{read_only:false; response_revision:754; number_of_response:1; }","duration":"411.853508ms","start":"2026-04-20T14:31:12.800681Z","end":"2026-04-20T14:31:13.212534Z","steps":["trace[836917588] 'process raft request' (duration: 411.655077ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:31:13.212628Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:31:12.800718Z","time spent":"411.850479ms","remote":"127.0.0.1:42848","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-04-20T14:31:13.212653Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:31:12.800655Z","time spent":"411.94523ms","remote":"127.0.0.1:42848","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-04-20T14:31:13.212784Z","caller":"traceutil/trace.go:171","msg":"trace[209520388] transaction","detail":"{read_only:false; response_revision:756; number_of_response:1; }","duration":"411.507155ms","start":"2026-04-20T14:31:12.801265Z","end":"2026-04-20T14:31:13.212772Z","steps":["trace[209520388] 'process raft request' (duration: 411.203412ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:31:13.212843Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:31:12.801251Z","time spent":"411.568516ms","remote":"127.0.0.1:42848","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T14:31:13.212985Z","caller":"traceutil/trace.go:171","msg":"trace[1745538744] transaction","detail":"{read_only:false; response_revision:757; number_of_response:1; }","duration":"411.167893ms","start":"2026-04-20T14:31:12.801804Z","end":"2026-04-20T14:31:13.212972Z","steps":["trace[1745538744] 'process raft request' (duration: 410.923231ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:31:13.213246Z","caller":"traceutil/trace.go:171","msg":"trace[1440073024] transaction","detail":"{read_only:false; response_revision:758; number_of_response:1; }","duration":"411.372664ms","start":"2026-04-20T14:31:12.801853Z","end":"2026-04-20T14:31:13.213225Z","steps":["trace[1440073024] 'process raft request' (duration: 410.989771ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:31:13.213384Z","caller":"traceutil/trace.go:171","msg":"trace[1581256202] transaction","detail":"{read_only:false; response_revision:759; number_of_response:1; }","duration":"410.363845ms","start":"2026-04-20T14:31:12.802999Z","end":"2026-04-20T14:31:13.213363Z","steps":["trace[1581256202] 'process raft request' (duration: 410.092263ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:31:13.213637Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:31:12.801845Z","time spent":"411.504416ms","remote":"127.0.0.1:42758","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":781,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T14:31:13.213763Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:31:12.80298Z","time spent":"410.465007ms","remote":"127.0.0.1:43090","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3852,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T14:31:13.213059Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:31:12.801791Z","time spent":"411.232763ms","remote":"127.0.0.1:42850","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1290,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T14:31:17.380403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.173766ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-04-20T14:31:17.380444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.187245ms","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-04-20T14:31:17.380523Z","caller":"traceutil/trace.go:171","msg":"trace[2028471573] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:775; }","duration":"146.296657ms","start":"2026-04-20T14:31:17.234208Z","end":"2026-04-20T14:31:17.380504Z","steps":["trace[2028471573] 'range keys from in-memory index tree' (duration: 146.048135ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:31:17.380521Z","caller":"traceutil/trace.go:171","msg":"trace[543351600] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:775; }","duration":"146.329457ms","start":"2026-04-20T14:31:17.234167Z","end":"2026-04-20T14:31:17.380496Z","steps":["trace[543351600] 'range keys from in-memory index tree' (duration: 145.992904ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:31:17.380553Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"333.505801ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T14:31:17.380638Z","caller":"traceutil/trace.go:171","msg":"trace[903192595] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:775; }","duration":"333.592682ms","start":"2026-04-20T14:31:17.047035Z","end":"2026-04-20T14:31:17.380627Z","steps":["trace[903192595] 'range keys from in-memory index tree' (duration: 333.49643ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:31:17.380763Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.980545ms","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-04-20T14:31:17.380805Z","caller":"traceutil/trace.go:171","msg":"trace[157005490] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:775; }","duration":"237.052135ms","start":"2026-04-20T14:31:17.143742Z","end":"2026-04-20T14:31:17.380795Z","steps":["trace[157005490] 'range keys from in-memory index tree' (duration: 236.853652ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:31:17.38099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.112173ms","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-04-20T14:31:17.381074Z","caller":"traceutil/trace.go:171","msg":"trace[1014933522] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:775; }","duration":"154.248064ms","start":"2026-04-20T14:31:17.226802Z","end":"2026-04-20T14:31:17.38105Z","steps":["trace[1014933522] 'range keys from in-memory index tree' (duration: 153.886211ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:31:17.752065Z","caller":"traceutil/trace.go:171","msg":"trace[1193107614] transaction","detail":"{read_only:false; response_revision:776; number_of_response:1; }","duration":"503.423707ms","start":"2026-04-20T14:31:17.248614Z","end":"2026-04-20T14:31:17.752038Z","steps":["trace[1193107614] 'process raft request' (duration: 503.277086ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:31:17.752415Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:31:17.248594Z","time spent":"503.677829ms","remote":"127.0.0.1:42816","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T14:31:17.787217Z","caller":"traceutil/trace.go:171","msg":"trace[1484418258] transaction","detail":"{read_only:false; response_revision:778; number_of_response:1; }","duration":"401.612237ms","start":"2026-04-20T14:31:17.385585Z","end":"2026-04-20T14:31:17.787197Z","steps":["trace[1484418258] 'process raft request' (duration: 401.535806ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:31:17.787253Z","caller":"traceutil/trace.go:171","msg":"trace[1869965315] transaction","detail":"{read_only:false; response_revision:777; number_of_response:1; }","duration":"402.628635ms","start":"2026-04-20T14:31:17.384589Z","end":"2026-04-20T14:31:17.787218Z","steps":["trace[1869965315] 'process raft request' (duration: 397.584872ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:31:17.787551Z","caller":"traceutil/trace.go:171","msg":"trace[1060268661] linearizableReadLoop","detail":"{readStateIndex:807; appliedIndex:802; }","duration":"245.268324ms","start":"2026-04-20T14:31:17.542248Z","end":"2026-04-20T14:31:17.787516Z","steps":["trace[1060268661] 'read index received' (duration: 209.759184ms)","trace[1060268661] 'applied index is now lower than readState.Index' (duration: 35.50793ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T14:31:17.787556Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:31:17.38554Z","time spent":"401.828968ms","remote":"127.0.0.1:42848","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-04-20T14:31:17.787619Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:31:17.384562Z","time spent":"402.939298ms","remote":"127.0.0.1:42848","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-04-20T14:31:17.787684Z","caller":"traceutil/trace.go:171","msg":"trace[283908873] transaction","detail":"{read_only:false; response_revision:779; number_of_response:1; }","duration":"402.016389ms","start":"2026-04-20T14:31:17.38562Z","end":"2026-04-20T14:31:17.787637Z","steps":["trace[283908873] 'process raft request' (duration: 401.542276ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:31:17.787799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.419835ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T14:31:17.787735Z","caller":"traceutil/trace.go:171","msg":"trace[1044709532] transaction","detail":"{read_only:false; response_revision:780; number_of_response:1; }","duration":"401.890499ms","start":"2026-04-20T14:31:17.385714Z","end":"2026-04-20T14:31:17.787605Z","steps":["trace[1044709532] 'process raft request' (duration: 401.681277ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:31:17.78785Z","caller":"traceutil/trace.go:171","msg":"trace[217452113] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:780; }","duration":"245.630467ms","start":"2026-04-20T14:31:17.542205Z","end":"2026-04-20T14:31:17.787835Z","steps":["trace[217452113] 'agreement among raft nodes before linearized reading' (duration: 245.425775ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:31:17.787863Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:31:17.385594Z","time spent":"402.181541ms","remote":"127.0.0.1:42848","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-04-20T14:31:17.787989Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:31:17.385703Z","time spent":"402.154411ms","remote":"127.0.0.1:42848","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T14:31:48.97991Z","caller":"traceutil/trace.go:171","msg":"trace[436814199] transaction","detail":"{read_only:false; response_revision:1010; number_of_response:1; }","duration":"143.189274ms","start":"2026-04-20T14:31:48.836675Z","end":"2026-04-20T14:31:48.979864Z","steps":["trace[436814199] 'process raft request' (duration: 142.983373ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:32:00.509689Z","caller":"traceutil/trace.go:171","msg":"trace[644069787] transaction","detail":"{read_only:false; response_revision:1084; number_of_response:1; }","duration":"178.657114ms","start":"2026-04-20T14:32:00.331004Z","end":"2026-04-20T14:32:00.509661Z","steps":["trace[644069787] 'process raft request' (duration: 178.476903ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:32:00.510584Z","caller":"traceutil/trace.go:171","msg":"trace[147731178] transaction","detail":"{read_only:false; response_revision:1085; number_of_response:1; }","duration":"179.098018ms","start":"2026-04-20T14:32:00.331445Z","end":"2026-04-20T14:32:00.510543Z","steps":["trace[147731178] 'process raft request' (duration: 178.894867ms)"],"step_count":1}