{"level":"warn","ts":"2026-06-24T17:10:09.764456Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-24T17:10:09.76453Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.65: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.65:2380","--initial-cluster=instance=https://199.204.45.65:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.65:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.65: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-06-24T17:10:09.764635Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-24T17:10:09.764651Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.65:2380"]} {"level":"info","ts":"2026-06-24T17:10:09.764699Z","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-06-24T17:10:09.765309Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.65:2379"]} {"level":"info","ts":"2026-06-24T17:10:09.765401Z","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.65:2380"],"listen-peer-urls":["https://199.204.45.65:2380"],"advertise-client-urls":["https://199.204.45.65:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.65:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.65: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-06-24T17:10:09.769229Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.575665ms"} {"level":"info","ts":"2026-06-24T17:10:09.776725Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"cf8c3a138c9a77a2","cluster-id":"c278183e1f634dff"} {"level":"info","ts":"2026-06-24T17:10:09.776815Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 switched to configuration voters=()"} {"level":"info","ts":"2026-06-24T17:10:09.776833Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 became follower at term 0"} {"level":"info","ts":"2026-06-24T17:10:09.776851Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft cf8c3a138c9a77a2 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-24T17:10:09.776861Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 became follower at term 1"} {"level":"info","ts":"2026-06-24T17:10:09.776901Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 switched to configuration voters=(14955392318228297634)"} {"level":"warn","ts":"2026-06-24T17:10:09.783106Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-24T17:10:09.784535Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-24T17:10:09.785868Z","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-06-24T17:10:09.790093Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"cf8c3a138c9a77a2","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-24T17:10:09.790317Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"cf8c3a138c9a77a2","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-24T17:10:09.790515Z","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-06-24T17:10:09.790557Z","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-06-24T17:10:09.790592Z","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-06-24T17:10:09.791122Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 switched to configuration voters=(14955392318228297634)"} {"level":"info","ts":"2026-06-24T17:10:09.791246Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"c278183e1f634dff","local-member-id":"cf8c3a138c9a77a2","added-peer-id":"cf8c3a138c9a77a2","added-peer-peer-urls":["https://199.204.45.65:2380"]} {"level":"info","ts":"2026-06-24T17:10:09.797208Z","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-06-24T17:10:09.797311Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.65:2380"} {"level":"info","ts":"2026-06-24T17:10:09.797377Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.65:2380"} {"level":"info","ts":"2026-06-24T17:10:09.797576Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"cf8c3a138c9a77a2","initial-advertise-peer-urls":["https://199.204.45.65:2380"],"listen-peer-urls":["https://199.204.45.65:2380"],"advertise-client-urls":["https://199.204.45.65:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.65:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-24T17:10:09.797626Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-24T17:10:10.777612Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 is starting a new election at term 1"} {"level":"info","ts":"2026-06-24T17:10:10.777671Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 became pre-candidate at term 1"} {"level":"info","ts":"2026-06-24T17:10:10.777708Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 received MsgPreVoteResp from cf8c3a138c9a77a2 at term 1"} {"level":"info","ts":"2026-06-24T17:10:10.777729Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 became candidate at term 2"} {"level":"info","ts":"2026-06-24T17:10:10.777741Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 received MsgVoteResp from cf8c3a138c9a77a2 at term 2"} {"level":"info","ts":"2026-06-24T17:10:10.777765Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 became leader at term 2"} {"level":"info","ts":"2026-06-24T17:10:10.777783Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: cf8c3a138c9a77a2 elected leader cf8c3a138c9a77a2 at term 2"} {"level":"info","ts":"2026-06-24T17:10:10.778832Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-24T17:10:10.780138Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"cf8c3a138c9a77a2","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.65:2379]}","request-path":"/0/members/cf8c3a138c9a77a2/attributes","cluster-id":"c278183e1f634dff","publish-timeout":"7s"} {"level":"info","ts":"2026-06-24T17:10:10.780185Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-24T17:10:10.780233Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-24T17:10:10.780413Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-24T17:10:10.780682Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-24T17:10:10.780876Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"c278183e1f634dff","local-member-id":"cf8c3a138c9a77a2","cluster-version":"3.5"} {"level":"info","ts":"2026-06-24T17:10:10.781039Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-24T17:10:10.781104Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-24T17:10:10.784098Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.65:2379"} {"level":"info","ts":"2026-06-24T17:10:10.784152Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-06-24T17:10:34.300901Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:10:33.798198Z","time spent":"502.69717ms","remote":"127.0.0.1:38000","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-06-24T17:10:44.570208Z","caller":"traceutil/trace.go:171","msg":"trace[2032762451] linearizableReadLoop","detail":"{readStateIndex:497; appliedIndex:496; }","duration":"156.644637ms","start":"2026-06-24T17:10:44.413537Z","end":"2026-06-24T17:10:44.570182Z","steps":["trace[2032762451] 'read index received' (duration: 155.89805ms)","trace[2032762451] 'applied index is now lower than readState.Index' (duration: 745.527µs)"],"step_count":2} {"level":"info","ts":"2026-06-24T17:10:44.570278Z","caller":"traceutil/trace.go:171","msg":"trace[1128966369] transaction","detail":"{read_only:false; response_revision:481; number_of_response:1; }","duration":"158.331035ms","start":"2026-06-24T17:10:44.411916Z","end":"2026-06-24T17:10:44.570247Z","steps":["trace[1128966369] 'process raft request' (duration: 157.931816ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:10:44.57049Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.940233ms","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-06-24T17:10:44.570531Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.527483ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-24T17:10:44.570586Z","caller":"traceutil/trace.go:171","msg":"trace[459460435] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:481; }","duration":"157.080826ms","start":"2026-06-24T17:10:44.413478Z","end":"2026-06-24T17:10:44.570559Z","steps":["trace[459460435] 'agreement among raft nodes before linearized reading' (duration: 156.882002ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T17:10:44.57064Z","caller":"traceutil/trace.go:171","msg":"trace[868548085] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:481; }","duration":"129.698307ms","start":"2026-06-24T17:10:44.44092Z","end":"2026-06-24T17:10:44.570618Z","steps":["trace[868548085] 'agreement among raft nodes before linearized reading' (duration: 129.518103ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T17:10:46.482689Z","caller":"traceutil/trace.go:171","msg":"trace[777111502] transaction","detail":"{read_only:false; response_revision:545; number_of_response:1; }","duration":"179.596055ms","start":"2026-06-24T17:10:46.303073Z","end":"2026-06-24T17:10:46.482669Z","steps":["trace[777111502] 'process raft request' (duration: 171.613247ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T17:10:46.484142Z","caller":"traceutil/trace.go:171","msg":"trace[332231089] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"118.504754ms","start":"2026-06-24T17:10:46.365626Z","end":"2026-06-24T17:10:46.484131Z","steps":["trace[332231089] 'process raft request' (duration: 118.461284ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T17:10:46.484477Z","caller":"traceutil/trace.go:171","msg":"trace[983573059] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"170.132423ms","start":"2026-06-24T17:10:46.314337Z","end":"2026-06-24T17:10:46.484469Z","steps":["trace[983573059] 'process raft request' (duration: 169.674453ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:10:47.085461Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8620627435942344097,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-24T17:10:47.186675Z","caller":"traceutil/trace.go:171","msg":"trace[98983880] transaction","detail":"{read_only:false; response_revision:553; number_of_response:1; }","duration":"607.791568ms","start":"2026-06-24T17:10:46.578858Z","end":"2026-06-24T17:10:47.18665Z","steps":["trace[98983880] 'process raft request' (duration: 586.429707ms)","trace[98983880] 'compare' (duration: 20.770459ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T17:10:47.187242Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:10:46.578837Z","time spent":"607.912301ms","remote":"127.0.0.1:38018","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29452,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T17:10:47.188286Z","caller":"traceutil/trace.go:171","msg":"trace[535528922] transaction","detail":"{read_only:false; response_revision:554; number_of_response:1; }","duration":"608.263548ms","start":"2026-06-24T17:10:46.57999Z","end":"2026-06-24T17:10:47.188254Z","steps":["trace[535528922] 'process raft request' (duration: 608.026703ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:10:47.18837Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:10:46.579972Z","time spent":"608.36582ms","remote":"127.0.0.1:38538","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":986,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-24T17:10:47.188547Z","caller":"traceutil/trace.go:171","msg":"trace[448484915] transaction","detail":"{read_only:false; response_revision:556; number_of_response:1; }","duration":"602.159803ms","start":"2026-06-24T17:10:46.586361Z","end":"2026-06-24T17:10:47.188521Z","steps":["trace[448484915] 'process raft request' (duration: 601.983958ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T17:10:47.188623Z","caller":"traceutil/trace.go:171","msg":"trace[1431624410] transaction","detail":"{read_only:false; response_revision:555; number_of_response:1; }","duration":"604.404493ms","start":"2026-06-24T17:10:46.584203Z","end":"2026-06-24T17:10:47.188607Z","steps":["trace[1431624410] 'process raft request' (duration: 603.934552ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:10:47.188693Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:10:46.584183Z","time spent":"604.467094ms","remote":"127.0.0.1:38018","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":31111,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T17:10:47.188715Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:10:46.586343Z","time spent":"602.274655ms","remote":"127.0.0.1:38018","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":150480,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T17:10:47.188733Z","caller":"traceutil/trace.go:171","msg":"trace[1459974302] linearizableReadLoop","detail":"{readStateIndex:575; appliedIndex:570; }","duration":"604.320371ms","start":"2026-06-24T17:10:46.584398Z","end":"2026-06-24T17:10:47.188719Z","steps":["trace[1459974302] 'read index received' (duration: 580.928135ms)","trace[1459974302] 'applied index is now lower than readState.Index' (duration: 23.391186ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T17:10:47.188876Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"604.473555ms","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-06-24T17:10:47.188909Z","caller":"traceutil/trace.go:171","msg":"trace[1099055946] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:557; }","duration":"604.523635ms","start":"2026-06-24T17:10:46.584375Z","end":"2026-06-24T17:10:47.188898Z","steps":["trace[1099055946] 'agreement among raft nodes before linearized reading' (duration: 604.463284ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:10:47.188939Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:10:46.584369Z","time spent":"604.564196ms","remote":"127.0.0.1:38262","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-24T17:10:47.189092Z","caller":"traceutil/trace.go:171","msg":"trace[1344644380] transaction","detail":"{read_only:false; response_revision:557; number_of_response:1; }","duration":"542.846484ms","start":"2026-06-24T17:10:46.646236Z","end":"2026-06-24T17:10:47.189082Z","steps":["trace[1344644380] 'process raft request' (duration: 542.236421ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:10:47.189145Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:10:46.646217Z","time spent":"542.902875ms","remote":"127.0.0.1:38018","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":97665,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-24T17:10:47.189205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"604.754691ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-24T17:10:47.189252Z","caller":"traceutil/trace.go:171","msg":"trace[269431537] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:557; }","duration":"604.805221ms","start":"2026-06-24T17:10:46.584429Z","end":"2026-06-24T17:10:47.189234Z","steps":["trace[269431537] 'agreement among raft nodes before linearized reading' (duration: 604.72988ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:10:47.189282Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:10:46.584426Z","time spent":"604.849372ms","remote":"127.0.0.1:38262","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-24T17:10:47.189393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.973966ms","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-06-24T17:10:47.189419Z","caller":"traceutil/trace.go:171","msg":"trace[732360437] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:557; }","duration":"261.034287ms","start":"2026-06-24T17:10:46.928375Z","end":"2026-06-24T17:10:47.18941Z","steps":["trace[732360437] 'agreement among raft nodes before linearized reading' (duration: 260.989266ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:10:53.732652Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8620627435942344300,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-24T17:10:53.852158Z","caller":"traceutil/trace.go:171","msg":"trace[754058435] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"626.252613ms","start":"2026-06-24T17:10:53.225874Z","end":"2026-06-24T17:10:53.852126Z","steps":["trace[754058435] 'process raft request' (duration: 625.571409ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:10:53.852366Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:10:53.225844Z","time spent":"626.400805ms","remote":"127.0.0.1:38072","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036313,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T17:10:53.8743Z","caller":"traceutil/trace.go:171","msg":"trace[568304889] linearizableReadLoop","detail":"{readStateIndex:648; appliedIndex:646; }","duration":"642.591214ms","start":"2026-06-24T17:10:53.231684Z","end":"2026-06-24T17:10:53.874275Z","steps":["trace[568304889] 'read index received' (duration: 619.723586ms)","trace[568304889] 'applied index is now lower than readState.Index' (duration: 22.866778ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T17:10:53.874647Z","caller":"traceutil/trace.go:171","msg":"trace[1802408818] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"646.134058ms","start":"2026-06-24T17:10:53.2285Z","end":"2026-06-24T17:10:53.874634Z","steps":["trace[1802408818] 'process raft request' (duration: 645.658248ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:10:53.874756Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:10:53.22848Z","time spent":"646.206759ms","remote":"127.0.0.1:38262","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T17:10:53.874937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"643.248338ms","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-06-24T17:10:53.874974Z","caller":"traceutil/trace.go:171","msg":"trace[1611361008] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:629; }","duration":"643.297269ms","start":"2026-06-24T17:10:53.231667Z","end":"2026-06-24T17:10:53.874964Z","steps":["trace[1611361008] 'agreement among raft nodes before linearized reading' (duration: 643.236528ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:10:53.875002Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:10:53.231662Z","time spent":"643.33422ms","remote":"127.0.0.1:38262","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":"warn","ts":"2026-06-24T17:10:53.875144Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.480001ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-f4ncz\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-06-24T17:10:53.875176Z","caller":"traceutil/trace.go:171","msg":"trace[363597062] range","detail":"{range_begin:/registry/pods/kube-system/cilium-f4ncz; range_end:; response_count:1; response_revision:629; }","duration":"310.557792ms","start":"2026-06-24T17:10:53.564611Z","end":"2026-06-24T17:10:53.875169Z","steps":["trace[363597062] 'agreement among raft nodes before linearized reading' (duration: 310.47325ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:10:53.875196Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:10:53.56458Z","time spent":"310.612054ms","remote":"127.0.0.1:38162","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16985,"request content":"key:\"/registry/pods/kube-system/cilium-f4ncz\" "} {"level":"warn","ts":"2026-06-24T17:10:53.875215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"637.12152ms","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-06-24T17:10:53.875245Z","caller":"traceutil/trace.go:171","msg":"trace[954723637] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:629; }","duration":"637.159782ms","start":"2026-06-24T17:10:53.238075Z","end":"2026-06-24T17:10:53.875235Z","steps":["trace[954723637] 'agreement among raft nodes before linearized reading' (duration: 637.090439ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:10:53.875144Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"637.243002ms","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-06-24T17:10:53.87528Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:10:53.23807Z","time spent":"637.202882ms","remote":"127.0.0.1:38262","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":"info","ts":"2026-06-24T17:10:53.875342Z","caller":"traceutil/trace.go:171","msg":"trace[1564876279] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:629; }","duration":"637.471178ms","start":"2026-06-24T17:10:53.237863Z","end":"2026-06-24T17:10:53.875334Z","steps":["trace[1564876279] 'agreement among raft nodes before linearized reading' (duration: 637.13513ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:10:53.87537Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:10:53.237847Z","time spent":"637.515019ms","remote":"127.0.0.1:38262","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-24T17:10:54.22989Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.12698ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:41"} {"level":"warn","ts":"2026-06-24T17:10:54.230284Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:10:53.878937Z","time spent":"351.342665ms","remote":"127.0.0.1:38000","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-06-24T17:10:54.3818Z","caller":"traceutil/trace.go:171","msg":"trace[1250957290] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"498.821372ms","start":"2026-06-24T17:10:53.882947Z","end":"2026-06-24T17:10:54.381768Z","steps":["trace[1250957290] 'process raft request' (duration: 498.627688ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T17:10:54.381813Z","caller":"traceutil/trace.go:171","msg":"trace[2006439737] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"498.875783ms","start":"2026-06-24T17:10:53.882877Z","end":"2026-06-24T17:10:54.381753Z","steps":["trace[2006439737] 'process raft request' (duration: 467.743598ms)","trace[2006439737] 'compare' (duration: 30.790448ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T17:10:54.381945Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:10:53.882938Z","time spent":"498.938434ms","remote":"127.0.0.1:38262","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T17:10:54.382Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:10:53.882859Z","time spent":"499.043377ms","remote":"127.0.0.1:38262","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T17:10:54.382085Z","caller":"traceutil/trace.go:171","msg":"trace[263603539] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"497.853841ms","start":"2026-06-24T17:10:53.884176Z","end":"2026-06-24T17:10:54.38203Z","steps":["trace[263603539] 'process raft request' (duration: 497.467483ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:10:54.382267Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:10:53.884169Z","time spent":"498.009324ms","remote":"127.0.0.1:38262","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T17:10:54.382462Z","caller":"traceutil/trace.go:171","msg":"trace[791786327] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"495.504293ms","start":"2026-06-24T17:10:53.886949Z","end":"2026-06-24T17:10:54.382453Z","steps":["trace[791786327] 'process raft request' (duration: 494.749337ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T17:10:54.382458Z","caller":"traceutil/trace.go:171","msg":"trace[1560434467] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"465.502796ms","start":"2026-06-24T17:10:53.916944Z","end":"2026-06-24T17:10:54.382447Z","steps":["trace[1560434467] 'process raft request' (duration: 465.142458ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:10:54.382508Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:10:53.886908Z","time spent":"495.578145ms","remote":"127.0.0.1:38162","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T17:10:54.38253Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:10:53.916929Z","time spent":"465.573228ms","remote":"127.0.0.1:38222","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-24T17:10:54.382667Z","caller":"traceutil/trace.go:171","msg":"trace[2037930272] linearizableReadLoop","detail":"{readStateIndex:654; appliedIndex:649; }","duration":"176.785995ms","start":"2026-06-24T17:10:54.205856Z","end":"2026-06-24T17:10:54.382642Z","steps":["trace[2037930272] 'read index received' (duration: 144.775911ms)","trace[2037930272] 'applied index is now lower than readState.Index' (duration: 32.008224ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T17:10:54.382789Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.929708ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T17:10:54.382824Z","caller":"traceutil/trace.go:171","msg":"trace[2047522235] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:634; }","duration":"176.993929ms","start":"2026-06-24T17:10:54.205821Z","end":"2026-06-24T17:10:54.382815Z","steps":["trace[2047522235] 'agreement among raft nodes before linearized reading' (duration: 176.917808ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T17:10:54.383046Z","caller":"traceutil/trace.go:171","msg":"trace[1631606131] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"151.47904ms","start":"2026-06-24T17:10:54.231556Z","end":"2026-06-24T17:10:54.383035Z","steps":["trace[1631606131] 'process raft request' (duration: 151.131713ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:10:55.595349Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.194624001s","expected-duration":"1s"} {"level":"warn","ts":"2026-06-24T17:10:55.755742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.037199ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-24T17:10:55.755866Z","caller":"traceutil/trace.go:171","msg":"trace[707205028] transaction","detail":"{read_only:false; response_revision:636; number_of_response:1; }","duration":"1.355239481s","start":"2026-06-24T17:10:54.400604Z","end":"2026-06-24T17:10:55.755844Z","steps":["trace[707205028] 'process raft request' (duration: 1.195002338s)","trace[707205028] 'compare' (duration: 159.679252ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T17:10:55.755938Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:10:54.400586Z","time spent":"1.355326083s","remote":"127.0.0.1:38162","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2735,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-24T17:10:58.034423Z","caller":"traceutil/trace.go:171","msg":"trace[1642298110] linearizableReadLoop","detail":"{readStateIndex:700; appliedIndex:699; }","duration":"144.170289ms","start":"2026-06-24T17:10:57.89023Z","end":"2026-06-24T17:10:58.0344Z","steps":["trace[1642298110] 'read index received' (duration: 143.949504ms)","trace[1642298110] 'applied index is now lower than readState.Index' (duration: 219.785µs)"],"step_count":2} {"level":"info","ts":"2026-06-24T17:10:58.034556Z","caller":"traceutil/trace.go:171","msg":"trace[246400932] transaction","detail":"{read_only:false; response_revision:679; number_of_response:1; }","duration":"180.151636ms","start":"2026-06-24T17:10:57.854349Z","end":"2026-06-24T17:10:58.0345Z","steps":["trace[246400932] 'process raft request' (duration: 179.84094ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:10:58.034774Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.484915ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-24T17:10:58.034816Z","caller":"traceutil/trace.go:171","msg":"trace[609560411] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:679; }","duration":"144.635718ms","start":"2026-06-24T17:10:57.89017Z","end":"2026-06-24T17:10:58.034805Z","steps":["trace[609560411] 'agreement among raft nodes before linearized reading' (duration: 144.306971ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T17:11:08.339451Z","caller":"traceutil/trace.go:171","msg":"trace[2000287680] transaction","detail":"{read_only:false; response_revision:778; number_of_response:1; }","duration":"252.363421ms","start":"2026-06-24T17:11:08.087024Z","end":"2026-06-24T17:11:08.339387Z","steps":["trace[2000287680] 'process raft request' (duration: 252.185058ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T17:11:11.367039Z","caller":"traceutil/trace.go:171","msg":"trace[1224260145] transaction","detail":"{read_only:false; response_revision:795; number_of_response:1; }","duration":"679.754893ms","start":"2026-06-24T17:11:10.687258Z","end":"2026-06-24T17:11:11.367012Z","steps":["trace[1224260145] 'process raft request' (duration: 679.598539ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:11:11.367229Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:11:10.687231Z","time spent":"679.889054ms","remote":"127.0.0.1:38162","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4027,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T17:12:58.221679Z","caller":"traceutil/trace.go:171","msg":"trace[161418452] transaction","detail":"{read_only:false; response_revision:1319; number_of_response:1; }","duration":"102.511138ms","start":"2026-06-24T17:12:58.119106Z","end":"2026-06-24T17:12:58.221617Z","steps":["trace[161418452] 'process raft request' (duration: 39.395077ms)","trace[161418452] 'compare' (duration: 62.759846ms)"],"step_count":2}