{"level":"warn","ts":"2026-07-09T16:40:28.331583Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-09T16:40:28.331686Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.86: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.19.213.86:2380","--initial-cluster=instance=https://199.19.213.86:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.86:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.86: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-07-09T16:40:28.331785Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-09T16:40:28.331799Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.86:2380"]} {"level":"info","ts":"2026-07-09T16:40:28.331823Z","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-07-09T16:40:28.33388Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.86:2379"]} {"level":"info","ts":"2026-07-09T16:40:28.333982Z","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.19.213.86:2380"],"listen-peer-urls":["https://199.19.213.86:2380"],"advertise-client-urls":["https://199.19.213.86:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.86:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.86: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-07-09T16:40:28.339383Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.136793ms"} {"level":"info","ts":"2026-07-09T16:40:28.34626Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"849a6ffb5e81c109","cluster-id":"d4d86b1dd8829199"} {"level":"info","ts":"2026-07-09T16:40:28.346355Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"849a6ffb5e81c109 switched to configuration voters=()"} {"level":"info","ts":"2026-07-09T16:40:28.346378Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"849a6ffb5e81c109 became follower at term 0"} {"level":"info","ts":"2026-07-09T16:40:28.346391Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 849a6ffb5e81c109 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-09T16:40:28.346449Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"849a6ffb5e81c109 became follower at term 1"} {"level":"info","ts":"2026-07-09T16:40:28.346549Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"849a6ffb5e81c109 switched to configuration voters=(9555072684832964873)"} {"level":"warn","ts":"2026-07-09T16:40:28.354838Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-09T16:40:28.356569Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-09T16:40:28.357712Z","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-07-09T16:40:28.359759Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"849a6ffb5e81c109","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-09T16:40:28.362327Z","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-07-09T16:40:28.36245Z","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-07-09T16:40:28.362465Z","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-07-09T16:40:28.360768Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"849a6ffb5e81c109","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-09T16:40:28.363487Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"849a6ffb5e81c109 switched to configuration voters=(9555072684832964873)"} {"level":"info","ts":"2026-07-09T16:40:28.363577Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"d4d86b1dd8829199","local-member-id":"849a6ffb5e81c109","added-peer-id":"849a6ffb5e81c109","added-peer-peer-urls":["https://199.19.213.86:2380"]} {"level":"info","ts":"2026-07-09T16:40:28.36878Z","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-07-09T16:40:28.368875Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.86:2380"} {"level":"info","ts":"2026-07-09T16:40:28.368926Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.86:2380"} {"level":"info","ts":"2026-07-09T16:40:28.369042Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"849a6ffb5e81c109","initial-advertise-peer-urls":["https://199.19.213.86:2380"],"listen-peer-urls":["https://199.19.213.86:2380"],"advertise-client-urls":["https://199.19.213.86:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.86:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-09T16:40:28.369069Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-09T16:40:29.14709Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"849a6ffb5e81c109 is starting a new election at term 1"} {"level":"info","ts":"2026-07-09T16:40:29.147166Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"849a6ffb5e81c109 became pre-candidate at term 1"} {"level":"info","ts":"2026-07-09T16:40:29.147198Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"849a6ffb5e81c109 received MsgPreVoteResp from 849a6ffb5e81c109 at term 1"} {"level":"info","ts":"2026-07-09T16:40:29.14722Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"849a6ffb5e81c109 became candidate at term 2"} {"level":"info","ts":"2026-07-09T16:40:29.147231Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"849a6ffb5e81c109 received MsgVoteResp from 849a6ffb5e81c109 at term 2"} {"level":"info","ts":"2026-07-09T16:40:29.147247Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"849a6ffb5e81c109 became leader at term 2"} {"level":"info","ts":"2026-07-09T16:40:29.14726Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 849a6ffb5e81c109 elected leader 849a6ffb5e81c109 at term 2"} {"level":"info","ts":"2026-07-09T16:40:29.148203Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-09T16:40:29.149417Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"849a6ffb5e81c109","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.86:2379]}","request-path":"/0/members/849a6ffb5e81c109/attributes","cluster-id":"d4d86b1dd8829199","publish-timeout":"7s"} {"level":"info","ts":"2026-07-09T16:40:29.149603Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-09T16:40:29.149683Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-09T16:40:29.150055Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"d4d86b1dd8829199","local-member-id":"849a6ffb5e81c109","cluster-version":"3.5"} {"level":"info","ts":"2026-07-09T16:40:29.150235Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-09T16:40:29.150254Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-09T16:40:29.152654Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-09T16:40:29.153078Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.86:2379"} {"level":"info","ts":"2026-07-09T16:40:29.159344Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-09T16:40:29.159387Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-09T16:40:32.884654Z","caller":"traceutil/trace.go:171","msg":"trace[1905980963] transaction","detail":"{read_only:false; response_revision:246; number_of_response:1; }","duration":"136.476788ms","start":"2026-07-09T16:40:32.748149Z","end":"2026-07-09T16:40:32.884626Z","steps":["trace[1905980963] 'process raft request' (duration: 136.2733ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T16:40:33.107396Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.095684ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-07-09T16:40:33.107534Z","caller":"traceutil/trace.go:171","msg":"trace[1449796323] transaction","detail":"{read_only:false; response_revision:247; number_of_response:1; }","duration":"214.71902ms","start":"2026-07-09T16:40:32.892791Z","end":"2026-07-09T16:40:33.10751Z","steps":["trace[1449796323] 'process raft request' (duration: 84.901939ms)","trace[1449796323] 'compare' (duration: 128.953817ms)"],"step_count":2} {"level":"info","ts":"2026-07-09T16:41:08.641528Z","caller":"traceutil/trace.go:171","msg":"trace[981872383] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"170.64067ms","start":"2026-07-09T16:41:08.470871Z","end":"2026-07-09T16:41:08.641512Z","steps":["trace[981872383] 'process raft request' (duration: 170.474355ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T16:41:08.649989Z","caller":"traceutil/trace.go:171","msg":"trace[1187703948] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"163.968945ms","start":"2026-07-09T16:41:08.485999Z","end":"2026-07-09T16:41:08.649968Z","steps":["trace[1187703948] 'process raft request' (duration: 163.650306ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T16:41:08.650306Z","caller":"traceutil/trace.go:171","msg":"trace[635729427] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"153.619137ms","start":"2026-07-09T16:41:08.496679Z","end":"2026-07-09T16:41:08.650298Z","steps":["trace[635729427] 'process raft request' (duration: 153.061811ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T16:41:15.736912Z","caller":"traceutil/trace.go:171","msg":"trace[33719757] transaction","detail":"{read_only:false; response_revision:701; number_of_response:1; }","duration":"200.378274ms","start":"2026-07-09T16:41:15.536488Z","end":"2026-07-09T16:41:15.736866Z","steps":["trace[33719757] 'process raft request' (duration: 200.189509ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T16:43:56.842892Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.881474731s","expected-duration":"1s"} {"level":"warn","ts":"2026-07-09T16:43:56.844638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.883160274s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-09T16:43:56.844783Z","caller":"traceutil/trace.go:171","msg":"trace[923828530] transaction","detail":"{read_only:false; response_revision:1460; number_of_response:1; }","duration":"2.124831528s","start":"2026-07-09T16:43:54.71994Z","end":"2026-07-09T16:43:56.844771Z","steps":["trace[923828530] 'process raft request' (duration: 2.124791797s)"],"step_count":1} {"level":"info","ts":"2026-07-09T16:43:56.844793Z","caller":"traceutil/trace.go:171","msg":"trace[351866261] transaction","detail":"{read_only:false; response_revision:1459; number_of_response:1; }","duration":"2.291649275s","start":"2026-07-09T16:43:54.553105Z","end":"2026-07-09T16:43:56.844754Z","steps":["trace[351866261] 'process raft request' (duration: 408.235247ms)","trace[351866261] 'compare' (duration: 1.8820798s)"],"step_count":2} {"level":"warn","ts":"2026-07-09T16:43:56.84486Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T16:43:54.719922Z","time spent":"2.124898838s","remote":"127.0.0.1:57670","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-09T16:43:56.844951Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T16:43:54.553091Z","time spent":"2.291762126s","remote":"127.0.0.1:57670","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-09T16:43:56.844946Z","caller":"traceutil/trace.go:171","msg":"trace[2084873990] linearizableReadLoop","detail":"{readStateIndex:1519; appliedIndex:1518; }","duration":"2.285713384s","start":"2026-07-09T16:43:54.559162Z","end":"2026-07-09T16:43:56.844875Z","steps":["trace[2084873990] 'read index received' (duration: 402.324507ms)","trace[2084873990] 'applied index is now lower than readState.Index' (duration: 1.883384507s)"],"step_count":2} {"level":"warn","ts":"2026-07-09T16:43:56.845115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.285910007s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-09T16:43:56.845197Z","caller":"traceutil/trace.go:171","msg":"trace[55414254] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:1460; }","duration":"2.286060539s","start":"2026-07-09T16:43:54.559099Z","end":"2026-07-09T16:43:56.845159Z","steps":["trace[55414254] 'agreement among raft nodes before linearized reading' (duration: 2.285896367s)"],"step_count":1} {"level":"warn","ts":"2026-07-09T16:43:56.845272Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T16:43:54.559076Z","time spent":"2.28615796s","remote":"127.0.0.1:36102","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true "} {"level":"warn","ts":"2026-07-09T16:43:56.858129Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.281911083s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/generic-garbage-collector\" ","response":"range_response_count:1 size:216"} {"level":"info","ts":"2026-07-09T16:43:56.858171Z","caller":"traceutil/trace.go:171","msg":"trace[1744751308] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/generic-garbage-collector; range_end:; response_count:1; response_revision:1461; }","duration":"2.281982404s","start":"2026-07-09T16:43:54.576179Z","end":"2026-07-09T16:43:56.858161Z","steps":["trace[1744751308] 'agreement among raft nodes before linearized reading' (duration: 2.281873892s)"],"step_count":1} {"level":"warn","ts":"2026-07-09T16:43:56.858196Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T16:43:54.576164Z","time spent":"2.282026304s","remote":"127.0.0.1:57626","response type":"/etcdserverpb.KV/Range","request count":0,"request size":65,"response count":1,"response size":240,"request content":"key:\"/registry/serviceaccounts/kube-system/generic-garbage-collector\" "} {"level":"info","ts":"2026-07-09T16:43:56.858365Z","caller":"traceutil/trace.go:171","msg":"trace[2129735041] transaction","detail":"{read_only:false; response_revision:1461; number_of_response:1; }","duration":"953.672811ms","start":"2026-07-09T16:43:55.904683Z","end":"2026-07-09T16:43:56.858356Z","steps":["trace[2129735041] 'process raft request' (duration: 953.291886ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T16:43:56.858463Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T16:43:55.904659Z","time spent":"953.755912ms","remote":"127.0.0.1:57670","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-09T16:43:56.858601Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.148135517s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-07-09T16:43:56.858654Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.250796493s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/expand-controller\" ","response":"range_response_count:1 size:199"} {"level":"info","ts":"2026-07-09T16:43:56.858673Z","caller":"traceutil/trace.go:171","msg":"trace[1189953909] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/expand-controller; range_end:; response_count:1; response_revision:1461; }","duration":"2.250843415s","start":"2026-07-09T16:43:54.607824Z","end":"2026-07-09T16:43:56.858667Z","steps":["trace[1189953909] 'agreement among raft nodes before linearized reading' (duration: 2.250812284s)"],"step_count":1} {"level":"info","ts":"2026-07-09T16:43:56.858662Z","caller":"traceutil/trace.go:171","msg":"trace[503543934] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1461; }","duration":"1.148233478s","start":"2026-07-09T16:43:55.710411Z","end":"2026-07-09T16:43:56.858645Z","steps":["trace[503543934] 'agreement among raft nodes before linearized reading' (duration: 1.148056076s)"],"step_count":1} {"level":"warn","ts":"2026-07-09T16:43:56.85869Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T16:43:54.607811Z","time spent":"2.250876015s","remote":"127.0.0.1:57626","response type":"/etcdserverpb.KV/Range","request count":0,"request size":57,"response count":1,"response size":223,"request content":"key:\"/registry/serviceaccounts/kube-system/expand-controller\" "} {"level":"warn","ts":"2026-07-09T16:43:56.858704Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T16:43:55.710392Z","time spent":"1.148304339s","remote":"127.0.0.1:57670","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-09T16:43:56.858915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"456.319639ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-09T16:43:56.858932Z","caller":"traceutil/trace.go:171","msg":"trace[1931756350] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1461; }","duration":"456.36792ms","start":"2026-07-09T16:43:56.402558Z","end":"2026-07-09T16:43:56.858926Z","steps":["trace[1931756350] 'agreement among raft nodes before linearized reading' (duration: 456.34214ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T16:43:56.85895Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T16:43:56.402544Z","time spent":"456.40138ms","remote":"127.0.0.1:57416","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-09T16:43:56.859033Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.737946ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-09T16:43:56.859046Z","caller":"traceutil/trace.go:171","msg":"trace[1966032075] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:1461; }","duration":"229.796777ms","start":"2026-07-09T16:43:56.629245Z","end":"2026-07-09T16:43:56.859042Z","steps":["trace[1966032075] 'agreement among raft nodes before linearized reading' (duration: 229.764676ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T16:43:56.859005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.143325602s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-07-09T16:43:56.859143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.882889ms","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-07-09T16:43:56.859156Z","caller":"traceutil/trace.go:171","msg":"trace[495252503] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1461; }","duration":"314.92459ms","start":"2026-07-09T16:43:56.544228Z","end":"2026-07-09T16:43:56.859152Z","steps":["trace[495252503] 'agreement among raft nodes before linearized reading' (duration: 314.88382ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T16:43:56.859168Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T16:43:56.54421Z","time spent":"314.95523ms","remote":"127.0.0.1:57670","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-09T16:43:56.858619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.176405888s","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-07-09T16:43:56.859303Z","caller":"traceutil/trace.go:171","msg":"trace[1451198750] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1461; }","duration":"1.177116867s","start":"2026-07-09T16:43:55.682182Z","end":"2026-07-09T16:43:56.859299Z","steps":["trace[1451198750] 'agreement among raft nodes before linearized reading' (duration: 1.176366187s)"],"step_count":1} {"level":"warn","ts":"2026-07-09T16:43:56.859319Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T16:43:55.682167Z","time spent":"1.177147387s","remote":"127.0.0.1:57670","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-07-09T16:43:56.859948Z","caller":"traceutil/trace.go:171","msg":"trace[449653771] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1461; }","duration":"1.143509605s","start":"2026-07-09T16:43:55.715632Z","end":"2026-07-09T16:43:56.859141Z","steps":["trace[449653771] 'agreement among raft nodes before linearized reading' (duration: 1.143299692s)"],"step_count":1} {"level":"warn","ts":"2026-07-09T16:43:56.860015Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T16:43:55.715611Z","time spent":"1.144383656s","remote":"127.0.0.1:57670","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-09T16:43:58.852353Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13909824054632237784,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-09T16:43:59.353509Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13909824054632237784,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-09T16:43:59.786329Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.45492587s","expected-duration":"1s"} {"level":"info","ts":"2026-07-09T16:43:59.78677Z","caller":"traceutil/trace.go:171","msg":"trace[1442015383] transaction","detail":"{read_only:false; response_revision:1466; number_of_response:1; }","duration":"1.455497168s","start":"2026-07-09T16:43:58.331249Z","end":"2026-07-09T16:43:59.786746Z","steps":["trace[1442015383] 'process raft request' (duration: 1.455325175s)"],"step_count":1} {"level":"warn","ts":"2026-07-09T16:43:59.786981Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T16:43:58.331205Z","time spent":"1.45559511s","remote":"127.0.0.1:57670","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-09T16:43:59.788827Z","caller":"traceutil/trace.go:171","msg":"trace[1258587557] linearizableReadLoop","detail":"{readStateIndex:1528; appliedIndex:1526; }","duration":"1.437242053s","start":"2026-07-09T16:43:58.35156Z","end":"2026-07-09T16:43:59.788802Z","steps":["trace[1258587557] 'read index received' (duration: 1.435029364s)","trace[1258587557] 'applied index is now lower than readState.Index' (duration: 2.211859ms)"],"step_count":2} {"level":"info","ts":"2026-07-09T16:43:59.788855Z","caller":"traceutil/trace.go:171","msg":"trace[111888948] transaction","detail":"{read_only:false; response_revision:1467; number_of_response:1; }","duration":"462.106775ms","start":"2026-07-09T16:43:59.326735Z","end":"2026-07-09T16:43:59.788842Z","steps":["trace[111888948] 'process raft request' (duration: 461.931692ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T16:43:59.788928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.437369465s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" ","response":"range_response_count:1 size:207"} {"level":"warn","ts":"2026-07-09T16:43:59.788973Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T16:43:59.326709Z","time spent":"462.217346ms","remote":"127.0.0.1:57670","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-09T16:43:59.789036Z","caller":"traceutil/trace.go:171","msg":"trace[1608944733] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replicaset-controller; range_end:; response_count:1; response_revision:1467; }","duration":"1.437430086s","start":"2026-07-09T16:43:58.351517Z","end":"2026-07-09T16:43:59.788947Z","steps":["trace[1608944733] 'agreement among raft nodes before linearized reading' (duration: 1.437371275s)"],"step_count":1} {"level":"warn","ts":"2026-07-09T16:43:59.789146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.393054652s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-09T16:43:59.789073Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T16:43:58.351501Z","time spent":"1.437560368s","remote":"127.0.0.1:57626","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":231,"request content":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" "} {"level":"warn","ts":"2026-07-09T16:43:59.789177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"917.186226ms","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-07-09T16:43:59.789207Z","caller":"traceutil/trace.go:171","msg":"trace[128809004] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1467; }","duration":"1.393177593s","start":"2026-07-09T16:43:58.396006Z","end":"2026-07-09T16:43:59.789183Z","steps":["trace[128809004] 'agreement among raft nodes before linearized reading' (duration: 1.393087092s)"],"step_count":1} {"level":"warn","ts":"2026-07-09T16:43:59.789223Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"563.4129ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-09T16:43:59.789024Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.43324899s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/replication-controller\" ","response":"range_response_count:1 size:209"} {"level":"warn","ts":"2026-07-09T16:43:59.789363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"917.125495ms","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-07-09T16:43:59.789392Z","caller":"traceutil/trace.go:171","msg":"trace[805661187] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replication-controller; range_end:; response_count:1; response_revision:1467; }","duration":"1.433678196s","start":"2026-07-09T16:43:58.355698Z","end":"2026-07-09T16:43:59.789376Z","steps":["trace[805661187] 'agreement among raft nodes before linearized reading' (duration: 1.43325733s)"],"step_count":1} {"level":"warn","ts":"2026-07-09T16:43:59.789422Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T16:43:58.355687Z","time spent":"1.433727556s","remote":"127.0.0.1:57626","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":233,"request content":"key:\"/registry/serviceaccounts/kube-system/replication-controller\" "} {"level":"warn","ts":"2026-07-09T16:43:59.78926Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T16:43:58.395977Z","time spent":"1.393273864s","remote":"127.0.0.1:57416","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-07-09T16:43:59.789399Z","caller":"traceutil/trace.go:171","msg":"trace[1123591791] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1467; }","duration":"917.258247ms","start":"2026-07-09T16:43:58.87213Z","end":"2026-07-09T16:43:59.789389Z","steps":["trace[1123591791] 'agreement among raft nodes before linearized reading' (duration: 917.125235ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T16:43:59.789505Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T16:43:58.872101Z","time spent":"917.392269ms","remote":"127.0.0.1:57670","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-07-09T16:43:59.789219Z","caller":"traceutil/trace.go:171","msg":"trace[1049079898] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1467; }","duration":"917.282288ms","start":"2026-07-09T16:43:58.871925Z","end":"2026-07-09T16:43:59.789207Z","steps":["trace[1049079898] 'agreement among raft nodes before linearized reading' (duration: 917.145596ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T16:43:59.789634Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T16:43:58.871888Z","time spent":"917.736523ms","remote":"127.0.0.1:57670","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-07-09T16:43:59.789435Z","caller":"traceutil/trace.go:171","msg":"trace[1491555290] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:1467; }","duration":"563.612593ms","start":"2026-07-09T16:43:59.22569Z","end":"2026-07-09T16:43:59.789303Z","steps":["trace[1491555290] 'agreement among raft nodes before linearized reading' (duration: 563.41584ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T16:43:59.789773Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T16:43:59.225662Z","time spent":"564.094599ms","remote":"127.0.0.1:36038","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true "} {"level":"warn","ts":"2026-07-09T16:43:59.789804Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"918.633985ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-07-09T16:43:59.789879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"917.803475ms","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-07-09T16:43:59.789902Z","caller":"traceutil/trace.go:171","msg":"trace[750289893] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1467; }","duration":"918.755138ms","start":"2026-07-09T16:43:58.871136Z","end":"2026-07-09T16:43:59.789891Z","steps":["trace[750289893] 'agreement among raft nodes before linearized reading' (duration: 917.894376ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T16:43:59.789914Z","caller":"traceutil/trace.go:171","msg":"trace[9425560] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1467; }","duration":"917.850885ms","start":"2026-07-09T16:43:58.872052Z","end":"2026-07-09T16:43:59.789903Z","steps":["trace[9425560] 'agreement among raft nodes before linearized reading' (duration: 916.923103ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T16:43:59.789954Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T16:43:58.871124Z","time spent":"918.808548ms","remote":"127.0.0.1:57670","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-09T16:43:59.789971Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T16:43:58.872046Z","time spent":"917.914696ms","remote":"127.0.0.1:57670","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-09T16:43:59.790473Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"940.971805ms","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-07-09T16:43:59.790513Z","caller":"traceutil/trace.go:171","msg":"trace[1783824344] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1467; }","duration":"941.075857ms","start":"2026-07-09T16:43:58.849427Z","end":"2026-07-09T16:43:59.790502Z","steps":["trace[1783824344] 'agreement among raft nodes before linearized reading' (duration: 939.627188ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T16:43:59.790542Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T16:43:58.849398Z","time spent":"941.135737ms","remote":"127.0.0.1:57670","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}