{"level":"warn","ts":"2026-05-09T12:49:19.270132Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-09T12:49:19.270261Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.216: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.216:2380","--initial-cluster=instance=https://199.204.45.216:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.216:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.216:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-05-09T12:49:19.270348Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-09T12:49:19.270374Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.216:2380"]} {"level":"info","ts":"2026-05-09T12:49:19.270406Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-09T12:49:19.271046Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.216:2379"]} {"level":"info","ts":"2026-05-09T12:49:19.271143Z","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.216:2380"],"listen-peer-urls":["https://199.204.45.216:2380"],"advertise-client-urls":["https://199.204.45.216:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.216:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.216:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-05-09T12:49:19.274636Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.268164ms"} {"level":"info","ts":"2026-05-09T12:49:19.281566Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"4e98569549cc430c","cluster-id":"65d70b4d1d4a8bf9"} {"level":"info","ts":"2026-05-09T12:49:19.281676Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c switched to configuration voters=()"} {"level":"info","ts":"2026-05-09T12:49:19.281721Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c became follower at term 0"} {"level":"info","ts":"2026-05-09T12:49:19.281759Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 4e98569549cc430c [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-09T12:49:19.281783Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c became follower at term 1"} {"level":"info","ts":"2026-05-09T12:49:19.281844Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c switched to configuration voters=(5663371730606637836)"} {"level":"warn","ts":"2026-05-09T12:49:19.288262Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-09T12:49:19.289648Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-09T12:49:19.29075Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-05-09T12:49:19.2944Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"4e98569549cc430c","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-09T12:49:19.296969Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-09T12:49:19.29704Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-09T12:49:19.297061Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-09T12:49:19.297081Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"4e98569549cc430c","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-09T12:49:19.297445Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c switched to configuration voters=(5663371730606637836)"} {"level":"info","ts":"2026-05-09T12:49:19.297594Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"65d70b4d1d4a8bf9","local-member-id":"4e98569549cc430c","added-peer-id":"4e98569549cc430c","added-peer-peer-urls":["https://199.204.45.216:2380"]} {"level":"info","ts":"2026-05-09T12:49:19.299203Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-09T12:49:19.299493Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"4e98569549cc430c","initial-advertise-peer-urls":["https://199.204.45.216:2380"],"listen-peer-urls":["https://199.204.45.216:2380"],"advertise-client-urls":["https://199.204.45.216:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.216:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-09T12:49:19.29953Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-09T12:49:19.299698Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.216:2380"} {"level":"info","ts":"2026-05-09T12:49:19.299731Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.216:2380"} {"level":"info","ts":"2026-05-09T12:49:20.18306Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c is starting a new election at term 1"} {"level":"info","ts":"2026-05-09T12:49:20.183162Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c became pre-candidate at term 1"} {"level":"info","ts":"2026-05-09T12:49:20.183203Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c received MsgPreVoteResp from 4e98569549cc430c at term 1"} {"level":"info","ts":"2026-05-09T12:49:20.183232Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c became candidate at term 2"} {"level":"info","ts":"2026-05-09T12:49:20.183249Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c received MsgVoteResp from 4e98569549cc430c at term 2"} {"level":"info","ts":"2026-05-09T12:49:20.183279Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c became leader at term 2"} {"level":"info","ts":"2026-05-09T12:49:20.183298Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 4e98569549cc430c elected leader 4e98569549cc430c at term 2"} {"level":"info","ts":"2026-05-09T12:49:20.184278Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-09T12:49:20.185024Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"4e98569549cc430c","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.216:2379]}","request-path":"/0/members/4e98569549cc430c/attributes","cluster-id":"65d70b4d1d4a8bf9","publish-timeout":"7s"} {"level":"info","ts":"2026-05-09T12:49:20.185022Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-09T12:49:20.185079Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-09T12:49:20.18541Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-09T12:49:20.185499Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-09T12:49:20.185645Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"65d70b4d1d4a8bf9","local-member-id":"4e98569549cc430c","cluster-version":"3.5"} {"level":"info","ts":"2026-05-09T12:49:20.185739Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-09T12:49:20.185766Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-09T12:49:20.188563Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.216:2379"} {"level":"info","ts":"2026-05-09T12:49:20.188739Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-05-09T12:49:22.899488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.310817ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-05-09T12:49:22.899687Z","caller":"traceutil/trace.go:171","msg":"trace[648306219] transaction","detail":"{read_only:false; response_revision:79; number_of_response:1; }","duration":"107.176771ms","start":"2026-05-09T12:49:22.792494Z","end":"2026-05-09T12:49:22.899671Z","steps":["trace[648306219] 'process raft request' (duration: 107.13253ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T12:49:22.89986Z","caller":"traceutil/trace.go:171","msg":"trace[1220453272] transaction","detail":"{read_only:false; response_revision:78; number_of_response:1; }","duration":"358.044044ms","start":"2026-05-09T12:49:22.541711Z","end":"2026-05-09T12:49:22.899755Z","steps":["trace[1220453272] 'process raft request' (duration: 171.950928ms)","trace[1220453272] 'compare' (duration: 185.149245ms)"],"step_count":2} {"level":"warn","ts":"2026-05-09T12:49:22.900043Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:49:22.541691Z","time spent":"358.257695ms","remote":"127.0.0.1:43582","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":607,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-09T12:49:23.154481Z","caller":"traceutil/trace.go:171","msg":"trace[1452921204] transaction","detail":"{read_only:false; response_revision:81; number_of_response:1; }","duration":"188.498049ms","start":"2026-05-09T12:49:22.965949Z","end":"2026-05-09T12:49:23.154447Z","steps":["trace[1452921204] 'process raft request' (duration: 110.316538ms)","trace[1452921204] 'compare' (duration: 77.992889ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T12:49:23.451685Z","caller":"traceutil/trace.go:171","msg":"trace[312630990] transaction","detail":"{read_only:false; response_revision:84; number_of_response:1; }","duration":"243.077701ms","start":"2026-05-09T12:49:23.20857Z","end":"2026-05-09T12:49:23.451648Z","steps":["trace[312630990] 'process raft request' (duration: 193.509727ms)","trace[312630990] 'compare' (duration: 49.322962ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T12:49:23.89722Z","caller":"traceutil/trace.go:171","msg":"trace[1785829415] transaction","detail":"{read_only:false; response_revision:90; number_of_response:1; }","duration":"152.228838ms","start":"2026-05-09T12:49:23.744954Z","end":"2026-05-09T12:49:23.897182Z","steps":["trace[1785829415] 'process raft request' (duration: 121.188066ms)","trace[1785829415] 'compare' (duration: 30.86681ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T12:49:24.11734Z","caller":"traceutil/trace.go:171","msg":"trace[143847860] transaction","detail":"{read_only:false; response_revision:98; number_of_response:1; }","duration":"120.022197ms","start":"2026-05-09T12:49:23.997282Z","end":"2026-05-09T12:49:24.117304Z","steps":["trace[143847860] 'process raft request' (duration: 37.009152ms)","trace[143847860] 'compare' (duration: 82.855372ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T12:49:26.665801Z","caller":"traceutil/trace.go:171","msg":"trace[741287869] transaction","detail":"{read_only:false; response_revision:216; number_of_response:1; }","duration":"189.720234ms","start":"2026-05-09T12:49:26.476045Z","end":"2026-05-09T12:49:26.665766Z","steps":["trace[741287869] 'process raft request' (duration: 107.132487ms)","trace[741287869] 'compare' (duration: 82.469646ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T12:49:26.666358Z","caller":"traceutil/trace.go:171","msg":"trace[1751450923] transaction","detail":"{read_only:false; response_revision:217; number_of_response:1; }","duration":"190.029068ms","start":"2026-05-09T12:49:26.4763Z","end":"2026-05-09T12:49:26.66633Z","steps":["trace[1751450923] 'process raft request' (duration: 189.888147ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T12:49:26.851905Z","caller":"traceutil/trace.go:171","msg":"trace[560124971] transaction","detail":"{read_only:false; response_revision:219; number_of_response:1; }","duration":"105.465741ms","start":"2026-05-09T12:49:26.746392Z","end":"2026-05-09T12:49:26.851858Z","steps":["trace[560124971] 'process raft request' (duration: 19.160324ms)","trace[560124971] 'marshal mvccpb.KeyValue' {req_type:put; key:/registry/clusterroles/kubeadm:get-nodes; req_size:287; } (duration: 86.128054ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T12:49:27.055998Z","caller":"traceutil/trace.go:171","msg":"trace[288978657] transaction","detail":"{read_only:false; response_revision:222; number_of_response:1; }","duration":"115.264134ms","start":"2026-05-09T12:49:26.940698Z","end":"2026-05-09T12:49:27.055962Z","steps":["trace[288978657] 'process raft request' (duration: 24.394686ms)","trace[288978657] 'compare' (duration: 90.622116ms)"],"step_count":2} {"level":"warn","ts":"2026-05-09T12:49:27.941298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.897985ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-09T12:49:27.941566Z","caller":"traceutil/trace.go:171","msg":"trace[862755974] transaction","detail":"{read_only:false; response_revision:236; number_of_response:1; }","duration":"325.125865ms","start":"2026-05-09T12:49:27.616409Z","end":"2026-05-09T12:49:27.941535Z","steps":["trace[862755974] 'process raft request' (duration: 95.872336ms)","trace[862755974] 'compare' (duration: 228.718263ms)"],"step_count":2} {"level":"warn","ts":"2026-05-09T12:49:27.94166Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:49:27.616385Z","time spent":"325.238915ms","remote":"127.0.0.1:43520","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-09T12:49:27.94171Z","caller":"traceutil/trace.go:171","msg":"trace[2055294771] transaction","detail":"{read_only:false; response_revision:238; number_of_response:1; }","duration":"310.416316ms","start":"2026-05-09T12:49:27.631275Z","end":"2026-05-09T12:49:27.941691Z","steps":["trace[2055294771] 'process raft request' (duration: 310.327715ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T12:49:27.941777Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:49:27.631262Z","time spent":"310.484418ms","remote":"127.0.0.1:43340","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":642,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-09T12:49:27.941742Z","caller":"traceutil/trace.go:171","msg":"trace[1554908398] transaction","detail":"{read_only:false; response_revision:237; number_of_response:1; }","duration":"325.247276ms","start":"2026-05-09T12:49:27.616435Z","end":"2026-05-09T12:49:27.941682Z","steps":["trace[1554908398] 'process raft request' (duration: 325.097385ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T12:49:27.942166Z","caller":"traceutil/trace.go:171","msg":"trace[611400956] transaction","detail":"{read_only:false; number_of_response:0; response_revision:239; }","duration":"293.238584ms","start":"2026-05-09T12:49:27.648911Z","end":"2026-05-09T12:49:27.942149Z","steps":["trace[611400956] 'process raft request' (duration: 293.164983ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T12:49:27.942145Z","caller":"traceutil/trace.go:171","msg":"trace[965157026] transaction","detail":"{read_only:false; response_revision:239; number_of_response:1; }","duration":"293.499826ms","start":"2026-05-09T12:49:27.648611Z","end":"2026-05-09T12:49:27.94211Z","steps":["trace[965157026] 'process raft request' (duration: 293.412306ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T12:49:27.94408Z","caller":"traceutil/trace.go:171","msg":"trace[838041217] linearizableReadLoop","detail":"{readStateIndex:250; appliedIndex:241; }","duration":"143.091151ms","start":"2026-05-09T12:49:27.800954Z","end":"2026-05-09T12:49:27.944046Z","steps":["trace[838041217] 'read index received' (duration: 140.305273ms)","trace[838041217] 'applied index is now lower than readState.Index' (duration: 2.674537ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T12:49:27.941822Z","caller":"traceutil/trace.go:171","msg":"trace[1739046929] transaction","detail":"{read_only:false; number_of_response:0; response_revision:238; }","duration":"310.077034ms","start":"2026-05-09T12:49:27.631712Z","end":"2026-05-09T12:49:27.941789Z","steps":["trace[1739046929] 'process raft request' (duration: 309.930271ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T12:49:27.944868Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:49:27.631694Z","time spent":"313.085064ms","remote":"127.0.0.1:43430","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":27,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-09T12:49:27.94511Z","caller":"traceutil/trace.go:171","msg":"trace[446479957] transaction","detail":"{read_only:false; response_revision:240; number_of_response:1; }","duration":"293.055701ms","start":"2026-05-09T12:49:27.649173Z","end":"2026-05-09T12:49:27.942229Z","steps":["trace[446479957] 'process raft request' (duration: 292.93653ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T12:49:27.946982Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.023772ms","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-05-09T12:49:27.947056Z","caller":"traceutil/trace.go:171","msg":"trace[1659904326] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:241; }","duration":"146.127432ms","start":"2026-05-09T12:49:27.800888Z","end":"2026-05-09T12:49:27.947015Z","steps":["trace[1659904326] 'agreement among raft nodes before linearized reading' (duration: 143.218733ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T12:49:27.947368Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:49:27.61641Z","time spent":"325.412458ms","remote":"127.0.0.1:43310","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":102,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-09T12:49:27.947506Z","caller":"traceutil/trace.go:171","msg":"trace[1103883152] transaction","detail":"{read_only:false; number_of_response:0; response_revision:241; }","duration":"297.065033ms","start":"2026-05-09T12:49:27.650432Z","end":"2026-05-09T12:49:27.947497Z","steps":["trace[1103883152] 'process raft request' (duration: 291.769509ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T12:49:27.947792Z","caller":"traceutil/trace.go:171","msg":"trace[209953989] transaction","detail":"{read_only:false; response_revision:241; number_of_response:1; }","duration":"298.417746ms","start":"2026-05-09T12:49:27.649282Z","end":"2026-05-09T12:49:27.9477Z","steps":["trace[209953989] 'process raft request' (duration: 292.86352ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T12:49:28.135281Z","caller":"traceutil/trace.go:171","msg":"trace[129528569] linearizableReadLoop","detail":"{readStateIndex:257; appliedIndex:256; }","duration":"112.352725ms","start":"2026-05-09T12:49:28.022902Z","end":"2026-05-09T12:49:28.135254Z","steps":["trace[129528569] 'read index received' (duration: 61.540086ms)","trace[129528569] 'applied index is now lower than readState.Index' (duration: 50.811739ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T12:49:28.135339Z","caller":"traceutil/trace.go:171","msg":"trace[1160131379] transaction","detail":"{read_only:false; response_revision:248; number_of_response:1; }","duration":"139.468705ms","start":"2026-05-09T12:49:27.995843Z","end":"2026-05-09T12:49:28.135311Z","steps":["trace[1160131379] 'process raft request' (duration: 88.498375ms)","trace[1160131379] 'compare' (duration: 50.787869ms)"],"step_count":2} {"level":"warn","ts":"2026-05-09T12:49:28.135619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.755068ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/namespace-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T12:49:28.13567Z","caller":"traceutil/trace.go:171","msg":"trace[1213299138] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/namespace-controller; range_end:; response_count:0; response_revision:248; }","duration":"136.028381ms","start":"2026-05-09T12:49:27.999628Z","end":"2026-05-09T12:49:28.135656Z","steps":["trace[1213299138] 'agreement among raft nodes before linearized reading' (duration: 135.735798ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T12:49:28.137295Z","caller":"traceutil/trace.go:171","msg":"trace[1970558548] transaction","detail":"{read_only:false; response_revision:249; number_of_response:1; }","duration":"105.411865ms","start":"2026-05-09T12:49:28.031851Z","end":"2026-05-09T12:49:28.137263Z","steps":["trace[1970558548] 'process raft request' (duration: 105.217243ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T12:49:28.992059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.417445ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-05-09T12:49:28.992187Z","caller":"traceutil/trace.go:171","msg":"trace[209549371] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:273; }","duration":"103.575206ms","start":"2026-05-09T12:49:28.888548Z","end":"2026-05-09T12:49:28.992123Z","steps":["trace[209549371] 'range keys from in-memory index tree' (duration: 103.297193ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T12:49:35.48382Z","caller":"traceutil/trace.go:171","msg":"trace[54321790] transaction","detail":"{read_only:false; response_revision:369; number_of_response:1; }","duration":"117.203083ms","start":"2026-05-09T12:49:35.366585Z","end":"2026-05-09T12:49:35.483788Z","steps":["trace[54321790] 'process raft request' (duration: 51.272441ms)","trace[54321790] 'compare' (duration: 65.77818ms)"],"step_count":2} {"level":"warn","ts":"2026-05-09T12:49:36.22604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.21026ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-09T12:49:36.226182Z","caller":"traceutil/trace.go:171","msg":"trace[1404696198] transaction","detail":"{read_only:false; response_revision:372; number_of_response:1; }","duration":"144.654208ms","start":"2026-05-09T12:49:36.081504Z","end":"2026-05-09T12:49:36.226158Z","steps":["trace[1404696198] 'process raft request' (duration: 34.229606ms)","trace[1404696198] 'compare' (duration: 109.970127ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T12:49:36.697163Z","caller":"traceutil/trace.go:171","msg":"trace[1054804638] transaction","detail":"{read_only:false; response_revision:373; number_of_response:1; }","duration":"105.318123ms","start":"2026-05-09T12:49:36.591812Z","end":"2026-05-09T12:49:36.69713Z","steps":["trace[1054804638] 'process raft request' (duration: 105.135371ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T12:49:45.67686Z","caller":"traceutil/trace.go:171","msg":"trace[425659384] transaction","detail":"{read_only:false; response_revision:428; number_of_response:1; }","duration":"149.786064ms","start":"2026-05-09T12:49:45.527055Z","end":"2026-05-09T12:49:45.676841Z","steps":["trace[425659384] 'process raft request' (duration: 149.682444ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T12:49:53.458672Z","caller":"traceutil/trace.go:171","msg":"trace[427680837] transaction","detail":"{read_only:false; response_revision:477; number_of_response:1; }","duration":"127.547785ms","start":"2026-05-09T12:49:53.33108Z","end":"2026-05-09T12:49:53.458628Z","steps":["trace[427680837] 'process raft request' (duration: 126.9907ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T12:49:53.582204Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.702058ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-05-09T12:49:53.582266Z","caller":"traceutil/trace.go:171","msg":"trace[597899417] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:477; }","duration":"203.8195ms","start":"2026-05-09T12:49:53.378432Z","end":"2026-05-09T12:49:53.582252Z","steps":["trace[597899417] 'agreement among raft nodes before linearized reading' (duration: 80.337729ms)","trace[597899417] 'range keys from in-memory index tree' (duration: 123.352999ms)"],"step_count":2} {"level":"warn","ts":"2026-05-09T12:49:53.817274Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.686009ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-09T12:49:53.817413Z","caller":"traceutil/trace.go:171","msg":"trace[650580886] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:479; }","duration":"100.84586ms","start":"2026-05-09T12:49:53.716537Z","end":"2026-05-09T12:49:53.817383Z","steps":["trace[650580886] 'range keys from in-memory index tree' (duration: 100.432176ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T12:49:56.450443Z","caller":"traceutil/trace.go:171","msg":"trace[1281665337] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"251.111104ms","start":"2026-05-09T12:49:56.199287Z","end":"2026-05-09T12:49:56.450398Z","steps":["trace[1281665337] 'process raft request' (duration: 250.978703ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T12:49:56.452293Z","caller":"traceutil/trace.go:171","msg":"trace[1801152019] linearizableReadLoop","detail":"{readStateIndex:610; appliedIndex:610; }","duration":"185.341649ms","start":"2026-05-09T12:49:56.26694Z","end":"2026-05-09T12:49:56.452281Z","steps":["trace[1801152019] 'read index received' (duration: 185.336759ms)","trace[1801152019] 'applied index is now lower than readState.Index' (duration: 4.02µs)"],"step_count":2} {"level":"warn","ts":"2026-05-09T12:49:56.452544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.591591ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-05-09T12:49:56.452592Z","caller":"traceutil/trace.go:171","msg":"trace[4616563] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:587; }","duration":"185.686623ms","start":"2026-05-09T12:49:56.266896Z","end":"2026-05-09T12:49:56.452583Z","steps":["trace[4616563] 'agreement among raft nodes before linearized reading' (duration: 185.52414ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T12:49:56.455711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.204989ms","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-05-09T12:49:56.45581Z","caller":"traceutil/trace.go:171","msg":"trace[1766137550] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:588; }","duration":"122.360969ms","start":"2026-05-09T12:49:56.333432Z","end":"2026-05-09T12:49:56.455793Z","steps":["trace[1766137550] 'agreement among raft nodes before linearized reading' (duration: 122.131558ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T12:50:02.652051Z","caller":"traceutil/trace.go:171","msg":"trace[455006374] transaction","detail":"{read_only:false; response_revision:650; number_of_response:1; }","duration":"154.624667ms","start":"2026-05-09T12:50:02.497402Z","end":"2026-05-09T12:50:02.652027Z","steps":["trace[455006374] 'process raft request' (duration: 139.118834ms)","trace[455006374] 'compare' (duration: 15.348322ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T12:50:02.776132Z","caller":"traceutil/trace.go:171","msg":"trace[1005059518] transaction","detail":"{read_only:false; response_revision:651; number_of_response:1; }","duration":"119.450686ms","start":"2026-05-09T12:50:02.656655Z","end":"2026-05-09T12:50:02.776106Z","steps":["trace[1005059518] 'process raft request' (duration: 116.4007ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T12:50:02.807005Z","caller":"traceutil/trace.go:171","msg":"trace[1294557474] linearizableReadLoop","detail":"{readStateIndex:676; appliedIndex:674; }","duration":"130.921984ms","start":"2026-05-09T12:50:02.676063Z","end":"2026-05-09T12:50:02.806985Z","steps":["trace[1294557474] 'read index received' (duration: 96.987243ms)","trace[1294557474] 'applied index is now lower than readState.Index' (duration: 33.933741ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T12:50:02.807409Z","caller":"traceutil/trace.go:171","msg":"trace[1173573925] transaction","detail":"{read_only:false; response_revision:652; number_of_response:1; }","duration":"143.557662ms","start":"2026-05-09T12:50:02.66383Z","end":"2026-05-09T12:50:02.807388Z","steps":["trace[1173573925] 'process raft request' (duration: 143.044237ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T12:50:02.80759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.344528ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T12:50:02.80769Z","caller":"traceutil/trace.go:171","msg":"trace[11685189] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:652; }","duration":"131.493489ms","start":"2026-05-09T12:50:02.676182Z","end":"2026-05-09T12:50:02.807675Z","steps":["trace[11685189] 'agreement among raft nodes before linearized reading' (duration: 131.267897ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T12:50:02.808209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.17316ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T12:50:02.808316Z","caller":"traceutil/trace.go:171","msg":"trace[1648748939] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:652; }","duration":"100.29517ms","start":"2026-05-09T12:50:02.708008Z","end":"2026-05-09T12:50:02.808303Z","steps":["trace[1648748939] 'agreement among raft nodes before linearized reading' (duration: 100.167129ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T12:50:02.808553Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.223054ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T12:50:02.808625Z","caller":"traceutil/trace.go:171","msg":"trace[974283612] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:652; }","duration":"132.309126ms","start":"2026-05-09T12:50:02.676307Z","end":"2026-05-09T12:50:02.808616Z","steps":["trace[974283612] 'agreement among raft nodes before linearized reading' (duration: 132.187325ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T12:50:02.807326Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.227567ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T12:50:02.808813Z","caller":"traceutil/trace.go:171","msg":"trace[582883097] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:652; }","duration":"132.77132ms","start":"2026-05-09T12:50:02.676032Z","end":"2026-05-09T12:50:02.808803Z","steps":["trace[582883097] 'agreement among raft nodes before linearized reading' (duration: 131.191446ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T12:50:04.205204Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4831410278010566298,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-09T12:50:04.268284Z","caller":"traceutil/trace.go:171","msg":"trace[389962522] linearizableReadLoop","detail":"{readStateIndex:678; appliedIndex:677; }","duration":"564.028692ms","start":"2026-05-09T12:50:03.704232Z","end":"2026-05-09T12:50:04.268261Z","steps":["trace[389962522] 'read index received' (duration: 563.774511ms)","trace[389962522] 'applied index is now lower than readState.Index' (duration: 253.231µs)"],"step_count":2} {"level":"info","ts":"2026-05-09T12:50:04.268399Z","caller":"traceutil/trace.go:171","msg":"trace[374730124] transaction","detail":"{read_only:false; response_revision:654; number_of_response:1; }","duration":"573.289533ms","start":"2026-05-09T12:50:03.695077Z","end":"2026-05-09T12:50:04.268366Z","steps":["trace[374730124] 'process raft request' (duration: 573.04479ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T12:50:04.268561Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:50:03.69506Z","time spent":"573.415094ms","remote":"127.0.0.1:43520","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-09T12:50:04.268594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"503.551285ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T12:50:04.268666Z","caller":"traceutil/trace.go:171","msg":"trace[239535762] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:654; }","duration":"503.662436ms","start":"2026-05-09T12:50:03.764991Z","end":"2026-05-09T12:50:04.268653Z","steps":["trace[239535762] 'agreement among raft nodes before linearized reading' (duration: 503.467425ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T12:50:04.26874Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:50:03.76498Z","time spent":"503.721516ms","remote":"127.0.0.1:39538","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 "} {"level":"warn","ts":"2026-05-09T12:50:04.268756Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"401.417301ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-05-09T12:50:04.26871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"564.424116ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T12:50:04.269597Z","caller":"traceutil/trace.go:171","msg":"trace[657729156] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:654; }","duration":"565.370694ms","start":"2026-05-09T12:50:03.704209Z","end":"2026-05-09T12:50:04.269579Z","steps":["trace[657729156] 'agreement among raft nodes before linearized reading' (duration: 564.234105ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T12:50:04.269653Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:50:03.704188Z","time spent":"565.448725ms","remote":"127.0.0.1:39514","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:10000 "} {"level":"warn","ts":"2026-05-09T12:50:04.268784Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"516.428446ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T12:50:04.269718Z","caller":"traceutil/trace.go:171","msg":"trace[1556020960] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:654; }","duration":"517.384674ms","start":"2026-05-09T12:50:03.752312Z","end":"2026-05-09T12:50:04.269697Z","steps":["trace[1556020960] 'agreement among raft nodes before linearized reading' (duration: 516.406986ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T12:50:04.269784Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:50:03.752297Z","time spent":"517.465555ms","remote":"127.0.0.1:39528","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"info","ts":"2026-05-09T12:50:04.268808Z","caller":"traceutil/trace.go:171","msg":"trace[1601699381] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:654; }","duration":"401.489881ms","start":"2026-05-09T12:50:03.867299Z","end":"2026-05-09T12:50:04.268789Z","steps":["trace[1601699381] 'agreement among raft nodes before linearized reading' (duration: 401.34744ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T12:50:04.269956Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:50:03.867279Z","time spent":"402.666111ms","remote":"127.0.0.1:43520","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-09T12:50:04.268853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"424.319938ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T12:50:04.270089Z","caller":"traceutil/trace.go:171","msg":"trace[2077547206] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:654; }","duration":"425.581108ms","start":"2026-05-09T12:50:03.844497Z","end":"2026-05-09T12:50:04.270078Z","steps":["trace[2077547206] 'agreement among raft nodes before linearized reading' (duration: 424.336117ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T12:50:04.270129Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:50:03.844475Z","time spent":"425.641289ms","remote":"127.0.0.1:43262","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-09T12:50:04.268844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"516.477425ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T12:50:04.270279Z","caller":"traceutil/trace.go:171","msg":"trace[2018105245] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:654; }","duration":"517.930378ms","start":"2026-05-09T12:50:03.752338Z","end":"2026-05-09T12:50:04.270269Z","steps":["trace[2018105245] 'agreement among raft nodes before linearized reading' (duration: 516.485405ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T12:50:04.270319Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:50:03.752323Z","time spent":"517.983719ms","remote":"127.0.0.1:39528","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 "} {"level":"warn","ts":"2026-05-09T12:50:04.268886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"476.511544ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T12:50:04.271167Z","caller":"traceutil/trace.go:171","msg":"trace[1934633132] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:654; }","duration":"478.801064ms","start":"2026-05-09T12:50:03.792341Z","end":"2026-05-09T12:50:04.271142Z","steps":["trace[1934633132] 'agreement among raft nodes before linearized reading' (duration: 476.526914ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T12:50:04.268893Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"476.941938ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-09T12:50:04.271237Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:50:03.792325Z","time spent":"478.891164ms","remote":"127.0.0.1:39544","response type":"/etcdserverpb.KV/Range","request count":0,"request size":95,"response count":0,"response size":27,"request content":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" limit:500 "} {"level":"warn","ts":"2026-05-09T12:50:04.268915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"490.09618ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T12:50:04.271336Z","caller":"traceutil/trace.go:171","msg":"trace[1485147549] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:654; }","duration":"492.516861ms","start":"2026-05-09T12:50:03.778804Z","end":"2026-05-09T12:50:04.271321Z","steps":["trace[1485147549] 'agreement among raft nodes before linearized reading' (duration: 490.09605ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T12:50:04.271382Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:50:03.778799Z","time spent":"492.567912ms","remote":"127.0.0.1:39542","response type":"/etcdserverpb.KV/Range","request count":0,"request size":81,"response count":0,"response size":27,"request content":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" limit:500 "} {"level":"warn","ts":"2026-05-09T12:50:04.268926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"476.625394ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T12:50:04.271458Z","caller":"traceutil/trace.go:171","msg":"trace[317796833] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:654; }","duration":"479.148316ms","start":"2026-05-09T12:50:03.792282Z","end":"2026-05-09T12:50:04.271431Z","steps":["trace[317796833] 'agreement among raft nodes before linearized reading' (duration: 476.627114ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T12:50:04.271278Z","caller":"traceutil/trace.go:171","msg":"trace[1492699605] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:654; }","duration":"479.346349ms","start":"2026-05-09T12:50:03.791918Z","end":"2026-05-09T12:50:04.271264Z","steps":["trace[1492699605] 'agreement among raft nodes before linearized reading' (duration: 476.955238ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T12:50:04.268962Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"564.235505ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-09T12:50:04.271656Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:50:03.792275Z","time spent":"479.350198ms","remote":"127.0.0.1:39544","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":27,"request content":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true "} {"level":"info","ts":"2026-05-09T12:50:04.271688Z","caller":"traceutil/trace.go:171","msg":"trace[1225763798] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:654; }","duration":"566.974919ms","start":"2026-05-09T12:50:03.704704Z","end":"2026-05-09T12:50:04.271679Z","steps":["trace[1225763798] 'agreement among raft nodes before linearized reading' (duration: 564.236945ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T12:50:04.271735Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:50:03.704695Z","time spent":"567.012779ms","remote":"127.0.0.1:39514","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:500 "} {"level":"warn","ts":"2026-05-09T12:50:04.268976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"490.325112ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T12:50:04.272074Z","caller":"traceutil/trace.go:171","msg":"trace[420146297] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:654; }","duration":"493.429149ms","start":"2026-05-09T12:50:03.778623Z","end":"2026-05-09T12:50:04.272052Z","steps":["trace[420146297] 'agreement among raft nodes before linearized reading' (duration: 490.329612ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T12:50:04.271645Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:50:03.791897Z","time spent":"479.734561ms","remote":"127.0.0.1:39544","response type":"/etcdserverpb.KV/Range","request count":0,"request size":95,"response count":0,"response size":27,"request content":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" limit:10000 "} {"level":"warn","ts":"2026-05-09T12:50:04.272139Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:50:03.778611Z","time spent":"493.50924ms","remote":"127.0.0.1:39542","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":27,"request content":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true "} {"level":"warn","ts":"2026-05-09T12:50:04.268594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"489.881378ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T12:50:04.272199Z","caller":"traceutil/trace.go:171","msg":"trace[1914945523] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:654; }","duration":"493.55384ms","start":"2026-05-09T12:50:03.778634Z","end":"2026-05-09T12:50:04.272188Z","steps":["trace[1914945523] 'agreement among raft nodes before linearized reading' (duration: 489.829059ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T12:50:04.272237Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:50:03.778609Z","time spent":"493.614551ms","remote":"127.0.0.1:39542","response type":"/etcdserverpb.KV/Range","request count":0,"request size":81,"response count":0,"response size":27,"request content":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" limit:10000 "} {"level":"warn","ts":"2026-05-09T12:50:04.269005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"503.641177ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T12:50:04.272289Z","caller":"traceutil/trace.go:171","msg":"trace[1656562102] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:654; }","duration":"506.949605ms","start":"2026-05-09T12:50:03.765323Z","end":"2026-05-09T12:50:04.272273Z","steps":["trace[1656562102] 'agreement among raft nodes before linearized reading' (duration: 503.663847ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T12:50:04.272341Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:50:03.765303Z","time spent":"507.019515ms","remote":"127.0.0.1:39528","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:500 "} {"level":"warn","ts":"2026-05-09T12:50:04.268995Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"503.945198ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T12:50:04.272445Z","caller":"traceutil/trace.go:171","msg":"trace[441676485] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:654; }","duration":"507.395428ms","start":"2026-05-09T12:50:03.765035Z","end":"2026-05-09T12:50:04.272431Z","steps":["trace[441676485] 'agreement among raft nodes before linearized reading' (duration: 503.910748ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T12:50:04.272493Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:50:03.765015Z","time spent":"507.463878ms","remote":"127.0.0.1:39538","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"warn","ts":"2026-05-09T12:50:04.26916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"564.908071ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T12:50:04.272569Z","caller":"traceutil/trace.go:171","msg":"trace[607794577] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:654; }","duration":"568.34594ms","start":"2026-05-09T12:50:03.704215Z","end":"2026-05-09T12:50:04.272561Z","steps":["trace[607794577] 'agreement among raft nodes before linearized reading' (duration: 564.141774ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T12:50:04.2726Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:50:03.704207Z","time spent":"568.384681ms","remote":"127.0.0.1:39514","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true "} {"level":"info","ts":"2026-05-09T12:50:04.647601Z","caller":"traceutil/trace.go:171","msg":"trace[870998369] transaction","detail":"{read_only:false; response_revision:655; number_of_response:1; }","duration":"372.390401ms","start":"2026-05-09T12:50:04.275182Z","end":"2026-05-09T12:50:04.647573Z","steps":["trace[870998369] 'process raft request' (duration: 291.352359ms)","trace[870998369] 'compare' (duration: 80.7704ms)"],"step_count":2} {"level":"warn","ts":"2026-05-09T12:50:04.647865Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:50:04.275157Z","time spent":"372.636273ms","remote":"127.0.0.1:43520","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-09T12:50:12.787903Z","caller":"traceutil/trace.go:171","msg":"trace[1280500200] transaction","detail":"{read_only:false; response_revision:705; number_of_response:1; }","duration":"102.569491ms","start":"2026-05-09T12:50:12.685309Z","end":"2026-05-09T12:50:12.787878Z","steps":["trace[1280500200] 'process raft request' (duration: 102.324239ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T12:50:13.905003Z","caller":"traceutil/trace.go:171","msg":"trace[653408500] transaction","detail":"{read_only:false; response_revision:714; number_of_response:1; }","duration":"107.57298ms","start":"2026-05-09T12:50:13.797411Z","end":"2026-05-09T12:50:13.904984Z","steps":["trace[653408500] 'process raft request' (duration: 107.195136ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T12:50:18.720443Z","caller":"traceutil/trace.go:171","msg":"trace[1976836210] transaction","detail":"{read_only:false; response_revision:754; number_of_response:1; }","duration":"144.813341ms","start":"2026-05-09T12:50:18.575604Z","end":"2026-05-09T12:50:18.720417Z","steps":["trace[1976836210] 'process raft request' (duration: 144.602509ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T12:50:21.300768Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4831410278010566521,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-09T12:50:21.654825Z","caller":"traceutil/trace.go:171","msg":"trace[990015703] linearizableReadLoop","detail":"{readStateIndex:797; appliedIndex:796; }","duration":"854.720537ms","start":"2026-05-09T12:50:20.800088Z","end":"2026-05-09T12:50:21.654809Z","steps":["trace[990015703] 'read index received' (duration: 854.647157ms)","trace[990015703] 'applied index is now lower than readState.Index' (duration: 70.77µs)"],"step_count":2} {"level":"info","ts":"2026-05-09T12:50:21.655094Z","caller":"traceutil/trace.go:171","msg":"trace[2124485658] transaction","detail":"{read_only:false; response_revision:768; number_of_response:1; }","duration":"904.974514ms","start":"2026-05-09T12:50:20.750112Z","end":"2026-05-09T12:50:21.655087Z","steps":["trace[2124485658] 'process raft request' (duration: 904.590991ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T12:50:21.655166Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:50:20.750096Z","time spent":"905.017344ms","remote":"127.0.0.1:43440","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4025,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-09T12:50:21.655476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"670.772347ms","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-05-09T12:50:21.655499Z","caller":"traceutil/trace.go:171","msg":"trace[1359721599] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:768; }","duration":"670.798527ms","start":"2026-05-09T12:50:20.984695Z","end":"2026-05-09T12:50:21.655494Z","steps":["trace[1359721599] 'agreement among raft nodes before linearized reading' (duration: 670.712147ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T12:50:21.655515Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:50:20.984638Z","time spent":"670.873347ms","remote":"127.0.0.1:43520","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-09T12:50:21.655508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"821.690454ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-09T12:50:21.655593Z","caller":"traceutil/trace.go:171","msg":"trace[1692942181] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:768; }","duration":"821.814006ms","start":"2026-05-09T12:50:20.833756Z","end":"2026-05-09T12:50:21.65557Z","steps":["trace[1692942181] 'agreement among raft nodes before linearized reading' (duration: 821.500072ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T12:50:21.655646Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:50:20.833746Z","time spent":"821.890566ms","remote":"127.0.0.1:43520","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-09T12:50:21.655803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"811.878924ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T12:50:21.655828Z","caller":"traceutil/trace.go:171","msg":"trace[1617589504] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:768; }","duration":"811.984824ms","start":"2026-05-09T12:50:20.843837Z","end":"2026-05-09T12:50:21.655822Z","steps":["trace[1617589504] 'agreement among raft nodes before linearized reading' (duration: 811.948144ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T12:50:21.655842Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:50:20.843828Z","time spent":"812.011935ms","remote":"127.0.0.1:43262","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-09T12:50:21.655935Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"719.063636ms","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-05-09T12:50:21.655952Z","caller":"traceutil/trace.go:171","msg":"trace[89492656] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:768; }","duration":"719.120246ms","start":"2026-05-09T12:50:20.936828Z","end":"2026-05-09T12:50:21.655948Z","steps":["trace[89492656] 'agreement among raft nodes before linearized reading' (duration: 719.077376ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T12:50:21.655965Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:50:20.936809Z","time spent":"719.152267ms","remote":"127.0.0.1:43520","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-09T12:50:21.655608Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"855.530105ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-09T12:50:21.656023Z","caller":"traceutil/trace.go:171","msg":"trace[88401882] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:768; }","duration":"855.944208ms","start":"2026-05-09T12:50:20.800072Z","end":"2026-05-09T12:50:21.656016Z","steps":["trace[88401882] 'agreement among raft nodes before linearized reading' (duration: 855.513795ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T12:50:21.656038Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:50:20.800006Z","time spent":"856.026939ms","remote":"127.0.0.1:43360","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":9,"response size":29,"request content":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true "} {"level":"info","ts":"2026-05-09T12:50:21.767035Z","caller":"traceutil/trace.go:171","msg":"trace[1418783770] transaction","detail":"{read_only:false; response_revision:771; number_of_response:1; }","duration":"103.977399ms","start":"2026-05-09T12:50:21.663027Z","end":"2026-05-09T12:50:21.767005Z","steps":["trace[1418783770] 'process raft request' (duration: 103.865948ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T12:50:21.767069Z","caller":"traceutil/trace.go:171","msg":"trace[569204596] transaction","detail":"{read_only:false; response_revision:770; number_of_response:1; }","duration":"104.698784ms","start":"2026-05-09T12:50:21.662335Z","end":"2026-05-09T12:50:21.767034Z","steps":["trace[569204596] 'process raft request' (duration: 104.382451ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T12:50:21.767175Z","caller":"traceutil/trace.go:171","msg":"trace[658938817] transaction","detail":"{read_only:false; response_revision:772; number_of_response:1; }","duration":"103.114841ms","start":"2026-05-09T12:50:21.66404Z","end":"2026-05-09T12:50:21.767155Z","steps":["trace[658938817] 'process raft request' (duration: 102.91623ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T12:50:24.892852Z","caller":"traceutil/trace.go:171","msg":"trace[1635907821] transaction","detail":"{read_only:false; response_revision:784; number_of_response:1; }","duration":"121.044075ms","start":"2026-05-09T12:50:24.771779Z","end":"2026-05-09T12:50:24.892823Z","steps":["trace[1635907821] 'process raft request' (duration: 120.881493ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T12:52:05.497349Z","caller":"traceutil/trace.go:171","msg":"trace[391840206] transaction","detail":"{read_only:false; response_revision:1276; number_of_response:1; }","duration":"198.518833ms","start":"2026-05-09T12:52:05.298792Z","end":"2026-05-09T12:52:05.497311Z","steps":["trace[391840206] 'process raft request' (duration: 188.03814ms)","trace[391840206] 'compare' (duration: 10.025249ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T12:52:13.799245Z","caller":"traceutil/trace.go:171","msg":"trace[1958409644] transaction","detail":"{read_only:false; response_revision:1307; number_of_response:1; }","duration":"275.110084ms","start":"2026-05-09T12:52:13.524107Z","end":"2026-05-09T12:52:13.799217Z","steps":["trace[1958409644] 'process raft request' (duration: 274.934423ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T12:52:48.014385Z","caller":"traceutil/trace.go:171","msg":"trace[207741950] transaction","detail":"{read_only:false; response_revision:1425; number_of_response:1; }","duration":"102.948439ms","start":"2026-05-09T12:52:47.911405Z","end":"2026-05-09T12:52:48.014353Z","steps":["trace[207741950] 'process raft request' (duration: 102.748387ms)"],"step_count":1}