{"level":"warn","ts":"2026-04-17T05:46:23.513302Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-17T05:46:23.513402Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.132: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.132:2380","--initial-cluster=instance=https://199.204.45.132:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.132:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.132: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-04-17T05:46:23.513475Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-17T05:46:23.51349Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.132:2380"]} {"level":"info","ts":"2026-04-17T05:46:23.513511Z","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-04-17T05:46:23.51418Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.132:2379"]} {"level":"info","ts":"2026-04-17T05:46:23.514257Z","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.132:2380"],"listen-peer-urls":["https://199.204.45.132:2380"],"advertise-client-urls":["https://199.204.45.132:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.132:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.132: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-04-17T05:46:23.519608Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.135453ms"} {"level":"info","ts":"2026-04-17T05:46:23.529112Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"56c01ea8fdc90390","cluster-id":"c930fe821aab8609"} {"level":"info","ts":"2026-04-17T05:46:23.529184Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 switched to configuration voters=()"} {"level":"info","ts":"2026-04-17T05:46:23.529215Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 became follower at term 0"} {"level":"info","ts":"2026-04-17T05:46:23.529228Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 56c01ea8fdc90390 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-17T05:46:23.52924Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 became follower at term 1"} {"level":"info","ts":"2026-04-17T05:46:23.529281Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 switched to configuration voters=(6251029993951396752)"} {"level":"warn","ts":"2026-04-17T05:46:23.539341Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-17T05:46:23.540518Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-17T05:46:23.541816Z","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-04-17T05:46:23.543872Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"56c01ea8fdc90390","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-17T05:46:23.548137Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"56c01ea8fdc90390","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-17T05:46:23.548136Z","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-04-17T05:46:23.548418Z","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-04-17T05:46:23.548447Z","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-04-17T05:46:23.549908Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 switched to configuration voters=(6251029993951396752)"} {"level":"info","ts":"2026-04-17T05:46:23.550157Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"c930fe821aab8609","local-member-id":"56c01ea8fdc90390","added-peer-id":"56c01ea8fdc90390","added-peer-peer-urls":["https://199.204.45.132:2380"]} {"level":"info","ts":"2026-04-17T05:46:23.550209Z","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-04-17T05:46:23.550273Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.132:2380"} {"level":"info","ts":"2026-04-17T05:46:23.550324Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.132:2380"} {"level":"info","ts":"2026-04-17T05:46:23.550623Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"56c01ea8fdc90390","initial-advertise-peer-urls":["https://199.204.45.132:2380"],"listen-peer-urls":["https://199.204.45.132:2380"],"advertise-client-urls":["https://199.204.45.132:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.132:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-17T05:46:23.550698Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-17T05:46:23.92966Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 is starting a new election at term 1"} {"level":"info","ts":"2026-04-17T05:46:23.929897Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-17T05:46:23.929965Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 received MsgPreVoteResp from 56c01ea8fdc90390 at term 1"} {"level":"info","ts":"2026-04-17T05:46:23.930016Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 became candidate at term 2"} {"level":"info","ts":"2026-04-17T05:46:23.930136Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 received MsgVoteResp from 56c01ea8fdc90390 at term 2"} {"level":"info","ts":"2026-04-17T05:46:23.930201Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 became leader at term 2"} {"level":"info","ts":"2026-04-17T05:46:23.930285Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 56c01ea8fdc90390 elected leader 56c01ea8fdc90390 at term 2"} {"level":"info","ts":"2026-04-17T05:46:23.961421Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"56c01ea8fdc90390","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.132:2379]}","request-path":"/0/members/56c01ea8fdc90390/attributes","cluster-id":"c930fe821aab8609","publish-timeout":"7s"} {"level":"info","ts":"2026-04-17T05:46:23.961467Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-17T05:46:23.961892Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-17T05:46:23.961994Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-17T05:46:23.96151Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-17T05:46:23.961416Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-17T05:46:23.966693Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.132:2379"} {"level":"info","ts":"2026-04-17T05:46:23.966993Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"c930fe821aab8609","local-member-id":"56c01ea8fdc90390","cluster-version":"3.5"} {"level":"info","ts":"2026-04-17T05:46:23.967157Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-17T05:46:23.967202Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-17T05:46:23.968196Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-17T05:46:29.962186Z","caller":"traceutil/trace.go:171","msg":"trace[784444321] linearizableReadLoop","detail":"{readStateIndex:254; appliedIndex:253; }","duration":"260.654082ms","start":"2026-04-17T05:46:29.701509Z","end":"2026-04-17T05:46:29.962163Z","steps":["trace[784444321] 'read index received' (duration: 260.464734ms)","trace[784444321] 'applied index is now lower than readState.Index' (duration: 188.427µs)"],"step_count":2} {"level":"info","ts":"2026-04-17T05:46:29.962442Z","caller":"traceutil/trace.go:171","msg":"trace[941011789] transaction","detail":"{read_only:false; response_revision:246; number_of_response:1; }","duration":"262.969505ms","start":"2026-04-17T05:46:29.699461Z","end":"2026-04-17T05:46:29.962431Z","steps":["trace[941011789] 'process raft request' (duration: 262.58883ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T05:46:29.962668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.151052ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T05:46:29.962723Z","caller":"traceutil/trace.go:171","msg":"trace[2089682076] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:0; response_revision:246; }","duration":"261.276706ms","start":"2026-04-17T05:46:29.701435Z","end":"2026-04-17T05:46:29.962712Z","steps":["trace[2089682076] 'agreement among raft nodes before linearized reading' (duration: 261.162692ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T05:46:54.416831Z","caller":"traceutil/trace.go:171","msg":"trace[1370079466] transaction","detail":"{read_only:false; response_revision:558; number_of_response:1; }","duration":"130.6536ms","start":"2026-04-17T05:46:54.286157Z","end":"2026-04-17T05:46:54.41681Z","steps":["trace[1370079466] 'process raft request' (duration: 128.142734ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T05:46:54.417079Z","caller":"traceutil/trace.go:171","msg":"trace[1108048242] transaction","detail":"{read_only:false; response_revision:559; number_of_response:1; }","duration":"119.670735ms","start":"2026-04-17T05:46:54.2974Z","end":"2026-04-17T05:46:54.417071Z","steps":["trace[1108048242] 'process raft request' (duration: 119.633424ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T05:46:54.654964Z","caller":"traceutil/trace.go:171","msg":"trace[1385033115] transaction","detail":"{read_only:false; response_revision:560; number_of_response:1; }","duration":"142.238604ms","start":"2026-04-17T05:46:54.512708Z","end":"2026-04-17T05:46:54.654947Z","steps":["trace[1385033115] 'process raft request' (duration: 132.353643ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T05:46:55.059312Z","caller":"traceutil/trace.go:171","msg":"trace[863208691] transaction","detail":"{read_only:false; response_revision:567; number_of_response:1; }","duration":"237.504859ms","start":"2026-04-17T05:46:54.821791Z","end":"2026-04-17T05:46:55.059296Z","steps":["trace[863208691] 'process raft request' (duration: 237.405226ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T05:46:55.069192Z","caller":"traceutil/trace.go:171","msg":"trace[852317954] linearizableReadLoop","detail":"{readStateIndex:590; appliedIndex:588; }","duration":"118.17654ms","start":"2026-04-17T05:46:54.950979Z","end":"2026-04-17T05:46:55.069155Z","steps":["trace[852317954] 'read index received' (duration: 108.623742ms)","trace[852317954] 'applied index is now lower than readState.Index' (duration: 9.551897ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T05:46:55.069333Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.332084ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T05:46:55.069372Z","caller":"traceutil/trace.go:171","msg":"trace[642940789] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:569; }","duration":"118.406087ms","start":"2026-04-17T05:46:54.950955Z","end":"2026-04-17T05:46:55.069361Z","steps":["trace[642940789] 'agreement among raft nodes before linearized reading' (duration: 118.302354ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T05:46:55.069657Z","caller":"traceutil/trace.go:171","msg":"trace[2064704035] transaction","detail":"{read_only:false; response_revision:569; number_of_response:1; }","duration":"172.639809ms","start":"2026-04-17T05:46:54.896999Z","end":"2026-04-17T05:46:55.069639Z","steps":["trace[2064704035] 'process raft request' (duration: 172.122784ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T05:46:55.069704Z","caller":"traceutil/trace.go:171","msg":"trace[1325370770] transaction","detail":"{read_only:false; response_revision:568; number_of_response:1; }","duration":"206.947104ms","start":"2026-04-17T05:46:54.862741Z","end":"2026-04-17T05:46:55.069688Z","steps":["trace[1325370770] 'process raft request' (duration: 206.012387ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T05:46:55.563116Z","caller":"traceutil/trace.go:171","msg":"trace[187447506] linearizableReadLoop","detail":"{readStateIndex:599; appliedIndex:598; }","duration":"298.292393ms","start":"2026-04-17T05:46:55.264807Z","end":"2026-04-17T05:46:55.563099Z","steps":["trace[187447506] 'read index received' (duration: 297.579802ms)","trace[187447506] 'applied index is now lower than readState.Index' (duration: 711.901µs)"],"step_count":2} {"level":"info","ts":"2026-04-17T05:46:55.563197Z","caller":"traceutil/trace.go:171","msg":"trace[552225589] transaction","detail":"{read_only:false; response_revision:578; number_of_response:1; }","duration":"312.961745ms","start":"2026-04-17T05:46:55.250214Z","end":"2026-04-17T05:46:55.563176Z","steps":["trace[552225589] 'process raft request' (duration: 312.236153ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T05:46:55.563289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.464049ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/udproutes.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:31126"} {"level":"info","ts":"2026-04-17T05:46:55.563313Z","caller":"traceutil/trace.go:171","msg":"trace[196573242] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/udproutes.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:578; }","duration":"298.520451ms","start":"2026-04-17T05:46:55.264785Z","end":"2026-04-17T05:46:55.563305Z","steps":["trace[196573242] 'agreement among raft nodes before linearized reading' (duration: 298.409586ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T05:46:55.563327Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.169986ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T05:46:55.563365Z","caller":"traceutil/trace.go:171","msg":"trace[1063326674] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io; range_end:; response_count:0; response_revision:578; }","duration":"267.242658ms","start":"2026-04-17T05:46:55.296111Z","end":"2026-04-17T05:46:55.563353Z","steps":["trace[1063326674] 'agreement among raft nodes before linearized reading' (duration: 267.178436ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T05:46:55.563517Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T05:46:55.250183Z","time spent":"313.059528ms","remote":"127.0.0.1:60056","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4165,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T05:46:59.118254Z","caller":"traceutil/trace.go:171","msg":"trace[1061582873] linearizableReadLoop","detail":"{readStateIndex:632; appliedIndex:631; }","duration":"432.758162ms","start":"2026-04-17T05:46:58.685473Z","end":"2026-04-17T05:46:59.118231Z","steps":["trace[1061582873] 'read index received' (duration: 358.511525ms)","trace[1061582873] 'applied index is now lower than readState.Index' (duration: 74.245697ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T05:46:59.118384Z","caller":"traceutil/trace.go:171","msg":"trace[648316607] transaction","detail":"{read_only:false; response_revision:610; number_of_response:1; }","duration":"592.273765ms","start":"2026-04-17T05:46:58.526099Z","end":"2026-04-17T05:46:59.118372Z","steps":["trace[648316607] 'process raft request' (duration: 517.953895ms)","trace[648316607] 'compare' (duration: 74.072811ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T05:46:59.118472Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T05:46:58.526079Z","time spent":"592.334376ms","remote":"127.0.0.1:60300","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":897,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-17T05:46:59.118436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"619.698416ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io\" ","response":"range_response_count:1 size:188495"} {"level":"warn","ts":"2026-04-17T05:46:59.118566Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.046377ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T05:46:59.118577Z","caller":"traceutil/trace.go:171","msg":"trace[1534023825] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io; range_end:; response_count:1; response_revision:609; }","duration":"619.890042ms","start":"2026-04-17T05:46:58.498669Z","end":"2026-04-17T05:46:59.118559Z","steps":["trace[1534023825] 'range keys from in-memory index tree' (duration: 619.390006ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T05:46:59.118623Z","caller":"traceutil/trace.go:171","msg":"trace[2038610608] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:610; }","duration":"167.136869ms","start":"2026-04-17T05:46:58.951467Z","end":"2026-04-17T05:46:59.118603Z","steps":["trace[2038610608] 'agreement among raft nodes before linearized reading' (duration: 167.012076ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T05:46:59.118624Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T05:46:58.498648Z","time spent":"619.964743ms","remote":"127.0.0.1:60056","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":1,"response size":188518,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io\" "} {"level":"warn","ts":"2026-04-17T05:46:59.118744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"433.264436ms","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-04-17T05:46:59.118815Z","caller":"traceutil/trace.go:171","msg":"trace[1544006637] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:610; }","duration":"433.37727ms","start":"2026-04-17T05:46:58.68542Z","end":"2026-04-17T05:46:59.118797Z","steps":["trace[1544006637] 'agreement among raft nodes before linearized reading' (duration: 433.082631ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T05:46:59.118856Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T05:46:58.685398Z","time spent":"433.450592ms","remote":"127.0.0.1:60242","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-17T05:47:02.37858Z","caller":"traceutil/trace.go:171","msg":"trace[1797276388] transaction","detail":"{read_only:false; response_revision:640; number_of_response:1; }","duration":"228.633764ms","start":"2026-04-17T05:47:02.149923Z","end":"2026-04-17T05:47:02.378557Z","steps":["trace[1797276388] 'process raft request' (duration: 228.457869ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T05:47:02.383899Z","caller":"traceutil/trace.go:171","msg":"trace[1252616989] linearizableReadLoop","detail":"{readStateIndex:663; appliedIndex:661; }","duration":"136.760207ms","start":"2026-04-17T05:47:02.247113Z","end":"2026-04-17T05:47:02.383873Z","steps":["trace[1252616989] 'read index received' (duration: 131.328835ms)","trace[1252616989] 'applied index is now lower than readState.Index' (duration: 5.430462ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T05:47:02.384123Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.995684ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-jnbcj\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-04-17T05:47:02.38417Z","caller":"traceutil/trace.go:171","msg":"trace[1849489347] range","detail":"{range_begin:/registry/pods/kube-system/cilium-jnbcj; range_end:; response_count:1; response_revision:641; }","duration":"137.083806ms","start":"2026-04-17T05:47:02.247075Z","end":"2026-04-17T05:47:02.384159Z","steps":["trace[1849489347] 'agreement among raft nodes before linearized reading' (duration: 136.899891ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T05:47:02.384485Z","caller":"traceutil/trace.go:171","msg":"trace[940551179] transaction","detail":"{read_only:false; response_revision:641; number_of_response:1; }","duration":"233.45809ms","start":"2026-04-17T05:47:02.151016Z","end":"2026-04-17T05:47:02.384474Z","steps":["trace[940551179] 'process raft request' (duration: 232.74492ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T05:47:02.641738Z","caller":"traceutil/trace.go:171","msg":"trace[1141814705] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"238.370317ms","start":"2026-04-17T05:47:02.403339Z","end":"2026-04-17T05:47:02.641709Z","steps":["trace[1141814705] 'process raft request' (duration: 210.529576ms)","trace[1141814705] 'compare' (duration: 27.44024ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T05:47:04.154309Z","caller":"traceutil/trace.go:171","msg":"trace[514314185] linearizableReadLoop","detail":"{readStateIndex:666; appliedIndex:665; }","duration":"426.647108ms","start":"2026-04-17T05:47:03.727586Z","end":"2026-04-17T05:47:04.154233Z","steps":["trace[514314185] 'read index received' (duration: 426.33971ms)","trace[514314185] 'applied index is now lower than readState.Index' (duration: 306.018µs)"],"step_count":2} {"level":"info","ts":"2026-04-17T05:47:04.154414Z","caller":"traceutil/trace.go:171","msg":"trace[965210603] transaction","detail":"{read_only:false; response_revision:643; number_of_response:1; }","duration":"965.084504ms","start":"2026-04-17T05:47:03.189281Z","end":"2026-04-17T05:47:04.154366Z","steps":["trace[965210603] 'process raft request' (duration: 964.744085ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T05:47:04.154629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"427.012758ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-04-17T05:47:04.154627Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T05:47:03.189253Z","time spent":"965.254459ms","remote":"127.0.0.1:60242","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T05:47:04.15467Z","caller":"traceutil/trace.go:171","msg":"trace[402634134] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:643; }","duration":"427.140452ms","start":"2026-04-17T05:47:03.727519Z","end":"2026-04-17T05:47:04.15466Z","steps":["trace[402634134] 'agreement among raft nodes before linearized reading' (duration: 426.934116ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T05:47:04.154725Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T05:47:03.727493Z","time spent":"427.218433ms","remote":"127.0.0.1:60242","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-17T05:47:04.154708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.884366ms","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-04-17T05:47:04.15478Z","caller":"traceutil/trace.go:171","msg":"trace[715318868] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:643; }","duration":"148.03222ms","start":"2026-04-17T05:47:04.006732Z","end":"2026-04-17T05:47:04.154765Z","steps":["trace[715318868] 'agreement among raft nodes before linearized reading' (duration: 147.818374ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T05:47:08.540745Z","caller":"traceutil/trace.go:171","msg":"trace[840048755] transaction","detail":"{read_only:false; response_revision:679; number_of_response:1; }","duration":"120.544207ms","start":"2026-04-17T05:47:08.420177Z","end":"2026-04-17T05:47:08.540721Z","steps":["trace[840048755] 'process raft request' (duration: 120.404433ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T05:47:23.696762Z","caller":"traceutil/trace.go:171","msg":"trace[2056563448] transaction","detail":"{read_only:false; response_revision:768; number_of_response:1; }","duration":"317.031612ms","start":"2026-04-17T05:47:23.379703Z","end":"2026-04-17T05:47:23.696735Z","steps":["trace[2056563448] 'process raft request' (duration: 316.761576ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T05:47:23.696924Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T05:47:23.379677Z","time spent":"317.165384ms","remote":"127.0.0.1:60228","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T05:49:05.360942Z","caller":"traceutil/trace.go:171","msg":"trace[1067548618] linearizableReadLoop","detail":"{readStateIndex:1283; appliedIndex:1282; }","duration":"220.262126ms","start":"2026-04-17T05:49:05.140663Z","end":"2026-04-17T05:49:05.360925Z","steps":["trace[1067548618] 'read index received' (duration: 219.598907ms)","trace[1067548618] 'applied index is now lower than readState.Index' (duration: 662.509µs)"],"step_count":2} {"level":"info","ts":"2026-04-17T05:49:05.360972Z","caller":"traceutil/trace.go:171","msg":"trace[941490980] transaction","detail":"{read_only:false; response_revision:1233; number_of_response:1; }","duration":"393.787921ms","start":"2026-04-17T05:49:04.967162Z","end":"2026-04-17T05:49:05.36095Z","steps":["trace[941490980] 'process raft request' (duration: 393.154383ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T05:49:05.361182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.516629ms","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-04-17T05:49:05.361255Z","caller":"traceutil/trace.go:171","msg":"trace[1433599488] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1233; }","duration":"190.631ms","start":"2026-04-17T05:49:05.170606Z","end":"2026-04-17T05:49:05.361237Z","steps":["trace[1433599488] 'agreement among raft nodes before linearized reading' (duration: 190.421028ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T05:49:05.361425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.747301ms","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-04-17T05:49:05.361499Z","caller":"traceutil/trace.go:171","msg":"trace[1033451087] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1233; }","duration":"220.858403ms","start":"2026-04-17T05:49:05.140622Z","end":"2026-04-17T05:49:05.361481Z","steps":["trace[1033451087] 'agreement among raft nodes before linearized reading' (duration: 220.390758ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T05:49:05.361199Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T05:49:04.967143Z","time spent":"393.888882ms","remote":"127.0.0.1:60242","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T05:49:12.663652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.22582ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-04-17T05:49:18.418575Z","caller":"traceutil/trace.go:171","msg":"trace[1947017809] transaction","detail":"{read_only:false; response_revision:1313; number_of_response:1; }","duration":"432.939199ms","start":"2026-04-17T05:49:17.985614Z","end":"2026-04-17T05:49:18.418554Z","steps":["trace[1947017809] 'process raft request' (duration: 432.789257ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T05:49:18.418723Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T05:49:17.985594Z","time spent":"433.041762ms","remote":"127.0.0.1:60242","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T05:49:19.140006Z","caller":"traceutil/trace.go:171","msg":"trace[1458312217] transaction","detail":"{read_only:false; response_revision:1314; number_of_response:1; }","duration":"143.235675ms","start":"2026-04-17T05:49:18.996745Z","end":"2026-04-17T05:49:19.13998Z","steps":["trace[1458312217] 'process raft request' (duration: 143.051313ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T05:49:19.320882Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.315616ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-17T05:49:19.321052Z","caller":"traceutil/trace.go:171","msg":"trace[2035312081] transaction","detail":"{read_only:false; response_revision:1315; number_of_response:1; }","duration":"176.843865ms","start":"2026-04-17T05:49:19.144189Z","end":"2026-04-17T05:49:19.321033Z","steps":["trace[2035312081] 'process raft request' (duration: 61.295366ms)","trace[2035312081] 'compare' (duration: 115.166134ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T05:49:19.799688Z","caller":"traceutil/trace.go:171","msg":"trace[1966522066] linearizableReadLoop","detail":"{readStateIndex:1371; appliedIndex:1369; }","duration":"150.146719ms","start":"2026-04-17T05:49:19.649523Z","end":"2026-04-17T05:49:19.799669Z","steps":["trace[1966522066] 'read index received' (duration: 24.595389ms)","trace[1966522066] 'applied index is now lower than readState.Index' (duration: 125.5504ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T05:49:19.799941Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.317101ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-17T05:49:19.800073Z","caller":"traceutil/trace.go:171","msg":"trace[1876035709] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1317; }","duration":"150.550395ms","start":"2026-04-17T05:49:19.649498Z","end":"2026-04-17T05:49:19.800048Z","steps":["trace[1876035709] 'agreement among raft nodes before linearized reading' (duration: 150.248371ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T05:49:19.799998Z","caller":"traceutil/trace.go:171","msg":"trace[1406217145] transaction","detail":"{read_only:false; response_revision:1317; number_of_response:1; }","duration":"181.851236ms","start":"2026-04-17T05:49:19.618128Z","end":"2026-04-17T05:49:19.799979Z","steps":["trace[1406217145] 'process raft request' (duration: 165.265784ms)","trace[1406217145] 'compare' (duration: 16.188626ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T05:49:20.17442Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.102831ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T05:49:20.174509Z","caller":"traceutil/trace.go:171","msg":"trace[1249615350] range","detail":"{range_begin:/registry/ingress/; range_end:/registry/ingress0; response_count:0; response_revision:1318; }","duration":"186.258434ms","start":"2026-04-17T05:49:19.988228Z","end":"2026-04-17T05:49:20.174487Z","steps":["trace[1249615350] 'count revisions from in-memory index tree' (duration: 186.030011ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T05:49:20.6777Z","caller":"traceutil/trace.go:171","msg":"trace[418037303] transaction","detail":"{read_only:false; response_revision:1319; number_of_response:1; }","duration":"253.254787ms","start":"2026-04-17T05:49:20.424423Z","end":"2026-04-17T05:49:20.677678Z","steps":["trace[418037303] 'process raft request' (duration: 253.056645ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T05:49:45.938116Z","caller":"traceutil/trace.go:171","msg":"trace[34446008] linearizableReadLoop","detail":"{readStateIndex:1467; appliedIndex:1466; }","duration":"114.91506ms","start":"2026-04-17T05:49:45.823181Z","end":"2026-04-17T05:49:45.938096Z","steps":["trace[34446008] 'read index received' (duration: 114.732308ms)","trace[34446008] 'applied index is now lower than readState.Index' (duration: 181.862µs)"],"step_count":2} {"level":"info","ts":"2026-04-17T05:49:45.93819Z","caller":"traceutil/trace.go:171","msg":"trace[1886483298] transaction","detail":"{read_only:false; response_revision:1407; number_of_response:1; }","duration":"146.518123ms","start":"2026-04-17T05:49:45.791637Z","end":"2026-04-17T05:49:45.938155Z","steps":["trace[1886483298] 'process raft request' (duration: 146.336471ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T05:49:45.938277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.077102ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/namespace-controller\" ","response":"range_response_count:1 size:205"} {"level":"info","ts":"2026-04-17T05:49:45.93832Z","caller":"traceutil/trace.go:171","msg":"trace[1231527356] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/namespace-controller; range_end:; response_count:1; response_revision:1407; }","duration":"115.136933ms","start":"2026-04-17T05:49:45.823173Z","end":"2026-04-17T05:49:45.93831Z","steps":["trace[1231527356] 'agreement among raft nodes before linearized reading' (duration: 115.044122ms)"],"step_count":1}