{"level":"warn","ts":"2026-04-20T14:15:17.016753Z","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-20T14:15:17.01685Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.38: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.38:2380","--initial-cluster=instance=https://199.204.45.38:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.38:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.38: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-20T14:15:17.016931Z","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-20T14:15:17.016946Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.38:2380"]} {"level":"info","ts":"2026-04-20T14:15:17.016973Z","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-20T14:15:17.017855Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.38:2379"]} {"level":"info","ts":"2026-04-20T14:15:17.017935Z","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.38:2380"],"listen-peer-urls":["https://199.204.45.38:2380"],"advertise-client-urls":["https://199.204.45.38:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.38:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.38: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-20T14:15:17.02366Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.332719ms"} {"level":"info","ts":"2026-04-20T14:15:17.031043Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"331455d6226d3423","cluster-id":"25c7803fb83a1455"} {"level":"info","ts":"2026-04-20T14:15:17.031294Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 switched to configuration voters=()"} {"level":"info","ts":"2026-04-20T14:15:17.031336Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 became follower at term 0"} {"level":"info","ts":"2026-04-20T14:15:17.031365Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 331455d6226d3423 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-20T14:15:17.031389Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 became follower at term 1"} {"level":"info","ts":"2026-04-20T14:15:17.031482Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 switched to configuration voters=(3680661173657482275)"} {"level":"warn","ts":"2026-04-20T14:15:17.0391Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-20T14:15:17.040586Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-20T14:15:17.041577Z","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-20T14:15:17.043732Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"331455d6226d3423","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-20T14:15:17.043858Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"331455d6226d3423","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-20T14:15:17.045839Z","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-20T14:15:17.046366Z","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-20T14:15:17.046407Z","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-20T14:15:17.046793Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 switched to configuration voters=(3680661173657482275)"} {"level":"info","ts":"2026-04-20T14:15:17.04713Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"25c7803fb83a1455","local-member-id":"331455d6226d3423","added-peer-id":"331455d6226d3423","added-peer-peer-urls":["https://199.204.45.38:2380"]} {"level":"info","ts":"2026-04-20T14:15:17.048583Z","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-20T14:15:17.048811Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.38:2380"} {"level":"info","ts":"2026-04-20T14:15:17.048852Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.38:2380"} {"level":"info","ts":"2026-04-20T14:15:17.049194Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"331455d6226d3423","initial-advertise-peer-urls":["https://199.204.45.38:2380"],"listen-peer-urls":["https://199.204.45.38:2380"],"advertise-client-urls":["https://199.204.45.38:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.38:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-20T14:15:17.04924Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-20T14:15:17.432403Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 is starting a new election at term 1"} {"level":"info","ts":"2026-04-20T14:15:17.432497Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-20T14:15:17.432544Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 received MsgPreVoteResp from 331455d6226d3423 at term 1"} {"level":"info","ts":"2026-04-20T14:15:17.432564Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 became candidate at term 2"} {"level":"info","ts":"2026-04-20T14:15:17.43258Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 received MsgVoteResp from 331455d6226d3423 at term 2"} {"level":"info","ts":"2026-04-20T14:15:17.432596Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 became leader at term 2"} {"level":"info","ts":"2026-04-20T14:15:17.432615Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 331455d6226d3423 elected leader 331455d6226d3423 at term 2"} {"level":"info","ts":"2026-04-20T14:15:17.434208Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"331455d6226d3423","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.38:2379]}","request-path":"/0/members/331455d6226d3423/attributes","cluster-id":"25c7803fb83a1455","publish-timeout":"7s"} {"level":"info","ts":"2026-04-20T14:15:17.434235Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-20T14:15:17.434291Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-20T14:15:17.434461Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T14:15:17.434662Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-20T14:15:17.434749Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-20T14:15:17.435519Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"25c7803fb83a1455","local-member-id":"331455d6226d3423","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T14:15:17.436198Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T14:15:17.436293Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T14:15:17.440517Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-20T14:15:17.442095Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.38:2379"} {"level":"info","ts":"2026-04-20T14:16:25.176757Z","caller":"traceutil/trace.go:171","msg":"trace[1560946737] linearizableReadLoop","detail":"{readStateIndex:581; appliedIndex:580; }","duration":"126.350095ms","start":"2026-04-20T14:16:25.050382Z","end":"2026-04-20T14:16:25.176732Z","steps":["trace[1560946737] 'read index received' (duration: 126.179968ms)","trace[1560946737] 'applied index is now lower than readState.Index' (duration: 169.146µs)"],"step_count":2} {"level":"warn","ts":"2026-04-20T14:16:25.177013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.562563ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-20T14:16:25.177313Z","caller":"traceutil/trace.go:171","msg":"trace[1542317353] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:551; }","duration":"126.96254ms","start":"2026-04-20T14:16:25.05034Z","end":"2026-04-20T14:16:25.177303Z","steps":["trace[1542317353] 'agreement among raft nodes before linearized reading' (duration: 126.502971ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:16:25.177584Z","caller":"traceutil/trace.go:171","msg":"trace[1850621447] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"134.562564ms","start":"2026-04-20T14:16:25.042992Z","end":"2026-04-20T14:16:25.177554Z","steps":["trace[1850621447] 'process raft request' (duration: 133.578734ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:16:25.185415Z","caller":"traceutil/trace.go:171","msg":"trace[1527596030] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"119.012081ms","start":"2026-04-20T14:16:25.066388Z","end":"2026-04-20T14:16:25.1854Z","steps":["trace[1527596030] 'process raft request' (duration: 118.697068ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:16:25.18561Z","caller":"traceutil/trace.go:171","msg":"trace[1902307122] transaction","detail":"{read_only:false; response_revision:553; number_of_response:1; }","duration":"118.477279ms","start":"2026-04-20T14:16:25.067123Z","end":"2026-04-20T14:16:25.1856Z","steps":["trace[1902307122] 'process raft request' (duration: 118.166836ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:16:25.185879Z","caller":"traceutil/trace.go:171","msg":"trace[665625640] transaction","detail":"{read_only:false; response_revision:554; number_of_response:1; }","duration":"118.633575ms","start":"2026-04-20T14:16:25.067237Z","end":"2026-04-20T14:16:25.18587Z","steps":["trace[665625640] 'process raft request' (duration: 118.129355ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:16:25.186082Z","caller":"traceutil/trace.go:171","msg":"trace[1489185444] transaction","detail":"{read_only:false; response_revision:555; number_of_response:1; }","duration":"118.543272ms","start":"2026-04-20T14:16:25.067529Z","end":"2026-04-20T14:16:25.186072Z","steps":["trace[1489185444] 'process raft request' (duration: 118.406446ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:16:25.186248Z","caller":"traceutil/trace.go:171","msg":"trace[1492078134] transaction","detail":"{read_only:false; response_revision:556; number_of_response:1; }","duration":"117.343681ms","start":"2026-04-20T14:16:25.068825Z","end":"2026-04-20T14:16:25.186168Z","steps":["trace[1492078134] 'process raft request' (duration: 117.210286ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:16:25.186448Z","caller":"traceutil/trace.go:171","msg":"trace[43806871] transaction","detail":"{read_only:false; response_revision:558; number_of_response:1; }","duration":"112.360238ms","start":"2026-04-20T14:16:25.07408Z","end":"2026-04-20T14:16:25.18644Z","steps":["trace[43806871] 'process raft request' (duration: 112.046654ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:16:25.186518Z","caller":"traceutil/trace.go:171","msg":"trace[162001123] transaction","detail":"{read_only:false; response_revision:559; number_of_response:1; }","duration":"103.029951ms","start":"2026-04-20T14:16:25.083472Z","end":"2026-04-20T14:16:25.186502Z","steps":["trace[162001123] 'process raft request' (duration: 102.697056ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:16:25.186643Z","caller":"traceutil/trace.go:171","msg":"trace[2034424990] transaction","detail":"{read_only:false; response_revision:560; number_of_response:1; }","duration":"103.056162ms","start":"2026-04-20T14:16:25.083578Z","end":"2026-04-20T14:16:25.186634Z","steps":["trace[2034424990] 'process raft request' (duration: 102.634004ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:16:25.186884Z","caller":"traceutil/trace.go:171","msg":"trace[486614511] transaction","detail":"{read_only:false; response_revision:557; number_of_response:1; }","duration":"114.531317ms","start":"2026-04-20T14:16:25.072152Z","end":"2026-04-20T14:16:25.186683Z","steps":["trace[486614511] 'process raft request' (duration: 113.9158ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:16:32.479097Z","caller":"traceutil/trace.go:171","msg":"trace[1722645386] transaction","detail":"{read_only:false; response_revision:656; number_of_response:1; }","duration":"485.859046ms","start":"2026-04-20T14:16:31.993214Z","end":"2026-04-20T14:16:32.479073Z","steps":["trace[1722645386] 'process raft request' (duration: 485.708331ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:16:32.47982Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:16:31.993183Z","time spent":"485.999302ms","remote":"127.0.0.1:52424","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1044,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-20T14:16:33.986954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.034144925s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-20T14:16:33.987079Z","caller":"traceutil/trace.go:171","msg":"trace[434668207] linearizableReadLoop","detail":"{readStateIndex:693; appliedIndex:692; }","duration":"1.118238034s","start":"2026-04-20T14:16:32.868821Z","end":"2026-04-20T14:16:33.987059Z","steps":["trace[434668207] 'read index received' (duration: 83.619771ms)","trace[434668207] 'applied index is now lower than readState.Index' (duration: 1.034616703s)"],"step_count":2} {"level":"info","ts":"2026-04-20T14:16:33.98716Z","caller":"traceutil/trace.go:171","msg":"trace[1246188829] transaction","detail":"{read_only:false; response_revision:657; number_of_response:1; }","duration":"1.494742751s","start":"2026-04-20T14:16:32.492357Z","end":"2026-04-20T14:16:33.9871Z","steps":["trace[1246188829] 'process raft request' (duration: 459.979903ms)","trace[1246188829] 'compare' (duration: 1.033899656s)"],"step_count":2} {"level":"warn","ts":"2026-04-20T14:16:33.987184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.118364719s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T14:16:33.987225Z","caller":"traceutil/trace.go:171","msg":"trace[358528076] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:657; }","duration":"1.118439831s","start":"2026-04-20T14:16:32.868772Z","end":"2026-04-20T14:16:33.987212Z","steps":["trace[358528076] 'agreement among raft nodes before linearized reading' (duration: 1.118370309s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:16:33.987263Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:16:32.868754Z","time spent":"1.118498754s","remote":"127.0.0.1:52088","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-04-20T14:16:33.987268Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:16:32.492336Z","time spent":"1.494880166s","remote":"127.0.0.1:52314","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T14:16:34.082464Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.129004961s","expected-duration":"1s"} {"level":"info","ts":"2026-04-20T14:16:34.085065Z","caller":"traceutil/trace.go:171","msg":"trace[284939871] transaction","detail":"{read_only:false; response_revision:658; number_of_response:1; }","duration":"1.180006755s","start":"2026-04-20T14:16:32.905015Z","end":"2026-04-20T14:16:34.085022Z","steps":["trace[284939871] 'process raft request' (duration: 1.178338572s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:16:34.085691Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:16:32.904981Z","time spent":"1.1801411s","remote":"127.0.0.1:52234","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036229,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T14:16:34.198352Z","caller":"traceutil/trace.go:171","msg":"trace[3865988] linearizableReadLoop","detail":"{readStateIndex:695; appliedIndex:693; }","duration":"211.177306ms","start":"2026-04-20T14:16:33.987115Z","end":"2026-04-20T14:16:34.198293Z","steps":["trace[3865988] 'read index received' (duration: 95.554742ms)","trace[3865988] 'applied index is now lower than readState.Index' (duration: 115.621554ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T14:16:34.198827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"544.456824ms","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-20T14:16:34.198946Z","caller":"traceutil/trace.go:171","msg":"trace[1126451209] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:659; }","duration":"544.60506ms","start":"2026-04-20T14:16:33.654292Z","end":"2026-04-20T14:16:34.198897Z","steps":["trace[1126451209] 'agreement among raft nodes before linearized reading' (duration: 544.251286ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:16:34.198976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"989.33312ms","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-04-20T14:16:34.199043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"682.298845ms","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-20T14:16:34.199106Z","caller":"traceutil/trace.go:171","msg":"trace[2015585406] transaction","detail":"{read_only:false; response_revision:659; number_of_response:1; }","duration":"1.0746528s","start":"2026-04-20T14:16:33.124439Z","end":"2026-04-20T14:16:34.199092Z","steps":["trace[2015585406] 'process raft request' (duration: 1.015086856s)","trace[2015585406] 'compare' (duration: 58.630778ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T14:16:34.199116Z","caller":"traceutil/trace.go:171","msg":"trace[1940811652] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:659; }","duration":"682.396148ms","start":"2026-04-20T14:16:33.516697Z","end":"2026-04-20T14:16:34.199094Z","steps":["trace[1940811652] 'agreement among raft nodes before linearized reading' (duration: 682.285024ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:16:34.199118Z","caller":"traceutil/trace.go:171","msg":"trace[240180400] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:659; }","duration":"989.565178ms","start":"2026-04-20T14:16:33.209509Z","end":"2026-04-20T14:16:34.199075Z","steps":["trace[240180400] 'agreement among raft nodes before linearized reading' (duration: 989.271957ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:16:34.199167Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:16:33.516673Z","time spent":"682.485851ms","remote":"127.0.0.1:52372","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":"warn","ts":"2026-04-20T14:16:34.199244Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:16:33.209485Z","time spent":"989.744895ms","remote":"127.0.0.1:52372","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":"warn","ts":"2026-04-20T14:16:34.199031Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:16:33.654271Z","time spent":"544.725214ms","remote":"127.0.0.1:52372","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-04-20T14:16:34.199252Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:16:33.124412Z","time spent":"1.074754374s","remote":"127.0.0.1:52372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T14:16:34.199344Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.776974ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-20T14:16:34.199459Z","caller":"traceutil/trace.go:171","msg":"trace[1655953168] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:659; }","duration":"315.912649ms","start":"2026-04-20T14:16:33.883535Z","end":"2026-04-20T14:16:34.199447Z","steps":["trace[1655953168] 'agreement among raft nodes before linearized reading' (duration: 315.742973ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:16:34.199495Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.55982ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-20T14:16:34.198916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"980.491287ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-20T14:16:34.19956Z","caller":"traceutil/trace.go:171","msg":"trace[46500837] range","detail":"{range_begin:/registry/csistoragecapacities/; range_end:/registry/csistoragecapacities0; response_count:0; response_revision:659; }","duration":"340.706134ms","start":"2026-04-20T14:16:33.858838Z","end":"2026-04-20T14:16:34.199545Z","steps":["trace[46500837] 'agreement among raft nodes before linearized reading' (duration: 340.527308ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:16:34.199526Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:16:33.88352Z","time spent":"315.993632ms","remote":"127.0.0.1:52508","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":13,"response size":29,"request content":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true "} {"level":"info","ts":"2026-04-20T14:16:34.199562Z","caller":"traceutil/trace.go:171","msg":"trace[1914641037] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:659; }","duration":"981.228634ms","start":"2026-04-20T14:16:33.218321Z","end":"2026-04-20T14:16:34.199549Z","steps":["trace[1914641037] 'agreement among raft nodes before linearized reading' (duration: 980.345701ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:16:34.199606Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:16:33.858794Z","time spent":"340.805318ms","remote":"127.0.0.1:52494","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":0,"response size":27,"request content":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true "} {"level":"warn","ts":"2026-04-20T14:16:34.199754Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:16:33.218299Z","time spent":"981.40798ms","remote":"127.0.0.1:52372","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-20T14:16:34.204898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.172205ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-20T14:16:34.204945Z","caller":"traceutil/trace.go:171","msg":"trace[1970117823] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:660; }","duration":"105.241848ms","start":"2026-04-20T14:16:34.099692Z","end":"2026-04-20T14:16:34.204934Z","steps":["trace[1970117823] 'agreement among raft nodes before linearized reading' (duration: 105.144794ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:16:34.205149Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.934656ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T14:16:34.205188Z","caller":"traceutil/trace.go:171","msg":"trace[1892896139] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:660; }","duration":"215.004879ms","start":"2026-04-20T14:16:33.990173Z","end":"2026-04-20T14:16:34.205177Z","steps":["trace[1892896139] 'agreement among raft nodes before linearized reading' (duration: 214.641295ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:16:35.523098Z","caller":"traceutil/trace.go:171","msg":"trace[1023566433] transaction","detail":"{read_only:false; response_revision:674; number_of_response:1; }","duration":"150.049136ms","start":"2026-04-20T14:16:35.373026Z","end":"2026-04-20T14:16:35.523075Z","steps":["trace[1023566433] 'process raft request' (duration: 140.606638ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:16:36.012217Z","caller":"traceutil/trace.go:171","msg":"trace[2027597410] transaction","detail":"{read_only:false; response_revision:688; number_of_response:1; }","duration":"247.402865ms","start":"2026-04-20T14:16:35.76478Z","end":"2026-04-20T14:16:36.012183Z","steps":["trace[2027597410] 'process raft request' (duration: 232.923914ms)","trace[2027597410] 'compare' (duration: 14.254553ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T14:16:36.012484Z","caller":"traceutil/trace.go:171","msg":"trace[1870782557] linearizableReadLoop","detail":"{readStateIndex:725; appliedIndex:724; }","duration":"205.766229ms","start":"2026-04-20T14:16:35.806655Z","end":"2026-04-20T14:16:36.012421Z","steps":["trace[1870782557] 'read index received' (duration: 190.917114ms)","trace[1870782557] 'applied index is now lower than readState.Index' (duration: 14.839494ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T14:16:36.012681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.006918ms","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-20T14:16:36.012722Z","caller":"traceutil/trace.go:171","msg":"trace[2000447274] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io; range_end:; response_count:0; response_revision:688; }","duration":"206.092491ms","start":"2026-04-20T14:16:35.806616Z","end":"2026-04-20T14:16:36.012708Z","steps":["trace[2000447274] 'agreement among raft nodes before linearized reading' (duration: 205.983307ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:16:36.015689Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.693366ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T14:16:36.015762Z","caller":"traceutil/trace.go:171","msg":"trace[228741798] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:689; }","duration":"147.81014ms","start":"2026-04-20T14:16:35.867937Z","end":"2026-04-20T14:16:36.015747Z","steps":["trace[228741798] 'agreement among raft nodes before linearized reading' (duration: 147.680275ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:16:49.069715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"361.917603ms","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-20T14:16:49.070179Z","caller":"traceutil/trace.go:171","msg":"trace[74047989] range","detail":"{range_begin:/registry/ingress/; range_end:/registry/ingress0; response_count:0; response_revision:823; }","duration":"362.492592ms","start":"2026-04-20T14:16:48.70766Z","end":"2026-04-20T14:16:49.070153Z","steps":["trace[74047989] 'count revisions from in-memory index tree' (duration: 361.78496ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:16:49.070333Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:16:48.707633Z","time spent":"362.678408ms","remote":"127.0.0.1:52396","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":0,"response size":27,"request content":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true "} {"level":"warn","ts":"2026-04-20T14:16:49.070204Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"382.734761ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-nvjpz\" ","response":"range_response_count:1 size:3964"} {"level":"info","ts":"2026-04-20T14:16:49.070614Z","caller":"traceutil/trace.go:171","msg":"trace[969197166] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-nvjpz; range_end:; response_count:1; response_revision:823; }","duration":"383.191125ms","start":"2026-04-20T14:16:48.687366Z","end":"2026-04-20T14:16:49.070558Z","steps":["trace[969197166] 'range keys from in-memory index tree' (duration: 382.490333ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:16:49.070678Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:16:48.687335Z","time spent":"383.32802ms","remote":"127.0.0.1:52314","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3986,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-nvjpz\" "} {"level":"warn","ts":"2026-04-20T14:16:49.069771Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.87726ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T14:16:49.070766Z","caller":"traceutil/trace.go:171","msg":"trace[1193704331] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:823; }","duration":"201.941504ms","start":"2026-04-20T14:16:48.868795Z","end":"2026-04-20T14:16:49.070737Z","steps":["trace[1193704331] 'range keys from in-memory index tree' (duration: 200.774467ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:18:30.771036Z","caller":"traceutil/trace.go:171","msg":"trace[371514229] transaction","detail":"{read_only:false; response_revision:1324; number_of_response:1; }","duration":"284.865432ms","start":"2026-04-20T14:18:30.486129Z","end":"2026-04-20T14:18:30.770994Z","steps":["trace[371514229] 'process raft request' (duration: 193.15908ms)","trace[371514229] 'compare' (duration: 91.266765ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T14:18:30.771432Z","caller":"traceutil/trace.go:171","msg":"trace[609528045] transaction","detail":"{read_only:false; response_revision:1325; number_of_response:1; }","duration":"235.341096ms","start":"2026-04-20T14:18:30.536061Z","end":"2026-04-20T14:18:30.771402Z","steps":["trace[609528045] 'process raft request' (duration: 234.856238ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:18:30.771392Z","caller":"traceutil/trace.go:171","msg":"trace[491165120] linearizableReadLoop","detail":"{readStateIndex:1389; appliedIndex:1387; }","duration":"192.178215ms","start":"2026-04-20T14:18:30.579193Z","end":"2026-04-20T14:18:30.771371Z","steps":["trace[491165120] 'read index received' (duration: 100.065207ms)","trace[491165120] 'applied index is now lower than readState.Index' (duration: 92.111088ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T14:18:30.771552Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.336997ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-20T14:18:30.771625Z","caller":"traceutil/trace.go:171","msg":"trace[269318490] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:1325; }","duration":"192.453569ms","start":"2026-04-20T14:18:30.579149Z","end":"2026-04-20T14:18:30.771603Z","steps":["trace[269318490] 'agreement among raft nodes before linearized reading' (duration: 192.298886ms)"],"step_count":1}