{"level":"warn","ts":"2026-04-20T09:41:05.659208Z","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-20T09:41:05.659288Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.23: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.23:2380","--initial-cluster=instance=https://199.204.45.23:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.23:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.23: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-20T09:41:05.659353Z","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-20T09:41:05.659366Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.23:2380"]} {"level":"info","ts":"2026-04-20T09:41:05.659384Z","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-20T09:41:05.660002Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.23:2379"]} {"level":"info","ts":"2026-04-20T09:41:05.660128Z","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.23:2380"],"listen-peer-urls":["https://199.204.45.23:2380"],"advertise-client-urls":["https://199.204.45.23:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.23:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.23: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-20T09:41:05.664962Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.566024ms"} {"level":"info","ts":"2026-04-20T09:41:05.670501Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"51a5c416a4d98c86","cluster-id":"ade2045974c19907"} {"level":"info","ts":"2026-04-20T09:41:05.670574Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 switched to configuration voters=()"} {"level":"info","ts":"2026-04-20T09:41:05.670597Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 became follower at term 0"} {"level":"info","ts":"2026-04-20T09:41:05.670607Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 51a5c416a4d98c86 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-20T09:41:05.670623Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 became follower at term 1"} {"level":"info","ts":"2026-04-20T09:41:05.670664Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 switched to configuration voters=(5883324089763466374)"} {"level":"warn","ts":"2026-04-20T09:41:05.680628Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-20T09:41:05.68176Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-20T09:41:05.682971Z","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-20T09:41:05.684987Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"51a5c416a4d98c86","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-20T09:41:05.68555Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"51a5c416a4d98c86","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-20T09:41:05.686044Z","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-20T09:41:05.688187Z","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-20T09:41:05.688215Z","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-20T09:41:05.687234Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 switched to configuration voters=(5883324089763466374)"} {"level":"info","ts":"2026-04-20T09:41:05.688397Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"ade2045974c19907","local-member-id":"51a5c416a4d98c86","added-peer-id":"51a5c416a4d98c86","added-peer-peer-urls":["https://199.204.45.23:2380"]} {"level":"info","ts":"2026-04-20T09:41:05.689881Z","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-20T09:41:05.690087Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"51a5c416a4d98c86","initial-advertise-peer-urls":["https://199.204.45.23:2380"],"listen-peer-urls":["https://199.204.45.23:2380"],"advertise-client-urls":["https://199.204.45.23:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.23:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-20T09:41:05.690141Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-20T09:41:05.690062Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.23:2380"} {"level":"info","ts":"2026-04-20T09:41:05.69027Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.23:2380"} {"level":"info","ts":"2026-04-20T09:41:05.771476Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 is starting a new election at term 1"} {"level":"info","ts":"2026-04-20T09:41:05.771538Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-20T09:41:05.771572Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 received MsgPreVoteResp from 51a5c416a4d98c86 at term 1"} {"level":"info","ts":"2026-04-20T09:41:05.771592Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 became candidate at term 2"} {"level":"info","ts":"2026-04-20T09:41:05.771603Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 received MsgVoteResp from 51a5c416a4d98c86 at term 2"} {"level":"info","ts":"2026-04-20T09:41:05.771631Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 became leader at term 2"} {"level":"info","ts":"2026-04-20T09:41:05.771652Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 51a5c416a4d98c86 elected leader 51a5c416a4d98c86 at term 2"} {"level":"info","ts":"2026-04-20T09:41:05.772517Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T09:41:05.772944Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"51a5c416a4d98c86","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.23:2379]}","request-path":"/0/members/51a5c416a4d98c86/attributes","cluster-id":"ade2045974c19907","publish-timeout":"7s"} {"level":"info","ts":"2026-04-20T09:41:05.773099Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-20T09:41:05.773098Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-20T09:41:05.773334Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"ade2045974c19907","local-member-id":"51a5c416a4d98c86","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T09:41:05.773535Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T09:41:05.773473Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-20T09:41:05.773579Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T09:41:05.773664Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-20T09:41:05.77635Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-20T09:41:05.786626Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.23:2379"} {"level":"info","ts":"2026-04-20T09:41:46.944916Z","caller":"traceutil/trace.go:171","msg":"trace[542464317] linearizableReadLoop","detail":"{readStateIndex:493; appliedIndex:492; }","duration":"127.495455ms","start":"2026-04-20T09:41:46.817394Z","end":"2026-04-20T09:41:46.944889Z","steps":["trace[542464317] 'read index received' (duration: 127.352561ms)","trace[542464317] 'applied index is now lower than readState.Index' (duration: 141.914µs)"],"step_count":2} {"level":"info","ts":"2026-04-20T09:41:46.945033Z","caller":"traceutil/trace.go:171","msg":"trace[1455993242] transaction","detail":"{read_only:false; response_revision:472; number_of_response:1; }","duration":"200.734913ms","start":"2026-04-20T09:41:46.744241Z","end":"2026-04-20T09:41:46.944976Z","steps":["trace[1455993242] 'process raft request' (duration: 200.454385ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T09:41:46.945215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.702621ms","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-04-20T09:41:46.945323Z","caller":"traceutil/trace.go:171","msg":"trace[1125181713] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:472; }","duration":"127.913006ms","start":"2026-04-20T09:41:46.817387Z","end":"2026-04-20T09:41:46.9453Z","steps":["trace[1125181713] 'agreement among raft nodes before linearized reading' (duration: 127.607568ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T09:41:49.312687Z","caller":"traceutil/trace.go:171","msg":"trace[405947551] linearizableReadLoop","detail":"{readStateIndex:498; appliedIndex:497; }","duration":"349.103329ms","start":"2026-04-20T09:41:48.963547Z","end":"2026-04-20T09:41:49.31265Z","steps":["trace[405947551] 'read index received' (duration: 348.918464ms)","trace[405947551] 'applied index is now lower than readState.Index' (duration: 183.845µs)"],"step_count":2} {"level":"info","ts":"2026-04-20T09:41:49.312834Z","caller":"traceutil/trace.go:171","msg":"trace[1515334639] transaction","detail":"{read_only:false; response_revision:477; number_of_response:1; }","duration":"359.557944ms","start":"2026-04-20T09:41:48.953241Z","end":"2026-04-20T09:41:49.312799Z","steps":["trace[1515334639] 'process raft request' (duration: 359.242315ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T09:41:49.312895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"349.304244ms","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-04-20T09:41:49.312934Z","caller":"traceutil/trace.go:171","msg":"trace[1702346117] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:477; }","duration":"349.419487ms","start":"2026-04-20T09:41:48.963501Z","end":"2026-04-20T09:41:49.312921Z","steps":["trace[1702346117] 'agreement among raft nodes before linearized reading' (duration: 349.316914ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T09:41:49.312979Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T09:41:48.963482Z","time spent":"349.485378ms","remote":"127.0.0.1:48258","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-20T09:41:49.313657Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T09:41:48.953225Z","time spent":"359.683638ms","remote":"127.0.0.1:48258","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T09:42:12.154238Z","caller":"traceutil/trace.go:171","msg":"trace[1018116522] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"193.74877ms","start":"2026-04-20T09:42:11.960466Z","end":"2026-04-20T09:42:12.154215Z","steps":["trace[1018116522] 'process raft request' (duration: 155.405579ms)","trace[1018116522] 'compare' (duration: 38.246238ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T09:42:12.161009Z","caller":"traceutil/trace.go:171","msg":"trace[2134142570] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"102.290063ms","start":"2026-04-20T09:42:12.058684Z","end":"2026-04-20T09:42:12.160974Z","steps":["trace[2134142570] 'process raft request' (duration: 102.243962ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T09:42:12.161352Z","caller":"traceutil/trace.go:171","msg":"trace[1907961234] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"194.311875ms","start":"2026-04-20T09:42:11.967021Z","end":"2026-04-20T09:42:12.161333Z","steps":["trace[1907961234] 'process raft request' (duration: 193.713379ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T09:42:12.161607Z","caller":"traceutil/trace.go:171","msg":"trace[1770673004] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"200.916385ms","start":"2026-04-20T09:42:11.960671Z","end":"2026-04-20T09:42:12.161588Z","steps":["trace[1770673004] 'process raft request' (duration: 199.97329ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T09:42:12.161625Z","caller":"traceutil/trace.go:171","msg":"trace[203476952] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"182.80189ms","start":"2026-04-20T09:42:11.978803Z","end":"2026-04-20T09:42:12.161605Z","steps":["trace[203476952] 'process raft request' (duration: 182.027689ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T09:42:12.367821Z","caller":"traceutil/trace.go:171","msg":"trace[870527812] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"196.288439ms","start":"2026-04-20T09:42:12.171504Z","end":"2026-04-20T09:42:12.367792Z","steps":["trace[870527812] 'process raft request' (duration: 192.881586ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T09:42:12.370416Z","caller":"traceutil/trace.go:171","msg":"trace[48944416] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"194.000507ms","start":"2026-04-20T09:42:12.176391Z","end":"2026-04-20T09:42:12.370391Z","steps":["trace[48944416] 'process raft request' (duration: 193.74482ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T09:42:12.370793Z","caller":"traceutil/trace.go:171","msg":"trace[2111133377] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"162.812862ms","start":"2026-04-20T09:42:12.207954Z","end":"2026-04-20T09:42:12.370767Z","steps":["trace[2111133377] 'process raft request' (duration: 162.344819ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T09:42:12.371057Z","caller":"traceutil/trace.go:171","msg":"trace[1893703407] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"151.680497ms","start":"2026-04-20T09:42:12.219351Z","end":"2026-04-20T09:42:12.371032Z","steps":["trace[1893703407] 'process raft request' (duration: 151.271356ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T09:42:17.536319Z","caller":"traceutil/trace.go:171","msg":"trace[1004529945] transaction","detail":"{read_only:false; response_revision:692; number_of_response:1; }","duration":"121.769048ms","start":"2026-04-20T09:42:17.414522Z","end":"2026-04-20T09:42:17.536291Z","steps":["trace[1004529945] 'process raft request' (duration: 121.089809ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T09:42:18.464297Z","caller":"traceutil/trace.go:171","msg":"trace[311841697] linearizableReadLoop","detail":"{readStateIndex:733; appliedIndex:732; }","duration":"142.093133ms","start":"2026-04-20T09:42:18.322187Z","end":"2026-04-20T09:42:18.46428Z","steps":["trace[311841697] 'read index received' (duration: 141.920348ms)","trace[311841697] 'applied index is now lower than readState.Index' (duration: 172.245µs)"],"step_count":2} {"level":"warn","ts":"2026-04-20T09:42:18.464459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.258347ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-20T09:42:18.464498Z","caller":"traceutil/trace.go:171","msg":"trace[778431584] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:703; }","duration":"142.34913ms","start":"2026-04-20T09:42:18.32214Z","end":"2026-04-20T09:42:18.464489Z","steps":["trace[778431584] 'agreement among raft nodes before linearized reading' (duration: 142.210856ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T09:42:18.464746Z","caller":"traceutil/trace.go:171","msg":"trace[93729064] transaction","detail":"{read_only:false; response_revision:703; number_of_response:1; }","duration":"158.147739ms","start":"2026-04-20T09:42:18.306592Z","end":"2026-04-20T09:42:18.46474Z","steps":["trace[93729064] 'process raft request' (duration: 157.562612ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T09:42:18.826846Z","caller":"traceutil/trace.go:171","msg":"trace[1417590429] linearizableReadLoop","detail":"{readStateIndex:734; appliedIndex:733; }","duration":"163.237125ms","start":"2026-04-20T09:42:18.663582Z","end":"2026-04-20T09:42:18.826819Z","steps":["trace[1417590429] 'read index received' (duration: 162.435421ms)","trace[1417590429] 'applied index is now lower than readState.Index' (duration: 800.424µs)"],"step_count":2} {"level":"warn","ts":"2026-04-20T09:42:18.826968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.364968ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T09:42:18.827Z","caller":"traceutil/trace.go:171","msg":"trace[336070864] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:704; }","duration":"163.412509ms","start":"2026-04-20T09:42:18.663575Z","end":"2026-04-20T09:42:18.826987Z","steps":["trace[336070864] 'agreement among raft nodes before linearized reading' (duration: 163.341827ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T09:42:18.827168Z","caller":"traceutil/trace.go:171","msg":"trace[1954619299] transaction","detail":"{read_only:false; response_revision:704; number_of_response:1; }","duration":"354.642749ms","start":"2026-04-20T09:42:18.47224Z","end":"2026-04-20T09:42:18.826883Z","steps":["trace[1954619299] 'process raft request' (duration: 353.9735ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T09:42:18.82752Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T09:42:18.472221Z","time spent":"355.182824ms","remote":"127.0.0.1:48096","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036313,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T09:42:18.989695Z","caller":"traceutil/trace.go:171","msg":"trace[1309124491] transaction","detail":"{read_only:false; response_revision:705; number_of_response:1; }","duration":"103.415102ms","start":"2026-04-20T09:42:18.886257Z","end":"2026-04-20T09:42:18.989672Z","steps":["trace[1309124491] 'process raft request' (duration: 78.36343ms)","trace[1309124491] 'compare' (duration: 24.933119ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T09:43:44.349188Z","caller":"traceutil/trace.go:171","msg":"trace[1874305284] linearizableReadLoop","detail":"{readStateIndex:1298; appliedIndex:1297; }","duration":"265.404772ms","start":"2026-04-20T09:43:44.083752Z","end":"2026-04-20T09:43:44.349157Z","steps":["trace[1874305284] 'read index received' (duration: 265.192956ms)","trace[1874305284] 'applied index is now lower than readState.Index' (duration: 210.706µs)"],"step_count":2} {"level":"info","ts":"2026-04-20T09:43:44.349325Z","caller":"traceutil/trace.go:171","msg":"trace[68476301] transaction","detail":"{read_only:false; response_revision:1248; number_of_response:1; }","duration":"267.866039ms","start":"2026-04-20T09:43:44.081448Z","end":"2026-04-20T09:43:44.349314Z","steps":["trace[68476301] 'process raft request' (duration: 267.51272ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T09:43:44.34949Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.940134ms","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-20T09:43:44.349574Z","caller":"traceutil/trace.go:171","msg":"trace[145204133] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1248; }","duration":"262.046117ms","start":"2026-04-20T09:43:44.087509Z","end":"2026-04-20T09:43:44.349555Z","steps":["trace[145204133] 'agreement among raft nodes before linearized reading' (duration: 261.849391ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T09:43:44.34964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.883515ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-20T09:43:44.349699Z","caller":"traceutil/trace.go:171","msg":"trace[1666115514] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1248; }","duration":"265.971227ms","start":"2026-04-20T09:43:44.083713Z","end":"2026-04-20T09:43:44.349684Z","steps":["trace[1666115514] 'agreement among raft nodes before linearized reading' (duration: 265.821543ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T09:43:44.3497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.915656ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T09:43:44.349742Z","caller":"traceutil/trace.go:171","msg":"trace[848691877] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:1248; }","duration":"142.981948ms","start":"2026-04-20T09:43:44.206748Z","end":"2026-04-20T09:43:44.34973Z","steps":["trace[848691877] 'agreement among raft nodes before linearized reading' (duration: 142.893935ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T09:43:44.519299Z","caller":"traceutil/trace.go:171","msg":"trace[353810389] transaction","detail":"{read_only:false; response_revision:1249; number_of_response:1; }","duration":"167.078453ms","start":"2026-04-20T09:43:44.35219Z","end":"2026-04-20T09:43:44.519268Z","steps":["trace[353810389] 'process raft request' (duration: 166.903448ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T09:43:44.519752Z","caller":"traceutil/trace.go:171","msg":"trace[128004830] transaction","detail":"{read_only:false; response_revision:1250; number_of_response:1; }","duration":"166.431504ms","start":"2026-04-20T09:43:44.353303Z","end":"2026-04-20T09:43:44.519735Z","steps":["trace[128004830] 'process raft request' (duration: 166.340141ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T09:44:00.685149Z","caller":"traceutil/trace.go:171","msg":"trace[1976297224] linearizableReadLoop","detail":"{readStateIndex:1375; appliedIndex:1374; }","duration":"134.856512ms","start":"2026-04-20T09:44:00.550246Z","end":"2026-04-20T09:44:00.685102Z","steps":["trace[1976297224] 'read index received' (duration: 134.520982ms)","trace[1976297224] 'applied index is now lower than readState.Index' (duration: 334.2µs)"],"step_count":2} {"level":"info","ts":"2026-04-20T09:44:00.685336Z","caller":"traceutil/trace.go:171","msg":"trace[1371100746] transaction","detail":"{read_only:false; response_revision:1321; number_of_response:1; }","duration":"270.937457ms","start":"2026-04-20T09:44:00.414368Z","end":"2026-04-20T09:44:00.685306Z","steps":["trace[1371100746] 'process raft request' (duration: 270.533954ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T09:44:00.685572Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.309464ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T09:44:00.685659Z","caller":"traceutil/trace.go:171","msg":"trace[243237067] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:1321; }","duration":"135.455369ms","start":"2026-04-20T09:44:00.550182Z","end":"2026-04-20T09:44:00.685638Z","steps":["trace[243237067] 'agreement among raft nodes before linearized reading' (duration: 135.336995ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T09:44:01.337305Z","caller":"traceutil/trace.go:171","msg":"trace[510139810] transaction","detail":"{read_only:false; response_revision:1333; number_of_response:1; }","duration":"143.152633ms","start":"2026-04-20T09:44:01.19413Z","end":"2026-04-20T09:44:01.337283Z","steps":["trace[510139810] 'process raft request' (duration: 122.984249ms)","trace[510139810] 'compare' (duration: 20.063431ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T09:45:05.423755Z","caller":"traceutil/trace.go:171","msg":"trace[443123766] linearizableReadLoop","detail":"{readStateIndex:1716; appliedIndex:1715; }","duration":"176.653268ms","start":"2026-04-20T09:45:05.24707Z","end":"2026-04-20T09:45:05.423723Z","steps":["trace[443123766] 'read index received' (duration: 175.410774ms)","trace[443123766] 'applied index is now lower than readState.Index' (duration: 1.241084ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T09:45:05.424163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.067279ms","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-20T09:45:05.424211Z","caller":"traceutil/trace.go:171","msg":"trace[1397808026] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1650; }","duration":"177.194353ms","start":"2026-04-20T09:45:05.247002Z","end":"2026-04-20T09:45:05.424197Z","steps":["trace[1397808026] 'agreement among raft nodes before linearized reading' (duration: 176.806082ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T09:45:05.42427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.490697ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-04-20T09:45:05.424325Z","caller":"traceutil/trace.go:171","msg":"trace[1554228574] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1651; }","duration":"174.58986ms","start":"2026-04-20T09:45:05.249723Z","end":"2026-04-20T09:45:05.424313Z","steps":["trace[1554228574] 'agreement among raft nodes before linearized reading' (duration: 174.412915ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T09:45:05.424399Z","caller":"traceutil/trace.go:171","msg":"trace[279132940] transaction","detail":"{read_only:false; response_revision:1650; number_of_response:1; }","duration":"111.982622ms","start":"2026-04-20T09:45:05.312381Z","end":"2026-04-20T09:45:05.424364Z","steps":["trace[279132940] 'process raft request' (duration: 111.300133ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T09:45:05.423743Z","caller":"traceutil/trace.go:171","msg":"trace[1100677122] transaction","detail":"{read_only:false; response_revision:1649; number_of_response:1; }","duration":"371.907223ms","start":"2026-04-20T09:45:05.051785Z","end":"2026-04-20T09:45:05.423692Z","steps":["trace[1100677122] 'process raft request' (duration: 370.730151ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T09:45:05.424567Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T09:45:05.051771Z","time spent":"372.715455ms","remote":"127.0.0.1:48258","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T09:45:05.424567Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.152494ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:532"} {"level":"info","ts":"2026-04-20T09:45:05.424654Z","caller":"traceutil/trace.go:171","msg":"trace[456809618] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1651; }","duration":"104.280257ms","start":"2026-04-20T09:45:05.320349Z","end":"2026-04-20T09:45:05.424629Z","steps":["trace[456809618] 'agreement among raft nodes before linearized reading' (duration: 104.02044ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T09:45:05.424642Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.655676ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-20T09:45:05.424751Z","caller":"traceutil/trace.go:171","msg":"trace[924584887] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1651; }","duration":"172.830841ms","start":"2026-04-20T09:45:05.251895Z","end":"2026-04-20T09:45:05.424726Z","steps":["trace[924584887] 'agreement among raft nodes before linearized reading' (duration: 172.512592ms)"],"step_count":1}