{"level":"warn","ts":"2026-05-09T05:07:56.231992Z","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-09T05:07:56.232099Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.22: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.22:2380","--initial-cluster=instance=https://199.204.45.22:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.22:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.22: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-09T05:07:56.23221Z","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-09T05:07:56.232228Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.22:2380"]} {"level":"info","ts":"2026-05-09T05:07:56.232254Z","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-09T05:07:56.233154Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.22:2379"]} {"level":"info","ts":"2026-05-09T05:07:56.233264Z","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.22:2380"],"listen-peer-urls":["https://199.204.45.22:2380"],"advertise-client-urls":["https://199.204.45.22:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.22:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.22: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-09T05:07:56.237928Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.40735ms"} {"level":"info","ts":"2026-05-09T05:07:56.24326Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"fed19d9291630e09","cluster-id":"6ebf1e01320cc017"} {"level":"info","ts":"2026-05-09T05:07:56.243371Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 switched to configuration voters=()"} {"level":"info","ts":"2026-05-09T05:07:56.24341Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 became follower at term 0"} {"level":"info","ts":"2026-05-09T05:07:56.243421Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft fed19d9291630e09 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-09T05:07:56.24343Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 became follower at term 1"} {"level":"info","ts":"2026-05-09T05:07:56.243488Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 switched to configuration voters=(18361630408596196873)"} {"level":"warn","ts":"2026-05-09T05:07:56.25202Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-09T05:07:56.254343Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-09T05:07:56.255998Z","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-09T05:07:56.261117Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"fed19d9291630e09","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-09T05:07:56.261266Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"fed19d9291630e09","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-09T05:07:56.261447Z","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-09T05:07:56.26152Z","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-09T05:07:56.261533Z","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-09T05:07:56.262299Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 switched to configuration voters=(18361630408596196873)"} {"level":"info","ts":"2026-05-09T05:07:56.262385Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"6ebf1e01320cc017","local-member-id":"fed19d9291630e09","added-peer-id":"fed19d9291630e09","added-peer-peer-urls":["https://199.204.45.22:2380"]} {"level":"info","ts":"2026-05-09T05:07:56.263838Z","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-09T05:07:56.264029Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.22:2380"} {"level":"info","ts":"2026-05-09T05:07:56.264087Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-09T05:07:56.264089Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.22:2380"} {"level":"info","ts":"2026-05-09T05:07:56.26405Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"fed19d9291630e09","initial-advertise-peer-urls":["https://199.204.45.22:2380"],"listen-peer-urls":["https://199.204.45.22:2380"],"advertise-client-urls":["https://199.204.45.22:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.22:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-09T05:07:56.444587Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 is starting a new election at term 1"} {"level":"info","ts":"2026-05-09T05:07:56.444656Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-09T05:07:56.444704Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 received MsgPreVoteResp from fed19d9291630e09 at term 1"} {"level":"info","ts":"2026-05-09T05:07:56.444726Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 became candidate at term 2"} {"level":"info","ts":"2026-05-09T05:07:56.444738Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 received MsgVoteResp from fed19d9291630e09 at term 2"} {"level":"info","ts":"2026-05-09T05:07:56.444756Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 became leader at term 2"} {"level":"info","ts":"2026-05-09T05:07:56.44477Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: fed19d9291630e09 elected leader fed19d9291630e09 at term 2"} {"level":"info","ts":"2026-05-09T05:07:56.459153Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"fed19d9291630e09","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.22:2379]}","request-path":"/0/members/fed19d9291630e09/attributes","cluster-id":"6ebf1e01320cc017","publish-timeout":"7s"} {"level":"info","ts":"2026-05-09T05:07:56.45935Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-09T05:07:56.459392Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-09T05:07:56.459487Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-09T05:07:56.459323Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-09T05:07:56.459549Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-09T05:07:56.461236Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-09T05:07:56.466964Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"6ebf1e01320cc017","local-member-id":"fed19d9291630e09","cluster-version":"3.5"} {"level":"info","ts":"2026-05-09T05:07:56.471485Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-09T05:07:56.471559Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-09T05:07:56.47186Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.22:2379"} {"level":"info","ts":"2026-05-09T05:08:28.119412Z","caller":"traceutil/trace.go:171","msg":"trace[1798663889] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"116.653427ms","start":"2026-05-09T05:08:28.002738Z","end":"2026-05-09T05:08:28.119392Z","steps":["trace[1798663889] 'process raft request' (duration: 116.471972ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T05:08:28.23015Z","caller":"traceutil/trace.go:171","msg":"trace[1388611440] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"223.2223ms","start":"2026-05-09T05:08:28.006909Z","end":"2026-05-09T05:08:28.230131Z","steps":["trace[1388611440] 'process raft request' (duration: 214.693009ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T05:08:32.581589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.940065ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-09T05:08:32.581809Z","caller":"traceutil/trace.go:171","msg":"trace[802311388] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"176.522437ms","start":"2026-05-09T05:08:32.405236Z","end":"2026-05-09T05:08:32.581759Z","steps":["trace[802311388] 'process raft request' (duration: 34.75119ms)","trace[802311388] 'compare' (duration: 140.555194ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T05:08:32.881741Z","caller":"traceutil/trace.go:171","msg":"trace[1584256147] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"225.217653ms","start":"2026-05-09T05:08:32.656482Z","end":"2026-05-09T05:08:32.881699Z","steps":["trace[1584256147] 'process raft request' (duration: 138.664981ms)","trace[1584256147] 'compare' (duration: 86.344336ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T05:08:32.888975Z","caller":"traceutil/trace.go:171","msg":"trace[2069786841] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"225.858141ms","start":"2026-05-09T05:08:32.663097Z","end":"2026-05-09T05:08:32.888955Z","steps":["trace[2069786841] 'process raft request' (duration: 225.743158ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T05:08:52.312295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.889996ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-05-09T05:08:52.312386Z","caller":"traceutil/trace.go:171","msg":"trace[1883569255] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:756; }","duration":"140.985518ms","start":"2026-05-09T05:08:52.17138Z","end":"2026-05-09T05:08:52.312366Z","steps":["trace[1883569255] 'range keys from in-memory index tree' (duration: 140.762202ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T05:08:52.31305Z","caller":"traceutil/trace.go:171","msg":"trace[73531244] transaction","detail":"{read_only:false; response_revision:757; number_of_response:1; }","duration":"118.035796ms","start":"2026-05-09T05:08:52.195001Z","end":"2026-05-09T05:08:52.313036Z","steps":["trace[73531244] 'process raft request' (duration: 89.491042ms)","trace[73531244] 'compare' (duration: 27.452787ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T05:10:13.880823Z","caller":"traceutil/trace.go:171","msg":"trace[634896971] transaction","detail":"{read_only:false; response_revision:1842; number_of_response:1; }","duration":"202.443903ms","start":"2026-05-09T05:10:13.678353Z","end":"2026-05-09T05:10:13.880797Z","steps":["trace[634896971] 'process raft request' (duration: 202.291308ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T05:10:14.289313Z","caller":"traceutil/trace.go:171","msg":"trace[186839951] transaction","detail":"{read_only:false; response_revision:1844; number_of_response:1; }","duration":"128.908734ms","start":"2026-05-09T05:10:14.160382Z","end":"2026-05-09T05:10:14.28929Z","steps":["trace[186839951] 'process raft request' (duration: 128.753191ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T05:11:02.737055Z","caller":"traceutil/trace.go:171","msg":"trace[2024900185] transaction","detail":"{read_only:false; response_revision:2154; number_of_response:1; }","duration":"129.580294ms","start":"2026-05-09T05:11:02.607444Z","end":"2026-05-09T05:11:02.737024Z","steps":["trace[2024900185] 'process raft request' (duration: 129.39553ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T05:12:17.25925Z","caller":"traceutil/trace.go:171","msg":"trace[1792210818] transaction","detail":"{read_only:false; response_revision:2668; number_of_response:1; }","duration":"170.739137ms","start":"2026-05-09T05:12:17.088483Z","end":"2026-05-09T05:12:17.259222Z","steps":["trace[1792210818] 'process raft request' (duration: 170.553093ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T05:12:17.387329Z","caller":"traceutil/trace.go:171","msg":"trace[1147940525] linearizableReadLoop","detail":"{readStateIndex:2768; appliedIndex:2767; }","duration":"118.14766ms","start":"2026-05-09T05:12:17.269156Z","end":"2026-05-09T05:12:17.387304Z","steps":["trace[1147940525] 'read index received' (duration: 32.887735ms)","trace[1147940525] 'applied index is now lower than readState.Index' (duration: 85.258855ms)"],"step_count":2} {"level":"warn","ts":"2026-05-09T05:12:17.38755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.378576ms","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-09T05:12:17.387591Z","caller":"traceutil/trace.go:171","msg":"trace[1245673803] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2669; }","duration":"118.467218ms","start":"2026-05-09T05:12:17.269114Z","end":"2026-05-09T05:12:17.387581Z","steps":["trace[1245673803] 'agreement among raft nodes before linearized reading' (duration: 118.317515ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T05:12:17.387636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.517058ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-05-09T05:12:17.387705Z","caller":"traceutil/trace.go:171","msg":"trace[1073167834] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2669; }","duration":"111.59624ms","start":"2026-05-09T05:12:17.276093Z","end":"2026-05-09T05:12:17.387689Z","steps":["trace[1073167834] 'agreement among raft nodes before linearized reading' (duration: 111.394835ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T05:12:17.388037Z","caller":"traceutil/trace.go:171","msg":"trace[443726594] transaction","detail":"{read_only:false; response_revision:2669; number_of_response:1; }","duration":"231.187144ms","start":"2026-05-09T05:12:17.156813Z","end":"2026-05-09T05:12:17.388Z","steps":["trace[443726594] 'process raft request' (duration: 145.286793ms)","trace[443726594] 'compare' (duration: 85.096222ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T05:12:22.630855Z","caller":"traceutil/trace.go:171","msg":"trace[1778301838] transaction","detail":"{read_only:false; response_revision:2697; number_of_response:1; }","duration":"175.076814ms","start":"2026-05-09T05:12:22.455695Z","end":"2026-05-09T05:12:22.630772Z","steps":["trace[1778301838] 'process raft request' (duration: 174.316297ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T05:16:03.155384Z","caller":"traceutil/trace.go:171","msg":"trace[1657682047] linearizableReadLoop","detail":"{readStateIndex:4716; appliedIndex:4715; }","duration":"111.0681ms","start":"2026-05-09T05:16:03.044292Z","end":"2026-05-09T05:16:03.15536Z","steps":["trace[1657682047] 'read index received' (duration: 110.873715ms)","trace[1657682047] 'applied index is now lower than readState.Index' (duration: 193.185µs)"],"step_count":2} {"level":"info","ts":"2026-05-09T05:16:03.155479Z","caller":"traceutil/trace.go:171","msg":"trace[1079909543] transaction","detail":"{read_only:false; response_revision:4543; number_of_response:1; }","duration":"112.99327ms","start":"2026-05-09T05:16:03.042459Z","end":"2026-05-09T05:16:03.155452Z","steps":["trace[1079909543] 'process raft request' (duration: 112.725884ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T05:16:03.156293Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.972948ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2195922"} {"level":"info","ts":"2026-05-09T05:16:03.156348Z","caller":"traceutil/trace.go:171","msg":"trace[502724915] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:4543; }","duration":"112.069701ms","start":"2026-05-09T05:16:03.044266Z","end":"2026-05-09T05:16:03.156335Z","steps":["trace[502724915] 'agreement among raft nodes before linearized reading' (duration: 111.193893ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T05:16:03.298363Z","caller":"traceutil/trace.go:171","msg":"trace[1817463652] linearizableReadLoop","detail":"{readStateIndex:4718; appliedIndex:4717; }","duration":"104.357275ms","start":"2026-05-09T05:16:03.19398Z","end":"2026-05-09T05:16:03.298338Z","steps":["trace[1817463652] 'read index received' (duration: 97.22376ms)","trace[1817463652] 'applied index is now lower than readState.Index' (duration: 7.132165ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T05:16:03.298447Z","caller":"traceutil/trace.go:171","msg":"trace[1860140790] transaction","detail":"{read_only:false; response_revision:4545; number_of_response:1; }","duration":"107.892286ms","start":"2026-05-09T05:16:03.190539Z","end":"2026-05-09T05:16:03.298431Z","steps":["trace[1860140790] 'process raft request' (duration: 100.740831ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T05:16:03.298693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.693262ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1817"} {"level":"info","ts":"2026-05-09T05:16:03.298742Z","caller":"traceutil/trace.go:171","msg":"trace[1744038639] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:4545; }","duration":"104.782584ms","start":"2026-05-09T05:16:03.193945Z","end":"2026-05-09T05:16:03.298728Z","steps":["trace[1744038639] 'agreement among raft nodes before linearized reading' (duration: 104.539269ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T05:16:09.162093Z","caller":"traceutil/trace.go:171","msg":"trace[1244019899] linearizableReadLoop","detail":"{readStateIndex:4804; appliedIndex:4803; }","duration":"176.154645ms","start":"2026-05-09T05:16:08.985913Z","end":"2026-05-09T05:16:09.162067Z","steps":["trace[1244019899] 'read index received' (duration: 36.990729ms)","trace[1244019899] 'applied index is now lower than readState.Index' (duration: 139.162796ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T05:16:09.162122Z","caller":"traceutil/trace.go:171","msg":"trace[825284061] transaction","detail":"{read_only:false; response_revision:4630; number_of_response:1; }","duration":"178.451192ms","start":"2026-05-09T05:16:08.983643Z","end":"2026-05-09T05:16:09.162094Z","steps":["trace[825284061] 'process raft request' (duration: 174.685675ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T05:16:09.162432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.502742ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-0\" ","response":"range_response_count:1 size:650"} {"level":"info","ts":"2026-05-09T05:16:09.162467Z","caller":"traceutil/trace.go:171","msg":"trace[1621196647] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-0; range_end:; response_count:1; response_revision:4630; }","duration":"176.568233ms","start":"2026-05-09T05:16:08.985887Z","end":"2026-05-09T05:16:09.162456Z","steps":["trace[1621196647] 'agreement among raft nodes before linearized reading' (duration: 176.310838ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T05:16:09.162603Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.605095ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" ","response":"range_response_count:72 size:60099"} {"level":"info","ts":"2026-05-09T05:16:09.162657Z","caller":"traceutil/trace.go:171","msg":"trace[913798124] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:72; response_revision:4630; }","duration":"136.707177ms","start":"2026-05-09T05:16:09.025938Z","end":"2026-05-09T05:16:09.162646Z","steps":["trace[913798124] 'agreement among raft nodes before linearized reading' (duration: 136.283158ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T05:16:09.291676Z","caller":"traceutil/trace.go:171","msg":"trace[1133422906] linearizableReadLoop","detail":"{readStateIndex:4805; appliedIndex:4804; }","duration":"123.946928ms","start":"2026-05-09T05:16:09.167706Z","end":"2026-05-09T05:16:09.291653Z","steps":["trace[1133422906] 'read index received' (duration: 101.697198ms)","trace[1133422906] 'applied index is now lower than readState.Index' (duration: 22.24876ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T05:16:09.291755Z","caller":"traceutil/trace.go:171","msg":"trace[1380099004] transaction","detail":"{read_only:false; response_revision:4631; number_of_response:1; }","duration":"126.269635ms","start":"2026-05-09T05:16:09.16546Z","end":"2026-05-09T05:16:09.29173Z","steps":["trace[1380099004] 'process raft request' (duration: 103.995974ms)","trace[1380099004] 'compare' (duration: 22.073317ms)"],"step_count":2} {"level":"warn","ts":"2026-05-09T05:16:09.291817Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.098651ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:basic-user\" ","response":"range_response_count:1 size:678"} {"level":"info","ts":"2026-05-09T05:16:09.29184Z","caller":"traceutil/trace.go:171","msg":"trace[1006080209] range","detail":"{range_begin:/registry/clusterroles/system:basic-user; range_end:; response_count:1; response_revision:4631; }","duration":"124.153802ms","start":"2026-05-09T05:16:09.16768Z","end":"2026-05-09T05:16:09.291834Z","steps":["trace[1006080209] 'agreement among raft nodes before linearized reading' (duration: 124.06766ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T05:16:09.303737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.880959ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-1\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T05:16:09.303792Z","caller":"traceutil/trace.go:171","msg":"trace[1264694757] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-1; range_end:; response_count:0; response_revision:4632; }","duration":"134.968691ms","start":"2026-05-09T05:16:09.16881Z","end":"2026-05-09T05:16:09.303778Z","steps":["trace[1264694757] 'agreement among raft nodes before linearized reading' (duration: 134.89008ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T05:16:09.304195Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.519511ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2195922"} {"level":"info","ts":"2026-05-09T05:16:09.304302Z","caller":"traceutil/trace.go:171","msg":"trace[1604306519] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:4632; }","duration":"133.643175ms","start":"2026-05-09T05:16:09.170643Z","end":"2026-05-09T05:16:09.304287Z","steps":["trace[1604306519] 'agreement among raft nodes before linearized reading' (duration: 132.650885ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T05:16:09.625903Z","caller":"traceutil/trace.go:171","msg":"trace[1052005960] linearizableReadLoop","detail":"{readStateIndex:4812; appliedIndex:4811; }","duration":"146.847041ms","start":"2026-05-09T05:16:09.479029Z","end":"2026-05-09T05:16:09.625876Z","steps":["trace[1052005960] 'read index received' (duration: 63.622898ms)","trace[1052005960] 'applied index is now lower than readState.Index' (duration: 83.223193ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T05:16:09.625985Z","caller":"traceutil/trace.go:171","msg":"trace[566165329] transaction","detail":"{read_only:false; response_revision:4638; number_of_response:1; }","duration":"147.369112ms","start":"2026-05-09T05:16:09.47858Z","end":"2026-05-09T05:16:09.625949Z","steps":["trace[566165329] 'process raft request' (duration: 64.106547ms)","trace[566165329] 'compare' (duration: 83.03199ms)"],"step_count":2} {"level":"warn","ts":"2026-05-09T05:16:09.626218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.157787ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:3506"} {"level":"warn","ts":"2026-05-09T05:16:09.626288Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.237438ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated\" ","response":"range_response_count:1 size:1131"} {"level":"info","ts":"2026-05-09T05:16:09.626304Z","caller":"traceutil/trace.go:171","msg":"trace[1484786065] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:4638; }","duration":"147.271039ms","start":"2026-05-09T05:16:09.47901Z","end":"2026-05-09T05:16:09.626281Z","steps":["trace[1484786065] 'agreement among raft nodes before linearized reading' (duration: 146.984574ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T05:16:09.626148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.591015ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T05:16:09.626357Z","caller":"traceutil/trace.go:171","msg":"trace[1557213658] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated; range_end:; response_count:1; response_revision:4638; }","duration":"144.303289ms","start":"2026-05-09T05:16:09.482033Z","end":"2026-05-09T05:16:09.626336Z","steps":["trace[1557213658] 'agreement among raft nodes before linearized reading' (duration: 144.139836ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T05:16:09.626481Z","caller":"traceutil/trace.go:171","msg":"trace[2141990678] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:0; response_revision:4638; }","duration":"144.969954ms","start":"2026-05-09T05:16:09.481488Z","end":"2026-05-09T05:16:09.626458Z","steps":["trace[2141990678] 'agreement among raft nodes before linearized reading' (duration: 144.545184ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T05:16:09.81712Z","caller":"traceutil/trace.go:171","msg":"trace[1388326713] linearizableReadLoop","detail":"{readStateIndex:4815; appliedIndex:4813; }","duration":"141.459583ms","start":"2026-05-09T05:16:09.675631Z","end":"2026-05-09T05:16:09.81709Z","steps":["trace[1388326713] 'read index received' (duration: 41.171503ms)","trace[1388326713] 'applied index is now lower than readState.Index' (duration: 100.286969ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T05:16:09.817266Z","caller":"traceutil/trace.go:171","msg":"trace[1064296418] transaction","detail":"{read_only:false; response_revision:4642; number_of_response:1; }","duration":"130.988181ms","start":"2026-05-09T05:16:09.686262Z","end":"2026-05-09T05:16:09.81725Z","steps":["trace[1064296418] 'process raft request' (duration: 130.755756ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T05:16:09.817272Z","caller":"traceutil/trace.go:171","msg":"trace[2109272906] transaction","detail":"{read_only:false; response_revision:4641; number_of_response:1; }","duration":"141.866771ms","start":"2026-05-09T05:16:09.675356Z","end":"2026-05-09T05:16:09.817223Z","steps":["trace[2109272906] 'process raft request' (duration: 141.516643ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T05:16:09.817432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.750949ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-1\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T05:16:09.817499Z","caller":"traceutil/trace.go:171","msg":"trace[106748648] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-1; range_end:; response_count:0; response_revision:4642; }","duration":"141.880841ms","start":"2026-05-09T05:16:09.675599Z","end":"2026-05-09T05:16:09.81748Z","steps":["trace[106748648] 'agreement among raft nodes before linearized reading' (duration: 141.717408ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T05:16:09.817473Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.502253ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config\" ","response":"range_response_count:1 size:708"} {"level":"info","ts":"2026-05-09T05:16:09.817599Z","caller":"traceutil/trace.go:171","msg":"trace[116462470] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config; range_end:; response_count:1; response_revision:4642; }","duration":"141.658847ms","start":"2026-05-09T05:16:09.675919Z","end":"2026-05-09T05:16:09.817578Z","steps":["trace[116462470] 'agreement among raft nodes before linearized reading' (duration: 141.379932ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T05:16:20.896865Z","caller":"traceutil/trace.go:171","msg":"trace[326981562] transaction","detail":"{read_only:false; response_revision:4838; number_of_response:1; }","duration":"125.063436ms","start":"2026-05-09T05:16:20.771774Z","end":"2026-05-09T05:16:20.896837Z","steps":["trace[326981562] 'process raft request' (duration: 124.890963ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T05:17:56.834568Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2877} {"level":"info","ts":"2026-05-09T05:17:56.908845Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2877,"took":"72.988185ms","hash":3120576870,"current-db-size-bytes":54349824,"current-db-size":"54 MB","current-db-size-in-use-bytes":29433856,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-05-09T05:17:56.90905Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3120576870,"revision":2877,"compact-revision":-1} {"level":"info","ts":"2026-05-09T05:22:56.84027Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5598} {"level":"info","ts":"2026-05-09T05:22:56.908523Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5598,"took":"67.086499ms","hash":3869231566,"current-db-size-bytes":54349824,"current-db-size":"54 MB","current-db-size-in-use-bytes":18153472,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-05-09T05:22:56.908599Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3869231566,"revision":5598,"compact-revision":2877}