{"level":"warn","ts":"2026-09-23T10:35:39.732302Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-23T10:35:39.732415Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.76: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://162.253.55.76:2380","--initial-cluster=instance=https://162.253.55.76:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.76:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.76: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-09-23T10:35:39.732498Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-23T10:35:39.732513Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.76:2380"]} {"level":"info","ts":"2026-09-23T10:35:39.732595Z","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-09-23T10:35:39.733528Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.76:2379"]} {"level":"info","ts":"2026-09-23T10:35:39.733642Z","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://162.253.55.76:2380"],"listen-peer-urls":["https://162.253.55.76:2380"],"advertise-client-urls":["https://162.253.55.76:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.76:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.76: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-09-23T10:35:39.7376Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.150053ms"} {"level":"info","ts":"2026-09-23T10:35:39.745701Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"30ad0c2b6ecdd25e","cluster-id":"855d190e6ef0a61f"} {"level":"info","ts":"2026-09-23T10:35:39.745826Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30ad0c2b6ecdd25e switched to configuration voters=()"} {"level":"info","ts":"2026-09-23T10:35:39.745847Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30ad0c2b6ecdd25e became follower at term 0"} {"level":"info","ts":"2026-09-23T10:35:39.745856Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 30ad0c2b6ecdd25e [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-23T10:35:39.745868Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30ad0c2b6ecdd25e became follower at term 1"} {"level":"info","ts":"2026-09-23T10:35:39.745905Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30ad0c2b6ecdd25e switched to configuration voters=(3507473065473593950)"} {"level":"warn","ts":"2026-09-23T10:35:39.753127Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-23T10:35:39.754675Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-23T10:35:39.756144Z","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-09-23T10:35:39.760303Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"30ad0c2b6ecdd25e","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-23T10:35:39.761204Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"30ad0c2b6ecdd25e","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-23T10:35:39.761292Z","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-09-23T10:35:39.761333Z","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-09-23T10:35:39.761347Z","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-09-23T10:35:39.765966Z","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-09-23T10:35:39.766043Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.76:2380"} {"level":"info","ts":"2026-09-23T10:35:39.766141Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.76:2380"} {"level":"info","ts":"2026-09-23T10:35:39.76671Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"30ad0c2b6ecdd25e","initial-advertise-peer-urls":["https://162.253.55.76:2380"],"listen-peer-urls":["https://162.253.55.76:2380"],"advertise-client-urls":["https://162.253.55.76:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.76:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-23T10:35:39.766758Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-23T10:35:39.768158Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30ad0c2b6ecdd25e switched to configuration voters=(3507473065473593950)"} {"level":"info","ts":"2026-09-23T10:35:39.768283Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"855d190e6ef0a61f","local-member-id":"30ad0c2b6ecdd25e","added-peer-id":"30ad0c2b6ecdd25e","added-peer-peer-urls":["https://162.253.55.76:2380"]} {"level":"info","ts":"2026-09-23T10:35:39.846973Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30ad0c2b6ecdd25e is starting a new election at term 1"} {"level":"info","ts":"2026-09-23T10:35:39.847059Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30ad0c2b6ecdd25e became pre-candidate at term 1"} {"level":"info","ts":"2026-09-23T10:35:39.847185Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30ad0c2b6ecdd25e received MsgPreVoteResp from 30ad0c2b6ecdd25e at term 1"} {"level":"info","ts":"2026-09-23T10:35:39.847235Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30ad0c2b6ecdd25e became candidate at term 2"} {"level":"info","ts":"2026-09-23T10:35:39.847252Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30ad0c2b6ecdd25e received MsgVoteResp from 30ad0c2b6ecdd25e at term 2"} {"level":"info","ts":"2026-09-23T10:35:39.847268Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30ad0c2b6ecdd25e became leader at term 2"} {"level":"info","ts":"2026-09-23T10:35:39.847285Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 30ad0c2b6ecdd25e elected leader 30ad0c2b6ecdd25e at term 2"} {"level":"info","ts":"2026-09-23T10:35:39.84834Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-23T10:35:39.849304Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-23T10:35:39.849369Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-23T10:35:39.849314Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"30ad0c2b6ecdd25e","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.76:2379]}","request-path":"/0/members/30ad0c2b6ecdd25e/attributes","cluster-id":"855d190e6ef0a61f","publish-timeout":"7s"} {"level":"info","ts":"2026-09-23T10:35:39.849568Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-23T10:35:39.849601Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-23T10:35:39.849821Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"855d190e6ef0a61f","local-member-id":"30ad0c2b6ecdd25e","cluster-version":"3.5"} {"level":"info","ts":"2026-09-23T10:35:39.849928Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-23T10:35:39.849966Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-23T10:35:39.851307Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-23T10:35:39.85271Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.76:2379"} {"level":"info","ts":"2026-09-23T10:35:43.253636Z","caller":"traceutil/trace.go:171","msg":"trace[1370330548] transaction","detail":"{read_only:false; response_revision:197; number_of_response:1; }","duration":"104.955797ms","start":"2026-09-23T10:35:43.148647Z","end":"2026-09-23T10:35:43.253603Z","steps":["trace[1370330548] 'process raft request' (duration: 102.677397ms)"],"step_count":1} {"level":"info","ts":"2026-09-23T10:35:45.824674Z","caller":"traceutil/trace.go:171","msg":"trace[470839916] linearizableReadLoop","detail":"{readStateIndex:321; appliedIndex:320; }","duration":"309.667256ms","start":"2026-09-23T10:35:45.514986Z","end":"2026-09-23T10:35:45.824653Z","steps":["trace[470839916] 'read index received' (duration: 309.501582ms)","trace[470839916] 'applied index is now lower than readState.Index' (duration: 164.944µs)"],"step_count":2} {"level":"warn","ts":"2026-09-23T10:35:45.82488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.880132ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/horizontal-pod-autoscaler\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-23T10:35:45.824912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.109339ms","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-09-23T10:35:45.824843Z","caller":"traceutil/trace.go:171","msg":"trace[2141083718] transaction","detail":"{read_only:false; response_revision:310; number_of_response:1; }","duration":"329.217397ms","start":"2026-09-23T10:35:45.495588Z","end":"2026-09-23T10:35:45.824805Z","steps":["trace[2141083718] 'process raft request' (duration: 328.95149ms)"],"step_count":1} {"level":"info","ts":"2026-09-23T10:35:45.824949Z","caller":"traceutil/trace.go:171","msg":"trace[1287276917] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/horizontal-pod-autoscaler; range_end:; response_count:0; response_revision:310; }","duration":"310.005955ms","start":"2026-09-23T10:35:45.514934Z","end":"2026-09-23T10:35:45.82494Z","steps":["trace[1287276917] 'agreement among raft nodes before linearized reading' (duration: 309.854701ms)"],"step_count":1} {"level":"info","ts":"2026-09-23T10:35:45.82496Z","caller":"traceutil/trace.go:171","msg":"trace[1118890456] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:310; }","duration":"200.161691ms","start":"2026-09-23T10:35:45.624785Z","end":"2026-09-23T10:35:45.824946Z","steps":["trace[1118890456] 'agreement among raft nodes before linearized reading' (duration: 200.063668ms)"],"step_count":1} {"level":"warn","ts":"2026-09-23T10:35:45.824965Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.228419ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-23T10:35:45.825045Z","caller":"traceutil/trace.go:171","msg":"trace[621899515] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:0; response_revision:310; }","duration":"150.364613ms","start":"2026-09-23T10:35:45.67466Z","end":"2026-09-23T10:35:45.825024Z","steps":["trace[621899515] 'agreement among raft nodes before linearized reading' (duration: 150.208289ms)"],"step_count":1} {"level":"warn","ts":"2026-09-23T10:35:45.824978Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-23T10:35:45.514915Z","time spent":"310.057096ms","remote":"127.0.0.1:38718","response type":"/etcdserverpb.KV/Range","request count":0,"request size":65,"response count":0,"response size":28,"request content":"key:\"/registry/serviceaccounts/kube-system/horizontal-pod-autoscaler\" "} {"level":"warn","ts":"2026-09-23T10:35:45.825696Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-23T10:35:45.495572Z","time spent":"329.405812ms","remote":"127.0.0.1:38790","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-23T10:35:46.036803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.560309ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-09-23T10:35:46.036866Z","caller":"traceutil/trace.go:171","msg":"trace[1808502797] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:310; }","duration":"208.680472ms","start":"2026-09-23T10:35:45.828173Z","end":"2026-09-23T10:35:46.036853Z","steps":["trace[1808502797] 'range keys from in-memory index tree' (duration: 208.426096ms)"],"step_count":1} {"level":"info","ts":"2026-09-23T10:35:46.077712Z","caller":"traceutil/trace.go:171","msg":"trace[2137759422] transaction","detail":"{read_only:false; response_revision:311; number_of_response:1; }","duration":"248.557104ms","start":"2026-09-23T10:35:45.829127Z","end":"2026-09-23T10:35:46.077684Z","steps":["trace[2137759422] 'process raft request' (duration: 248.40903ms)"],"step_count":1} {"level":"info","ts":"2026-09-23T10:35:46.273028Z","caller":"traceutil/trace.go:171","msg":"trace[771132484] transaction","detail":"{read_only:false; number_of_response:0; response_revision:312; }","duration":"276.172184ms","start":"2026-09-23T10:35:45.996834Z","end":"2026-09-23T10:35:46.273006Z","steps":["trace[771132484] 'process raft request' (duration: 276.121303ms)"],"step_count":1} {"level":"info","ts":"2026-09-23T10:35:46.273067Z","caller":"traceutil/trace.go:171","msg":"trace[1947373289] transaction","detail":"{read_only:false; response_revision:312; number_of_response:1; }","duration":"442.484371ms","start":"2026-09-23T10:35:45.83054Z","end":"2026-09-23T10:35:46.273024Z","steps":["trace[1947373289] 'process raft request' (duration: 442.288316ms)"],"step_count":1} {"level":"warn","ts":"2026-09-23T10:35:46.27322Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-23T10:35:45.830522Z","time spent":"442.627645ms","remote":"127.0.0.1:38790","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-23T10:35:46.27335Z","caller":"traceutil/trace.go:171","msg":"trace[1538758056] transaction","detail":"{read_only:false; number_of_response:0; response_revision:312; }","duration":"276.166473ms","start":"2026-09-23T10:35:45.997155Z","end":"2026-09-23T10:35:46.273322Z","steps":["trace[1538758056] 'process raft request' (duration: 275.825304ms)"],"step_count":1} {"level":"warn","ts":"2026-09-23T10:35:46.273945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.656035ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/etcd-instance\" ","response":"range_response_count:1 size:3974"} {"level":"info","ts":"2026-09-23T10:35:46.274021Z","caller":"traceutil/trace.go:171","msg":"trace[364489543] range","detail":"{range_begin:/registry/pods/kube-system/etcd-instance; range_end:; response_count:1; response_revision:313; }","duration":"276.743988ms","start":"2026-09-23T10:35:45.997245Z","end":"2026-09-23T10:35:46.273989Z","steps":["trace[364489543] 'agreement among raft nodes before linearized reading' (duration: 276.163594ms)"],"step_count":1} {"level":"info","ts":"2026-09-23T10:35:46.274148Z","caller":"traceutil/trace.go:171","msg":"trace[1172601919] transaction","detail":"{read_only:false; number_of_response:0; response_revision:312; }","duration":"276.889542ms","start":"2026-09-23T10:35:45.997239Z","end":"2026-09-23T10:35:46.274129Z","steps":["trace[1172601919] 'process raft request' (duration: 275.970498ms)"],"step_count":1} {"level":"info","ts":"2026-09-23T10:35:46.274432Z","caller":"traceutil/trace.go:171","msg":"trace[2142189714] transaction","detail":"{read_only:false; number_of_response:0; response_revision:312; }","duration":"276.753378ms","start":"2026-09-23T10:35:45.99766Z","end":"2026-09-23T10:35:46.274413Z","steps":["trace[2142189714] 'process raft request' (duration: 275.581998ms)"],"step_count":1} {"level":"info","ts":"2026-09-23T10:35:46.275159Z","caller":"traceutil/trace.go:171","msg":"trace[902354600] transaction","detail":"{read_only:false; response_revision:313; number_of_response:1; }","duration":"235.06583ms","start":"2026-09-23T10:35:46.039886Z","end":"2026-09-23T10:35:46.274952Z","steps":["trace[902354600] 'process raft request' (duration: 233.394407ms)"],"step_count":1} {"level":"info","ts":"2026-09-23T10:35:46.273381Z","caller":"traceutil/trace.go:171","msg":"trace[401890083] linearizableReadLoop","detail":"{readStateIndex:326; appliedIndex:321; }","duration":"276.079041ms","start":"2026-09-23T10:35:45.997276Z","end":"2026-09-23T10:35:46.273355Z","steps":["trace[401890083] 'read index received' (duration: 80.346796ms)","trace[401890083] 'applied index is now lower than readState.Index' (duration: 195.731305ms)"],"step_count":2} {"level":"warn","ts":"2026-09-23T10:35:46.278714Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.82736ms","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-09-23T10:35:46.278804Z","caller":"traceutil/trace.go:171","msg":"trace[50222429] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:314; }","duration":"197.954514ms","start":"2026-09-23T10:35:46.080827Z","end":"2026-09-23T10:35:46.278782Z","steps":["trace[50222429] 'agreement among raft nodes before linearized reading' (duration: 197.755528ms)"],"step_count":1} {"level":"warn","ts":"2026-09-23T10:35:46.279026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.44482ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-09-23T10:35:46.279092Z","caller":"traceutil/trace.go:171","msg":"trace[940788070] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:314; }","duration":"118.539952ms","start":"2026-09-23T10:35:46.160528Z","end":"2026-09-23T10:35:46.279068Z","steps":["trace[940788070] 'agreement among raft nodes before linearized reading' (duration: 118.45851ms)"],"step_count":1} {"level":"info","ts":"2026-09-23T10:35:46.279288Z","caller":"traceutil/trace.go:171","msg":"trace[615824191] transaction","detail":"{read_only:false; response_revision:314; number_of_response:1; }","duration":"197.79594ms","start":"2026-09-23T10:35:46.081459Z","end":"2026-09-23T10:35:46.279255Z","steps":["trace[615824191] 'process raft request' (duration: 196.799804ms)"],"step_count":1} {"level":"info","ts":"2026-09-23T10:36:22.552706Z","caller":"traceutil/trace.go:171","msg":"trace[1485561303] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"118.207143ms","start":"2026-09-23T10:36:22.434461Z","end":"2026-09-23T10:36:22.552668Z","steps":["trace[1485561303] 'process raft request' (duration: 117.975307ms)"],"step_count":1} {"level":"info","ts":"2026-09-23T10:36:29.352554Z","caller":"traceutil/trace.go:171","msg":"trace[641158439] linearizableReadLoop","detail":"{readStateIndex:678; appliedIndex:677; }","duration":"125.893474ms","start":"2026-09-23T10:36:29.226592Z","end":"2026-09-23T10:36:29.352485Z","steps":["trace[641158439] 'read index received' (duration: 125.447162ms)","trace[641158439] 'applied index is now lower than readState.Index' (duration: 444.462µs)"],"step_count":2} {"level":"warn","ts":"2026-09-23T10:36:29.352695Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.079579ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-23T10:36:29.352771Z","caller":"traceutil/trace.go:171","msg":"trace[999448546] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:651; }","duration":"126.230183ms","start":"2026-09-23T10:36:29.226523Z","end":"2026-09-23T10:36:29.352753Z","steps":["trace[999448546] 'agreement among raft nodes before linearized reading' (duration: 126.095379ms)"],"step_count":1} {"level":"info","ts":"2026-09-23T10:36:29.352603Z","caller":"traceutil/trace.go:171","msg":"trace[985714929] transaction","detail":"{read_only:false; response_revision:651; number_of_response:1; }","duration":"163.67518ms","start":"2026-09-23T10:36:29.188876Z","end":"2026-09-23T10:36:29.352551Z","steps":["trace[985714929] 'process raft request' (duration: 163.163986ms)"],"step_count":1} {"level":"warn","ts":"2026-09-23T10:36:29.576485Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.645095ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-23T10:36:29.576616Z","caller":"traceutil/trace.go:171","msg":"trace[896051299] transaction","detail":"{read_only:false; response_revision:652; number_of_response:1; }","duration":"331.913088ms","start":"2026-09-23T10:36:29.244683Z","end":"2026-09-23T10:36:29.576596Z","steps":["trace[896051299] 'process raft request' (duration: 230.309438ms)","trace[896051299] 'compare' (duration: 100.270565ms)"],"step_count":2} {"level":"warn","ts":"2026-09-23T10:36:29.577003Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-23T10:36:29.244646Z","time spent":"332.011641ms","remote":"127.0.0.1:38596","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036285,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-23T10:36:30.337192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.101008ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-09-23T10:36:30.337278Z","caller":"traceutil/trace.go:171","msg":"trace[865572226] linearizableReadLoop","detail":"{readStateIndex:680; appliedIndex:679; }","duration":"225.918172ms","start":"2026-09-23T10:36:30.111344Z","end":"2026-09-23T10:36:30.337262Z","steps":["trace[865572226] 'read index received' (duration: 47.741µs)","trace[865572226] 'applied index is now lower than readState.Index' (duration: 225.869291ms)"],"step_count":2} {"level":"info","ts":"2026-09-23T10:36:30.33779Z","caller":"traceutil/trace.go:171","msg":"trace[355254513] transaction","detail":"{read_only:false; response_revision:653; number_of_response:1; }","duration":"689.491404ms","start":"2026-09-23T10:36:29.648203Z","end":"2026-09-23T10:36:30.337694Z","steps":["trace[355254513] 'process raft request' (duration: 406.831121ms)","trace[355254513] 'compare' (duration: 281.989925ms)"],"step_count":2} {"level":"warn","ts":"2026-09-23T10:36:30.337885Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-23T10:36:29.648184Z","time spent":"689.658688ms","remote":"127.0.0.1:39018","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-23T10:36:30.338007Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.629581ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-09-23T10:36:30.337539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.419ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-23T10:36:30.338179Z","caller":"traceutil/trace.go:171","msg":"trace[1168956341] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:653; }","duration":"111.090788ms","start":"2026-09-23T10:36:30.227073Z","end":"2026-09-23T10:36:30.338163Z","steps":["trace[1168956341] 'agreement among raft nodes before linearized reading' (duration: 110.427131ms)"],"step_count":1} {"level":"info","ts":"2026-09-23T10:36:30.338084Z","caller":"traceutil/trace.go:171","msg":"trace[735572687] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:653; }","duration":"226.774775ms","start":"2026-09-23T10:36:30.111286Z","end":"2026-09-23T10:36:30.338061Z","steps":["trace[735572687] 'agreement among raft nodes before linearized reading' (duration: 226.140828ms)"],"step_count":1} {"level":"info","ts":"2026-09-23T10:36:49.650206Z","caller":"traceutil/trace.go:171","msg":"trace[1202984795] linearizableReadLoop","detail":"{readStateIndex:863; appliedIndex:862; }","duration":"377.574038ms","start":"2026-09-23T10:36:49.272609Z","end":"2026-09-23T10:36:49.650183Z","steps":["trace[1202984795] 'read index received' (duration: 377.349694ms)","trace[1202984795] 'applied index is now lower than readState.Index' (duration: 223.414µs)"],"step_count":2} {"level":"info","ts":"2026-09-23T10:36:49.650266Z","caller":"traceutil/trace.go:171","msg":"trace[1882966499] transaction","detail":"{read_only:false; response_revision:830; number_of_response:1; }","duration":"406.128584ms","start":"2026-09-23T10:36:49.244113Z","end":"2026-09-23T10:36:49.650241Z","steps":["trace[1882966499] 'process raft request' (duration: 405.918189ms)"],"step_count":1} {"level":"warn","ts":"2026-09-23T10:36:49.650426Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"313.031173ms","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":"warn","ts":"2026-09-23T10:36:49.650388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"377.739313ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-23T10:36:49.65047Z","caller":"traceutil/trace.go:171","msg":"trace[801925971] 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:830; }","duration":"313.110676ms","start":"2026-09-23T10:36:49.337346Z","end":"2026-09-23T10:36:49.650457Z","steps":["trace[801925971] 'agreement among raft nodes before linearized reading' (duration: 313.041444ms)"],"step_count":1} {"level":"warn","ts":"2026-09-23T10:36:49.650473Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"313.133496ms","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-09-23T10:36:49.650482Z","caller":"traceutil/trace.go:171","msg":"trace[1688298764] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:830; }","duration":"377.882667ms","start":"2026-09-23T10:36:49.272586Z","end":"2026-09-23T10:36:49.650468Z","steps":["trace[1688298764] 'agreement among raft nodes before linearized reading' (duration: 377.704132ms)"],"step_count":1} {"level":"warn","ts":"2026-09-23T10:36:49.650382Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-23T10:36:49.244092Z","time spent":"406.226027ms","remote":"127.0.0.1:38708","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4024,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-23T10:36:49.650511Z","caller":"traceutil/trace.go:171","msg":"trace[1803958089] 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:830; }","duration":"313.166048ms","start":"2026-09-23T10:36:49.337331Z","end":"2026-09-23T10:36:49.650497Z","steps":["trace[1803958089] 'agreement among raft nodes before linearized reading' (duration: 313.122567ms)"],"step_count":1} {"level":"warn","ts":"2026-09-23T10:36:49.650524Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-23T10:36:49.272571Z","time spent":"377.938938ms","remote":"127.0.0.1:44082","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-09-23T10:36:49.650553Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.990985ms","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":"warn","ts":"2026-09-23T10:36:49.650553Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-23T10:36:49.337291Z","time spent":"313.25324ms","remote":"127.0.0.1:44146","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:10000 "} {"level":"info","ts":"2026-09-23T10:36:49.650572Z","caller":"traceutil/trace.go:171","msg":"trace[664405442] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:830; }","duration":"253.039616ms","start":"2026-09-23T10:36:49.397525Z","end":"2026-09-23T10:36:49.650565Z","steps":["trace[664405442] 'agreement among raft nodes before linearized reading' (duration: 253.000665ms)"],"step_count":1} {"level":"warn","ts":"2026-09-23T10:36:49.650575Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.90624ms","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":"warn","ts":"2026-09-23T10:36:49.650499Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-23T10:36:49.337325Z","time spent":"313.168308ms","remote":"127.0.0.1:44146","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"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-09-23T10:36:49.650623Z","caller":"traceutil/trace.go:171","msg":"trace[1995195477] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:830; }","duration":"350.970602ms","start":"2026-09-23T10:36:49.299639Z","end":"2026-09-23T10:36:49.65061Z","steps":["trace[1995195477] 'agreement among raft nodes before linearized reading' (duration: 350.88822ms)"],"step_count":1} {"level":"warn","ts":"2026-09-23T10:36:49.650656Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-23T10:36:49.299633Z","time spent":"351.013764ms","remote":"127.0.0.1:44114","response type":"/etcdserverpb.KV/Range","request count":0,"request size":81,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" limit:500 "} {"level":"warn","ts":"2026-09-23T10:36:49.650425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"377.737023ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-23T10:36:49.650784Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.112284ms","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-09-23T10:36:49.65079Z","caller":"traceutil/trace.go:171","msg":"trace[68779314] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:830; }","duration":"378.129443ms","start":"2026-09-23T10:36:49.272649Z","end":"2026-09-23T10:36:49.650779Z","steps":["trace[68779314] 'agreement among raft nodes before linearized reading' (duration: 377.712772ms)"],"step_count":1} {"level":"info","ts":"2026-09-23T10:36:49.650807Z","caller":"traceutil/trace.go:171","msg":"trace[2130351626] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:830; }","duration":"254.165626ms","start":"2026-09-23T10:36:49.396632Z","end":"2026-09-23T10:36:49.650798Z","steps":["trace[2130351626] 'agreement among raft nodes before linearized reading' (duration: 254.130475ms)"],"step_count":1} {"level":"warn","ts":"2026-09-23T10:36:49.650825Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-23T10:36:49.272634Z","time spent":"378.178534ms","remote":"127.0.0.1:44082","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true "} {"level":"warn","ts":"2026-09-23T10:36:49.650854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"365.896697ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-23T10:36:49.650854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"334.908168ms","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-09-23T10:36:49.650878Z","caller":"traceutil/trace.go:171","msg":"trace[1421042899] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:830; }","duration":"365.933859ms","start":"2026-09-23T10:36:49.284937Z","end":"2026-09-23T10:36:49.650871Z","steps":["trace[1421042899] 'agreement among raft nodes before linearized reading' (duration: 365.886237ms)"],"step_count":1} {"level":"info","ts":"2026-09-23T10:36:49.650884Z","caller":"traceutil/trace.go:171","msg":"trace[1060123379] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:830; }","duration":"334.95975ms","start":"2026-09-23T10:36:49.315914Z","end":"2026-09-23T10:36:49.650874Z","steps":["trace[1060123379] 'agreement among raft nodes before linearized reading' (duration: 334.906578ms)"],"step_count":1} {"level":"warn","ts":"2026-09-23T10:36:49.650895Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-23T10:36:49.284928Z","time spent":"365.962049ms","remote":"127.0.0.1:44098","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true "} {"level":"warn","ts":"2026-09-23T10:36:49.650898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"378.00166ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-23T10:36:49.650915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.278649ms","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-09-23T10:36:49.650935Z","caller":"traceutil/trace.go:171","msg":"trace[1873285736] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:830; }","duration":"254.32032ms","start":"2026-09-23T10:36:49.39661Z","end":"2026-09-23T10:36:49.65093Z","steps":["trace[1873285736] 'agreement among raft nodes before linearized reading' (duration: 254.287119ms)"],"step_count":1} {"level":"info","ts":"2026-09-23T10:36:49.650934Z","caller":"traceutil/trace.go:171","msg":"trace[945389987] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:830; }","duration":"378.040671ms","start":"2026-09-23T10:36:49.272882Z","end":"2026-09-23T10:36:49.650923Z","steps":["trace[945389987] 'agreement among raft nodes before linearized reading' (duration: 377.977599ms)"],"step_count":1} {"level":"warn","ts":"2026-09-23T10:36:49.650947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"335.270287ms","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-09-23T10:36:49.650972Z","caller":"traceutil/trace.go:171","msg":"trace[172681258] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:830; }","duration":"335.309788ms","start":"2026-09-23T10:36:49.315655Z","end":"2026-09-23T10:36:49.650965Z","steps":["trace[172681258] 'agreement among raft nodes before linearized reading' (duration: 335.272917ms)"],"step_count":1} {"level":"warn","ts":"2026-09-23T10:36:49.650977Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"351.358432ms","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":"warn","ts":"2026-09-23T10:36:49.650973Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-23T10:36:49.272865Z","time spent":"378.097072ms","remote":"127.0.0.1:44082","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:500 "} {"level":"info","ts":"2026-09-23T10:36:49.650998Z","caller":"traceutil/trace.go:171","msg":"trace[608557762] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:830; }","duration":"351.399544ms","start":"2026-09-23T10:36:49.299593Z","end":"2026-09-23T10:36:49.650993Z","steps":["trace[608557762] 'agreement among raft nodes before linearized reading' (duration: 351.370433ms)"],"step_count":1} {"level":"warn","ts":"2026-09-23T10:36:49.650996Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-23T10:36:49.31565Z","time spent":"335.339139ms","remote":"127.0.0.1:44130","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true "} {"level":"warn","ts":"2026-09-23T10:36:49.651015Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-23T10:36:49.299581Z","time spent":"351.429034ms","remote":"127.0.0.1:44114","response type":"/etcdserverpb.KV/Range","request count":0,"request size":81,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" limit:10000 "} {"level":"warn","ts":"2026-09-23T10:36:49.651015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.15613ms","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-09-23T10:36:49.651046Z","caller":"traceutil/trace.go:171","msg":"trace[1289079158] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:830; }","duration":"272.209921ms","start":"2026-09-23T10:36:49.378832Z","end":"2026-09-23T10:36:49.651042Z","steps":["trace[1289079158] 'agreement among raft nodes before linearized reading' (duration: 272.16834ms)"],"step_count":1} {"level":"warn","ts":"2026-09-23T10:36:49.651122Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.283773ms","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":"warn","ts":"2026-09-23T10:36:49.651128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"366.096283ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-23T10:36:49.651128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"335.483823ms","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":"info","ts":"2026-09-23T10:36:49.651138Z","caller":"traceutil/trace.go:171","msg":"trace[969036418] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:830; }","duration":"272.323984ms","start":"2026-09-23T10:36:49.378808Z","end":"2026-09-23T10:36:49.651132Z","steps":["trace[969036418] 'agreement among raft nodes before linearized reading' (duration: 272.296434ms)"],"step_count":1} {"level":"info","ts":"2026-09-23T10:36:49.651149Z","caller":"traceutil/trace.go:171","msg":"trace[183765496] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:830; }","duration":"366.153624ms","start":"2026-09-23T10:36:49.284989Z","end":"2026-09-23T10:36:49.651143Z","steps":["trace[183765496] 'agreement among raft nodes before linearized reading' (duration: 366.111683ms)"],"step_count":1} {"level":"warn","ts":"2026-09-23T10:36:49.651168Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-23T10:36:49.284968Z","time spent":"366.193735ms","remote":"127.0.0.1:44098","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" limit:10000 "} {"level":"info","ts":"2026-09-23T10:36:49.651169Z","caller":"traceutil/trace.go:171","msg":"trace[574902398] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:830; }","duration":"335.535075ms","start":"2026-09-23T10:36:49.31561Z","end":"2026-09-23T10:36:49.651145Z","steps":["trace[574902398] 'agreement among raft nodes before linearized reading' (duration: 335.496844ms)"],"step_count":1} {"level":"warn","ts":"2026-09-23T10:36:49.651194Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-23T10:36:49.315592Z","time spent":"335.594766ms","remote":"127.0.0.1:44130","response type":"/etcdserverpb.KV/Range","request count":0,"request size":95,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" limit:10000 "} {"level":"warn","ts":"2026-09-23T10:36:49.651217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.175943ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-23T10:36:49.651232Z","caller":"traceutil/trace.go:171","msg":"trace[1627584631] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:830; }","duration":"295.210164ms","start":"2026-09-23T10:36:49.356017Z","end":"2026-09-23T10:36:49.651228Z","steps":["trace[1627584631] 'agreement among raft nodes before linearized reading' (duration: 295.181723ms)"],"step_count":1} {"level":"warn","ts":"2026-09-23T10:36:49.651243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.673436ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-23T10:36:49.651255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"366.242416ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-23T10:36:49.651277Z","caller":"traceutil/trace.go:171","msg":"trace[1009940066] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:830; }","duration":"366.282587ms","start":"2026-09-23T10:36:49.284988Z","end":"2026-09-23T10:36:49.65127Z","steps":["trace[1009940066] 'agreement among raft nodes before linearized reading' (duration: 366.249736ms)"],"step_count":1} {"level":"warn","ts":"2026-09-23T10:36:49.651271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"313.018334ms","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":"info","ts":"2026-09-23T10:36:49.651285Z","caller":"traceutil/trace.go:171","msg":"trace[220736865] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:830; }","duration":"295.734198ms","start":"2026-09-23T10:36:49.355532Z","end":"2026-09-23T10:36:49.651266Z","steps":["trace[220736865] 'agreement among raft nodes before linearized reading' (duration: 295.682937ms)"],"step_count":1} {"level":"warn","ts":"2026-09-23T10:36:49.650912Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-23T10:36:49.315906Z","time spent":"334.99867ms","remote":"127.0.0.1:44130","response type":"/etcdserverpb.KV/Range","request count":0,"request size":95,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" limit:500 "} {"level":"info","ts":"2026-09-23T10:36:49.651302Z","caller":"traceutil/trace.go:171","msg":"trace[652538858] 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:830; }","duration":"313.067265ms","start":"2026-09-23T10:36:49.338226Z","end":"2026-09-23T10:36:49.651293Z","steps":["trace[652538858] 'agreement among raft nodes before linearized reading' (duration: 313.020103ms)"],"step_count":1} {"level":"warn","ts":"2026-09-23T10:36:49.651329Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-23T10:36:49.338215Z","time spent":"313.106815ms","remote":"127.0.0.1:44146","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"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-09-23T10:36:49.651408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.756368ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-23T10:36:49.651296Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-23T10:36:49.284971Z","time spent":"366.318088ms","remote":"127.0.0.1:44098","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" limit:500 "} {"level":"info","ts":"2026-09-23T10:36:49.651436Z","caller":"traceutil/trace.go:171","msg":"trace[2023108979] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:830; }","duration":"295.81788ms","start":"2026-09-23T10:36:49.355609Z","end":"2026-09-23T10:36:49.651427Z","steps":["trace[2023108979] 'agreement among raft nodes before linearized reading' (duration: 295.775449ms)"],"step_count":1} {"level":"warn","ts":"2026-09-23T10:36:49.6513Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"351.584689ms","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-09-23T10:36:49.651493Z","caller":"traceutil/trace.go:171","msg":"trace[394335323] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:830; }","duration":"351.797464ms","start":"2026-09-23T10:36:49.299688Z","end":"2026-09-23T10:36:49.651485Z","steps":["trace[394335323] 'agreement among raft nodes before linearized reading' (duration: 351.593388ms)"],"step_count":1} {"level":"warn","ts":"2026-09-23T10:36:49.651515Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-23T10:36:49.299683Z","time spent":"351.824984ms","remote":"127.0.0.1:44114","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true "} {"level":"warn","ts":"2026-09-23T10:37:48.408813Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.477422ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-23T10:37:48.40893Z","caller":"traceutil/trace.go:171","msg":"trace[1414148169] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/; range_end:/registry/mutatingwebhookconfigurations0; response_count:0; response_revision:1173; }","duration":"109.614495ms","start":"2026-09-23T10:37:48.299289Z","end":"2026-09-23T10:37:48.408903Z","steps":["trace[1414148169] 'count revisions from in-memory index tree' (duration: 109.37871ms)"],"step_count":1} {"level":"warn","ts":"2026-09-23T10:37:51.254515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.363776ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-09-23T10:37:51.254585Z","caller":"traceutil/trace.go:171","msg":"trace[1773462593] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1201; }","duration":"236.466728ms","start":"2026-09-23T10:37:51.018106Z","end":"2026-09-23T10:37:51.254573Z","steps":["trace[1773462593] 'range keys from in-memory index tree' (duration: 236.293844ms)"],"step_count":1} {"level":"warn","ts":"2026-09-23T10:37:52.909812Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.739644ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-23T10:37:52.909947Z","caller":"traceutil/trace.go:171","msg":"trace[348839992] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:0; response_revision:1208; }","duration":"145.930868ms","start":"2026-09-23T10:37:52.763984Z","end":"2026-09-23T10:37:52.909915Z","steps":["trace[348839992] 'range keys from in-memory index tree' (duration: 145.59909ms)"],"step_count":1} {"level":"info","ts":"2026-09-23T10:37:53.115033Z","caller":"traceutil/trace.go:171","msg":"trace[1408062640] transaction","detail":"{read_only:false; response_revision:1209; number_of_response:1; }","duration":"201.205984ms","start":"2026-09-23T10:37:52.913796Z","end":"2026-09-23T10:37:53.115002Z","steps":["trace[1408062640] 'process raft request' (duration: 201.06843ms)"],"step_count":1} {"level":"info","ts":"2026-09-23T10:37:53.131256Z","caller":"traceutil/trace.go:171","msg":"trace[420546828] transaction","detail":"{read_only:false; response_revision:1211; number_of_response:1; }","duration":"153.860365ms","start":"2026-09-23T10:37:52.977371Z","end":"2026-09-23T10:37:53.131232Z","steps":["trace[420546828] 'process raft request' (duration: 153.775583ms)"],"step_count":1} {"level":"info","ts":"2026-09-23T10:37:53.131304Z","caller":"traceutil/trace.go:171","msg":"trace[186502889] transaction","detail":"{read_only:false; response_revision:1210; number_of_response:1; }","duration":"215.293539ms","start":"2026-09-23T10:37:52.915981Z","end":"2026-09-23T10:37:53.131274Z","steps":["trace[186502889] 'process raft request' (duration: 215.018862ms)"],"step_count":1} {"level":"info","ts":"2026-09-23T10:37:53.287478Z","caller":"traceutil/trace.go:171","msg":"trace[877916445] transaction","detail":"{read_only:false; response_revision:1213; number_of_response:1; }","duration":"148.925517ms","start":"2026-09-23T10:37:53.138521Z","end":"2026-09-23T10:37:53.287447Z","steps":["trace[877916445] 'process raft request' (duration: 118.852526ms)","trace[877916445] 'compare' (duration: 29.918577ms)"],"step_count":2} {"level":"info","ts":"2026-09-23T10:37:53.346102Z","caller":"traceutil/trace.go:171","msg":"trace[1054162049] linearizableReadLoop","detail":"{readStateIndex:1261; appliedIndex:1259; }","duration":"197.351373ms","start":"2026-09-23T10:37:53.14873Z","end":"2026-09-23T10:37:53.346081Z","steps":["trace[1054162049] 'read index received' (duration: 108.667711ms)","trace[1054162049] 'applied index is now lower than readState.Index' (duration: 88.683012ms)"],"step_count":2} {"level":"info","ts":"2026-09-23T10:37:53.346223Z","caller":"traceutil/trace.go:171","msg":"trace[1815902303] transaction","detail":"{read_only:false; response_revision:1214; number_of_response:1; }","duration":"204.446527ms","start":"2026-09-23T10:37:53.141768Z","end":"2026-09-23T10:37:53.346214Z","steps":["trace[1815902303] 'process raft request' (duration: 204.189031ms)"],"step_count":1} {"level":"warn","ts":"2026-09-23T10:37:53.346626Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.884576ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.76\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-09-23T10:37:53.346742Z","caller":"traceutil/trace.go:171","msg":"trace[2049415649] range","detail":"{range_begin:/registry/masterleases/162.253.55.76; range_end:; response_count:1; response_revision:1214; }","duration":"198.077652ms","start":"2026-09-23T10:37:53.14864Z","end":"2026-09-23T10:37:53.346717Z","steps":["trace[2049415649] 'agreement among raft nodes before linearized reading' (duration: 197.886867ms)"],"step_count":1} {"level":"info","ts":"2026-09-23T10:38:03.859808Z","caller":"traceutil/trace.go:171","msg":"trace[937427850] transaction","detail":"{read_only:false; response_revision:1292; number_of_response:1; }","duration":"188.950276ms","start":"2026-09-23T10:38:03.670815Z","end":"2026-09-23T10:38:03.859765Z","steps":["trace[937427850] 'process raft request' (duration: 188.809693ms)"],"step_count":1} {"level":"info","ts":"2026-09-23T10:38:04.48633Z","caller":"traceutil/trace.go:171","msg":"trace[1064893902] transaction","detail":"{read_only:false; response_revision:1293; number_of_response:1; }","duration":"175.785093ms","start":"2026-09-23T10:38:04.310518Z","end":"2026-09-23T10:38:04.486303Z","steps":["trace[1064893902] 'process raft request' (duration: 175.613139ms)"],"step_count":1} {"level":"info","ts":"2026-09-23T10:42:25.777069Z","caller":"traceutil/trace.go:171","msg":"trace[279299449] transaction","detail":"{read_only:false; response_revision:2513; number_of_response:1; }","duration":"113.057182ms","start":"2026-09-23T10:42:25.663984Z","end":"2026-09-23T10:42:25.777041Z","steps":["trace[279299449] 'process raft request' (duration: 112.866097ms)"],"step_count":1}