{"level":"warn","ts":"2026-04-26T02:36:50.735958Z","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-26T02:36:50.736064Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.4: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.4:2380","--initial-cluster=instance=https://199.204.45.4:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.4:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.4: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-26T02:36:50.736162Z","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-26T02:36:50.736185Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.4:2380"]} {"level":"info","ts":"2026-04-26T02:36:50.736207Z","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-26T02:36:50.737125Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.4:2379"]} {"level":"info","ts":"2026-04-26T02:36:50.737235Z","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.4:2380"],"listen-peer-urls":["https://199.204.45.4:2380"],"advertise-client-urls":["https://199.204.45.4:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.4:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.4: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-26T02:36:50.797906Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"60.338385ms"} {"level":"warn","ts":"2026-04-26T02:36:52.090721Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.28933181s","expected-duration":"1s"} {"level":"info","ts":"2026-04-26T02:36:52.34873Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"66f7b57d56ad567d","cluster-id":"ec267dcaac715770"} {"level":"info","ts":"2026-04-26T02:36:52.348851Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d switched to configuration voters=()"} {"level":"info","ts":"2026-04-26T02:36:52.348877Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d became follower at term 0"} {"level":"info","ts":"2026-04-26T02:36:52.348891Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 66f7b57d56ad567d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-26T02:36:52.348903Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d became follower at term 1"} {"level":"info","ts":"2026-04-26T02:36:52.348955Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d switched to configuration voters=(7419598461045921405)"} {"level":"warn","ts":"2026-04-26T02:36:52.351011Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-26T02:36:52.355129Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-26T02:36:52.358075Z","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-26T02:36:52.360566Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"66f7b57d56ad567d","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-26T02:36:52.360666Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"66f7b57d56ad567d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-26T02:36:52.361553Z","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-26T02:36:52.361752Z","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-26T02:36:52.361876Z","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-26T02:36:52.362716Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d switched to configuration voters=(7419598461045921405)"} {"level":"info","ts":"2026-04-26T02:36:52.362932Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"ec267dcaac715770","local-member-id":"66f7b57d56ad567d","added-peer-id":"66f7b57d56ad567d","added-peer-peer-urls":["https://199.204.45.4:2380"]} {"level":"info","ts":"2026-04-26T02:36:52.364671Z","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-26T02:36:52.364734Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.4:2380"} {"level":"info","ts":"2026-04-26T02:36:52.364795Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.4:2380"} {"level":"info","ts":"2026-04-26T02:36:52.364913Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"66f7b57d56ad567d","initial-advertise-peer-urls":["https://199.204.45.4:2380"],"listen-peer-urls":["https://199.204.45.4:2380"],"advertise-client-urls":["https://199.204.45.4:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.4:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-26T02:36:52.36494Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-26T02:36:52.649683Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d is starting a new election at term 1"} {"level":"info","ts":"2026-04-26T02:36:52.649753Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d became pre-candidate at term 1"} {"level":"info","ts":"2026-04-26T02:36:52.649821Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d received MsgPreVoteResp from 66f7b57d56ad567d at term 1"} {"level":"info","ts":"2026-04-26T02:36:52.649873Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d became candidate at term 2"} {"level":"info","ts":"2026-04-26T02:36:52.649895Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d received MsgVoteResp from 66f7b57d56ad567d at term 2"} {"level":"info","ts":"2026-04-26T02:36:52.649932Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d became leader at term 2"} {"level":"info","ts":"2026-04-26T02:36:52.649956Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 66f7b57d56ad567d elected leader 66f7b57d56ad567d at term 2"} {"level":"info","ts":"2026-04-26T02:36:52.650789Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-26T02:36:52.650779Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-26T02:36:52.650802Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"66f7b57d56ad567d","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.4:2379]}","request-path":"/0/members/66f7b57d56ad567d/attributes","cluster-id":"ec267dcaac715770","publish-timeout":"7s"} {"level":"info","ts":"2026-04-26T02:36:52.65084Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-26T02:36:52.651104Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-26T02:36:52.651148Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-26T02:36:52.651657Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"ec267dcaac715770","local-member-id":"66f7b57d56ad567d","cluster-version":"3.5"} {"level":"info","ts":"2026-04-26T02:36:52.651803Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-26T02:36:52.652184Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-26T02:36:52.655032Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-26T02:36:52.655823Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.4:2379"} {"level":"info","ts":"2026-04-26T02:37:17.992441Z","caller":"traceutil/trace.go:171","msg":"trace[1823373299] transaction","detail":"{read_only:false; response_revision:563; number_of_response:1; }","duration":"156.679477ms","start":"2026-04-26T02:37:17.835736Z","end":"2026-04-26T02:37:17.992415Z","steps":["trace[1823373299] 'process raft request' (duration: 151.244152ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T02:37:21.208754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.808827ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-04-26T02:37:21.224365Z","caller":"traceutil/trace.go:171","msg":"trace[180702219] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"219.983044ms","start":"2026-04-26T02:37:21.004333Z","end":"2026-04-26T02:37:21.224316Z","steps":["trace[180702219] 'process raft request' (duration: 216.911743ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T02:37:23.318518Z","caller":"traceutil/trace.go:171","msg":"trace[1486035492] linearizableReadLoop","detail":"{readStateIndex:624; appliedIndex:623; }","duration":"190.526783ms","start":"2026-04-26T02:37:23.127965Z","end":"2026-04-26T02:37:23.318492Z","steps":["trace[1486035492] 'read index received' (duration: 189.701069ms)","trace[1486035492] 'applied index is now lower than readState.Index' (duration: 824.544µs)"],"step_count":2} {"level":"info","ts":"2026-04-26T02:37:23.31866Z","caller":"traceutil/trace.go:171","msg":"trace[1865930264] transaction","detail":"{read_only:false; response_revision:604; number_of_response:1; }","duration":"221.012121ms","start":"2026-04-26T02:37:23.097622Z","end":"2026-04-26T02:37:23.318634Z","steps":["trace[1865930264] 'process raft request' (duration: 220.362139ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T02:37:23.318705Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.414303ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-26T02:37:23.318742Z","caller":"traceutil/trace.go:171","msg":"trace[1168233395] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:604; }","duration":"145.503135ms","start":"2026-04-26T02:37:23.173228Z","end":"2026-04-26T02:37:23.318731Z","steps":["trace[1168233395] 'agreement among raft nodes before linearized reading' (duration: 145.421054ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T02:37:23.318877Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.889049ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-vzz54\" ","response":"range_response_count:1 size:16957"} {"level":"info","ts":"2026-04-26T02:37:23.319008Z","caller":"traceutil/trace.go:171","msg":"trace[228357910] range","detail":"{range_begin:/registry/pods/kube-system/cilium-vzz54; range_end:; response_count:1; response_revision:604; }","duration":"191.043142ms","start":"2026-04-26T02:37:23.127917Z","end":"2026-04-26T02:37:23.31896Z","steps":["trace[228357910] 'agreement among raft nodes before linearized reading' (duration: 190.744937ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T02:37:23.472822Z","caller":"traceutil/trace.go:171","msg":"trace[505948191] transaction","detail":"{read_only:false; response_revision:605; number_of_response:1; }","duration":"133.114152ms","start":"2026-04-26T02:37:23.339683Z","end":"2026-04-26T02:37:23.472798Z","steps":["trace[505948191] 'process raft request' (duration: 132.955409ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T02:37:23.860894Z","caller":"traceutil/trace.go:171","msg":"trace[1289730186] transaction","detail":"{read_only:false; response_revision:606; number_of_response:1; }","duration":"490.900966ms","start":"2026-04-26T02:37:23.369961Z","end":"2026-04-26T02:37:23.860862Z","steps":["trace[1289730186] 'process raft request' (duration: 462.354532ms)","trace[1289730186] 'compare' (duration: 28.259679ms)"],"step_count":2} {"level":"warn","ts":"2026-04-26T02:37:23.861759Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T02:37:23.36993Z","time spent":"491.405065ms","remote":"127.0.0.1:47140","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-26T02:37:24.886668Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6232310940153086445,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-26T02:37:25.332769Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.079619731s","expected-duration":"1s"} {"level":"warn","ts":"2026-04-26T02:37:25.337922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.087058844s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-04-26T02:37:25.337996Z","caller":"traceutil/trace.go:171","msg":"trace[140454316] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:606; }","duration":"1.087175666s","start":"2026-04-26T02:37:24.250802Z","end":"2026-04-26T02:37:25.337977Z","steps":["trace[140454316] 'range keys from in-memory index tree' (duration: 1.086898851s)"],"step_count":1} {"level":"warn","ts":"2026-04-26T02:37:25.337956Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.144398ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-26T02:37:25.338035Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T02:37:24.250781Z","time spent":"1.087246017s","remote":"127.0.0.1:46874","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-26T02:37:25.338049Z","caller":"traceutil/trace.go:171","msg":"trace[982418220] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:606; }","duration":"203.238819ms","start":"2026-04-26T02:37:25.13479Z","end":"2026-04-26T02:37:25.338029Z","steps":["trace[982418220] 'range keys from in-memory index tree' (duration: 203.133377ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T02:37:25.338261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.230268037s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"} {"level":"info","ts":"2026-04-26T02:37:25.338327Z","caller":"traceutil/trace.go:171","msg":"trace[638794792] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:606; }","duration":"1.230388309s","start":"2026-04-26T02:37:24.107918Z","end":"2026-04-26T02:37:25.338306Z","steps":["trace[638794792] 'range keys from in-memory index tree' (duration: 1.230150665s)"],"step_count":1} {"level":"warn","ts":"2026-04-26T02:37:25.338373Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T02:37:24.107895Z","time spent":"1.23046728s","remote":"127.0.0.1:46874","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-26T02:37:25.338405Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.164553914s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-26T02:37:25.338447Z","caller":"traceutil/trace.go:171","msg":"trace[948333425] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:606; }","duration":"1.164625635s","start":"2026-04-26T02:37:24.173811Z","end":"2026-04-26T02:37:25.338437Z","steps":["trace[948333425] 'range keys from in-memory index tree' (duration: 1.164487923s)"],"step_count":1} {"level":"warn","ts":"2026-04-26T02:37:25.338481Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T02:37:24.173792Z","time spent":"1.164682686s","remote":"127.0.0.1:46598","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-26T02:37:25.338426Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.229656656s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-04-26T02:37:25.338583Z","caller":"traceutil/trace.go:171","msg":"trace[465138266] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:606; }","duration":"1.22984086s","start":"2026-04-26T02:37:24.108723Z","end":"2026-04-26T02:37:25.338564Z","steps":["trace[465138266] 'range keys from in-memory index tree' (duration: 1.229521054s)"],"step_count":1} {"level":"warn","ts":"2026-04-26T02:37:25.33863Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T02:37:24.108713Z","time spent":"1.229906331s","remote":"127.0.0.1:46874","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-26T02:37:25.338797Z","caller":"traceutil/trace.go:171","msg":"trace[1138695124] transaction","detail":"{read_only:false; response_revision:607; number_of_response:1; }","duration":"1.08738428s","start":"2026-04-26T02:37:24.251397Z","end":"2026-04-26T02:37:25.338782Z","steps":["trace[1138695124] 'process raft request' (duration: 1.081896462s)"],"step_count":1} {"level":"warn","ts":"2026-04-26T02:37:25.339138Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T02:37:24.251381Z","time spent":"1.087460711s","remote":"127.0.0.1:46682","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036309,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-26T02:37:25.339222Z","caller":"traceutil/trace.go:171","msg":"trace[1947068829] linearizableReadLoop","detail":"{readStateIndex:628; appliedIndex:626; }","duration":"952.339019ms","start":"2026-04-26T02:37:24.386599Z","end":"2026-04-26T02:37:25.338938Z","steps":["trace[1947068829] 'read index received' (duration: 946.478265ms)","trace[1947068829] 'applied index is now lower than readState.Index' (duration: 5.859714ms)"],"step_count":2} {"level":"info","ts":"2026-04-26T02:37:25.339333Z","caller":"traceutil/trace.go:171","msg":"trace[473972987] transaction","detail":"{read_only:false; response_revision:608; number_of_response:1; }","duration":"534.357835ms","start":"2026-04-26T02:37:24.804957Z","end":"2026-04-26T02:37:25.339315Z","steps":["trace[473972987] 'process raft request' (duration: 533.643342ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T02:37:25.339449Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T02:37:24.804935Z","time spent":"534.442216ms","remote":"127.0.0.1:46874","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-26T02:37:25.340722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"954.122912ms","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-26T02:37:25.340813Z","caller":"traceutil/trace.go:171","msg":"trace[1754654357] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:608; }","duration":"954.248123ms","start":"2026-04-26T02:37:24.386548Z","end":"2026-04-26T02:37:25.340797Z","steps":["trace[1754654357] 'agreement among raft nodes before linearized reading' (duration: 952.738727ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T02:37:25.340878Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T02:37:24.386529Z","time spent":"954.339316ms","remote":"127.0.0.1:46874","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-26T02:37:30.431841Z","caller":"traceutil/trace.go:171","msg":"trace[2003154072] transaction","detail":"{read_only:false; response_revision:691; number_of_response:1; }","duration":"105.152073ms","start":"2026-04-26T02:37:30.326644Z","end":"2026-04-26T02:37:30.431796Z","steps":["trace[2003154072] 'process raft request' (duration: 104.864597ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T02:37:46.003719Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6232310940153086872,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-26T02:37:46.422747Z","caller":"traceutil/trace.go:171","msg":"trace[1419094293] transaction","detail":"{read_only:false; response_revision:784; number_of_response:1; }","duration":"920.740351ms","start":"2026-04-26T02:37:45.501979Z","end":"2026-04-26T02:37:46.422719Z","steps":["trace[1419094293] 'process raft request' (duration: 920.507416ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T02:37:46.422921Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T02:37:45.501958Z","time spent":"920.876024ms","remote":"127.0.0.1:46874","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-26T02:37:46.597168Z","caller":"traceutil/trace.go:171","msg":"trace[1615773581] linearizableReadLoop","detail":"{readStateIndex:810; appliedIndex:808; }","duration":"1.094456802s","start":"2026-04-26T02:37:45.502679Z","end":"2026-04-26T02:37:46.597136Z","steps":["trace[1615773581] 'read index received' (duration: 919.874901ms)","trace[1615773581] 'applied index is now lower than readState.Index' (duration: 174.580751ms)"],"step_count":2} {"level":"info","ts":"2026-04-26T02:37:46.597261Z","caller":"traceutil/trace.go:171","msg":"trace[1556193223] transaction","detail":"{read_only:false; response_revision:786; number_of_response:1; }","duration":"349.938429ms","start":"2026-04-26T02:37:46.247284Z","end":"2026-04-26T02:37:46.597222Z","steps":["trace[1556193223] 'process raft request' (duration: 349.796936ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T02:37:46.597593Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T02:37:46.247261Z","time spent":"350.195274ms","remote":"127.0.0.1:46832","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-26T02:37:46.597749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.090994855s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-04-26T02:37:46.597814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.095120877s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-04-26T02:37:46.597886Z","caller":"traceutil/trace.go:171","msg":"trace[457011488] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:786; }","duration":"1.091113899s","start":"2026-04-26T02:37:45.506719Z","end":"2026-04-26T02:37:46.597832Z","steps":["trace[457011488] 'agreement among raft nodes before linearized reading' (duration: 1.090800672s)"],"step_count":1} {"level":"info","ts":"2026-04-26T02:37:46.597286Z","caller":"traceutil/trace.go:171","msg":"trace[1539357995] transaction","detail":"{read_only:false; response_revision:785; number_of_response:1; }","duration":"664.88375ms","start":"2026-04-26T02:37:45.932373Z","end":"2026-04-26T02:37:46.597256Z","steps":["trace[1539357995] 'process raft request' (duration: 664.532872ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T02:37:46.59798Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T02:37:45.506709Z","time spent":"1.091221321s","remote":"127.0.0.1:46874","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-26T02:37:46.598008Z","caller":"traceutil/trace.go:171","msg":"trace[1343138105] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:786; }","duration":"1.095229569s","start":"2026-04-26T02:37:45.502632Z","end":"2026-04-26T02:37:46.597861Z","steps":["trace[1343138105] 'agreement among raft nodes before linearized reading' (duration: 1.094673377s)"],"step_count":1} {"level":"warn","ts":"2026-04-26T02:37:46.598253Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T02:37:45.502612Z","time spent":"1.095621549s","remote":"127.0.0.1:46874","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-26T02:37:46.598315Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.091409795s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-04-26T02:37:46.598329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"424.278774ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-26T02:37:46.598345Z","caller":"traceutil/trace.go:171","msg":"trace[134637906] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:786; }","duration":"1.091459896s","start":"2026-04-26T02:37:45.506874Z","end":"2026-04-26T02:37:46.598334Z","steps":["trace[134637906] 'agreement among raft nodes before linearized reading' (duration: 1.091288722s)"],"step_count":1} {"level":"warn","ts":"2026-04-26T02:37:46.598372Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T02:37:45.506867Z","time spent":"1.091500687s","remote":"127.0.0.1:46874","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-26T02:37:46.598385Z","caller":"traceutil/trace.go:171","msg":"trace[1356221319] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:786; }","duration":"424.351556ms","start":"2026-04-26T02:37:46.174014Z","end":"2026-04-26T02:37:46.598366Z","steps":["trace[1356221319] 'agreement among raft nodes before linearized reading' (duration: 424.281584ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T02:37:46.598431Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T02:37:46.173997Z","time spent":"424.422537ms","remote":"127.0.0.1:46598","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-26T02:37:46.598254Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.067946033s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.4\" ","response":"range_response_count:1 size:131"} {"level":"info","ts":"2026-04-26T02:37:46.598483Z","caller":"traceutil/trace.go:171","msg":"trace[193283213] range","detail":"{range_begin:/registry/masterleases/199.204.45.4; range_end:; response_count:1; response_revision:786; }","duration":"1.06822486s","start":"2026-04-26T02:37:45.530251Z","end":"2026-04-26T02:37:46.598476Z","steps":["trace[193283213] 'agreement among raft nodes before linearized reading' (duration: 1.06777342s)"],"step_count":1} {"level":"warn","ts":"2026-04-26T02:37:46.598503Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T02:37:45.530239Z","time spent":"1.068258711s","remote":"127.0.0.1:46638","response type":"/etcdserverpb.KV/Range","request count":0,"request size":37,"response count":1,"response size":154,"request content":"key:\"/registry/masterleases/199.204.45.4\" "} {"level":"warn","ts":"2026-04-26T02:37:46.598115Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T02:37:45.932349Z","time spent":"665.670318ms","remote":"127.0.0.1:46874","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-26T02:38:35.731688Z","caller":"traceutil/trace.go:171","msg":"trace[20513523] transaction","detail":"{read_only:false; response_revision:1117; number_of_response:1; }","duration":"190.996541ms","start":"2026-04-26T02:38:35.540667Z","end":"2026-04-26T02:38:35.731663Z","steps":["trace[20513523] 'process raft request' (duration: 190.830667ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T02:38:55.172237Z","caller":"traceutil/trace.go:171","msg":"trace[1959090614] linearizableReadLoop","detail":"{readStateIndex:1225; appliedIndex:1224; }","duration":"108.813752ms","start":"2026-04-26T02:38:55.063396Z","end":"2026-04-26T02:38:55.17221Z","steps":["trace[1959090614] 'read index received' (duration: 108.545064ms)","trace[1959090614] 'applied index is now lower than readState.Index' (duration: 267.608µs)"],"step_count":2} {"level":"info","ts":"2026-04-26T02:38:55.17235Z","caller":"traceutil/trace.go:171","msg":"trace[763261294] transaction","detail":"{read_only:false; response_revision:1183; number_of_response:1; }","duration":"117.135753ms","start":"2026-04-26T02:38:55.055167Z","end":"2026-04-26T02:38:55.172302Z","steps":["trace[763261294] 'process raft request' (duration: 116.863195ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T02:38:55.173623Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.199084ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" ","response":"range_response_count:1 size:1036305"} {"level":"info","ts":"2026-04-26T02:38:55.173672Z","caller":"traceutil/trace.go:171","msg":"trace[1574724939] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1; range_end:; response_count:1; response_revision:1183; }","duration":"110.305267ms","start":"2026-04-26T02:38:55.063352Z","end":"2026-04-26T02:38:55.173657Z","steps":["trace[1574724939] 'agreement among raft nodes before linearized reading' (duration: 108.998798ms)"],"step_count":1}