{"level":"warn","ts":"2026-09-18T05:17:24.156682Z","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-18T05:17:24.156802Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.95: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.95:2380","--initial-cluster=instance=https://162.253.55.95:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.95:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.95: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-18T05:17:24.156889Z","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-18T05:17:24.156903Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.95:2380"]} {"level":"info","ts":"2026-09-18T05:17:24.156924Z","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-18T05:17:24.157621Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.95:2379"]} {"level":"info","ts":"2026-09-18T05:17:24.157718Z","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.95:2380"],"listen-peer-urls":["https://162.253.55.95:2380"],"advertise-client-urls":["https://162.253.55.95:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.95:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.95: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-18T05:17:24.16341Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.475019ms"} {"level":"info","ts":"2026-09-18T05:17:24.171013Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"282167b6747c9cda","cluster-id":"dc65cfc6e389e361"} {"level":"info","ts":"2026-09-18T05:17:24.171097Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"282167b6747c9cda switched to configuration voters=()"} {"level":"info","ts":"2026-09-18T05:17:24.17112Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"282167b6747c9cda became follower at term 0"} {"level":"info","ts":"2026-09-18T05:17:24.171134Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 282167b6747c9cda [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-18T05:17:24.171148Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"282167b6747c9cda became follower at term 1"} {"level":"info","ts":"2026-09-18T05:17:24.171187Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"282167b6747c9cda switched to configuration voters=(2891706469084601562)"} {"level":"warn","ts":"2026-09-18T05:17:24.177054Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-18T05:17:24.178308Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-18T05:17:24.179557Z","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-18T05:17:24.181479Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"282167b6747c9cda","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-18T05:17:24.185283Z","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-18T05:17:24.185962Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"282167b6747c9cda","initial-advertise-peer-urls":["https://162.253.55.95:2380"],"listen-peer-urls":["https://162.253.55.95:2380"],"advertise-client-urls":["https://162.253.55.95:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.95:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-18T05:17:24.186002Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-18T05:17:24.18665Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"282167b6747c9cda","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-18T05:17:24.186843Z","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-18T05:17:24.186918Z","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-18T05:17:24.186931Z","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-18T05:17:24.187049Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.95:2380"} {"level":"info","ts":"2026-09-18T05:17:24.187068Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.95:2380"} {"level":"info","ts":"2026-09-18T05:17:24.187192Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"282167b6747c9cda switched to configuration voters=(2891706469084601562)"} {"level":"info","ts":"2026-09-18T05:17:24.187349Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"dc65cfc6e389e361","local-member-id":"282167b6747c9cda","added-peer-id":"282167b6747c9cda","added-peer-peer-urls":["https://162.253.55.95:2380"]} {"level":"info","ts":"2026-09-18T05:17:24.372406Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"282167b6747c9cda is starting a new election at term 1"} {"level":"info","ts":"2026-09-18T05:17:24.372498Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"282167b6747c9cda became pre-candidate at term 1"} {"level":"info","ts":"2026-09-18T05:17:24.372529Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"282167b6747c9cda received MsgPreVoteResp from 282167b6747c9cda at term 1"} {"level":"info","ts":"2026-09-18T05:17:24.372567Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"282167b6747c9cda became candidate at term 2"} {"level":"info","ts":"2026-09-18T05:17:24.372578Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"282167b6747c9cda received MsgVoteResp from 282167b6747c9cda at term 2"} {"level":"info","ts":"2026-09-18T05:17:24.372598Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"282167b6747c9cda became leader at term 2"} {"level":"info","ts":"2026-09-18T05:17:24.372611Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 282167b6747c9cda elected leader 282167b6747c9cda at term 2"} {"level":"info","ts":"2026-09-18T05:17:24.373853Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-18T05:17:24.375836Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"282167b6747c9cda","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.95:2379]}","request-path":"/0/members/282167b6747c9cda/attributes","cluster-id":"dc65cfc6e389e361","publish-timeout":"7s"} {"level":"info","ts":"2026-09-18T05:17:24.376Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-18T05:17:24.376109Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-18T05:17:24.377348Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-18T05:17:24.377416Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-18T05:17:24.379382Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-18T05:17:24.379493Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"dc65cfc6e389e361","local-member-id":"282167b6747c9cda","cluster-version":"3.5"} {"level":"info","ts":"2026-09-18T05:17:24.381319Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.95:2379"} {"level":"info","ts":"2026-09-18T05:17:24.387935Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-18T05:17:24.388009Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-18T05:17:29.301034Z","caller":"traceutil/trace.go:171","msg":"trace[1285287808] transaction","detail":"{read_only:false; response_revision:217; number_of_response:1; }","duration":"120.25137ms","start":"2026-09-18T05:17:29.18076Z","end":"2026-09-18T05:17:29.301011Z","steps":["trace[1285287808] 'process raft request' (duration: 39.867584ms)","trace[1285287808] 'compare' (duration: 80.276182ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T05:17:37.107704Z","caller":"traceutil/trace.go:171","msg":"trace[966162291] linearizableReadLoop","detail":"{readStateIndex:367; appliedIndex:366; }","duration":"232.744126ms","start":"2026-09-18T05:17:36.874931Z","end":"2026-09-18T05:17:37.107675Z","steps":["trace[966162291] 'read index received' (duration: 232.439408ms)","trace[966162291] 'applied index is now lower than readState.Index' (duration: 303.098µs)"],"step_count":2} {"level":"info","ts":"2026-09-18T05:17:37.107924Z","caller":"traceutil/trace.go:171","msg":"trace[1031784484] transaction","detail":"{read_only:false; response_revision:354; number_of_response:1; }","duration":"481.160115ms","start":"2026-09-18T05:17:36.626723Z","end":"2026-09-18T05:17:37.107883Z","steps":["trace[1031784484] 'process raft request' (duration: 480.713333ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:17:37.107946Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.954582ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-proxy-lgdsk\" ","response":"range_response_count:1 size:4462"} {"level":"info","ts":"2026-09-18T05:17:37.108038Z","caller":"traceutil/trace.go:171","msg":"trace[798826822] range","detail":"{range_begin:/registry/pods/kube-system/kube-proxy-lgdsk; range_end:; response_count:1; response_revision:354; }","duration":"233.131117ms","start":"2026-09-18T05:17:36.874887Z","end":"2026-09-18T05:17:37.108018Z","steps":["trace[798826822] 'agreement among raft nodes before linearized reading' (duration: 232.905421ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:17:37.108628Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T05:17:36.626705Z","time spent":"481.3156ms","remote":"127.0.0.1:57580","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-18T05:17:37.740827Z","caller":"traceutil/trace.go:171","msg":"trace[1743003749] linearizableReadLoop","detail":"{readStateIndex:368; appliedIndex:367; }","duration":"257.744288ms","start":"2026-09-18T05:17:37.483056Z","end":"2026-09-18T05:17:37.740801Z","steps":["trace[1743003749] 'read index received' (duration: 257.600224ms)","trace[1743003749] 'applied index is now lower than readState.Index' (duration: 142.944µs)"],"step_count":2} {"level":"info","ts":"2026-09-18T05:17:37.740886Z","caller":"traceutil/trace.go:171","msg":"trace[369461908] transaction","detail":"{read_only:false; response_revision:355; number_of_response:1; }","duration":"625.116021ms","start":"2026-09-18T05:17:37.11573Z","end":"2026-09-18T05:17:37.740846Z","steps":["trace[369461908] 'process raft request' (duration: 624.936086ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:17:37.741065Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.978215ms","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-09-18T05:17:37.741178Z","caller":"traceutil/trace.go:171","msg":"trace[1440875321] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:355; }","duration":"258.14712ms","start":"2026-09-18T05:17:37.483008Z","end":"2026-09-18T05:17:37.741155Z","steps":["trace[1440875321] 'agreement among raft nodes before linearized reading' (duration: 257.893092ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:17:37.741218Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T05:17:37.115708Z","time spent":"625.322777ms","remote":"127.0.0.1:57490","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-18T05:18:05.992405Z","caller":"traceutil/trace.go:171","msg":"trace[1480365642] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"125.940096ms","start":"2026-09-18T05:18:05.86644Z","end":"2026-09-18T05:18:05.992381Z","steps":["trace[1480365642] 'process raft request' (duration: 125.836503ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:18:05.997515Z","caller":"traceutil/trace.go:171","msg":"trace[1967605024] linearizableReadLoop","detail":"{readStateIndex:519; appliedIndex:513; }","duration":"110.139877ms","start":"2026-09-18T05:18:05.887351Z","end":"2026-09-18T05:18:05.997491Z","steps":["trace[1967605024] 'read index received' (duration: 104.986948ms)","trace[1967605024] 'applied index is now lower than readState.Index' (duration: 5.151939ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T05:18:05.997842Z","caller":"traceutil/trace.go:171","msg":"trace[2060180414] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"125.341847ms","start":"2026-09-18T05:18:05.872487Z","end":"2026-09-18T05:18:05.997829Z","steps":["trace[2060180414] 'process raft request' (duration: 124.41794ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:18:05.998028Z","caller":"traceutil/trace.go:171","msg":"trace[740875798] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"118.119019ms","start":"2026-09-18T05:18:05.8799Z","end":"2026-09-18T05:18:05.998019Z","steps":["trace[740875798] 'process raft request' (duration: 117.11831ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:18:05.998147Z","caller":"traceutil/trace.go:171","msg":"trace[2032995439] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"110.953461ms","start":"2026-09-18T05:18:05.887186Z","end":"2026-09-18T05:18:05.99814Z","steps":["trace[2032995439] 'process raft request' (duration: 109.864309ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:18:05.998255Z","caller":"traceutil/trace.go:171","msg":"trace[998054403] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"111.012413ms","start":"2026-09-18T05:18:05.887234Z","end":"2026-09-18T05:18:05.998247Z","steps":["trace[998054403] 'process raft request' (duration: 109.8533ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:18:05.998323Z","caller":"traceutil/trace.go:171","msg":"trace[854819121] transaction","detail":"{read_only:false; response_revision:500; number_of_response:1; }","duration":"111.029223ms","start":"2026-09-18T05:18:05.887287Z","end":"2026-09-18T05:18:05.998316Z","steps":["trace[854819121] 'process raft request' (duration: 109.833258ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:18:05.99839Z","caller":"traceutil/trace.go:171","msg":"trace[1456345913] transaction","detail":"{read_only:false; response_revision:501; number_of_response:1; }","duration":"107.844521ms","start":"2026-09-18T05:18:05.890539Z","end":"2026-09-18T05:18:05.998383Z","steps":["trace[1456345913] 'process raft request' (duration: 106.619136ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:18:05.998459Z","caller":"traceutil/trace.go:171","msg":"trace[1099061756] transaction","detail":"{read_only:false; response_revision:502; number_of_response:1; }","duration":"102.464415ms","start":"2026-09-18T05:18:05.895987Z","end":"2026-09-18T05:18:05.998451Z","steps":["trace[1099061756] 'process raft request' (duration: 101.2581ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:18:05.998762Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.390963ms","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-09-18T05:18:05.998811Z","caller":"traceutil/trace.go:171","msg":"trace[1290322563] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:505; }","duration":"111.470916ms","start":"2026-09-18T05:18:05.887327Z","end":"2026-09-18T05:18:05.998798Z","steps":["trace[1290322563] 'agreement among raft nodes before linearized reading' (duration: 111.339602ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:18:12.194391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.17438ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-18T05:18:12.194542Z","caller":"traceutil/trace.go:171","msg":"trace[758424556] linearizableReadLoop","detail":"{readStateIndex:624; appliedIndex:623; }","duration":"237.308944ms","start":"2026-09-18T05:18:11.957199Z","end":"2026-09-18T05:18:12.194508Z","steps":["trace[758424556] 'read index received' (duration: 15.499263ms)","trace[758424556] 'applied index is now lower than readState.Index' (duration: 221.80097ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T05:18:12.194659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.740768ms","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-18T05:18:12.194621Z","caller":"traceutil/trace.go:171","msg":"trace[147169486] transaction","detail":"{read_only:false; response_revision:602; number_of_response:1; }","duration":"249.495439ms","start":"2026-09-18T05:18:11.945075Z","end":"2026-09-18T05:18:12.19457Z","steps":["trace[147169486] 'process raft request' (duration: 63.948418ms)","trace[147169486] 'get key's previous created_revision and leaseID' {req_type:put; key:/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1; req_size:1036281; } (duration: 182.77884ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T05:18:12.194693Z","caller":"traceutil/trace.go:171","msg":"trace[599390919] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:602; }","duration":"236.794819ms","start":"2026-09-18T05:18:11.957889Z","end":"2026-09-18T05:18:12.194684Z","steps":["trace[599390919] 'agreement among raft nodes before linearized reading' (duration: 236.721767ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:18:12.194836Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.960777ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-09-18T05:18:12.194854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.626444ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-dncrm\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-09-18T05:18:12.194908Z","caller":"traceutil/trace.go:171","msg":"trace[32695413] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:602; }","duration":"142.087262ms","start":"2026-09-18T05:18:12.052802Z","end":"2026-09-18T05:18:12.19489Z","steps":["trace[32695413] 'agreement among raft nodes before linearized reading' (duration: 141.867105ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:18:12.19494Z","caller":"traceutil/trace.go:171","msg":"trace[810593340] range","detail":"{range_begin:/registry/pods/kube-system/cilium-dncrm; range_end:; response_count:1; response_revision:602; }","duration":"237.756977ms","start":"2026-09-18T05:18:11.957155Z","end":"2026-09-18T05:18:12.194912Z","steps":["trace[810593340] 'agreement among raft nodes before linearized reading' (duration: 237.455969ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:18:12.195022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.987265ms","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-18T05:18:12.195055Z","caller":"traceutil/trace.go:171","msg":"trace[570251629] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:602; }","duration":"159.066988ms","start":"2026-09-18T05:18:12.035978Z","end":"2026-09-18T05:18:12.195045Z","steps":["trace[570251629] 'agreement among raft nodes before linearized reading' (duration: 158.935714ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:18:12.793716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.294843ms","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-18T05:18:12.793795Z","caller":"traceutil/trace.go:171","msg":"trace[2092092353] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:607; }","duration":"110.425586ms","start":"2026-09-18T05:18:12.683351Z","end":"2026-09-18T05:18:12.793777Z","steps":["trace[2092092353] 'range keys from in-memory index tree' (duration: 110.161469ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:18:13.544065Z","caller":"traceutil/trace.go:171","msg":"trace[1267445080] transaction","detail":"{read_only:false; response_revision:610; number_of_response:1; }","duration":"648.785235ms","start":"2026-09-18T05:18:12.895245Z","end":"2026-09-18T05:18:13.544031Z","steps":["trace[1267445080] 'process raft request' (duration: 635.59456ms)","trace[1267445080] 'compare' (duration: 12.641909ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T05:18:13.544212Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T05:18:12.895221Z","time spent":"648.921429ms","remote":"127.0.0.1:57542","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-18T05:18:15.221144Z","caller":"traceutil/trace.go:171","msg":"trace[1467517588] transaction","detail":"{read_only:false; response_revision:648; number_of_response:1; }","duration":"141.143574ms","start":"2026-09-18T05:18:15.079983Z","end":"2026-09-18T05:18:15.221126Z","steps":["trace[1467517588] 'process raft request' (duration: 141.02827ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:18:29.775398Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.748166ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T05:18:29.775505Z","caller":"traceutil/trace.go:171","msg":"trace[1843700769] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:768; }","duration":"123.907641ms","start":"2026-09-18T05:18:29.651573Z","end":"2026-09-18T05:18:29.775481Z","steps":["trace[1843700769] 'range keys from in-memory index tree' (duration: 123.590162ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:19:10.453098Z","caller":"traceutil/trace.go:171","msg":"trace[665423264] linearizableReadLoop","detail":"{readStateIndex:1098; appliedIndex:1097; }","duration":"119.119811ms","start":"2026-09-18T05:19:10.333961Z","end":"2026-09-18T05:19:10.45308Z","steps":["trace[665423264] 'read index received' (duration: 118.983707ms)","trace[665423264] 'applied index is now lower than readState.Index' (duration: 135.594µs)"],"step_count":2} {"level":"info","ts":"2026-09-18T05:19:10.453156Z","caller":"traceutil/trace.go:171","msg":"trace[2049764682] transaction","detail":"{read_only:false; response_revision:1058; number_of_response:1; }","duration":"136.184879ms","start":"2026-09-18T05:19:10.316948Z","end":"2026-09-18T05:19:10.453133Z","steps":["trace[2049764682] 'process raft request' (duration: 136.038835ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:19:10.45325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.274705ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T05:19:10.453329Z","caller":"traceutil/trace.go:171","msg":"trace[810081687] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:1058; }","duration":"119.397508ms","start":"2026-09-18T05:19:10.333911Z","end":"2026-09-18T05:19:10.453308Z","steps":["trace[810081687] 'agreement among raft nodes before linearized reading' (duration: 119.259054ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:19:24.788591Z","caller":"traceutil/trace.go:171","msg":"trace[698161393] linearizableReadLoop","detail":"{readStateIndex:1147; appliedIndex:1146; }","duration":"136.725975ms","start":"2026-09-18T05:19:24.651846Z","end":"2026-09-18T05:19:24.788572Z","steps":["trace[698161393] 'read index received' (duration: 136.522419ms)","trace[698161393] 'applied index is now lower than readState.Index' (duration: 202.416µs)"],"step_count":2} {"level":"info","ts":"2026-09-18T05:19:24.788667Z","caller":"traceutil/trace.go:171","msg":"trace[1684690795] transaction","detail":"{read_only:false; response_revision:1104; number_of_response:1; }","duration":"214.114497ms","start":"2026-09-18T05:19:24.574514Z","end":"2026-09-18T05:19:24.788628Z","steps":["trace[1684690795] 'process raft request' (duration: 213.85228ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:19:24.788736Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.879459ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T05:19:24.78877Z","caller":"traceutil/trace.go:171","msg":"trace[1058360252] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1104; }","duration":"136.952631ms","start":"2026-09-18T05:19:24.651807Z","end":"2026-09-18T05:19:24.788759Z","steps":["trace[1058360252] 'agreement among raft nodes before linearized reading' (duration: 136.887809ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:19:25.625763Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.772317ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-18T05:19:25.625862Z","caller":"traceutil/trace.go:171","msg":"trace[1848197668] range","detail":"{range_begin:/registry/certificatesigningrequests/; range_end:/registry/certificatesigningrequests0; response_count:0; response_revision:1109; }","duration":"188.87269ms","start":"2026-09-18T05:19:25.436959Z","end":"2026-09-18T05:19:25.625832Z","steps":["trace[1848197668] 'count revisions from in-memory index tree' (duration: 188.662103ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:19:27.086188Z","caller":"traceutil/trace.go:171","msg":"trace[319033547] linearizableReadLoop","detail":"{readStateIndex:1153; appliedIndex:1152; }","duration":"288.583117ms","start":"2026-09-18T05:19:26.797583Z","end":"2026-09-18T05:19:27.086166Z","steps":["trace[319033547] 'read index received' (duration: 288.376071ms)","trace[319033547] 'applied index is now lower than readState.Index' (duration: 205.956µs)"],"step_count":2} {"level":"info","ts":"2026-09-18T05:19:27.086661Z","caller":"traceutil/trace.go:171","msg":"trace[1593733776] transaction","detail":"{read_only:false; response_revision:1110; number_of_response:1; }","duration":"292.485179ms","start":"2026-09-18T05:19:26.794159Z","end":"2026-09-18T05:19:27.086644Z","steps":["trace[1593733776] 'process raft request' (duration: 291.856181ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:19:27.087712Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.136861ms","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-18T05:19:27.087776Z","caller":"traceutil/trace.go:171","msg":"trace[1041238084] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1110; }","duration":"290.203433ms","start":"2026-09-18T05:19:26.797542Z","end":"2026-09-18T05:19:27.087745Z","steps":["trace[1041238084] 'agreement among raft nodes before linearized reading' (duration: 290.07827ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:19:27.087577Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.279217ms","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-09-18T05:19:27.088662Z","caller":"traceutil/trace.go:171","msg":"trace[222856802] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1110; }","duration":"289.3962ms","start":"2026-09-18T05:19:26.79924Z","end":"2026-09-18T05:19:27.088636Z","steps":["trace[222856802] 'agreement among raft nodes before linearized reading' (duration: 288.149884ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:19:27.088229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.119072ms","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-09-18T05:19:27.088995Z","caller":"traceutil/trace.go:171","msg":"trace[555658383] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1110; }","duration":"132.915685ms","start":"2026-09-18T05:19:26.956065Z","end":"2026-09-18T05:19:27.088981Z","steps":["trace[555658383] 'agreement among raft nodes before linearized reading' (duration: 132.097731ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:19:27.7841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"334.700117ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-18T05:19:27.785048Z","caller":"traceutil/trace.go:171","msg":"trace[919442479] transaction","detail":"{read_only:false; response_revision:1111; number_of_response:1; }","duration":"691.383518ms","start":"2026-09-18T05:19:27.093634Z","end":"2026-09-18T05:19:27.785017Z","steps":["trace[919442479] 'process raft request' (duration: 355.695653ms)","trace[919442479] 'compare' (duration: 334.48544ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T05:19:27.78518Z","caller":"traceutil/trace.go:171","msg":"trace[1909385047] transaction","detail":"{read_only:false; response_revision:1113; number_of_response:1; }","duration":"688.596427ms","start":"2026-09-18T05:19:27.09657Z","end":"2026-09-18T05:19:27.785166Z","steps":["trace[1909385047] 'process raft request' (duration: 688.457143ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:19:27.785185Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T05:19:27.093613Z","time spent":"691.496812ms","remote":"127.0.0.1:57580","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-18T05:19:27.785231Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T05:19:27.096548Z","time spent":"688.660819ms","remote":"127.0.0.1:57580","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-18T05:19:27.786831Z","caller":"traceutil/trace.go:171","msg":"trace[1588741562] transaction","detail":"{read_only:false; response_revision:1112; number_of_response:1; }","duration":"691.314186ms","start":"2026-09-18T05:19:27.09377Z","end":"2026-09-18T05:19:27.785084Z","steps":["trace[1588741562] 'process raft request' (duration: 691.176502ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:19:27.787053Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T05:19:27.093758Z","time spent":"693.234521ms","remote":"127.0.0.1:57580","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-18T05:19:27.787529Z","caller":"traceutil/trace.go:171","msg":"trace[226029238] linearizableReadLoop","detail":"{readStateIndex:1156; appliedIndex:1153; }","duration":"498.595155ms","start":"2026-09-18T05:19:27.28886Z","end":"2026-09-18T05:19:27.787455Z","steps":["trace[226029238] 'read index received' (duration: 160.4834ms)","trace[226029238] 'applied index is now lower than readState.Index' (duration: 338.110425ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T05:19:27.787678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"498.828062ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-09-18T05:19:27.78789Z","caller":"traceutil/trace.go:171","msg":"trace[1242078673] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1113; }","duration":"499.081079ms","start":"2026-09-18T05:19:27.288796Z","end":"2026-09-18T05:19:27.787877Z","steps":["trace[1242078673] 'agreement among raft nodes before linearized reading' (duration: 498.778101ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:19:27.787832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"481.520423ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-09-18T05:19:27.788226Z","caller":"traceutil/trace.go:171","msg":"trace[775235602] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1113; }","duration":"481.933995ms","start":"2026-09-18T05:19:27.306276Z","end":"2026-09-18T05:19:27.78821Z","steps":["trace[775235602] 'agreement among raft nodes before linearized reading' (duration: 481.519403ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:19:27.788361Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T05:19:27.306261Z","time spent":"482.086159ms","remote":"127.0.0.1:57580","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-09-18T05:19:27.787852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.634553ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T05:19:27.788513Z","caller":"traceutil/trace.go:171","msg":"trace[206270183] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1113; }","duration":"137.290361ms","start":"2026-09-18T05:19:27.651179Z","end":"2026-09-18T05:19:27.788469Z","steps":["trace[206270183] 'agreement among raft nodes before linearized reading' (duration: 136.664703ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:19:27.788055Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T05:19:27.288773Z","time spent":"499.266025ms","remote":"127.0.0.1:57580","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-09-18T05:19:28.445989Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11302522905275880588,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-09-18T05:19:28.946807Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11302522905275880588,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-09-18T05:19:29.421176Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.625452976s","expected-duration":"1s"} {"level":"info","ts":"2026-09-18T05:19:29.421624Z","caller":"traceutil/trace.go:171","msg":"trace[701907176] transaction","detail":"{read_only:false; response_revision:1114; number_of_response:1; }","duration":"1.625985153s","start":"2026-09-18T05:19:27.79561Z","end":"2026-09-18T05:19:29.421595Z","steps":["trace[701907176] 'process raft request' (duration: 1.625781687s)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:19:29.421785Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T05:19:27.795593Z","time spent":"1.626107706s","remote":"127.0.0.1:57580","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-18T05:19:29.433166Z","caller":"traceutil/trace.go:171","msg":"trace[2013043412] transaction","detail":"{read_only:false; response_revision:1115; number_of_response:1; }","duration":"1.637489554s","start":"2026-09-18T05:19:27.795656Z","end":"2026-09-18T05:19:29.433145Z","steps":["trace[2013043412] 'process raft request' (duration: 1.637293569s)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:19:29.433279Z","caller":"traceutil/trace.go:171","msg":"trace[457288953] transaction","detail":"{read_only:false; response_revision:1116; number_of_response:1; }","duration":"339.919068ms","start":"2026-09-18T05:19:29.093319Z","end":"2026-09-18T05:19:29.433238Z","steps":["trace[457288953] 'process raft request' (duration: 339.759573ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:19:29.433371Z","caller":"traceutil/trace.go:171","msg":"trace[1648243164] linearizableReadLoop","detail":"{readStateIndex:1158; appliedIndex:1156; }","duration":"1.488173117s","start":"2026-09-18T05:19:27.944943Z","end":"2026-09-18T05:19:29.433116Z","steps":["trace[1648243164] 'read index received' (duration: 1.476490669s)","trace[1648243164] 'applied index is now lower than readState.Index' (duration: 11.681337ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T05:19:29.433391Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T05:19:29.093287Z","time spent":"340.043242ms","remote":"127.0.0.1:57580","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-18T05:19:29.433532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"806.904711ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-18T05:19:29.433584Z","caller":"traceutil/trace.go:171","msg":"trace[1436503767] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:1116; }","duration":"807.001244ms","start":"2026-09-18T05:19:28.626569Z","end":"2026-09-18T05:19:29.43357Z","steps":["trace[1436503767] 'agreement among raft nodes before linearized reading' (duration: 806.87811ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:19:29.433615Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T05:19:28.626523Z","time spent":"807.083247ms","remote":"127.0.0.1:59070","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":4,"response size":30,"request content":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true "} {"level":"warn","ts":"2026-09-18T05:19:29.433708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.73606ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T05:19:29.433771Z","caller":"traceutil/trace.go:171","msg":"trace[322228369] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:1116; }","duration":"141.838683ms","start":"2026-09-18T05:19:29.291913Z","end":"2026-09-18T05:19:29.433752Z","steps":["trace[322228369] 'agreement among raft nodes before linearized reading' (duration: 141.720429ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:19:29.433955Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T05:19:27.795605Z","time spent":"1.637638509s","remote":"127.0.0.1:57580","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-18T05:19:29.43417Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.489222456s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.95\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-09-18T05:19:29.43421Z","caller":"traceutil/trace.go:171","msg":"trace[242535191] range","detail":"{range_begin:/registry/masterleases/162.253.55.95; range_end:; response_count:1; response_revision:1116; }","duration":"1.489288289s","start":"2026-09-18T05:19:27.944907Z","end":"2026-09-18T05:19:29.434195Z","steps":["trace[242535191] 'agreement among raft nodes before linearized reading' (duration: 1.488411763s)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:19:29.434233Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T05:19:27.944894Z","time spent":"1.48933148s","remote":"127.0.0.1:57344","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/162.253.55.95\" "} {"level":"info","ts":"2026-09-18T05:19:29.59888Z","caller":"traceutil/trace.go:171","msg":"trace[9888012] transaction","detail":"{read_only:false; response_revision:1117; number_of_response:1; }","duration":"133.170502ms","start":"2026-09-18T05:19:29.465683Z","end":"2026-09-18T05:19:29.598853Z","steps":["trace[9888012] 'process raft request' (duration: 43.157585ms)","trace[9888012] 'compare' (duration: 89.75457ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T05:19:30.273974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.917284ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T05:19:30.274054Z","caller":"traceutil/trace.go:171","msg":"trace[914063674] range","detail":"{range_begin:/registry/poddisruptionbudgets/; range_end:/registry/poddisruptionbudgets0; response_count:0; response_revision:1122; }","duration":"143.045647ms","start":"2026-09-18T05:19:30.13099Z","end":"2026-09-18T05:19:30.274035Z","steps":["trace[914063674] 'count revisions from in-memory index tree' (duration: 142.796649ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:19:30.274138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.647289ms","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-09-18T05:19:30.274199Z","caller":"traceutil/trace.go:171","msg":"trace[2000141635] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:1122; }","duration":"148.762292ms","start":"2026-09-18T05:19:30.125421Z","end":"2026-09-18T05:19:30.274184Z","steps":["trace[2000141635] 'count revisions from in-memory index tree' (duration: 148.522245ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:19:46.10046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.213617ms","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-18T05:19:46.100556Z","caller":"traceutil/trace.go:171","msg":"trace[1588741695] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1240; }","duration":"217.354181ms","start":"2026-09-18T05:19:45.883184Z","end":"2026-09-18T05:19:46.100538Z","steps":["trace[1588741695] 'range keys from in-memory index tree' (duration: 217.044032ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:19:46.100831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.811253ms","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-09-18T05:19:46.100864Z","caller":"traceutil/trace.go:171","msg":"trace[1281074384] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1240; }","duration":"114.897445ms","start":"2026-09-18T05:19:45.985957Z","end":"2026-09-18T05:19:46.100855Z","steps":["trace[1281074384] 'range keys from in-memory index tree' (duration: 114.72741ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:19:46.100933Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.306827ms","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-09-18T05:19:46.100965Z","caller":"traceutil/trace.go:171","msg":"trace[1835567120] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1240; }","duration":"115.384019ms","start":"2026-09-18T05:19:45.985571Z","end":"2026-09-18T05:19:46.100955Z","steps":["trace[1835567120] 'range keys from in-memory index tree' (duration: 115.172323ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:19:46.542841Z","caller":"traceutil/trace.go:171","msg":"trace[1535475884] transaction","detail":"{read_only:false; response_revision:1241; number_of_response:1; }","duration":"438.107979ms","start":"2026-09-18T05:19:46.104709Z","end":"2026-09-18T05:19:46.542817Z","steps":["trace[1535475884] 'process raft request' (duration: 437.975336ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:19:46.542989Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T05:19:46.104686Z","time spent":"438.222272ms","remote":"127.0.0.1:57580","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-18T05:19:46.61945Z","caller":"traceutil/trace.go:171","msg":"trace[2011973047] transaction","detail":"{read_only:false; response_revision:1243; number_of_response:1; }","duration":"512.99207ms","start":"2026-09-18T05:19:46.106436Z","end":"2026-09-18T05:19:46.619428Z","steps":["trace[2011973047] 'process raft request' (duration: 512.944169ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:19:46.619619Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T05:19:46.106422Z","time spent":"513.117733ms","remote":"127.0.0.1:57580","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-18T05:19:46.619848Z","caller":"traceutil/trace.go:171","msg":"trace[711469940] transaction","detail":"{read_only:false; response_revision:1242; number_of_response:1; }","duration":"513.986388ms","start":"2026-09-18T05:19:46.105838Z","end":"2026-09-18T05:19:46.619824Z","steps":["trace[711469940] 'process raft request' (duration: 513.427402ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:19:46.62005Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T05:19:46.105829Z","time spent":"514.126862ms","remote":"127.0.0.1:57580","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"}