{"level":"warn","ts":"2026-05-10T04:01:29.22972Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-10T04:01:29.229811Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.162:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.162:2380","--initial-cluster=instance=https://199.204.45.162:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.162:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.162:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-05-10T04:01:29.229904Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-10T04:01:29.229917Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.162:2380"]} {"level":"info","ts":"2026-05-10T04:01:29.229934Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-10T04:01:29.23051Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.162:2379"]} {"level":"info","ts":"2026-05-10T04:01:29.230587Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.162:2380"],"listen-peer-urls":["https://199.204.45.162:2380"],"advertise-client-urls":["https://199.204.45.162:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.162:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.162:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-05-10T04:01:29.234167Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.408182ms"} {"level":"info","ts":"2026-05-10T04:01:29.243445Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"2d372260bb4c37a","cluster-id":"52bb6ec15e8722ff"} {"level":"info","ts":"2026-05-10T04:01:29.243514Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a switched to configuration voters=()"} {"level":"info","ts":"2026-05-10T04:01:29.24354Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a became follower at term 0"} {"level":"info","ts":"2026-05-10T04:01:29.243557Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 2d372260bb4c37a [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-10T04:01:29.24357Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a became follower at term 1"} {"level":"info","ts":"2026-05-10T04:01:29.243611Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a switched to configuration voters=(203631915892523898)"} {"level":"warn","ts":"2026-05-10T04:01:29.248242Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-10T04:01:29.249755Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-10T04:01:29.250785Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-05-10T04:01:29.252503Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"2d372260bb4c37a","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-10T04:01:29.252685Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"2d372260bb4c37a","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-10T04:01:29.252904Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-10T04:01:29.252971Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-10T04:01:29.252994Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-10T04:01:29.253596Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a switched to configuration voters=(203631915892523898)"} {"level":"info","ts":"2026-05-10T04:01:29.254863Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"52bb6ec15e8722ff","local-member-id":"2d372260bb4c37a","added-peer-id":"2d372260bb4c37a","added-peer-peer-urls":["https://199.204.45.162:2380"]} {"level":"info","ts":"2026-05-10T04:01:29.261855Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-10T04:01:29.262092Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"2d372260bb4c37a","initial-advertise-peer-urls":["https://199.204.45.162:2380"],"listen-peer-urls":["https://199.204.45.162:2380"],"advertise-client-urls":["https://199.204.45.162:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.162:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-10T04:01:29.262123Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-10T04:01:29.262164Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.162:2380"} {"level":"info","ts":"2026-05-10T04:01:29.262213Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.162:2380"} {"level":"info","ts":"2026-05-10T04:01:29.848053Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a is starting a new election at term 1"} {"level":"info","ts":"2026-05-10T04:01:29.848206Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a became pre-candidate at term 1"} {"level":"info","ts":"2026-05-10T04:01:29.848301Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a received MsgPreVoteResp from 2d372260bb4c37a at term 1"} {"level":"info","ts":"2026-05-10T04:01:29.84835Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a became candidate at term 2"} {"level":"info","ts":"2026-05-10T04:01:29.848364Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a received MsgVoteResp from 2d372260bb4c37a at term 2"} {"level":"info","ts":"2026-05-10T04:01:29.84838Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a became leader at term 2"} {"level":"info","ts":"2026-05-10T04:01:29.848394Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 2d372260bb4c37a elected leader 2d372260bb4c37a at term 2"} {"level":"info","ts":"2026-05-10T04:01:29.856968Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-10T04:01:29.858395Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"52bb6ec15e8722ff","local-member-id":"2d372260bb4c37a","cluster-version":"3.5"} {"level":"info","ts":"2026-05-10T04:01:29.858506Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-10T04:01:29.858545Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-10T04:01:29.85859Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"2d372260bb4c37a","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.162:2379]}","request-path":"/0/members/2d372260bb4c37a/attributes","cluster-id":"52bb6ec15e8722ff","publish-timeout":"7s"} {"level":"info","ts":"2026-05-10T04:01:29.863105Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-10T04:01:29.863163Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-10T04:01:29.863366Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-10T04:01:29.86343Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-10T04:01:29.864814Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.162:2379"} {"level":"info","ts":"2026-05-10T04:01:29.866747Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-05-10T04:01:32.802436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.202656ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-10T04:01:32.802577Z","caller":"traceutil/trace.go:171","msg":"trace[1959547048] transaction","detail":"{read_only:false; response_revision:168; number_of_response:1; }","duration":"258.274198ms","start":"2026-05-10T04:01:32.544284Z","end":"2026-05-10T04:01:32.802559Z","steps":["trace[1959547048] 'process raft request' (duration: 120.444926ms)","trace[1959547048] 'compare' (duration: 137.058302ms)"],"step_count":2} {"level":"warn","ts":"2026-05-10T04:01:33.177085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.474819ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-10T04:01:33.177208Z","caller":"traceutil/trace.go:171","msg":"trace[1716384034] transaction","detail":"{read_only:false; response_revision:169; number_of_response:1; }","duration":"369.036024ms","start":"2026-05-10T04:01:32.808148Z","end":"2026-05-10T04:01:33.177184Z","steps":["trace[1716384034] 'process raft request' (duration: 268.38064ms)","trace[1716384034] 'compare' (duration: 100.303625ms)"],"step_count":2} {"level":"warn","ts":"2026-05-10T04:01:33.17728Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T04:01:32.808126Z","time spent":"369.130187ms","remote":"127.0.0.1:55226","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":709,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-10T04:01:59.189576Z","caller":"traceutil/trace.go:171","msg":"trace[1724106948] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"100.055558ms","start":"2026-05-10T04:01:59.089285Z","end":"2026-05-10T04:01:59.18934Z","steps":["trace[1724106948] 'process raft request' (duration: 97.673446ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T04:01:59.1895Z","caller":"traceutil/trace.go:171","msg":"trace[400383063] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"100.274344ms","start":"2026-05-10T04:01:59.0891Z","end":"2026-05-10T04:01:59.189375Z","steps":["trace[400383063] 'process raft request' (duration: 97.764127ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T04:02:05.516293Z","caller":"traceutil/trace.go:171","msg":"trace[527838061] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"235.639088ms","start":"2026-05-10T04:02:05.280631Z","end":"2026-05-10T04:02:05.51627Z","steps":["trace[527838061] 'process raft request' (duration: 235.495994ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T04:02:05.712874Z","caller":"traceutil/trace.go:171","msg":"trace[248055503] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"432.043027ms","start":"2026-05-10T04:02:05.280756Z","end":"2026-05-10T04:02:05.712799Z","steps":["trace[248055503] 'process raft request' (duration: 431.721419ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T04:02:05.71338Z","caller":"traceutil/trace.go:171","msg":"trace[1890416777] linearizableReadLoop","detail":"{readStateIndex:642; appliedIndex:640; }","duration":"410.858966ms","start":"2026-05-10T04:02:05.302498Z","end":"2026-05-10T04:02:05.713357Z","steps":["trace[1890416777] 'read index received' (duration: 213.637996ms)","trace[1890416777] 'applied index is now lower than readState.Index' (duration: 197.21998ms)"],"step_count":2} {"level":"info","ts":"2026-05-10T04:02:05.713608Z","caller":"traceutil/trace.go:171","msg":"trace[322355645] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"371.640878ms","start":"2026-05-10T04:02:05.341801Z","end":"2026-05-10T04:02:05.713442Z","steps":["trace[322355645] 'process raft request' (duration: 370.998801ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T04:02:05.713695Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"411.155113ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-v942j\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-05-10T04:02:05.713791Z","caller":"traceutil/trace.go:171","msg":"trace[721324213] range","detail":"{range_begin:/registry/pods/kube-system/cilium-v942j; range_end:; response_count:1; response_revision:619; }","duration":"411.287216ms","start":"2026-05-10T04:02:05.302477Z","end":"2026-05-10T04:02:05.713764Z","steps":["trace[721324213] 'agreement among raft nodes before linearized reading' (duration: 410.973188ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T04:02:05.713843Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T04:02:05.302467Z","time spent":"411.366388ms","remote":"127.0.0.1:55076","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16987,"request content":"key:\"/registry/pods/kube-system/cilium-v942j\" "} {"level":"warn","ts":"2026-05-10T04:02:05.714219Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T04:02:05.341777Z","time spent":"371.903844ms","remote":"127.0.0.1:54994","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036301,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-10T04:02:05.714134Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T04:02:05.28073Z","time spent":"432.249082ms","remote":"127.0.0.1:55152","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-10T04:02:05.724876Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.233885ms","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-05-10T04:02:05.724938Z","caller":"traceutil/trace.go:171","msg":"trace[693485887] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:620; }","duration":"329.314387ms","start":"2026-05-10T04:02:05.395604Z","end":"2026-05-10T04:02:05.724919Z","steps":["trace[693485887] 'agreement among raft nodes before linearized reading' (duration: 329.161883ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T04:02:05.724963Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T04:02:05.395589Z","time spent":"329.369129ms","remote":"127.0.0.1:55152","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-05-10T04:02:19.999638Z","caller":"traceutil/trace.go:171","msg":"trace[588922856] transaction","detail":"{read_only:false; response_revision:776; number_of_response:1; }","duration":"168.289725ms","start":"2026-05-10T04:02:19.831323Z","end":"2026-05-10T04:02:19.999613Z","steps":["trace[588922856] 'process raft request' (duration: 168.240254ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T04:02:19.999742Z","caller":"traceutil/trace.go:171","msg":"trace[1047516323] transaction","detail":"{read_only:false; response_revision:775; number_of_response:1; }","duration":"168.765288ms","start":"2026-05-10T04:02:19.830949Z","end":"2026-05-10T04:02:19.999715Z","steps":["trace[1047516323] 'process raft request' (duration: 133.521364ms)","trace[1047516323] 'compare' (duration: 34.968617ms)"],"step_count":2} {"level":"info","ts":"2026-05-10T04:02:27.665469Z","caller":"traceutil/trace.go:171","msg":"trace[689083085] transaction","detail":"{read_only:false; response_revision:871; number_of_response:1; }","duration":"105.524383ms","start":"2026-05-10T04:02:27.559914Z","end":"2026-05-10T04:02:27.665438Z","steps":["trace[689083085] 'process raft request' (duration: 104.468755ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T04:02:27.666123Z","caller":"traceutil/trace.go:171","msg":"trace[800597922] transaction","detail":"{read_only:false; response_revision:872; number_of_response:1; }","duration":"101.682702ms","start":"2026-05-10T04:02:27.564418Z","end":"2026-05-10T04:02:27.6661Z","steps":["trace[800597922] 'process raft request' (duration: 100.936752ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T04:03:14.553298Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14085744576314385403,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-10T04:03:15.053605Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14085744576314385403,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-10T04:03:15.553849Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14085744576314385403,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-10T04:03:16.052782Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000186469s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-05-10T04:03:16.052865Z","caller":"traceutil/trace.go:171","msg":"trace[1673155210] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000307293s","start":"2026-05-10T04:03:14.052538Z","end":"2026-05-10T04:03:16.052845Z","steps":["trace[1673155210] 'agreement among raft nodes before linearized reading' (duration: 2.00020719s)"],"step_count":1} {"level":"warn","ts":"2026-05-10T04:03:16.052913Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T04:03:14.052522Z","time spent":"2.000380894s","remote":"127.0.0.1:54914","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-10T04:03:16.054072Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14085744576314385403,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-10T04:03:16.555173Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14085744576314385403,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-10T04:03:17.055728Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14085744576314385403,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-10T04:03:17.111441Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"3.198049849s","expected-duration":"1s"} {"level":"info","ts":"2026-05-10T04:03:17.111865Z","caller":"traceutil/trace.go:171","msg":"trace[162234799] transaction","detail":"{read_only:false; response_revision:1057; number_of_response:1; }","duration":"3.198499751s","start":"2026-05-10T04:03:13.913312Z","end":"2026-05-10T04:03:17.111812Z","steps":["trace[162234799] 'process raft request' (duration: 3.198326816s)"],"step_count":1} {"level":"warn","ts":"2026-05-10T04:03:17.112019Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T04:03:13.9133Z","time spent":"3.198636475s","remote":"127.0.0.1:55152","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-10T04:03:17.137777Z","caller":"traceutil/trace.go:171","msg":"trace[912210996] transaction","detail":"{read_only:false; response_revision:1058; number_of_response:1; }","duration":"2.522938177s","start":"2026-05-10T04:03:14.614811Z","end":"2026-05-10T04:03:17.137749Z","steps":["trace[912210996] 'process raft request' (duration: 2.522757353s)"],"step_count":1} {"level":"warn","ts":"2026-05-10T04:03:17.137915Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T04:03:14.614796Z","time spent":"2.523036779s","remote":"127.0.0.1:55152","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-10T04:03:17.13793Z","caller":"traceutil/trace.go:171","msg":"trace[806110740] linearizableReadLoop","detail":"{readStateIndex:1101; appliedIndex:1098; }","duration":"3.085312925s","start":"2026-05-10T04:03:14.052572Z","end":"2026-05-10T04:03:17.137885Z","steps":["trace[806110740] 'read index received' (duration: 3.059039089s)","trace[806110740] 'applied index is now lower than readState.Index' (duration: 26.272156ms)"],"step_count":2} {"level":"info","ts":"2026-05-10T04:03:17.137954Z","caller":"traceutil/trace.go:171","msg":"trace[1597045830] transaction","detail":"{read_only:false; response_revision:1059; number_of_response:1; }","duration":"161.427743ms","start":"2026-05-10T04:03:16.976496Z","end":"2026-05-10T04:03:17.137923Z","steps":["trace[1597045830] 'process raft request' (duration: 161.200557ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T04:03:17.138106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.084841148s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-10T04:03:17.138152Z","caller":"traceutil/trace.go:171","msg":"trace[1506004151] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1059; }","duration":"1.08489016s","start":"2026-05-10T04:03:16.05325Z","end":"2026-05-10T04:03:17.13814Z","steps":["trace[1506004151] 'agreement among raft nodes before linearized reading' (duration: 1.084811587s)"],"step_count":1} {"level":"warn","ts":"2026-05-10T04:03:17.138172Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.040610782s","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-05-10T04:03:17.138182Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T04:03:16.0532Z","time spent":"1.084975891s","remote":"127.0.0.1:54918","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-10T04:03:17.138169Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.88650925s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"warn","ts":"2026-05-10T04:03:17.138165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.517428189s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-10T04:03:17.138222Z","caller":"traceutil/trace.go:171","msg":"trace[1473551160] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1059; }","duration":"1.886576891s","start":"2026-05-10T04:03:15.251632Z","end":"2026-05-10T04:03:17.138209Z","steps":["trace[1473551160] 'agreement among raft nodes before linearized reading' (duration: 1.886420917s)"],"step_count":1} {"level":"info","ts":"2026-05-10T04:03:17.138209Z","caller":"traceutil/trace.go:171","msg":"trace[1530785054] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1059; }","duration":"3.040697304s","start":"2026-05-10T04:03:14.097501Z","end":"2026-05-10T04:03:17.138198Z","steps":["trace[1530785054] 'agreement among raft nodes before linearized reading' (duration: 3.04054294s)"],"step_count":1} {"level":"warn","ts":"2026-05-10T04:03:17.13825Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T04:03:15.25159Z","time spent":"1.886654044s","remote":"127.0.0.1:55152","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-10T04:03:17.138259Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T04:03:14.097485Z","time spent":"3.040762766s","remote":"127.0.0.1:55152","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-05-10T04:03:17.13827Z","caller":"traceutil/trace.go:171","msg":"trace[1162790349] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1059; }","duration":"1.517576644s","start":"2026-05-10T04:03:15.620663Z","end":"2026-05-10T04:03:17.13824Z","steps":["trace[1162790349] 'agreement among raft nodes before linearized reading' (duration: 1.517403019s)"],"step_count":1} {"level":"warn","ts":"2026-05-10T04:03:17.138287Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.32353908s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-10T04:03:17.138333Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T04:03:15.620642Z","time spent":"1.517677806s","remote":"127.0.0.1:54914","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-10T04:03:17.138351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.86865432s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-05-10T04:03:17.138364Z","caller":"traceutil/trace.go:171","msg":"trace[834094517] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:1059; }","duration":"2.323655863s","start":"2026-05-10T04:03:14.814686Z","end":"2026-05-10T04:03:17.138341Z","steps":["trace[834094517] 'agreement among raft nodes before linearized reading' (duration: 2.323503968s)"],"step_count":1} {"level":"info","ts":"2026-05-10T04:03:17.138411Z","caller":"traceutil/trace.go:171","msg":"trace[1557290195] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1059; }","duration":"2.868744231s","start":"2026-05-10T04:03:14.269649Z","end":"2026-05-10T04:03:17.138393Z","steps":["trace[1557290195] 'agreement among raft nodes before linearized reading' (duration: 2.868562065s)"],"step_count":1} {"level":"warn","ts":"2026-05-10T04:03:17.13842Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T04:03:14.814673Z","time spent":"2.323732074s","remote":"127.0.0.1:58698","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true "} {"level":"warn","ts":"2026-05-10T04:03:17.138452Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T04:03:14.269631Z","time spent":"2.868810133s","remote":"127.0.0.1:55152","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":526,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-10T04:03:17.138721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.813158251s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-10T04:03:17.138777Z","caller":"traceutil/trace.go:171","msg":"trace[51753072] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1059; }","duration":"2.813254914s","start":"2026-05-10T04:03:14.325509Z","end":"2026-05-10T04:03:17.138764Z","steps":["trace[51753072] 'agreement among raft nodes before linearized reading' (duration: 2.812605526s)"],"step_count":1} {"level":"warn","ts":"2026-05-10T04:03:17.138816Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T04:03:14.325488Z","time spent":"2.813317825s","remote":"127.0.0.1:55152","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-05-10T04:03:19.235508Z","caller":"traceutil/trace.go:171","msg":"trace[904133820] transaction","detail":"{read_only:false; response_revision:1065; number_of_response:1; }","duration":"114.710747ms","start":"2026-05-10T04:03:19.120765Z","end":"2026-05-10T04:03:19.235476Z","steps":["trace[904133820] 'process raft request' (duration: 114.526902ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T04:03:19.426981Z","caller":"traceutil/trace.go:171","msg":"trace[1662422365] linearizableReadLoop","detail":"{readStateIndex:1109; appliedIndex:1107; }","duration":"218.244666ms","start":"2026-05-10T04:03:19.208705Z","end":"2026-05-10T04:03:19.42695Z","steps":["trace[1662422365] 'read index received' (duration: 26.593983ms)","trace[1662422365] 'applied index is now lower than readState.Index' (duration: 191.649703ms)"],"step_count":2} {"level":"info","ts":"2026-05-10T04:03:19.427032Z","caller":"traceutil/trace.go:171","msg":"trace[653552664] transaction","detail":"{read_only:false; response_revision:1066; number_of_response:1; }","duration":"283.693961ms","start":"2026-05-10T04:03:19.143298Z","end":"2026-05-10T04:03:19.426992Z","steps":["trace[653552664] 'process raft request' (duration: 194.602152ms)","trace[653552664] 'compare' (duration: 88.931744ms)"],"step_count":2} {"level":"warn","ts":"2026-05-10T04:03:19.42719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.474144ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-05-10T04:03:19.427231Z","caller":"traceutil/trace.go:171","msg":"trace[1136937926] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1066; }","duration":"218.548225ms","start":"2026-05-10T04:03:19.208671Z","end":"2026-05-10T04:03:19.427219Z","steps":["trace[1136937926] 'agreement among raft nodes before linearized reading' (duration: 218.425922ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T04:03:19.427327Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.41783ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-05-10T04:03:19.427409Z","caller":"traceutil/trace.go:171","msg":"trace[210942404] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1066; }","duration":"179.492691ms","start":"2026-05-10T04:03:19.247879Z","end":"2026-05-10T04:03:19.427372Z","steps":["trace[210942404] 'agreement among raft nodes before linearized reading' (duration: 179.370398ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T04:03:19.427529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.884859ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-05-10T04:03:19.427614Z","caller":"traceutil/trace.go:171","msg":"trace[1177312868] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1066; }","duration":"181.022923ms","start":"2026-05-10T04:03:19.246572Z","end":"2026-05-10T04:03:19.427595Z","steps":["trace[1177312868] 'agreement among raft nodes before linearized reading' (duration: 180.686574ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T04:03:19.427816Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.633449ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-10T04:03:19.427876Z","caller":"traceutil/trace.go:171","msg":"trace[945497488] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1066; }","duration":"181.712681ms","start":"2026-05-10T04:03:19.246148Z","end":"2026-05-10T04:03:19.427861Z","steps":["trace[945497488] 'agreement among raft nodes before linearized reading' (duration: 181.015583ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T04:03:31.810693Z","caller":"traceutil/trace.go:171","msg":"trace[372292792] linearizableReadLoop","detail":"{readStateIndex:1205; appliedIndex:1204; }","duration":"244.563844ms","start":"2026-05-10T04:03:31.566107Z","end":"2026-05-10T04:03:31.81067Z","steps":["trace[372292792] 'read index received' (duration: 244.392669ms)","trace[372292792] 'applied index is now lower than readState.Index' (duration: 170.165µs)"],"step_count":2} {"level":"info","ts":"2026-05-10T04:03:31.810754Z","caller":"traceutil/trace.go:171","msg":"trace[1538951080] transaction","detail":"{read_only:false; response_revision:1159; number_of_response:1; }","duration":"252.440793ms","start":"2026-05-10T04:03:31.558263Z","end":"2026-05-10T04:03:31.810704Z","steps":["trace[1538951080] 'process raft request' (duration: 252.281438ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T04:03:31.810969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.848821ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-05-10T04:03:31.810969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.27695ms","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-05-10T04:03:31.810985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.683652ms","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-05-10T04:03:31.811013Z","caller":"traceutil/trace.go:171","msg":"trace[1301951366] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1159; }","duration":"244.958684ms","start":"2026-05-10T04:03:31.566043Z","end":"2026-05-10T04:03:31.811002Z","steps":["trace[1301951366] 'agreement among raft nodes before linearized reading' (duration: 244.748609ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T04:03:31.811041Z","caller":"traceutil/trace.go:171","msg":"trace[211491462] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:1159; }","duration":"135.395964ms","start":"2026-05-10T04:03:31.675625Z","end":"2026-05-10T04:03:31.811021Z","steps":["trace[211491462] 'agreement among raft nodes before linearized reading' (duration: 135.25592ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T04:03:31.811062Z","caller":"traceutil/trace.go:171","msg":"trace[2073365722] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1159; }","duration":"237.792024ms","start":"2026-05-10T04:03:31.573248Z","end":"2026-05-10T04:03:31.81104Z","steps":["trace[2073365722] 'agreement among raft nodes before linearized reading' (duration: 237.574289ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T04:03:31.931785Z","caller":"traceutil/trace.go:171","msg":"trace[1000301213] transaction","detail":"{read_only:false; response_revision:1160; number_of_response:1; }","duration":"117.520981ms","start":"2026-05-10T04:03:31.814235Z","end":"2026-05-10T04:03:31.931756Z","steps":["trace[1000301213] 'process raft request' (duration: 30.410525ms)","trace[1000301213] 'compare' (duration: 86.983683ms)"],"step_count":2} {"level":"info","ts":"2026-05-10T04:03:31.946057Z","caller":"traceutil/trace.go:171","msg":"trace[1437516043] transaction","detail":"{read_only:false; response_revision:1161; number_of_response:1; }","duration":"130.576666ms","start":"2026-05-10T04:03:31.81547Z","end":"2026-05-10T04:03:31.946047Z","steps":["trace[1437516043] 'process raft request' (duration: 130.500604ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T04:03:48.114223Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14085744576314385777,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-10T04:03:48.614943Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14085744576314385777,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-10T04:03:49.115674Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14085744576314385777,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-10T04:03:49.61605Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14085744576314385777,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-10T04:03:49.981325Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.627840654s","expected-duration":"1s"} {"level":"info","ts":"2026-05-10T04:03:49.981912Z","caller":"traceutil/trace.go:171","msg":"trace[235671885] transaction","detail":"{read_only:false; response_revision:1218; number_of_response:1; }","duration":"2.628482282s","start":"2026-05-10T04:03:47.353401Z","end":"2026-05-10T04:03:49.981884Z","steps":["trace[235671885] 'process raft request' (duration: 2.628342898s)"],"step_count":1} {"level":"warn","ts":"2026-05-10T04:03:49.982162Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T04:03:47.353386Z","time spent":"2.628693878s","remote":"127.0.0.1:55152","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-10T04:03:50.359988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.581167ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-10T04:03:50.36021Z","caller":"traceutil/trace.go:171","msg":"trace[476881042] transaction","detail":"{read_only:false; response_revision:1219; number_of_response:1; }","duration":"2.796480989s","start":"2026-05-10T04:03:47.563694Z","end":"2026-05-10T04:03:50.360175Z","steps":["trace[476881042] 'process raft request' (duration: 2.577610984s)","trace[476881042] 'compare' (duration: 218.429022ms)"],"step_count":2} {"level":"warn","ts":"2026-05-10T04:03:50.360345Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T04:03:47.563671Z","time spent":"2.796602112s","remote":"127.0.0.1:55152","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-10T04:03:50.360382Z","caller":"traceutil/trace.go:171","msg":"trace[1167214187] transaction","detail":"{read_only:false; response_revision:1220; number_of_response:1; }","duration":"2.595515679s","start":"2026-05-10T04:03:47.76484Z","end":"2026-05-10T04:03:50.360356Z","steps":["trace[1167214187] 'process raft request' (duration: 2.595254893s)"],"step_count":1} {"level":"warn","ts":"2026-05-10T04:03:50.360603Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T04:03:47.764822Z","time spent":"2.595627402s","remote":"127.0.0.1:55152","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-10T04:03:50.645341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.144587ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-05-10T04:03:50.645532Z","caller":"traceutil/trace.go:171","msg":"trace[1990177059] linearizableReadLoop","detail":"{readStateIndex:1271; appliedIndex:1267; }","duration":"3.032052204s","start":"2026-05-10T04:03:47.613449Z","end":"2026-05-10T04:03:50.645501Z","steps":["trace[1990177059] 'read index received' (duration: 2.368225912s)","trace[1990177059] 'applied index is now lower than readState.Index' (duration: 663.824042ms)"],"step_count":2} {"level":"info","ts":"2026-05-10T04:03:50.645577Z","caller":"traceutil/trace.go:171","msg":"trace[1717597521] transaction","detail":"{read_only:false; response_revision:1221; number_of_response:1; }","duration":"441.932759ms","start":"2026-05-10T04:03:50.203626Z","end":"2026-05-10T04:03:50.645559Z","steps":["trace[1717597521] 'process raft request' (duration: 441.811796ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T04:03:50.645673Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T04:03:50.203603Z","time spent":"442.014171ms","remote":"127.0.0.1:54978","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":757,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-10T04:03:50.64597Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.462164439s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-10T04:03:50.645973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.752761312s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-05-10T04:03:50.646021Z","caller":"traceutil/trace.go:171","msg":"trace[1458079148] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:1221; }","duration":"2.462268951s","start":"2026-05-10T04:03:48.183735Z","end":"2026-05-10T04:03:50.646004Z","steps":["trace[1458079148] 'agreement among raft nodes before linearized reading' (duration: 2.462171509s)"],"step_count":1} {"level":"info","ts":"2026-05-10T04:03:50.646054Z","caller":"traceutil/trace.go:171","msg":"trace[1950667683] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1221; }","duration":"2.752902175s","start":"2026-05-10T04:03:47.893135Z","end":"2026-05-10T04:03:50.646037Z","steps":["trace[1950667683] 'agreement among raft nodes before linearized reading' (duration: 2.752679039s)"],"step_count":1} {"level":"warn","ts":"2026-05-10T04:03:50.646075Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T04:03:48.183716Z","time spent":"2.462345314s","remote":"127.0.0.1:58860","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":27,"request content":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true "} {"level":"warn","ts":"2026-05-10T04:03:50.6461Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T04:03:47.893102Z","time spent":"2.752984808s","remote":"127.0.0.1:55152","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-10T04:03:50.646131Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.568115564s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-05-10T04:03:50.646167Z","caller":"traceutil/trace.go:171","msg":"trace[1032673549] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1221; }","duration":"2.568174235s","start":"2026-05-10T04:03:48.077982Z","end":"2026-05-10T04:03:50.646156Z","steps":["trace[1032673549] 'agreement among raft nodes before linearized reading' (duration: 2.568040552s)"],"step_count":1} {"level":"warn","ts":"2026-05-10T04:03:50.646196Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T04:03:48.077972Z","time spent":"2.568217386s","remote":"127.0.0.1:55152","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-10T04:03:50.646338Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.571541084s","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-05-10T04:03:50.646368Z","caller":"traceutil/trace.go:171","msg":"trace[1529945634] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1221; }","duration":"2.571607316s","start":"2026-05-10T04:03:48.074752Z","end":"2026-05-10T04:03:50.646359Z","steps":["trace[1529945634] 'agreement among raft nodes before linearized reading' (duration: 2.571507693s)"],"step_count":1} {"level":"warn","ts":"2026-05-10T04:03:50.646371Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.355653ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:5331"} {"level":"warn","ts":"2026-05-10T04:03:50.646396Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T04:03:48.074731Z","time spent":"2.571656597s","remote":"127.0.0.1:55152","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-05-10T04:03:50.646408Z","caller":"traceutil/trace.go:171","msg":"trace[741343611] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:1221; }","duration":"277.416014ms","start":"2026-05-10T04:03:50.368981Z","end":"2026-05-10T04:03:50.646397Z","steps":["trace[741343611] 'agreement among raft nodes before linearized reading' (duration: 277.305931ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T04:03:50.646482Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.594174211s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-10T04:03:50.646507Z","caller":"traceutil/trace.go:171","msg":"trace[1015129099] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1221; }","duration":"1.594220022s","start":"2026-05-10T04:03:49.052279Z","end":"2026-05-10T04:03:50.646499Z","steps":["trace[1015129099] 'agreement among raft nodes before linearized reading' (duration: 1.594181321s)"],"step_count":1} {"level":"warn","ts":"2026-05-10T04:03:50.646532Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T04:03:49.052251Z","time spent":"1.594276674s","remote":"127.0.0.1:54914","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-10T04:03:50.646767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.033320248s","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-05-10T04:03:50.646832Z","caller":"traceutil/trace.go:171","msg":"trace[26491015] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1221; }","duration":"3.033412201s","start":"2026-05-10T04:03:47.61341Z","end":"2026-05-10T04:03:50.646822Z","steps":["trace[26491015] 'agreement among raft nodes before linearized reading' (duration: 3.03221593s)"],"step_count":1} {"level":"warn","ts":"2026-05-10T04:03:50.646862Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T04:03:47.613395Z","time spent":"3.033459362s","remote":"127.0.0.1:55152","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-10T04:03:51.104167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.387638ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-10T04:03:51.109526Z","caller":"traceutil/trace.go:171","msg":"trace[1198452875] transaction","detail":"{read_only:false; response_revision:1222; number_of_response:1; }","duration":"457.994073ms","start":"2026-05-10T04:03:50.651486Z","end":"2026-05-10T04:03:51.10948Z","steps":["trace[1198452875] 'process raft request' (duration: 270.101889ms)","trace[1198452875] 'compare' (duration: 181.620378ms)"],"step_count":2} {"level":"warn","ts":"2026-05-10T04:03:51.109614Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T04:03:50.65147Z","time spent":"458.098326ms","remote":"127.0.0.1:55152","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-10T04:03:51.190535Z","caller":"traceutil/trace.go:171","msg":"trace[1181789077] transaction","detail":"{read_only:false; response_revision:1223; number_of_response:1; }","duration":"538.996118ms","start":"2026-05-10T04:03:50.651509Z","end":"2026-05-10T04:03:51.190505Z","steps":["trace[1181789077] 'process raft request' (duration: 538.756122ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T04:03:51.190716Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T04:03:50.651491Z","time spent":"539.123321ms","remote":"127.0.0.1:55152","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-10T04:03:51.190817Z","caller":"traceutil/trace.go:171","msg":"trace[2068320344] transaction","detail":"{read_only:false; response_revision:1224; number_of_response:1; }","duration":"538.339481ms","start":"2026-05-10T04:03:50.652458Z","end":"2026-05-10T04:03:51.190797Z","steps":["trace[2068320344] 'process raft request' (duration: 537.990732ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T04:03:51.190859Z","caller":"traceutil/trace.go:171","msg":"trace[859594376] transaction","detail":"{read_only:false; response_revision:1225; number_of_response:1; }","duration":"538.029643ms","start":"2026-05-10T04:03:50.652806Z","end":"2026-05-10T04:03:51.190836Z","steps":["trace[859594376] 'process raft request' (duration: 537.829617ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T04:03:51.190918Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T04:03:50.652432Z","time spent":"538.428873ms","remote":"127.0.0.1:55152","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-10T04:03:51.190997Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T04:03:50.652798Z","time spent":"538.125055ms","remote":"127.0.0.1:55152","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-10T04:03:51.190982Z","caller":"traceutil/trace.go:171","msg":"trace[653008244] transaction","detail":"{read_only:false; response_revision:1226; number_of_response:1; }","duration":"537.245072ms","start":"2026-05-10T04:03:50.653713Z","end":"2026-05-10T04:03:51.190958Z","steps":["trace[653008244] 'process raft request' (duration: 537.076887ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T04:03:51.191139Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T04:03:50.653705Z","time spent":"537.334695ms","remote":"127.0.0.1:55068","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5457,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-10T04:03:51.191288Z","caller":"traceutil/trace.go:171","msg":"trace[814878654] linearizableReadLoop","detail":"{readStateIndex:1277; appliedIndex:1272; }","duration":"535.225799ms","start":"2026-05-10T04:03:50.656041Z","end":"2026-05-10T04:03:51.191267Z","steps":["trace[814878654] 'read index received' (duration: 265.567241ms)","trace[814878654] 'applied index is now lower than readState.Index' (duration: 269.656938ms)"],"step_count":2} {"level":"info","ts":"2026-05-10T04:03:51.191307Z","caller":"traceutil/trace.go:171","msg":"trace[475554105] transaction","detail":"{read_only:false; response_revision:1227; number_of_response:1; }","duration":"420.324767ms","start":"2026-05-10T04:03:50.77097Z","end":"2026-05-10T04:03:51.191294Z","steps":["trace[475554105] 'process raft request' (duration: 419.929236ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T04:03:51.191376Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T04:03:50.770946Z","time spent":"420.402999ms","remote":"127.0.0.1:54978","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":757,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-10T04:03:51.191522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"535.475785ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-10T04:03:51.191578Z","caller":"traceutil/trace.go:171","msg":"trace[400567428] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1227; }","duration":"535.588958ms","start":"2026-05-10T04:03:50.65597Z","end":"2026-05-10T04:03:51.191559Z","steps":["trace[400567428] 'agreement among raft nodes before linearized reading' (duration: 535.415963ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T04:03:51.191625Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T04:03:50.655957Z","time spent":"535.65291ms","remote":"127.0.0.1:54914","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-10T04:03:51.351772Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.216021ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-10T04:03:51.351959Z","caller":"traceutil/trace.go:171","msg":"trace[1730561261] transaction","detail":"{read_only:false; response_revision:1228; number_of_response:1; }","duration":"155.560549ms","start":"2026-05-10T04:03:51.196371Z","end":"2026-05-10T04:03:51.351931Z","steps":["trace[1730561261] 'process raft request' (duration: 46.123162ms)","trace[1730561261] 'compare' (duration: 109.054737ms)"],"step_count":2} {"level":"info","ts":"2026-05-10T04:03:51.352303Z","caller":"traceutil/trace.go:171","msg":"trace[1221288831] transaction","detail":"{read_only:false; response_revision:1229; number_of_response:1; }","duration":"152.136028ms","start":"2026-05-10T04:03:51.20016Z","end":"2026-05-10T04:03:51.352296Z","steps":["trace[1221288831] 'process raft request' (duration: 151.946933ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T04:03:52.951621Z","caller":"traceutil/trace.go:171","msg":"trace[1925162575] transaction","detail":"{read_only:false; response_revision:1234; number_of_response:1; }","duration":"154.908711ms","start":"2026-05-10T04:03:52.796692Z","end":"2026-05-10T04:03:52.9516Z","steps":["trace[1925162575] 'process raft request' (duration: 154.785308ms)"],"step_count":1}