{"level":"warn","ts":"2026-05-07T03:17:45.188135Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-07T03:17:45.188267Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.115: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.115:2380","--initial-cluster=instance=https://199.204.45.115:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.115:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.115: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-05-07T03:17:45.188391Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-07T03:17:45.188419Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.115:2380"]} {"level":"info","ts":"2026-05-07T03:17:45.188454Z","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-05-07T03:17:45.189949Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.115:2379"]} {"level":"info","ts":"2026-05-07T03:17:45.190144Z","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.115:2380"],"listen-peer-urls":["https://199.204.45.115:2380"],"advertise-client-urls":["https://199.204.45.115:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.115:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.115: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-05-07T03:17:45.195555Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.810382ms"} {"level":"info","ts":"2026-05-07T03:17:45.208765Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"e3aaa5c123e150e0","cluster-id":"61ec519698823541"} {"level":"info","ts":"2026-05-07T03:17:45.208896Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 switched to configuration voters=()"} {"level":"info","ts":"2026-05-07T03:17:45.208931Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 became follower at term 0"} {"level":"info","ts":"2026-05-07T03:17:45.209017Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft e3aaa5c123e150e0 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-07T03:17:45.209173Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 became follower at term 1"} {"level":"info","ts":"2026-05-07T03:17:45.209243Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 switched to configuration voters=(16405106841599693024)"} {"level":"warn","ts":"2026-05-07T03:17:45.217376Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-07T03:17:45.221308Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-07T03:17:45.223442Z","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-05-07T03:17:45.226349Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"e3aaa5c123e150e0","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-07T03:17:45.226491Z","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-05-07T03:17:45.226579Z","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-05-07T03:17:45.226615Z","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-05-07T03:17:45.226607Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"e3aaa5c123e150e0","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-07T03:17:45.22815Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 switched to configuration voters=(16405106841599693024)"} {"level":"info","ts":"2026-05-07T03:17:45.228337Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"61ec519698823541","local-member-id":"e3aaa5c123e150e0","added-peer-id":"e3aaa5c123e150e0","added-peer-peer-urls":["https://199.204.45.115:2380"]} {"level":"info","ts":"2026-05-07T03:17:45.23062Z","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-05-07T03:17:45.230733Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.115:2380"} {"level":"info","ts":"2026-05-07T03:17:45.230788Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.115:2380"} {"level":"info","ts":"2026-05-07T03:17:45.230791Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"e3aaa5c123e150e0","initial-advertise-peer-urls":["https://199.204.45.115:2380"],"listen-peer-urls":["https://199.204.45.115:2380"],"advertise-client-urls":["https://199.204.45.115:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.115:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-07T03:17:45.230816Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-07T03:17:46.009939Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 is starting a new election at term 1"} {"level":"info","ts":"2026-05-07T03:17:46.009977Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-07T03:17:46.009994Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 received MsgPreVoteResp from e3aaa5c123e150e0 at term 1"} {"level":"info","ts":"2026-05-07T03:17:46.010005Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 became candidate at term 2"} {"level":"info","ts":"2026-05-07T03:17:46.01001Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 received MsgVoteResp from e3aaa5c123e150e0 at term 2"} {"level":"info","ts":"2026-05-07T03:17:46.010018Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 became leader at term 2"} {"level":"info","ts":"2026-05-07T03:17:46.010027Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: e3aaa5c123e150e0 elected leader e3aaa5c123e150e0 at term 2"} {"level":"info","ts":"2026-05-07T03:17:46.012595Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"e3aaa5c123e150e0","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.115:2379]}","request-path":"/0/members/e3aaa5c123e150e0/attributes","cluster-id":"61ec519698823541","publish-timeout":"7s"} {"level":"info","ts":"2026-05-07T03:17:46.012638Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-07T03:17:46.012705Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-07T03:17:46.012697Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-07T03:17:46.012842Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-07T03:17:46.012905Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-07T03:17:46.014035Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"61ec519698823541","local-member-id":"e3aaa5c123e150e0","cluster-version":"3.5"} {"level":"info","ts":"2026-05-07T03:17:46.014174Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-07T03:17:46.014218Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-07T03:17:46.014292Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-07T03:17:46.015362Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.115:2379"} {"level":"info","ts":"2026-05-07T03:17:56.405106Z","caller":"traceutil/trace.go:171","msg":"trace[1650748703] transaction","detail":"{read_only:false; response_revision:363; number_of_response:1; }","duration":"129.864174ms","start":"2026-05-07T03:17:56.275211Z","end":"2026-05-07T03:17:56.405075Z","steps":["trace[1650748703] 'process raft request' (duration: 127.182201ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:18:16.129768Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.538675042s","expected-duration":"1s"} {"level":"info","ts":"2026-05-07T03:18:16.134071Z","caller":"traceutil/trace.go:171","msg":"trace[1302068752] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"1.543124801s","start":"2026-05-07T03:18:14.59093Z","end":"2026-05-07T03:18:16.134054Z","steps":["trace[1302068752] 'process raft request' (duration: 1.538992332s)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:18:16.13431Z","caller":"traceutil/trace.go:171","msg":"trace[735572102] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"1.53821372s","start":"2026-05-07T03:18:14.59609Z","end":"2026-05-07T03:18:16.134304Z","steps":["trace[735572102] 'process raft request' (duration: 1.538022572s)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:18:16.135118Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:18:14.590913Z","time spent":"1.543205709s","remote":"127.0.0.1:36776","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":64462,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-07T03:18:16.135226Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:18:14.596083Z","time spent":"1.5385305s","remote":"127.0.0.1:36776","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-07T03:18:16.137035Z","caller":"traceutil/trace.go:171","msg":"trace[351817141] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"1.53787566s","start":"2026-05-07T03:18:14.599137Z","end":"2026-05-07T03:18:16.137013Z","steps":["trace[351817141] 'process raft request' (duration: 1.535612617s)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:18:16.137149Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:18:14.599117Z","time spent":"1.537969339s","remote":"127.0.0.1:36776","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29452,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-07T03:18:16.137288Z","caller":"traceutil/trace.go:171","msg":"trace[1055001123] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"1.538052287s","start":"2026-05-07T03:18:14.599213Z","end":"2026-05-07T03:18:16.137265Z","steps":["trace[1055001123] 'process raft request' (duration: 1.537850508s)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:18:16.137408Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:18:14.599209Z","time spent":"1.538149866s","remote":"127.0.0.1:36776","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-07T03:18:16.139694Z","caller":"traceutil/trace.go:171","msg":"trace[630876760] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"1.533027137s","start":"2026-05-07T03:18:14.606655Z","end":"2026-05-07T03:18:16.139682Z","steps":["trace[630876760] 'process raft request' (duration: 1.530581957s)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:18:16.139764Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:18:14.606645Z","time spent":"1.533078282s","remote":"127.0.0.1:36776","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58844,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-07T03:18:23.264306Z","caller":"traceutil/trace.go:171","msg":"trace[1755599338] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"109.200977ms","start":"2026-05-07T03:18:23.15508Z","end":"2026-05-07T03:18:23.264281Z","steps":["trace[1755599338] 'process raft request' (duration: 109.057386ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:19:06.737253Z","caller":"traceutil/trace.go:171","msg":"trace[255121949] linearizableReadLoop","detail":"{readStateIndex:1214; appliedIndex:1213; }","duration":"235.910648ms","start":"2026-05-07T03:19:06.501317Z","end":"2026-05-07T03:19:06.737227Z","steps":["trace[255121949] 'read index received' (duration: 71.641105ms)","trace[255121949] 'applied index is now lower than readState.Index' (duration: 164.268373ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T03:19:06.737528Z","caller":"traceutil/trace.go:171","msg":"trace[1041173365] transaction","detail":"{read_only:false; response_revision:1176; number_of_response:1; }","duration":"236.49968ms","start":"2026-05-07T03:19:06.500794Z","end":"2026-05-07T03:19:06.737294Z","steps":["trace[1041173365] 'process raft request' (duration: 216.926992ms)","trace[1041173365] 'compare' (duration: 19.295147ms)"],"step_count":2} {"level":"warn","ts":"2026-05-07T03:19:06.737703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.188545ms","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-05-07T03:19:06.737874Z","caller":"traceutil/trace.go:171","msg":"trace[1881091618] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1177; }","duration":"235.379356ms","start":"2026-05-07T03:19:06.50243Z","end":"2026-05-07T03:19:06.737809Z","steps":["trace[1881091618] 'agreement among raft nodes before linearized reading' (duration: 234.997594ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:19:06.7376Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.244349ms","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-05-07T03:19:06.738105Z","caller":"traceutil/trace.go:171","msg":"trace[637450091] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1177; }","duration":"236.807442ms","start":"2026-05-07T03:19:06.501277Z","end":"2026-05-07T03:19:06.738084Z","steps":["trace[637450091] 'agreement among raft nodes before linearized reading' (duration: 236.099028ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:19:06.737336Z","caller":"traceutil/trace.go:171","msg":"trace[1828602151] transaction","detail":"{read_only:false; response_revision:1177; number_of_response:1; }","duration":"178.028387ms","start":"2026-05-07T03:19:06.55928Z","end":"2026-05-07T03:19:06.737309Z","steps":["trace[1828602151] 'process raft request' (duration: 177.894356ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:19:26.189512Z","caller":"traceutil/trace.go:171","msg":"trace[1510627650] transaction","detail":"{read_only:false; response_revision:1398; number_of_response:1; }","duration":"326.102729ms","start":"2026-05-07T03:19:25.863391Z","end":"2026-05-07T03:19:26.189494Z","steps":["trace[1510627650] 'process raft request' (duration: 325.830202ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:19:26.18962Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:19:25.863361Z","time spent":"326.199761ms","remote":"127.0.0.1:36824","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":105443,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-07T03:19:26.189665Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.924966ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/ingress-nginx/ingress-nginx-backend\" ","response":"range_response_count:1 size:1041"} {"level":"info","ts":"2026-05-07T03:19:26.189499Z","caller":"traceutil/trace.go:171","msg":"trace[1649611185] linearizableReadLoop","detail":"{readStateIndex:1447; appliedIndex:1446; }","duration":"241.724681ms","start":"2026-05-07T03:19:25.947737Z","end":"2026-05-07T03:19:26.189462Z","steps":["trace[1649611185] 'read index received' (duration: 241.380413ms)","trace[1649611185] 'applied index is now lower than readState.Index' (duration: 343.418µs)"],"step_count":2} {"level":"info","ts":"2026-05-07T03:19:26.189707Z","caller":"traceutil/trace.go:171","msg":"trace[43052506] range","detail":"{range_begin:/registry/serviceaccounts/ingress-nginx/ingress-nginx-backend; range_end:; response_count:1; response_revision:1398; }","duration":"242.009418ms","start":"2026-05-07T03:19:25.947687Z","end":"2026-05-07T03:19:26.189696Z","steps":["trace[43052506] 'agreement among raft nodes before linearized reading' (duration: 241.860824ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:19:26.189769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.040628ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/ingress-nginx/ingress-nginx\" ","response":"range_response_count:1 size:1020"} {"level":"info","ts":"2026-05-07T03:19:26.189787Z","caller":"traceutil/trace.go:171","msg":"trace[475353452] range","detail":"{range_begin:/registry/serviceaccounts/ingress-nginx/ingress-nginx; range_end:; response_count:1; response_revision:1398; }","duration":"242.0933ms","start":"2026-05-07T03:19:25.947688Z","end":"2026-05-07T03:19:26.189781Z","steps":["trace[475353452] 'agreement among raft nodes before linearized reading' (duration: 242.035868ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:19:26.641596Z","caller":"traceutil/trace.go:171","msg":"trace[127339456] transaction","detail":"{read_only:false; response_revision:1407; number_of_response:1; }","duration":"186.545866ms","start":"2026-05-07T03:19:26.454996Z","end":"2026-05-07T03:19:26.641542Z","steps":["trace[127339456] 'process raft request' (duration: 168.884862ms)","trace[127339456] 'compare' (duration: 17.421198ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T03:19:26.641731Z","caller":"traceutil/trace.go:171","msg":"trace[2077542984] transaction","detail":"{read_only:false; response_revision:1409; number_of_response:1; }","duration":"180.976523ms","start":"2026-05-07T03:19:26.460736Z","end":"2026-05-07T03:19:26.641712Z","steps":["trace[2077542984] 'process raft request' (duration: 180.798639ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:19:26.641801Z","caller":"traceutil/trace.go:171","msg":"trace[1552050623] transaction","detail":"{read_only:false; response_revision:1408; number_of_response:1; }","duration":"186.178678ms","start":"2026-05-07T03:19:26.455582Z","end":"2026-05-07T03:19:26.641761Z","steps":["trace[1552050623] 'process raft request' (duration: 185.86591ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:19:53.82707Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.612485ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-07T03:19:53.82721Z","caller":"traceutil/trace.go:171","msg":"trace[266646089] linearizableReadLoop","detail":"{readStateIndex:1915; appliedIndex:1914; }","duration":"237.39328ms","start":"2026-05-07T03:19:53.589797Z","end":"2026-05-07T03:19:53.82719Z","steps":["trace[266646089] 'read index received' (duration: 92.204291ms)","trace[266646089] 'applied index is now lower than readState.Index' (duration: 145.187059ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T03:19:53.827245Z","caller":"traceutil/trace.go:171","msg":"trace[168396796] transaction","detail":"{read_only:false; response_revision:1839; number_of_response:1; }","duration":"298.087948ms","start":"2026-05-07T03:19:53.529131Z","end":"2026-05-07T03:19:53.827219Z","steps":["trace[168396796] 'process raft request' (duration: 152.831186ms)","trace[168396796] 'compare' (duration: 144.439138ms)"],"step_count":2} {"level":"warn","ts":"2026-05-07T03:19:53.827491Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.739599ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-d269d531-384e-4b7b-91e5-c29249427b9e\" ","response":"range_response_count:1 size:3627"} {"level":"warn","ts":"2026-05-07T03:19:53.82755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.739554ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-05-07T03:19:53.827603Z","caller":"traceutil/trace.go:171","msg":"trace[362237504] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1839; }","duration":"237.86708ms","start":"2026-05-07T03:19:53.589723Z","end":"2026-05-07T03:19:53.82759Z","steps":["trace[362237504] 'agreement among raft nodes before linearized reading' (duration: 237.575017ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:19:53.827627Z","caller":"traceutil/trace.go:171","msg":"trace[1828473275] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-d269d531-384e-4b7b-91e5-c29249427b9e; range_end:; response_count:1; response_revision:1839; }","duration":"235.883475ms","start":"2026-05-07T03:19:53.591698Z","end":"2026-05-07T03:19:53.827581Z","steps":["trace[1828473275] 'agreement among raft nodes before linearized reading' (duration: 235.658686ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:19:53.979483Z","caller":"traceutil/trace.go:171","msg":"trace[975862069] transaction","detail":"{read_only:false; response_revision:1841; number_of_response:1; }","duration":"144.51667ms","start":"2026-05-07T03:19:53.83494Z","end":"2026-05-07T03:19:53.979456Z","steps":["trace[975862069] 'process raft request' (duration: 97.157032ms)","trace[975862069] 'compare' (duration: 47.026094ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T03:20:28.257795Z","caller":"traceutil/trace.go:171","msg":"trace[447376249] transaction","detail":"{read_only:false; response_revision:2083; number_of_response:1; }","duration":"162.347296ms","start":"2026-05-07T03:20:28.095412Z","end":"2026-05-07T03:20:28.257759Z","steps":["trace[447376249] 'process raft request' (duration: 162.116843ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:20:28.282669Z","caller":"traceutil/trace.go:171","msg":"trace[2060229824] transaction","detail":"{read_only:false; response_revision:2084; number_of_response:1; }","duration":"175.690875ms","start":"2026-05-07T03:20:28.106933Z","end":"2026-05-07T03:20:28.282624Z","steps":["trace[2060229824] 'process raft request' (duration: 175.419699ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:22:11.870695Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.684414ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-07T03:22:11.870805Z","caller":"traceutil/trace.go:171","msg":"trace[793940510] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2749; }","duration":"117.855447ms","start":"2026-05-07T03:22:11.75293Z","end":"2026-05-07T03:22:11.870786Z","steps":["trace[793940510] 'range keys from in-memory index tree' (duration: 117.568056ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:22:11.997905Z","caller":"traceutil/trace.go:171","msg":"trace[1627437006] transaction","detail":"{read_only:false; response_revision:2750; number_of_response:1; }","duration":"121.15688ms","start":"2026-05-07T03:22:11.87673Z","end":"2026-05-07T03:22:11.997887Z","steps":["trace[1627437006] 'process raft request' (duration: 121.0305ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:25:26.784088Z","caller":"traceutil/trace.go:171","msg":"trace[329336936] linearizableReadLoop","detail":"{readStateIndex:4108; appliedIndex:4107; }","duration":"119.086887ms","start":"2026-05-07T03:25:26.664974Z","end":"2026-05-07T03:25:26.78406Z","steps":["trace[329336936] 'read index received' (duration: 118.85894ms)","trace[329336936] 'applied index is now lower than readState.Index' (duration: 226.737µs)"],"step_count":2} {"level":"info","ts":"2026-05-07T03:25:26.784171Z","caller":"traceutil/trace.go:171","msg":"trace[1174223775] transaction","detail":"{read_only:false; response_revision:3942; number_of_response:1; }","duration":"251.152688ms","start":"2026-05-07T03:25:26.533004Z","end":"2026-05-07T03:25:26.784156Z","steps":["trace[1174223775] 'process raft request' (duration: 250.89965ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:25:26.784342Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.351665ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-05-07T03:25:26.784405Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.802877ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-07T03:25:26.78441Z","caller":"traceutil/trace.go:171","msg":"trace[1225548676] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:3942; }","duration":"119.458928ms","start":"2026-05-07T03:25:26.664937Z","end":"2026-05-07T03:25:26.784396Z","steps":["trace[1225548676] 'agreement among raft nodes before linearized reading' (duration: 119.243471ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:25:26.784437Z","caller":"traceutil/trace.go:171","msg":"trace[1746060493] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:3942; }","duration":"118.858809ms","start":"2026-05-07T03:25:26.66557Z","end":"2026-05-07T03:25:26.784429Z","steps":["trace[1746060493] 'agreement among raft nodes before linearized reading' (duration: 118.742365ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:25:57.462679Z","caller":"traceutil/trace.go:171","msg":"trace[1451356911] transaction","detail":"{read_only:false; response_revision:4685; number_of_response:1; }","duration":"138.359199ms","start":"2026-05-07T03:25:57.324291Z","end":"2026-05-07T03:25:57.46265Z","steps":["trace[1451356911] 'process raft request' (duration: 137.624221ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:26:03.805728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.458546ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-07T03:26:03.805883Z","caller":"traceutil/trace.go:171","msg":"trace[913966801] transaction","detail":"{read_only:false; response_revision:4841; number_of_response:1; }","duration":"268.02579ms","start":"2026-05-07T03:26:03.537839Z","end":"2026-05-07T03:26:03.805864Z","steps":["trace[913966801] 'process raft request' (duration: 89.979801ms)","trace[913966801] 'compare' (duration: 177.081851ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T03:27:46.042037Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2930} {"level":"info","ts":"2026-05-07T03:27:46.133931Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2930,"took":"90.41403ms","hash":3218965430,"current-db-size-bytes":54194176,"current-db-size":"54 MB","current-db-size-in-use-bytes":29351936,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-05-07T03:27:46.134022Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3218965430,"revision":2930,"compact-revision":-1} {"level":"warn","ts":"2026-05-07T03:32:36.71545Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.445129ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/envoy-gateway-system/envoy-gateway-gateway-helm-leader-election-role\" ","response":"range_response_count:1 size:1131"} {"level":"info","ts":"2026-05-07T03:32:36.715563Z","caller":"traceutil/trace.go:171","msg":"trace[767129746] range","detail":"{range_begin:/registry/roles/envoy-gateway-system/envoy-gateway-gateway-helm-leader-election-role; range_end:; response_count:1; response_revision:7429; }","duration":"107.627277ms","start":"2026-05-07T03:32:36.607914Z","end":"2026-05-07T03:32:36.715541Z","steps":["trace[767129746] 'range keys from in-memory index tree' (duration: 107.180173ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:32:46.047315Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5680} {"level":"info","ts":"2026-05-07T03:32:46.124456Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5680,"took":"75.925511ms","hash":1376307435,"current-db-size-bytes":54194176,"current-db-size":"54 MB","current-db-size-in-use-bytes":18419712,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-05-07T03:32:46.124509Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1376307435,"revision":5680,"compact-revision":2930}