{"level":"warn","ts":"2026-04-11T02:11:12.901268Z","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-11T02:11:12.901409Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.35: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.35:2380","--initial-cluster=instance=https://199.204.45.35:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.35:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.35: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-11T02:11:12.901503Z","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-11T02:11:12.901519Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.35:2380"]} {"level":"info","ts":"2026-04-11T02:11:12.901544Z","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-11T02:11:12.902559Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.35:2379"]} {"level":"info","ts":"2026-04-11T02:11:12.902662Z","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.35:2380"],"listen-peer-urls":["https://199.204.45.35:2380"],"advertise-client-urls":["https://199.204.45.35:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.35:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.35: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-11T02:11:12.907726Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.805623ms"} {"level":"info","ts":"2026-04-11T02:11:12.914471Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"fb85913747d92cac","cluster-id":"636a84d5a3ba9c31"} {"level":"info","ts":"2026-04-11T02:11:12.914549Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac switched to configuration voters=()"} {"level":"info","ts":"2026-04-11T02:11:12.914574Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac became follower at term 0"} {"level":"info","ts":"2026-04-11T02:11:12.914586Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft fb85913747d92cac [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-11T02:11:12.914594Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac became follower at term 1"} {"level":"info","ts":"2026-04-11T02:11:12.914624Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac switched to configuration voters=(18124051942037073068)"} {"level":"warn","ts":"2026-04-11T02:11:12.920583Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-11T02:11:12.922035Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-11T02:11:12.923293Z","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-11T02:11:12.926264Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"fb85913747d92cac","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-11T02:11:12.928589Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"fb85913747d92cac","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-11T02:11:12.93039Z","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-11T02:11:12.930499Z","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-11T02:11:12.930516Z","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-11T02:11:12.931232Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac switched to configuration voters=(18124051942037073068)"} {"level":"info","ts":"2026-04-11T02:11:12.931364Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"636a84d5a3ba9c31","local-member-id":"fb85913747d92cac","added-peer-id":"fb85913747d92cac","added-peer-peer-urls":["https://199.204.45.35:2380"]} {"level":"info","ts":"2026-04-11T02:11:12.93564Z","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-11T02:11:12.935713Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.35:2380"} {"level":"info","ts":"2026-04-11T02:11:12.935739Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.35:2380"} {"level":"info","ts":"2026-04-11T02:11:12.935932Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"fb85913747d92cac","initial-advertise-peer-urls":["https://199.204.45.35:2380"],"listen-peer-urls":["https://199.204.45.35:2380"],"advertise-client-urls":["https://199.204.45.35:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.35:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-11T02:11:12.936083Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-11T02:11:13.415301Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac is starting a new election at term 1"} {"level":"info","ts":"2026-04-11T02:11:13.415358Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac became pre-candidate at term 1"} {"level":"info","ts":"2026-04-11T02:11:13.415391Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac received MsgPreVoteResp from fb85913747d92cac at term 1"} {"level":"info","ts":"2026-04-11T02:11:13.415415Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac became candidate at term 2"} {"level":"info","ts":"2026-04-11T02:11:13.415431Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac received MsgVoteResp from fb85913747d92cac at term 2"} {"level":"info","ts":"2026-04-11T02:11:13.415452Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac became leader at term 2"} {"level":"info","ts":"2026-04-11T02:11:13.415469Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: fb85913747d92cac elected leader fb85913747d92cac at term 2"} {"level":"info","ts":"2026-04-11T02:11:13.418001Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-11T02:11:13.418408Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"fb85913747d92cac","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.35:2379]}","request-path":"/0/members/fb85913747d92cac/attributes","cluster-id":"636a84d5a3ba9c31","publish-timeout":"7s"} {"level":"info","ts":"2026-04-11T02:11:13.418454Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-11T02:11:13.418791Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"636a84d5a3ba9c31","local-member-id":"fb85913747d92cac","cluster-version":"3.5"} {"level":"info","ts":"2026-04-11T02:11:13.418882Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-11T02:11:13.419332Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-11T02:11:13.419381Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-11T02:11:13.422204Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.35:2379"} {"level":"info","ts":"2026-04-11T02:11:13.422416Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-11T02:11:13.422451Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-11T02:11:13.42325Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-04-11T02:11:43.910557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.990318ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/httproutes.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:151236"} {"level":"info","ts":"2026-04-11T02:11:43.91075Z","caller":"traceutil/trace.go:171","msg":"trace[603818006] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/httproutes.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:545; }","duration":"216.242693ms","start":"2026-04-11T02:11:43.694482Z","end":"2026-04-11T02:11:43.910725Z","steps":["trace[603818006] 'range keys from in-memory index tree' (duration: 215.725262ms)"],"step_count":1} {"level":"warn","ts":"2026-04-11T02:11:43.912938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.741842ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/envoyproxies.gateway.envoyproxy.io\" ","response":"range_response_count:1 size:570096"} {"level":"info","ts":"2026-04-11T02:11:43.912991Z","caller":"traceutil/trace.go:171","msg":"trace[1304103074] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/envoyproxies.gateway.envoyproxy.io; range_end:; response_count:1; response_revision:545; }","duration":"228.827534ms","start":"2026-04-11T02:11:43.68415Z","end":"2026-04-11T02:11:43.912978Z","steps":["trace[1304103074] 'range keys from in-memory index tree' (duration: 226.849192ms)"],"step_count":1} {"level":"info","ts":"2026-04-11T02:11:43.923639Z","caller":"traceutil/trace.go:171","msg":"trace[1547425399] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"214.633179ms","start":"2026-04-11T02:11:43.708989Z","end":"2026-04-11T02:11:43.923622Z","steps":["trace[1547425399] 'process raft request' (duration: 213.878263ms)"],"step_count":1} {"level":"warn","ts":"2026-04-11T02:11:49.552749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.535118ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-vfx5z\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-04-11T02:11:49.55287Z","caller":"traceutil/trace.go:171","msg":"trace[1335878148] range","detail":"{range_begin:/registry/pods/kube-system/cilium-vfx5z; range_end:; response_count:1; response_revision:580; }","duration":"289.693112ms","start":"2026-04-11T02:11:49.263138Z","end":"2026-04-11T02:11:49.552831Z","steps":["trace[1335878148] 'range keys from in-memory index tree' (duration: 289.14411ms)"],"step_count":1} {"level":"warn","ts":"2026-04-11T02:11:49.552989Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"503.412061ms","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-11T02:11:49.553039Z","caller":"traceutil/trace.go:171","msg":"trace[862129887] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:580; }","duration":"503.485983ms","start":"2026-04-11T02:11:49.049541Z","end":"2026-04-11T02:11:49.553027Z","steps":["trace[862129887] 'range keys from in-memory index tree' (duration: 503.328129ms)"],"step_count":1} {"level":"warn","ts":"2026-04-11T02:11:49.552709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"529.662064ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-04-11T02:11:49.553298Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-11T02:11:49.049527Z","time spent":"503.534513ms","remote":"127.0.0.1:56114","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":"info","ts":"2026-04-11T02:11:49.55342Z","caller":"traceutil/trace.go:171","msg":"trace[809307370] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:580; }","duration":"530.383789ms","start":"2026-04-11T02:11:49.02294Z","end":"2026-04-11T02:11:49.553324Z","steps":["trace[809307370] 'range keys from in-memory index tree' (duration: 529.416239ms)"],"step_count":1} {"level":"warn","ts":"2026-04-11T02:11:49.553598Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-11T02:11:49.022921Z","time spent":"530.643205ms","remote":"127.0.0.1:56114","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-04-11T02:11:49.554434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"468.377308ms","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-11T02:11:49.554513Z","caller":"traceutil/trace.go:171","msg":"trace[1419915270] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:580; }","duration":"468.493811ms","start":"2026-04-11T02:11:49.085997Z","end":"2026-04-11T02:11:49.554491Z","steps":["trace[1419915270] 'range keys from in-memory index tree' (duration: 465.771352ms)"],"step_count":1} {"level":"warn","ts":"2026-04-11T02:11:49.554581Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-11T02:11:49.085991Z","time spent":"468.560312ms","remote":"127.0.0.1:56114","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-04-11T02:11:49.559463Z","caller":"traceutil/trace.go:171","msg":"trace[2068137390] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"208.786464ms","start":"2026-04-11T02:11:49.350628Z","end":"2026-04-11T02:11:49.559414Z","steps":["trace[2068137390] 'process raft request' (duration: 192.289469ms)","trace[2068137390] 'compare' (duration: 10.366293ms)"],"step_count":2} {"level":"info","ts":"2026-04-11T02:12:44.000708Z","caller":"traceutil/trace.go:171","msg":"trace[1668544392] transaction","detail":"{read_only:false; response_revision:963; number_of_response:1; }","duration":"116.209804ms","start":"2026-04-11T02:12:43.88447Z","end":"2026-04-11T02:12:44.00068Z","steps":["trace[1668544392] 'process raft request' (duration: 114.303483ms)"],"step_count":1} {"level":"warn","ts":"2026-04-11T02:13:14.331444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.863402ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-11T02:13:14.331566Z","caller":"traceutil/trace.go:171","msg":"trace[829749910] linearizableReadLoop","detail":"{readStateIndex:1107; appliedIndex:1105; }","duration":"162.923829ms","start":"2026-04-11T02:13:14.168624Z","end":"2026-04-11T02:13:14.331548Z","steps":["trace[829749910] 'read index received' (duration: 14.284248ms)","trace[829749910] 'applied index is now lower than readState.Index' (duration: 148.635871ms)"],"step_count":2} {"level":"info","ts":"2026-04-11T02:13:14.331672Z","caller":"traceutil/trace.go:171","msg":"trace[331650594] transaction","detail":"{read_only:false; response_revision:1065; number_of_response:1; }","duration":"239.117841ms","start":"2026-04-11T02:13:14.092486Z","end":"2026-04-11T02:13:14.331603Z","steps":["trace[331650594] 'process raft request' (duration: 98.501082ms)","trace[331650594] 'compare' (duration: 139.670229ms)"],"step_count":2} {"level":"warn","ts":"2026-04-11T02:13:14.331751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.121784ms","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-11T02:13:14.331779Z","caller":"traceutil/trace.go:171","msg":"trace[292714938] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1065; }","duration":"163.174754ms","start":"2026-04-11T02:13:14.168595Z","end":"2026-04-11T02:13:14.33177Z","steps":["trace[292714938] 'agreement among raft nodes before linearized reading' (duration: 162.99946ms)"],"step_count":1} {"level":"info","ts":"2026-04-11T02:13:27.635467Z","caller":"traceutil/trace.go:171","msg":"trace[509454976] transaction","detail":"{read_only:false; response_revision:1159; number_of_response:1; }","duration":"244.856774ms","start":"2026-04-11T02:13:27.390577Z","end":"2026-04-11T02:13:27.635434Z","steps":["trace[509454976] 'process raft request' (duration: 244.68894ms)"],"step_count":1} {"level":"warn","ts":"2026-04-11T02:13:38.361279Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3219120982295419994,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-11T02:13:38.862422Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3219120982295419994,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-11T02:13:39.363057Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3219120982295419994,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-11T02:13:39.863586Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3219120982295419994,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-11T02:13:40.364551Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3219120982295419994,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-11T02:13:40.865474Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3219120982295419994,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-11T02:13:41.366132Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3219120982295419994,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-11T02:13:41.628313Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.00028759s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-04-11T02:13:41.628438Z","caller":"traceutil/trace.go:171","msg":"trace[182269634] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000455384s","start":"2026-04-11T02:13:39.627961Z","end":"2026-04-11T02:13:41.628416Z","steps":["trace[182269634] 'agreement among raft nodes before linearized reading' (duration: 2.000314071s)"],"step_count":1} {"level":"warn","ts":"2026-04-11T02:13:41.628493Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-11T02:13:39.627945Z","time spent":"2.000536915s","remote":"127.0.0.1:55802","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-11T02:13:41.867355Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3219120982295419994,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-11T02:13:42.368162Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3219120982295419994,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-11T02:13:42.735627Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-11T02:13:37.72755Z","time spent":"5.008071092s","remote":"127.0.0.1:56114","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""} 2026/04/11 02:13:42 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-04-11T02:13:42.864455Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-11T02:13:37.866201Z","time spent":"4.998241523s","remote":"127.0.0.1:56114","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""} {"level":"warn","ts":"2026-04-11T02:13:42.868881Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3219120982295419994,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-11T02:13:43.274567Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.999694456s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-04-11T02:13:43.274717Z","caller":"traceutil/trace.go:171","msg":"trace[1356985850] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; }","duration":"4.999952061s","start":"2026-04-11T02:13:38.274744Z","end":"2026-04-11T02:13:43.274696Z","steps":["trace[1356985850] 'agreement among raft nodes before linearized reading' (duration: 4.999740727s)"],"step_count":1} {"level":"warn","ts":"2026-04-11T02:13:43.274763Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-11T02:13:38.274693Z","time spent":"5.000059993s","remote":"127.0.0.1:56114","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} 2026/04/11 02:13:43 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-04-11T02:13:43.369484Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3219120982295419994,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-11T02:13:43.425856Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.999340147s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-04-11T02:13:43.425947Z","caller":"traceutil/trace.go:171","msg":"trace[720246832] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; }","duration":"4.9994895s","start":"2026-04-11T02:13:38.426436Z","end":"2026-04-11T02:13:43.425925Z","steps":["trace[720246832] 'agreement among raft nodes before linearized reading' (duration: 4.999377028s)"],"step_count":1} {"level":"warn","ts":"2026-04-11T02:13:43.425994Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-11T02:13:38.426415Z","time spent":"4.999570003s","remote":"127.0.0.1:56114","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} 2026/04/11 02:13:43 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-04-11T02:13:43.466855Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"5.739216122s","expected-duration":"1s"} {"level":"info","ts":"2026-04-11T02:13:43.475822Z","caller":"traceutil/trace.go:171","msg":"trace[260549502] transaction","detail":"{read_only:false; response_revision:1195; number_of_response:1; }","duration":"2.047742816s","start":"2026-04-11T02:13:41.428059Z","end":"2026-04-11T02:13:43.475802Z","steps":["trace[260549502] 'process raft request' (duration: 2.047665315s)"],"step_count":1} {"level":"info","ts":"2026-04-11T02:13:43.475866Z","caller":"traceutil/trace.go:171","msg":"trace[1430022074] transaction","detail":"{read_only:false; response_revision:1194; number_of_response:1; }","duration":"5.30739003s","start":"2026-04-11T02:13:38.168446Z","end":"2026-04-11T02:13:43.475836Z","steps":["trace[1430022074] 'process raft request' (duration: 5.307246487s)"],"step_count":1} {"level":"warn","ts":"2026-04-11T02:13:43.47594Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-11T02:13:41.428037Z","time spent":"2.047842449s","remote":"127.0.0.1:56114","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-11T02:13:43.476005Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-11T02:13:38.168418Z","time spent":"5.307512953s","remote":"127.0.0.1:56114","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-04-11T02:13:43.539996Z","caller":"traceutil/trace.go:171","msg":"trace[1841161955] linearizableReadLoop","detail":"{readStateIndex:1245; appliedIndex:1240; }","duration":"5.679379071s","start":"2026-04-11T02:13:37.86059Z","end":"2026-04-11T02:13:43.539969Z","steps":["trace[1841161955] 'read index received' (duration: 5.606712806s)","trace[1841161955] 'applied index is now lower than readState.Index' (duration: 72.663565ms)"],"step_count":2} {"level":"warn","ts":"2026-04-11T02:13:43.540477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"5.679855102s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-11T02:13:43.540613Z","caller":"traceutil/trace.go:171","msg":"trace[348530596] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:1195; }","duration":"5.679972954s","start":"2026-04-11T02:13:37.860554Z","end":"2026-04-11T02:13:43.540527Z","steps":["trace[348530596] 'agreement among raft nodes before linearized reading' (duration: 5.679846962s)"],"step_count":1} {"level":"warn","ts":"2026-04-11T02:13:43.540742Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-11T02:13:37.860538Z","time spent":"5.680186478s","remote":"127.0.0.1:48698","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true "} {"level":"warn","ts":"2026-04-11T02:13:43.541187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"674.186929ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" ","response":"range_response_count:1 size:550"} {"level":"info","ts":"2026-04-11T02:13:43.541225Z","caller":"traceutil/trace.go:171","msg":"trace[550804660] range","detail":"{range_begin:/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io; range_end:; response_count:1; response_revision:1195; }","duration":"674.258041ms","start":"2026-04-11T02:13:42.866959Z","end":"2026-04-11T02:13:43.541217Z","steps":["trace[550804660] 'agreement among raft nodes before linearized reading' (duration: 674.184099ms)"],"step_count":1} {"level":"warn","ts":"2026-04-11T02:13:43.541231Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"5.099555242s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-04-11T02:13:43.54128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"438.494205ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-11T02:13:43.541286Z","caller":"traceutil/trace.go:171","msg":"trace[1050921473] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1195; }","duration":"5.099640703s","start":"2026-04-11T02:13:38.441627Z","end":"2026-04-11T02:13:43.541268Z","steps":["trace[1050921473] 'agreement among raft nodes before linearized reading' (duration: 5.09950965s)"],"step_count":1} {"level":"info","ts":"2026-04-11T02:13:43.5413Z","caller":"traceutil/trace.go:171","msg":"trace[2048739914] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:1195; }","duration":"438.552466ms","start":"2026-04-11T02:13:43.102741Z","end":"2026-04-11T02:13:43.541294Z","steps":["trace[2048739914] 'agreement among raft nodes before linearized reading' (duration: 438.521766ms)"],"step_count":1} {"level":"warn","ts":"2026-04-11T02:13:43.541312Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-11T02:13:38.441608Z","time spent":"5.099699035s","remote":"127.0.0.1:56114","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-11T02:13:43.541319Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-11T02:13:43.102722Z","time spent":"438.591727ms","remote":"127.0.0.1:48622","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"warn","ts":"2026-04-11T02:13:43.541311Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.45171491s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-11T02:13:43.541776Z","caller":"traceutil/trace.go:171","msg":"trace[1121342828] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:1195; }","duration":"1.452213611s","start":"2026-04-11T02:13:42.089541Z","end":"2026-04-11T02:13:43.541754Z","steps":["trace[1121342828] 'agreement among raft nodes before linearized reading' (duration: 1.451727281s)"],"step_count":1} {"level":"warn","ts":"2026-04-11T02:13:43.541351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.092881805s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-11T02:13:43.541854Z","caller":"traceutil/trace.go:171","msg":"trace[1575295197] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:1195; }","duration":"3.093496838s","start":"2026-04-11T02:13:40.448347Z","end":"2026-04-11T02:13:43.541844Z","steps":["trace[1575295197] 'agreement among raft nodes before linearized reading' (duration: 3.092967707s)"],"step_count":1} {"level":"warn","ts":"2026-04-11T02:13:43.541866Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-11T02:13:42.089523Z","time spent":"1.452322143s","remote":"127.0.0.1:48628","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-11T02:13:43.541886Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-11T02:13:40.448323Z","time spent":"3.093552859s","remote":"127.0.0.1:39154","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"warn","ts":"2026-04-11T02:13:43.541218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.912304038s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-11T02:13:43.542005Z","caller":"traceutil/trace.go:171","msg":"trace[89597767] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1195; }","duration":"1.913140976s","start":"2026-04-11T02:13:41.628855Z","end":"2026-04-11T02:13:43.541996Z","steps":["trace[89597767] 'agreement among raft nodes before linearized reading' (duration: 1.912293538s)"],"step_count":1} {"level":"warn","ts":"2026-04-11T02:13:43.542031Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-11T02:13:41.628839Z","time spent":"1.913184967s","remote":"127.0.0.1:55818","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-11T02:13:43.541444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.476551258s","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-11T02:13:43.542145Z","caller":"traceutil/trace.go:171","msg":"trace[939568143] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1195; }","duration":"4.477276753s","start":"2026-04-11T02:13:39.064862Z","end":"2026-04-11T02:13:43.542139Z","steps":["trace[939568143] 'agreement among raft nodes before linearized reading' (duration: 4.476547038s)"],"step_count":1} {"level":"warn","ts":"2026-04-11T02:13:43.542167Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-11T02:13:39.064848Z","time spent":"4.477312924s","remote":"127.0.0.1:56114","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-11T02:13:43.541247Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-11T02:13:42.866943Z","time spent":"674.298611ms","remote":"127.0.0.1:56114","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":573,"request content":"key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" "} {"level":"warn","ts":"2026-04-11T02:13:43.541475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"625.369824ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-11T02:13:43.542319Z","caller":"traceutil/trace.go:171","msg":"trace[1039618042] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:1195; }","duration":"626.247463ms","start":"2026-04-11T02:13:42.916065Z","end":"2026-04-11T02:13:43.542313Z","steps":["trace[1039618042] 'agreement among raft nodes before linearized reading' (duration: 625.359424ms)"],"step_count":1} {"level":"warn","ts":"2026-04-11T02:13:43.542363Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-11T02:13:42.916049Z","time spent":"626.284843ms","remote":"127.0.0.1:59506","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":70,"response size":30,"request content":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true "} {"level":"warn","ts":"2026-04-11T02:13:43.541482Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.86521368s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-11T02:13:43.542489Z","caller":"traceutil/trace.go:171","msg":"trace[520604155] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1195; }","duration":"1.866243912s","start":"2026-04-11T02:13:41.67624Z","end":"2026-04-11T02:13:43.542484Z","steps":["trace[520604155] 'agreement among raft nodes before linearized reading' (duration: 1.865222921s)"],"step_count":1} {"level":"warn","ts":"2026-04-11T02:13:43.54251Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-11T02:13:41.676228Z","time spent":"1.866276613s","remote":"127.0.0.1:55802","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-11T02:13:52.59007Z","caller":"traceutil/trace.go:171","msg":"trace[176914720] transaction","detail":"{read_only:false; response_revision:1259; number_of_response:1; }","duration":"111.745872ms","start":"2026-04-11T02:13:52.478304Z","end":"2026-04-11T02:13:52.59005Z","steps":["trace[176914720] 'process raft request' (duration: 111.604319ms)"],"step_count":1} {"level":"info","ts":"2026-04-11T02:13:53.484308Z","caller":"traceutil/trace.go:171","msg":"trace[1105727443] transaction","detail":"{read_only:false; response_revision:1261; number_of_response:1; }","duration":"135.53113ms","start":"2026-04-11T02:13:53.348738Z","end":"2026-04-11T02:13:53.484269Z","steps":["trace[1105727443] 'process raft request' (duration: 135.316845ms)"],"step_count":1} {"level":"info","ts":"2026-04-11T02:13:54.152043Z","caller":"traceutil/trace.go:171","msg":"trace[633374276] transaction","detail":"{read_only:false; response_revision:1268; number_of_response:1; }","duration":"129.515332ms","start":"2026-04-11T02:13:54.022503Z","end":"2026-04-11T02:13:54.152018Z","steps":["trace[633374276] 'process raft request' (duration: 129.249487ms)"],"step_count":1} {"level":"warn","ts":"2026-04-11T02:13:57.900923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.965946ms","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-11T02:13:57.901004Z","caller":"traceutil/trace.go:171","msg":"trace[1224654876] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1307; }","duration":"119.099859ms","start":"2026-04-11T02:13:57.781887Z","end":"2026-04-11T02:13:57.900987Z","steps":["trace[1224654876] 'range keys from in-memory index tree' (duration: 118.793771ms)"],"step_count":1} {"level":"info","ts":"2026-04-11T02:14:09.216215Z","caller":"traceutil/trace.go:171","msg":"trace[2062826072] linearizableReadLoop","detail":"{readStateIndex:1410; appliedIndex:1409; }","duration":"342.240264ms","start":"2026-04-11T02:14:08.873944Z","end":"2026-04-11T02:14:09.216184Z","steps":["trace[2062826072] 'read index received' (duration: 341.914497ms)","trace[2062826072] 'applied index is now lower than readState.Index' (duration: 323.607µs)"],"step_count":2} {"level":"warn","ts":"2026-04-11T02:14:09.21646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"342.49198ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-11T02:14:09.216537Z","caller":"traceutil/trace.go:171","msg":"trace[1673902767] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1355; }","duration":"342.615842ms","start":"2026-04-11T02:14:08.8739Z","end":"2026-04-11T02:14:09.216516Z","steps":["trace[1673902767] 'agreement among raft nodes before linearized reading' (duration: 342.437839ms)"],"step_count":1} {"level":"warn","ts":"2026-04-11T02:14:09.216608Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-11T02:14:08.873879Z","time spent":"342.709804ms","remote":"127.0.0.1:56114","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-04-11T02:14:09.216594Z","caller":"traceutil/trace.go:171","msg":"trace[649613843] transaction","detail":"{read_only:false; response_revision:1355; number_of_response:1; }","duration":"525.274961ms","start":"2026-04-11T02:14:08.691274Z","end":"2026-04-11T02:14:09.216549Z","steps":["trace[649613843] 'process raft request' (duration: 524.659778ms)"],"step_count":1} {"level":"warn","ts":"2026-04-11T02:14:09.216792Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-11T02:14:08.691259Z","time spent":"525.425135ms","remote":"127.0.0.1:56114","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":517,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-11T02:14:19.903614Z","caller":"traceutil/trace.go:171","msg":"trace[1200242396] transaction","detail":"{read_only:false; response_revision:1405; number_of_response:1; }","duration":"102.233047ms","start":"2026-04-11T02:14:19.801353Z","end":"2026-04-11T02:14:19.903586Z","steps":["trace[1200242396] 'process raft request' (duration: 19.798213ms)","trace[1200242396] 'compare' (duration: 82.199029ms)"],"step_count":2}