{"level":"warn","ts":"2026-04-30T05:58:29.355287Z","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-30T05:58:29.355378Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.19: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.19:2380","--initial-cluster=instance=https://199.204.45.19:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.19:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.19: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-30T05:58:29.355435Z","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-30T05:58:29.355442Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.19:2380"]} {"level":"info","ts":"2026-04-30T05:58:29.355458Z","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-30T05:58:29.35619Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.19:2379"]} {"level":"info","ts":"2026-04-30T05:58:29.356269Z","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.19:2380"],"listen-peer-urls":["https://199.204.45.19:2380"],"advertise-client-urls":["https://199.204.45.19:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.19:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.19: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-30T05:58:29.360722Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.257724ms"} {"level":"info","ts":"2026-04-30T05:58:29.370776Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"a847c2e9c7010db6","cluster-id":"2b11a68e27507b05"} {"level":"info","ts":"2026-04-30T05:58:29.370839Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 switched to configuration voters=()"} {"level":"info","ts":"2026-04-30T05:58:29.370859Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 became follower at term 0"} {"level":"info","ts":"2026-04-30T05:58:29.370869Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft a847c2e9c7010db6 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-30T05:58:29.370876Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 became follower at term 1"} {"level":"info","ts":"2026-04-30T05:58:29.370903Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 switched to configuration voters=(12125874831040253366)"} {"level":"warn","ts":"2026-04-30T05:58:29.382302Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-30T05:58:29.384502Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-30T05:58:29.386439Z","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-30T05:58:29.388912Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"a847c2e9c7010db6","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-30T05:58:29.389174Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"a847c2e9c7010db6","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-30T05:58:29.389362Z","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-30T05:58:29.38945Z","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-30T05:58:29.389461Z","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-30T05:58:29.390059Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 switched to configuration voters=(12125874831040253366)"} {"level":"info","ts":"2026-04-30T05:58:29.390481Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"2b11a68e27507b05","local-member-id":"a847c2e9c7010db6","added-peer-id":"a847c2e9c7010db6","added-peer-peer-urls":["https://199.204.45.19:2380"]} {"level":"info","ts":"2026-04-30T05:58:29.392908Z","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-30T05:58:29.39308Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.19:2380"} {"level":"info","ts":"2026-04-30T05:58:29.393116Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.19:2380"} {"level":"info","ts":"2026-04-30T05:58:29.39337Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"a847c2e9c7010db6","initial-advertise-peer-urls":["https://199.204.45.19:2380"],"listen-peer-urls":["https://199.204.45.19:2380"],"advertise-client-urls":["https://199.204.45.19:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.19:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-30T05:58:29.393418Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-30T05:58:29.572226Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 is starting a new election at term 1"} {"level":"info","ts":"2026-04-30T05:58:29.572428Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-30T05:58:29.572521Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 received MsgPreVoteResp from a847c2e9c7010db6 at term 1"} {"level":"info","ts":"2026-04-30T05:58:29.572637Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 became candidate at term 2"} {"level":"info","ts":"2026-04-30T05:58:29.572791Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 received MsgVoteResp from a847c2e9c7010db6 at term 2"} {"level":"info","ts":"2026-04-30T05:58:29.572896Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 became leader at term 2"} {"level":"info","ts":"2026-04-30T05:58:29.572961Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: a847c2e9c7010db6 elected leader a847c2e9c7010db6 at term 2"} {"level":"info","ts":"2026-04-30T05:58:29.573898Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-30T05:58:29.574712Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-30T05:58:29.574833Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-30T05:58:29.574703Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"a847c2e9c7010db6","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.19:2379]}","request-path":"/0/members/a847c2e9c7010db6/attributes","cluster-id":"2b11a68e27507b05","publish-timeout":"7s"} {"level":"info","ts":"2026-04-30T05:58:29.575195Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"2b11a68e27507b05","local-member-id":"a847c2e9c7010db6","cluster-version":"3.5"} {"level":"info","ts":"2026-04-30T05:58:29.575387Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-30T05:58:29.575497Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-30T05:58:29.578306Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-30T05:58:29.578569Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.19:2379"} {"level":"info","ts":"2026-04-30T05:58:29.578699Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-30T05:58:29.578751Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"warn","ts":"2026-04-30T05:58:58.091638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.092176ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-04-30T05:58:58.095672Z","caller":"traceutil/trace.go:171","msg":"trace[337266812] transaction","detail":"{read_only:false; response_revision:506; number_of_response:1; }","duration":"161.02559ms","start":"2026-04-30T05:58:57.934618Z","end":"2026-04-30T05:58:58.095643Z","steps":["trace[337266812] 'process raft request' (duration: 160.861525ms)"],"step_count":1} {"level":"info","ts":"2026-04-30T05:58:58.095852Z","caller":"traceutil/trace.go:171","msg":"trace[781225498] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"146.659784ms","start":"2026-04-30T05:58:57.94918Z","end":"2026-04-30T05:58:58.09584Z","steps":["trace[781225498] 'process raft request' (duration: 146.48975ms)"],"step_count":1} {"level":"info","ts":"2026-04-30T05:58:58.095928Z","caller":"traceutil/trace.go:171","msg":"trace[1584903958] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"155.632985ms","start":"2026-04-30T05:58:57.940288Z","end":"2026-04-30T05:58:58.095921Z","steps":["trace[1584903958] 'process raft request' (duration: 155.295467ms)"],"step_count":1} {"level":"info","ts":"2026-04-30T05:58:58.096085Z","caller":"traceutil/trace.go:171","msg":"trace[2020282905] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"155.721648ms","start":"2026-04-30T05:58:57.940353Z","end":"2026-04-30T05:58:58.096074Z","steps":["trace[2020282905] 'process raft request' (duration: 155.269297ms)"],"step_count":1} {"level":"info","ts":"2026-04-30T05:58:58.096119Z","caller":"traceutil/trace.go:171","msg":"trace[1031084795] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"146.900611ms","start":"2026-04-30T05:58:57.949198Z","end":"2026-04-30T05:58:58.096098Z","steps":["trace[1031084795] 'process raft request' (duration: 146.509181ms)"],"step_count":1} {"level":"info","ts":"2026-04-30T05:58:58.096295Z","caller":"traceutil/trace.go:171","msg":"trace[1610837098] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"147.000814ms","start":"2026-04-30T05:58:57.949247Z","end":"2026-04-30T05:58:58.096248Z","steps":["trace[1610837098] 'process raft request' (duration: 146.50436ms)"],"step_count":1} {"level":"info","ts":"2026-04-30T05:58:58.096106Z","caller":"traceutil/trace.go:171","msg":"trace[1390538931] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"146.577722ms","start":"2026-04-30T05:58:57.949255Z","end":"2026-04-30T05:58:58.095833Z","steps":["trace[1390538931] 'process raft request' (duration: 146.544031ms)"],"step_count":1} {"level":"info","ts":"2026-04-30T05:58:58.104029Z","caller":"traceutil/trace.go:171","msg":"trace[293721025] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"152.80252ms","start":"2026-04-30T05:58:57.95121Z","end":"2026-04-30T05:58:58.104012Z","steps":["trace[293721025] 'process raft request' (duration: 152.253505ms)"],"step_count":1} {"level":"info","ts":"2026-04-30T05:58:58.104132Z","caller":"traceutil/trace.go:171","msg":"trace[936269300] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"150.033055ms","start":"2026-04-30T05:58:57.954093Z","end":"2026-04-30T05:58:58.104126Z","steps":["trace[936269300] 'process raft request' (duration: 149.47811ms)"],"step_count":1} {"level":"info","ts":"2026-04-30T05:58:58.104202Z","caller":"traceutil/trace.go:171","msg":"trace[1763548028] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"142.576815ms","start":"2026-04-30T05:58:57.96162Z","end":"2026-04-30T05:58:58.104197Z","steps":["trace[1763548028] 'process raft request' (duration: 141.99116ms)"],"step_count":1} {"level":"info","ts":"2026-04-30T05:58:58.104268Z","caller":"traceutil/trace.go:171","msg":"trace[852208339] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"102.490289ms","start":"2026-04-30T05:58:58.001771Z","end":"2026-04-30T05:58:58.104261Z","steps":["trace[852208339] 'process raft request' (duration: 101.874302ms)"],"step_count":1} {"level":"info","ts":"2026-04-30T05:59:04.021188Z","caller":"traceutil/trace.go:171","msg":"trace[401694801] transaction","detail":"{read_only:false; response_revision:612; number_of_response:1; }","duration":"103.974411ms","start":"2026-04-30T05:59:03.917165Z","end":"2026-04-30T05:59:04.02114Z","steps":["trace[401694801] 'process raft request' (duration: 103.318893ms)"],"step_count":1} {"level":"warn","ts":"2026-04-30T05:59:05.077386Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":988150740627291915,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-30T05:59:05.103927Z","caller":"traceutil/trace.go:171","msg":"trace[1963798680] linearizableReadLoop","detail":"{readStateIndex:637; appliedIndex:636; }","duration":"526.941128ms","start":"2026-04-30T05:59:04.576918Z","end":"2026-04-30T05:59:05.103859Z","steps":["trace[1963798680] 'read index received' (duration: 520.451604ms)","trace[1963798680] 'applied index is now lower than readState.Index' (duration: 6.487924ms)"],"step_count":2} {"level":"info","ts":"2026-04-30T05:59:05.103929Z","caller":"traceutil/trace.go:171","msg":"trace[1247207206] transaction","detail":"{read_only:false; response_revision:614; number_of_response:1; }","duration":"553.768697ms","start":"2026-04-30T05:59:04.550115Z","end":"2026-04-30T05:59:05.103884Z","steps":["trace[1247207206] 'process raft request' (duration: 548.022543ms)"],"step_count":1} {"level":"warn","ts":"2026-04-30T05:59:05.104107Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"527.170543ms","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-30T05:59:05.104159Z","caller":"traceutil/trace.go:171","msg":"trace[620275824] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:614; }","duration":"527.268257ms","start":"2026-04-30T05:59:04.576876Z","end":"2026-04-30T05:59:05.104144Z","steps":["trace[620275824] 'agreement among raft nodes before linearized reading' (duration: 527.108942ms)"],"step_count":1} {"level":"warn","ts":"2026-04-30T05:59:05.104195Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-30T05:59:04.576861Z","time spent":"527.323959ms","remote":"127.0.0.1:33524","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-30T05:59:05.104346Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"388.755541ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-zqn48\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-04-30T05:59:05.104397Z","caller":"traceutil/trace.go:171","msg":"trace[1034879804] range","detail":"{range_begin:/registry/pods/kube-system/cilium-zqn48; range_end:; response_count:1; response_revision:614; }","duration":"389.018608ms","start":"2026-04-30T05:59:04.715363Z","end":"2026-04-30T05:59:05.104382Z","steps":["trace[1034879804] 'agreement among raft nodes before linearized reading' (duration: 388.700609ms)"],"step_count":1} {"level":"warn","ts":"2026-04-30T05:59:05.104439Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-30T05:59:04.715348Z","time spent":"389.078489ms","remote":"127.0.0.1:33422","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16984,"request content":"key:\"/registry/pods/kube-system/cilium-zqn48\" "} {"level":"warn","ts":"2026-04-30T05:59:05.104559Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-30T05:59:04.550098Z","time spent":"553.922961ms","remote":"127.0.0.1:33312","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036305,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-30T05:59:20.414133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.858037ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-30T05:59:20.414269Z","caller":"traceutil/trace.go:171","msg":"trace[1535207728] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:772; }","duration":"268.007231ms","start":"2026-04-30T05:59:20.146243Z","end":"2026-04-30T05:59:20.414251Z","steps":["trace[1535207728] 'range keys from in-memory index tree' (duration: 267.744924ms)"],"step_count":1} {"level":"warn","ts":"2026-04-30T06:00:15.060708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.015664ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-30T06:00:15.060778Z","caller":"traceutil/trace.go:171","msg":"trace[210069173] range","detail":"{range_begin:/registry/controllerrevisions/; range_end:/registry/controllerrevisions0; response_count:0; response_revision:1062; }","duration":"136.141126ms","start":"2026-04-30T06:00:14.924621Z","end":"2026-04-30T06:00:15.060762Z","steps":["trace[210069173] 'count revisions from in-memory index tree' (duration: 135.925642ms)"],"step_count":1} {"level":"info","ts":"2026-04-30T06:00:15.669414Z","caller":"traceutil/trace.go:171","msg":"trace[1124660183] transaction","detail":"{read_only:false; response_revision:1066; number_of_response:1; }","duration":"105.641916ms","start":"2026-04-30T06:00:15.56375Z","end":"2026-04-30T06:00:15.669392Z","steps":["trace[1124660183] 'process raft request' (duration: 105.548523ms)"],"step_count":1} {"level":"warn","ts":"2026-04-30T06:00:16.960047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.865376ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-30T06:00:16.960134Z","caller":"traceutil/trace.go:171","msg":"trace[218693576] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1068; }","duration":"121.01024ms","start":"2026-04-30T06:00:16.839101Z","end":"2026-04-30T06:00:16.960112Z","steps":["trace[218693576] 'range keys from in-memory index tree' (duration: 120.60273ms)"],"step_count":1} {"level":"warn","ts":"2026-04-30T06:00:30.753286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"609.264799ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-30T06:00:30.753414Z","caller":"traceutil/trace.go:171","msg":"trace[728814205] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1164; }","duration":"609.443994ms","start":"2026-04-30T06:00:30.14395Z","end":"2026-04-30T06:00:30.753394Z","steps":["trace[728814205] 'range keys from in-memory index tree' (duration: 609.162916ms)"],"step_count":1} {"level":"warn","ts":"2026-04-30T06:00:30.753457Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-30T06:00:30.143933Z","time spent":"609.514797ms","remote":"127.0.0.1:33224","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-30T06:00:45.566181Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.621173ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-30T06:00:45.566251Z","caller":"traceutil/trace.go:171","msg":"trace[624855999] transaction","detail":"{read_only:false; response_revision:1233; number_of_response:1; }","duration":"122.772896ms","start":"2026-04-30T06:00:45.443446Z","end":"2026-04-30T06:00:45.566219Z","steps":["trace[624855999] 'process raft request' (duration: 118.35025ms)"],"step_count":1} {"level":"info","ts":"2026-04-30T06:00:45.566283Z","caller":"traceutil/trace.go:171","msg":"trace[238220029] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:1232; }","duration":"240.781267ms","start":"2026-04-30T06:00:45.325484Z","end":"2026-04-30T06:00:45.566265Z","steps":["trace[238220029] 'count revisions from in-memory index tree' (duration: 240.54513ms)"],"step_count":1} {"level":"warn","ts":"2026-04-30T06:00:45.886085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.626443ms","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-30T06:00:45.886169Z","caller":"traceutil/trace.go:171","msg":"trace[908640428] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1233; }","duration":"111.763086ms","start":"2026-04-30T06:00:45.774386Z","end":"2026-04-30T06:00:45.88615Z","steps":["trace[908640428] 'range keys from in-memory index tree' (duration: 111.432238ms)"],"step_count":1} {"level":"warn","ts":"2026-04-30T06:00:45.886969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.079859ms","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-30T06:00:45.887052Z","caller":"traceutil/trace.go:171","msg":"trace[996495606] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1233; }","duration":"178.215463ms","start":"2026-04-30T06:00:45.708818Z","end":"2026-04-30T06:00:45.887033Z","steps":["trace[996495606] 'range keys from in-memory index tree' (duration: 177.022572ms)"],"step_count":1} {"level":"info","ts":"2026-04-30T06:00:47.727409Z","caller":"traceutil/trace.go:171","msg":"trace[302925779] transaction","detail":"{read_only:false; response_revision:1247; number_of_response:1; }","duration":"155.892736ms","start":"2026-04-30T06:00:47.571485Z","end":"2026-04-30T06:00:47.727378Z","steps":["trace[302925779] 'process raft request' (duration: 155.630369ms)"],"step_count":1} {"level":"info","ts":"2026-04-30T06:00:59.924964Z","caller":"traceutil/trace.go:171","msg":"trace[355264615] transaction","detail":"{read_only:false; response_revision:1328; number_of_response:1; }","duration":"340.77921ms","start":"2026-04-30T06:00:59.584157Z","end":"2026-04-30T06:00:59.924937Z","steps":["trace[355264615] 'process raft request' (duration: 340.602846ms)"],"step_count":1} {"level":"warn","ts":"2026-04-30T06:00:59.925125Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-30T06:00:59.584141Z","time spent":"340.901043ms","remote":"127.0.0.1:33524","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":517,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-30T06:01:00.475901Z","caller":"traceutil/trace.go:171","msg":"trace[728586534] linearizableReadLoop","detail":"{readStateIndex:1380; appliedIndex:1379; }","duration":"458.062055ms","start":"2026-04-30T06:01:00.017812Z","end":"2026-04-30T06:01:00.475874Z","steps":["trace[728586534] 'read index received' (duration: 457.182372ms)","trace[728586534] 'applied index is now lower than readState.Index' (duration: 878.763µs)"],"step_count":2} {"level":"info","ts":"2026-04-30T06:01:00.475973Z","caller":"traceutil/trace.go:171","msg":"trace[1179875469] transaction","detail":"{read_only:false; response_revision:1329; number_of_response:1; }","duration":"713.566762ms","start":"2026-04-30T06:00:59.762364Z","end":"2026-04-30T06:01:00.47593Z","steps":["trace[1179875469] 'process raft request' (duration: 713.349637ms)"],"step_count":1} {"level":"warn","ts":"2026-04-30T06:01:00.476213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.001676ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-04-30T06:01:00.476266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.441309ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-30T06:01:00.476233Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.632771ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:533"} {"level":"info","ts":"2026-04-30T06:01:00.476306Z","caller":"traceutil/trace.go:171","msg":"trace[1774058895] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:1329; }","duration":"135.509721ms","start":"2026-04-30T06:01:00.340788Z","end":"2026-04-30T06:01:00.476297Z","steps":["trace[1774058895] 'agreement among raft nodes before linearized reading' (duration: 135.45518ms)"],"step_count":1} {"level":"info","ts":"2026-04-30T06:01:00.476319Z","caller":"traceutil/trace.go:171","msg":"trace[1713974956] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1329; }","duration":"277.11894ms","start":"2026-04-30T06:01:00.19915Z","end":"2026-04-30T06:01:00.476269Z","steps":["trace[1713974956] 'agreement among raft nodes before linearized reading' (duration: 276.931075ms)"],"step_count":1} {"level":"info","ts":"2026-04-30T06:01:00.47634Z","caller":"traceutil/trace.go:171","msg":"trace[48797928] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1329; }","duration":"199.770656ms","start":"2026-04-30T06:01:00.276548Z","end":"2026-04-30T06:01:00.476318Z","steps":["trace[48797928] 'agreement among raft nodes before linearized reading' (duration: 199.523248ms)"],"step_count":1} {"level":"warn","ts":"2026-04-30T06:01:00.476443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"458.552437ms","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-30T06:01:00.476623Z","caller":"traceutil/trace.go:171","msg":"trace[1058054746] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1329; }","duration":"458.785633ms","start":"2026-04-30T06:01:00.017761Z","end":"2026-04-30T06:01:00.476547Z","steps":["trace[1058054746] 'agreement among raft nodes before linearized reading' (duration: 458.248239ms)"],"step_count":1} {"level":"warn","ts":"2026-04-30T06:01:00.476752Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-30T06:01:00.017741Z","time spent":"458.992159ms","remote":"127.0.0.1:33524","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-30T06:01:00.476166Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"438.572846ms","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-30T06:01:00.477051Z","caller":"traceutil/trace.go:171","msg":"trace[221414442] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1329; }","duration":"439.46558ms","start":"2026-04-30T06:01:00.037567Z","end":"2026-04-30T06:01:00.477033Z","steps":["trace[221414442] 'agreement among raft nodes before linearized reading' (duration: 438.491264ms)"],"step_count":1} {"level":"warn","ts":"2026-04-30T06:01:00.477101Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-30T06:01:00.037534Z","time spent":"439.550782ms","remote":"127.0.0.1:33524","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-30T06:01:00.476217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"435.883936ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-04-30T06:01:00.477217Z","caller":"traceutil/trace.go:171","msg":"trace[189246789] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1329; }","duration":"436.868552ms","start":"2026-04-30T06:01:00.040329Z","end":"2026-04-30T06:01:00.477197Z","steps":["trace[189246789] 'agreement among raft nodes before linearized reading' (duration: 435.855965ms)"],"step_count":1} {"level":"warn","ts":"2026-04-30T06:01:00.477268Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-30T06:01:00.040269Z","time spent":"436.983976ms","remote":"127.0.0.1:33524","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-30T06:01:00.477497Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-30T06:00:59.762325Z","time spent":"713.934682ms","remote":"127.0.0.1:33524","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-30T06:03:59.536183Z","caller":"traceutil/trace.go:171","msg":"trace[568460790] transaction","detail":"{read_only:false; response_revision:2174; number_of_response:1; }","duration":"123.656352ms","start":"2026-04-30T06:03:59.41251Z","end":"2026-04-30T06:03:59.536167Z","steps":["trace[568460790] 'process raft request' (duration: 119.925587ms)"],"step_count":1} {"level":"warn","ts":"2026-04-30T06:03:59.536308Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.142832ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-30T06:03:59.536392Z","caller":"traceutil/trace.go:171","msg":"trace[1866811351] range","detail":"{range_begin:/registry/csidrivers/; range_end:/registry/csidrivers0; response_count:0; response_revision:2175; }","duration":"122.262125ms","start":"2026-04-30T06:03:59.414111Z","end":"2026-04-30T06:03:59.536373Z","steps":["trace[1866811351] 'agreement among raft nodes before linearized reading' (duration: 122.03849ms)"],"step_count":1} {"level":"info","ts":"2026-04-30T06:04:01.643246Z","caller":"traceutil/trace.go:171","msg":"trace[1717015111] linearizableReadLoop","detail":"{readStateIndex:2270; appliedIndex:2269; }","duration":"102.459238ms","start":"2026-04-30T06:04:01.540763Z","end":"2026-04-30T06:04:01.643222Z","steps":["trace[1717015111] 'read index received' (duration: 102.000946ms)","trace[1717015111] 'applied index is now lower than readState.Index' (duration: 457.352µs)"],"step_count":2} {"level":"info","ts":"2026-04-30T06:04:01.643324Z","caller":"traceutil/trace.go:171","msg":"trace[635854819] transaction","detail":"{read_only:false; response_revision:2182; number_of_response:1; }","duration":"149.582587ms","start":"2026-04-30T06:04:01.493714Z","end":"2026-04-30T06:04:01.643297Z","steps":["trace[635854819] 'process raft request' (duration: 149.33796ms)"],"step_count":1} {"level":"warn","ts":"2026-04-30T06:04:01.643619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.800627ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-04-30T06:04:01.643705Z","caller":"traceutil/trace.go:171","msg":"trace[1938077651] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2182; }","duration":"102.93677ms","start":"2026-04-30T06:04:01.540749Z","end":"2026-04-30T06:04:01.643686Z","steps":["trace[1938077651] 'agreement among raft nodes before linearized reading' (duration: 102.703624ms)"],"step_count":1} {"level":"warn","ts":"2026-04-30T06:04:01.643681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.914119ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-04-30T06:04:01.643778Z","caller":"traceutil/trace.go:171","msg":"trace[5351733] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2182; }","duration":"103.054462ms","start":"2026-04-30T06:04:01.540707Z","end":"2026-04-30T06:04:01.643761Z","steps":["trace[5351733] 'agreement among raft nodes before linearized reading' (duration: 102.704434ms)"],"step_count":1} {"level":"info","ts":"2026-04-30T06:04:02.731537Z","caller":"traceutil/trace.go:171","msg":"trace[1714764515] transaction","detail":"{read_only:false; response_revision:2188; number_of_response:1; }","duration":"125.438837ms","start":"2026-04-30T06:04:02.606068Z","end":"2026-04-30T06:04:02.731507Z","steps":["trace[1714764515] 'process raft request' (duration: 125.112299ms)"],"step_count":1} {"level":"info","ts":"2026-04-30T06:04:02.931231Z","caller":"traceutil/trace.go:171","msg":"trace[810619925] linearizableReadLoop","detail":"{readStateIndex:2279; appliedIndex:2278; }","duration":"111.261293ms","start":"2026-04-30T06:04:02.819945Z","end":"2026-04-30T06:04:02.931206Z","steps":["trace[810619925] 'read index received' (duration: 76.647006ms)","trace[810619925] 'applied index is now lower than readState.Index' (duration: 34.613297ms)"],"step_count":2} {"level":"info","ts":"2026-04-30T06:04:02.931426Z","caller":"traceutil/trace.go:171","msg":"trace[723338675] transaction","detail":"{read_only:false; response_revision:2190; number_of_response:1; }","duration":"111.702536ms","start":"2026-04-30T06:04:02.819642Z","end":"2026-04-30T06:04:02.931345Z","steps":["trace[723338675] 'process raft request' (duration: 77.057257ms)","trace[723338675] 'compare' (duration: 34.383561ms)"],"step_count":2} {"level":"warn","ts":"2026-04-30T06:04:02.931477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.551002ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/\" range_end:\"/registry/masterleases0\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-04-30T06:04:02.931699Z","caller":"traceutil/trace.go:171","msg":"trace[1354501629] range","detail":"{range_begin:/registry/masterleases/; range_end:/registry/masterleases0; response_count:1; response_revision:2190; }","duration":"111.838909ms","start":"2026-04-30T06:04:02.819837Z","end":"2026-04-30T06:04:02.931676Z","steps":["trace[1354501629] 'agreement among raft nodes before linearized reading' (duration: 111.4777ms)"],"step_count":1}