{"level":"warn","ts":"2026-08-19T08:59:34.903224Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-19T08:59:34.903305Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.140: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.140:2380","--initial-cluster=instance=https://199.204.45.140:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.140:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.140: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-08-19T08:59:34.903369Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-19T08:59:34.903381Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.140:2380"]} {"level":"info","ts":"2026-08-19T08:59:34.903398Z","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-08-19T08:59:34.904013Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.140:2379"]} {"level":"info","ts":"2026-08-19T08:59:34.904086Z","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.140:2380"],"listen-peer-urls":["https://199.204.45.140:2380"],"advertise-client-urls":["https://199.204.45.140:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.140:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.140: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-08-19T08:59:34.907573Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.274917ms"} {"level":"info","ts":"2026-08-19T08:59:34.915296Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"35b2766da46a76bb","cluster-id":"f5fd3aeb8d9f53dc"} {"level":"info","ts":"2026-08-19T08:59:34.915383Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"35b2766da46a76bb switched to configuration voters=()"} {"level":"info","ts":"2026-08-19T08:59:34.915404Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"35b2766da46a76bb became follower at term 0"} {"level":"info","ts":"2026-08-19T08:59:34.915417Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 35b2766da46a76bb [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-19T08:59:34.915428Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"35b2766da46a76bb became follower at term 1"} {"level":"info","ts":"2026-08-19T08:59:34.915468Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"35b2766da46a76bb switched to configuration voters=(3869285243146630843)"} {"level":"warn","ts":"2026-08-19T08:59:34.923537Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-19T08:59:34.924744Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-19T08:59:34.925857Z","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-08-19T08:59:34.928106Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"35b2766da46a76bb","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-19T08:59:34.928341Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"35b2766da46a76bb","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-19T08:59:34.928388Z","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-08-19T08:59:34.928558Z","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-08-19T08:59:34.928634Z","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-08-19T08:59:34.929032Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"35b2766da46a76bb switched to configuration voters=(3869285243146630843)"} {"level":"info","ts":"2026-08-19T08:59:34.929208Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"f5fd3aeb8d9f53dc","local-member-id":"35b2766da46a76bb","added-peer-id":"35b2766da46a76bb","added-peer-peer-urls":["https://199.204.45.140:2380"]} {"level":"info","ts":"2026-08-19T08:59:34.931665Z","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-08-19T08:59:34.931837Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"35b2766da46a76bb","initial-advertise-peer-urls":["https://199.204.45.140:2380"],"listen-peer-urls":["https://199.204.45.140:2380"],"advertise-client-urls":["https://199.204.45.140:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.140:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-19T08:59:34.931862Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-19T08:59:34.93191Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.140:2380"} {"level":"info","ts":"2026-08-19T08:59:34.931919Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.140:2380"} {"level":"info","ts":"2026-08-19T08:59:35.515859Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"35b2766da46a76bb is starting a new election at term 1"} {"level":"info","ts":"2026-08-19T08:59:35.515924Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"35b2766da46a76bb became pre-candidate at term 1"} {"level":"info","ts":"2026-08-19T08:59:35.515975Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"35b2766da46a76bb received MsgPreVoteResp from 35b2766da46a76bb at term 1"} {"level":"info","ts":"2026-08-19T08:59:35.516001Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"35b2766da46a76bb became candidate at term 2"} {"level":"info","ts":"2026-08-19T08:59:35.516013Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"35b2766da46a76bb received MsgVoteResp from 35b2766da46a76bb at term 2"} {"level":"info","ts":"2026-08-19T08:59:35.516038Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"35b2766da46a76bb became leader at term 2"} {"level":"info","ts":"2026-08-19T08:59:35.516057Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 35b2766da46a76bb elected leader 35b2766da46a76bb at term 2"} {"level":"info","ts":"2026-08-19T08:59:35.516986Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-19T08:59:35.517937Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-19T08:59:35.517958Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"35b2766da46a76bb","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.140:2379]}","request-path":"/0/members/35b2766da46a76bb/attributes","cluster-id":"f5fd3aeb8d9f53dc","publish-timeout":"7s"} {"level":"info","ts":"2026-08-19T08:59:35.518042Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-19T08:59:35.518347Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-19T08:59:35.518365Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-19T08:59:35.51842Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"f5fd3aeb8d9f53dc","local-member-id":"35b2766da46a76bb","cluster-version":"3.5"} {"level":"info","ts":"2026-08-19T08:59:35.518485Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-19T08:59:35.518514Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-08-19T08:59:35.520494Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.140:2379"} {"level":"info","ts":"2026-08-19T08:59:35.521258Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-08-19T08:59:58.233386Z","caller":"traceutil/trace.go:171","msg":"trace[1068404140] transaction","detail":"{read_only:false; response_revision:433; number_of_response:1; }","duration":"157.515454ms","start":"2026-08-19T08:59:58.075847Z","end":"2026-08-19T08:59:58.233363Z","steps":["trace[1068404140] 'process raft request' (duration: 157.359241ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T08:59:58.591766Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.63303ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-08-19T08:59:58.591716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.620182ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-19T08:59:58.591843Z","caller":"traceutil/trace.go:171","msg":"trace[174167123] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:433; }","duration":"200.788033ms","start":"2026-08-19T08:59:58.391039Z","end":"2026-08-19T08:59:58.591827Z","steps":["trace[174167123] 'range keys from in-memory index tree' (duration: 200.547489ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T08:59:58.591856Z","caller":"traceutil/trace.go:171","msg":"trace[78436417] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:433; }","duration":"244.811996ms","start":"2026-08-19T08:59:58.347026Z","end":"2026-08-19T08:59:58.591838Z","steps":["trace[78436417] 'range keys from in-memory index tree' (duration: 244.524061ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T08:59:58.731105Z","caller":"traceutil/trace.go:171","msg":"trace[1340052705] linearizableReadLoop","detail":"{readStateIndex:446; appliedIndex:446; }","duration":"135.71071ms","start":"2026-08-19T08:59:58.595347Z","end":"2026-08-19T08:59:58.731058Z","steps":["trace[1340052705] 'read index received' (duration: 135.700379ms)","trace[1340052705] 'applied index is now lower than readState.Index' (duration: 8.451µs)"],"step_count":2} {"level":"warn","ts":"2026-08-19T08:59:58.731199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.837862ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-19T08:59:58.731261Z","caller":"traceutil/trace.go:171","msg":"trace[44127948] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:433; }","duration":"135.903563ms","start":"2026-08-19T08:59:58.595338Z","end":"2026-08-19T08:59:58.731241Z","steps":["trace[44127948] 'agreement among raft nodes before linearized reading' (duration: 135.801741ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T08:59:58.784343Z","caller":"traceutil/trace.go:171","msg":"trace[995845324] transaction","detail":"{read_only:false; response_revision:434; number_of_response:1; }","duration":"186.64962ms","start":"2026-08-19T08:59:58.597673Z","end":"2026-08-19T08:59:58.784323Z","steps":["trace[995845324] 'process raft request' (duration: 186.399916ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T09:00:12.733119Z","caller":"traceutil/trace.go:171","msg":"trace[631865535] transaction","detail":"{read_only:false; response_revision:567; number_of_response:1; }","duration":"103.70196ms","start":"2026-08-19T09:00:12.62939Z","end":"2026-08-19T09:00:12.733092Z","steps":["trace[631865535] 'process raft request' (duration: 91.072492ms)","trace[631865535] 'compare' (duration: 12.359573ms)"],"step_count":2} {"level":"info","ts":"2026-08-19T09:00:19.021544Z","caller":"traceutil/trace.go:171","msg":"trace[1111382884] linearizableReadLoop","detail":"{readStateIndex:660; appliedIndex:659; }","duration":"107.470699ms","start":"2026-08-19T09:00:18.91403Z","end":"2026-08-19T09:00:19.0215Z","steps":["trace[1111382884] 'read index received' (duration: 43.941103ms)","trace[1111382884] 'applied index is now lower than readState.Index' (duration: 63.527526ms)"],"step_count":2} {"level":"info","ts":"2026-08-19T09:00:19.021631Z","caller":"traceutil/trace.go:171","msg":"trace[818838189] transaction","detail":"{read_only:false; response_revision:638; number_of_response:1; }","duration":"256.426325ms","start":"2026-08-19T09:00:18.765125Z","end":"2026-08-19T09:00:19.021551Z","steps":["trace[818838189] 'process raft request' (duration: 192.853798ms)","trace[818838189] 'compare' (duration: 63.211041ms)"],"step_count":2} {"level":"warn","ts":"2026-08-19T09:00:19.022042Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.987887ms","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-08-19T09:00:19.022201Z","caller":"traceutil/trace.go:171","msg":"trace[1822475464] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:638; }","duration":"108.204161ms","start":"2026-08-19T09:00:18.913967Z","end":"2026-08-19T09:00:19.022171Z","steps":["trace[1822475464] 'agreement among raft nodes before linearized reading' (duration: 107.686152ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T09:00:19.502604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.632673ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-mrnth\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-08-19T09:00:19.502667Z","caller":"traceutil/trace.go:171","msg":"trace[1609951742] range","detail":"{range_begin:/registry/pods/kube-system/cilium-mrnth; range_end:; response_count:1; response_revision:640; }","duration":"205.748455ms","start":"2026-08-19T09:00:19.296907Z","end":"2026-08-19T09:00:19.502656Z","steps":["trace[1609951742] 'range keys from in-memory index tree' (duration: 205.333429ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T09:00:34.690996Z","caller":"traceutil/trace.go:171","msg":"trace[2051913765] transaction","detail":"{read_only:false; response_revision:801; number_of_response:1; }","duration":"165.040979ms","start":"2026-08-19T09:00:34.5259Z","end":"2026-08-19T09:00:34.690941Z","steps":["trace[2051913765] 'process raft request' (duration: 137.679909ms)","trace[2051913765] 'compare' (duration: 27.203988ms)"],"step_count":2} {"level":"info","ts":"2026-08-19T09:00:43.648692Z","caller":"traceutil/trace.go:171","msg":"trace[417838994] transaction","detail":"{read_only:false; response_revision:905; number_of_response:1; }","duration":"104.329789ms","start":"2026-08-19T09:00:43.54433Z","end":"2026-08-19T09:00:43.64866Z","steps":["trace[417838994] 'process raft request' (duration: 85.962794ms)","trace[417838994] 'compare' (duration: 18.222212ms)"],"step_count":2} {"level":"info","ts":"2026-08-19T09:01:05.097006Z","caller":"traceutil/trace.go:171","msg":"trace[2111532228] linearizableReadLoop","detail":"{readStateIndex:1240; appliedIndex:1239; }","duration":"117.871633ms","start":"2026-08-19T09:01:04.979098Z","end":"2026-08-19T09:01:05.09697Z","steps":["trace[2111532228] 'read index received' (duration: 117.631071ms)","trace[2111532228] 'applied index is now lower than readState.Index' (duration: 238.872µs)"],"step_count":2} {"level":"info","ts":"2026-08-19T09:01:05.097125Z","caller":"traceutil/trace.go:171","msg":"trace[2083840395] transaction","detail":"{read_only:false; response_revision:1205; number_of_response:1; }","duration":"177.445105ms","start":"2026-08-19T09:01:04.919637Z","end":"2026-08-19T09:01:05.097082Z","steps":["trace[2083840395] 'process raft request' (duration: 177.105541ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T09:01:05.097523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.370679ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-08-19T09:01:05.097581Z","caller":"traceutil/trace.go:171","msg":"trace[41315709] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1205; }","duration":"118.533211ms","start":"2026-08-19T09:01:04.979034Z","end":"2026-08-19T09:01:05.097568Z","steps":["trace[41315709] 'agreement among raft nodes before linearized reading' (duration: 118.108606ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T09:01:50.86247Z","caller":"traceutil/trace.go:171","msg":"trace[2046310040] transaction","detail":"{read_only:false; response_revision:1872; number_of_response:1; }","duration":"121.351065ms","start":"2026-08-19T09:01:50.741094Z","end":"2026-08-19T09:01:50.862445Z","steps":["trace[2046310040] 'process raft request' (duration: 120.797969ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T09:02:25.755345Z","caller":"traceutil/trace.go:171","msg":"trace[931225457] transaction","detail":"{read_only:false; response_revision:2109; number_of_response:1; }","duration":"145.505029ms","start":"2026-08-19T09:02:25.609821Z","end":"2026-08-19T09:02:25.755326Z","steps":["trace[931225457] 'process raft request' (duration: 145.334628ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T09:02:25.931109Z","caller":"traceutil/trace.go:171","msg":"trace[1942707640] transaction","detail":"{read_only:false; response_revision:2112; number_of_response:1; }","duration":"102.397603ms","start":"2026-08-19T09:02:25.828685Z","end":"2026-08-19T09:02:25.931083Z","steps":["trace[1942707640] 'process raft request' (duration: 102.346082ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T09:02:25.931414Z","caller":"traceutil/trace.go:171","msg":"trace[545468241] transaction","detail":"{read_only:false; response_revision:2111; number_of_response:1; }","duration":"171.710883ms","start":"2026-08-19T09:02:25.759674Z","end":"2026-08-19T09:02:25.931385Z","steps":["trace[545468241] 'process raft request' (duration: 97.186119ms)","trace[545468241] 'compare' (duration: 74.043168ms)"],"step_count":2} {"level":"info","ts":"2026-08-19T09:02:26.117023Z","caller":"traceutil/trace.go:171","msg":"trace[534279341] transaction","detail":"{read_only:false; response_revision:2113; number_of_response:1; }","duration":"144.614499ms","start":"2026-08-19T09:02:25.97238Z","end":"2026-08-19T09:02:26.116995Z","steps":["trace[534279341] 'process raft request' (duration: 114.908551ms)","trace[534279341] 'compare' (duration: 29.453086ms)"],"step_count":2} {"level":"info","ts":"2026-08-19T09:02:26.117085Z","caller":"traceutil/trace.go:171","msg":"trace[344867212] transaction","detail":"{read_only:false; response_revision:2114; number_of_response:1; }","duration":"138.378595ms","start":"2026-08-19T09:02:25.978681Z","end":"2026-08-19T09:02:26.11706Z","steps":["trace[344867212] 'process raft request' (duration: 138.280884ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T09:02:26.640592Z","caller":"traceutil/trace.go:171","msg":"trace[1808194769] linearizableReadLoop","detail":"{readStateIndex:2194; appliedIndex:2193; }","duration":"106.173521ms","start":"2026-08-19T09:02:26.534389Z","end":"2026-08-19T09:02:26.640562Z","steps":["trace[1808194769] 'read index received' (duration: 105.934878ms)","trace[1808194769] 'applied index is now lower than readState.Index' (duration: 237.133µs)"],"step_count":2} {"level":"info","ts":"2026-08-19T09:02:26.640665Z","caller":"traceutil/trace.go:171","msg":"trace[416461140] transaction","detail":"{read_only:false; response_revision:2115; number_of_response:1; }","duration":"132.394232ms","start":"2026-08-19T09:02:26.508236Z","end":"2026-08-19T09:02:26.64063Z","steps":["trace[416461140] 'process raft request' (duration: 132.12944ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T09:02:26.640796Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.376913ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-19T09:02:26.640883Z","caller":"traceutil/trace.go:171","msg":"trace[865409552] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:2115; }","duration":"106.510134ms","start":"2026-08-19T09:02:26.534353Z","end":"2026-08-19T09:02:26.640863Z","steps":["trace[865409552] 'agreement among raft nodes before linearized reading' (duration: 106.352452ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T09:02:26.750495Z","caller":"traceutil/trace.go:171","msg":"trace[576112737] transaction","detail":"{read_only:false; response_revision:2116; number_of_response:1; }","duration":"104.653514ms","start":"2026-08-19T09:02:26.645801Z","end":"2026-08-19T09:02:26.750454Z","steps":["trace[576112737] 'process raft request' (duration: 42.900364ms)","trace[576112737] 'compare' (duration: 61.505808ms)"],"step_count":2} {"level":"info","ts":"2026-08-19T09:02:26.750682Z","caller":"traceutil/trace.go:171","msg":"trace[631135308] transaction","detail":"{read_only:false; response_revision:2117; number_of_response:1; }","duration":"103.626474ms","start":"2026-08-19T09:02:26.647012Z","end":"2026-08-19T09:02:26.750638Z","steps":["trace[631135308] 'process raft request' (duration: 103.363531ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T09:04:07.460065Z","caller":"traceutil/trace.go:171","msg":"trace[1365945344] transaction","detail":"{read_only:false; response_revision:2759; number_of_response:1; }","duration":"172.571649ms","start":"2026-08-19T09:04:07.287465Z","end":"2026-08-19T09:04:07.460036Z","steps":["trace[1365945344] 'process raft request' (duration: 104.782801ms)","trace[1365945344] 'compare' (duration: 67.471041ms)"],"step_count":2} {"level":"info","ts":"2026-08-19T09:04:07.460189Z","caller":"traceutil/trace.go:171","msg":"trace[1045276530] linearizableReadLoop","detail":"{readStateIndex:2862; appliedIndex:2860; }","duration":"113.033702ms","start":"2026-08-19T09:04:07.347135Z","end":"2026-08-19T09:04:07.460169Z","steps":["trace[1045276530] 'read index received' (duration: 45.06952ms)","trace[1045276530] 'applied index is now lower than readState.Index' (duration: 67.962902ms)"],"step_count":2} {"level":"warn","ts":"2026-08-19T09:04:07.460302Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.148684ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-19T09:04:07.460334Z","caller":"traceutil/trace.go:171","msg":"trace[1246172138] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2760; }","duration":"113.254436ms","start":"2026-08-19T09:04:07.347069Z","end":"2026-08-19T09:04:07.460323Z","steps":["trace[1246172138] 'agreement among raft nodes before linearized reading' (duration: 113.183365ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T09:04:07.460298Z","caller":"traceutil/trace.go:171","msg":"trace[1908256376] transaction","detail":"{read_only:false; response_revision:2760; number_of_response:1; }","duration":"172.16858ms","start":"2026-08-19T09:04:07.288074Z","end":"2026-08-19T09:04:07.460242Z","steps":["trace[1908256376] 'process raft request' (duration: 171.877574ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T09:08:08.563362Z","caller":"traceutil/trace.go:171","msg":"trace[1547323864] transaction","detail":"{read_only:false; response_revision:4882; number_of_response:1; }","duration":"108.343259ms","start":"2026-08-19T09:08:08.454935Z","end":"2026-08-19T09:08:08.563278Z","steps":["trace[1547323864] 'process raft request' (duration: 108.126746ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T09:08:08.709145Z","caller":"traceutil/trace.go:171","msg":"trace[45155168] linearizableReadLoop","detail":"{readStateIndex:5063; appliedIndex:5062; }","duration":"125.055243ms","start":"2026-08-19T09:08:08.584071Z","end":"2026-08-19T09:08:08.709126Z","steps":["trace[45155168] 'read index received' (duration: 124.901561ms)","trace[45155168] 'applied index is now lower than readState.Index' (duration: 153.012µs)"],"step_count":2} {"level":"warn","ts":"2026-08-19T09:08:08.709302Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.221875ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.140\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-08-19T09:08:08.709329Z","caller":"traceutil/trace.go:171","msg":"trace[1349258054] range","detail":"{range_begin:/registry/masterleases/199.204.45.140; range_end:; response_count:1; response_revision:4883; }","duration":"125.289656ms","start":"2026-08-19T09:08:08.584033Z","end":"2026-08-19T09:08:08.709322Z","steps":["trace[1349258054] 'agreement among raft nodes before linearized reading' (duration: 125.178994ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T09:08:08.709395Z","caller":"traceutil/trace.go:171","msg":"trace[1604739014] transaction","detail":"{read_only:false; response_revision:4883; number_of_response:1; }","duration":"140.419748ms","start":"2026-08-19T09:08:08.568785Z","end":"2026-08-19T09:08:08.709204Z","steps":["trace[1604739014] 'process raft request' (duration: 140.221076ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T09:08:08.709524Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.383527ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/monitoring/prometheus-kube-prometheus-stack-prometheus-0-tls\" ","response":"range_response_count:1 size:2319"} {"level":"info","ts":"2026-08-19T09:08:08.709725Z","caller":"traceutil/trace.go:171","msg":"trace[207800972] range","detail":"{range_begin:/registry/cert-manager.io/certificates/monitoring/prometheus-kube-prometheus-stack-prometheus-0-tls; range_end:; response_count:1; response_revision:4883; }","duration":"125.631001ms","start":"2026-08-19T09:08:08.584075Z","end":"2026-08-19T09:08:08.709706Z","steps":["trace[207800972] 'agreement among raft nodes before linearized reading' (duration: 125.236586ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T09:09:35.541092Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2907} {"level":"info","ts":"2026-08-19T09:09:35.62374Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2907,"took":"80.985882ms","hash":2992583680,"current-db-size-bytes":54026240,"current-db-size":"54 MB","current-db-size-in-use-bytes":30179328,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-08-19T09:09:35.624038Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2992583680,"revision":2907,"compact-revision":-1} {"level":"info","ts":"2026-08-19T09:14:35.54709Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5630} {"level":"info","ts":"2026-08-19T09:14:35.624515Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5630,"took":"75.79593ms","hash":2735335301,"current-db-size-bytes":54026240,"current-db-size":"54 MB","current-db-size-in-use-bytes":18513920,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-08-19T09:14:35.624683Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2735335301,"revision":5630,"compact-revision":2907}