{"level":"warn","ts":"2026-09-01T18:19:07.367694Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-01T18:19:07.367772Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.75: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://162.253.55.75:2380","--initial-cluster=instance=https://162.253.55.75:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.75:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.75: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-09-01T18:19:07.367836Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-01T18:19:07.367844Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.75:2380"]} {"level":"info","ts":"2026-09-01T18:19:07.367865Z","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-09-01T18:19:07.36865Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.75:2379"]} {"level":"info","ts":"2026-09-01T18:19:07.368741Z","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://162.253.55.75:2380"],"listen-peer-urls":["https://162.253.55.75:2380"],"advertise-client-urls":["https://162.253.55.75:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.75:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.75: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-09-01T18:19:07.373838Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.817345ms"} {"level":"info","ts":"2026-09-01T18:19:07.38307Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"871515da6373d131","cluster-id":"1ca87f0850671e76"} {"level":"info","ts":"2026-09-01T18:19:07.383138Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"871515da6373d131 switched to configuration voters=()"} {"level":"info","ts":"2026-09-01T18:19:07.383166Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"871515da6373d131 became follower at term 0"} {"level":"info","ts":"2026-09-01T18:19:07.383178Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 871515da6373d131 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-01T18:19:07.383188Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"871515da6373d131 became follower at term 1"} {"level":"info","ts":"2026-09-01T18:19:07.383223Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"871515da6373d131 switched to configuration voters=(9733710197346783537)"} {"level":"warn","ts":"2026-09-01T18:19:07.393206Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-01T18:19:07.39477Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-01T18:19:07.396113Z","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-09-01T18:19:07.398184Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"871515da6373d131","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-01T18:19:07.398384Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"871515da6373d131","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-01T18:19:07.39853Z","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-09-01T18:19:07.398987Z","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-09-01T18:19:07.399011Z","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-09-01T18:19:07.399597Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"871515da6373d131 switched to configuration voters=(9733710197346783537)"} {"level":"info","ts":"2026-09-01T18:19:07.400005Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"1ca87f0850671e76","local-member-id":"871515da6373d131","added-peer-id":"871515da6373d131","added-peer-peer-urls":["https://162.253.55.75:2380"]} {"level":"info","ts":"2026-09-01T18:19:07.402911Z","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-09-01T18:19:07.403005Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.75:2380"} {"level":"info","ts":"2026-09-01T18:19:07.403058Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.75:2380"} {"level":"info","ts":"2026-09-01T18:19:07.40327Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"871515da6373d131","initial-advertise-peer-urls":["https://162.253.55.75:2380"],"listen-peer-urls":["https://162.253.55.75:2380"],"advertise-client-urls":["https://162.253.55.75:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.75:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-01T18:19:07.403337Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-01T18:19:08.18405Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"871515da6373d131 is starting a new election at term 1"} {"level":"info","ts":"2026-09-01T18:19:08.184092Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"871515da6373d131 became pre-candidate at term 1"} {"level":"info","ts":"2026-09-01T18:19:08.184107Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"871515da6373d131 received MsgPreVoteResp from 871515da6373d131 at term 1"} {"level":"info","ts":"2026-09-01T18:19:08.184118Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"871515da6373d131 became candidate at term 2"} {"level":"info","ts":"2026-09-01T18:19:08.184123Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"871515da6373d131 received MsgVoteResp from 871515da6373d131 at term 2"} {"level":"info","ts":"2026-09-01T18:19:08.184131Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"871515da6373d131 became leader at term 2"} {"level":"info","ts":"2026-09-01T18:19:08.184137Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 871515da6373d131 elected leader 871515da6373d131 at term 2"} {"level":"info","ts":"2026-09-01T18:19:08.186347Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"871515da6373d131","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.75:2379]}","request-path":"/0/members/871515da6373d131/attributes","cluster-id":"1ca87f0850671e76","publish-timeout":"7s"} {"level":"info","ts":"2026-09-01T18:19:08.186393Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-01T18:19:08.186405Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-01T18:19:08.187721Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"1ca87f0850671e76","local-member-id":"871515da6373d131","cluster-version":"3.5"} {"level":"info","ts":"2026-09-01T18:19:08.187767Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.75:2379"} {"level":"info","ts":"2026-09-01T18:19:08.187821Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-01T18:19:08.187855Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-01T18:19:08.187872Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-01T18:19:08.189179Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-01T18:19:08.18926Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-01T18:19:08.191074Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-01T18:19:47.492732Z","caller":"traceutil/trace.go:171","msg":"trace[1845703123] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"207.135272ms","start":"2026-09-01T18:19:47.285572Z","end":"2026-09-01T18:19:47.492708Z","steps":["trace[1845703123] 'process raft request' (duration: 207.004229ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T18:19:47.50597Z","caller":"traceutil/trace.go:171","msg":"trace[1948890657] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"213.902017ms","start":"2026-09-01T18:19:47.292041Z","end":"2026-09-01T18:19:47.505943Z","steps":["trace[1948890657] 'process raft request' (duration: 213.522798ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T18:19:47.506417Z","caller":"traceutil/trace.go:171","msg":"trace[378870267] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"208.621758ms","start":"2026-09-01T18:19:47.29774Z","end":"2026-09-01T18:19:47.506362Z","steps":["trace[378870267] 'process raft request' (duration: 208.207747ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T18:19:47.50656Z","caller":"traceutil/trace.go:171","msg":"trace[1063234661] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"204.60199ms","start":"2026-09-01T18:19:47.301947Z","end":"2026-09-01T18:19:47.506549Z","steps":["trace[1063234661] 'process raft request' (duration: 204.430286ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T18:19:47.506711Z","caller":"traceutil/trace.go:171","msg":"trace[777205527] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"196.494811ms","start":"2026-09-01T18:19:47.310129Z","end":"2026-09-01T18:19:47.506624Z","steps":["trace[777205527] 'process raft request' (duration: 196.362668ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T18:19:47.506742Z","caller":"traceutil/trace.go:171","msg":"trace[866793539] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"195.494307ms","start":"2026-09-01T18:19:47.311234Z","end":"2026-09-01T18:19:47.506729Z","steps":["trace[866793539] 'process raft request' (duration: 195.367064ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T18:19:47.506499Z","caller":"traceutil/trace.go:171","msg":"trace[850776096] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"207.703675ms","start":"2026-09-01T18:19:47.298772Z","end":"2026-09-01T18:19:47.506476Z","steps":["trace[850776096] 'process raft request' (duration: 207.4749ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T18:19:47.506938Z","caller":"traceutil/trace.go:171","msg":"trace[186607928] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"193.17941ms","start":"2026-09-01T18:19:47.313738Z","end":"2026-09-01T18:19:47.506917Z","steps":["trace[186607928] 'process raft request' (duration: 192.947814ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T18:19:47.507155Z","caller":"traceutil/trace.go:171","msg":"trace[1585386822] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"157.599008ms","start":"2026-09-01T18:19:47.34954Z","end":"2026-09-01T18:19:47.507139Z","steps":["trace[1585386822] 'process raft request' (duration: 157.314251ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T18:19:47.507112Z","caller":"traceutil/trace.go:171","msg":"trace[654328797] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"211.652543ms","start":"2026-09-01T18:19:47.294467Z","end":"2026-09-01T18:19:47.50612Z","steps":["trace[654328797] 'process raft request' (duration: 211.374375ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T18:19:47.507432Z","caller":"traceutil/trace.go:171","msg":"trace[896919771] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"136.206986ms","start":"2026-09-01T18:19:47.371211Z","end":"2026-09-01T18:19:47.507418Z","steps":["trace[896919771] 'process raft request' (duration: 135.894887ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T18:19:47.864409Z","caller":"traceutil/trace.go:171","msg":"trace[1476255406] transaction","detail":"{read_only:false; response_revision:573; number_of_response:1; }","duration":"105.605215ms","start":"2026-09-01T18:19:47.758767Z","end":"2026-09-01T18:19:47.864372Z","steps":["trace[1476255406] 'process raft request' (duration: 105.294027ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T18:19:53.831036Z","caller":"traceutil/trace.go:171","msg":"trace[1940797881] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"133.249813ms","start":"2026-09-01T18:19:53.697738Z","end":"2026-09-01T18:19:53.830987Z","steps":["trace[1940797881] 'process raft request' (duration: 131.176565ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T18:19:54.468317Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.218398ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-01T18:19:54.468451Z","caller":"traceutil/trace.go:171","msg":"trace[91769374] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"495.665898ms","start":"2026-09-01T18:19:53.972767Z","end":"2026-09-01T18:19:54.468433Z","steps":["trace[91769374] 'process raft request' (duration: 310.701594ms)","trace[91769374] 'compare' (duration: 184.044404ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T18:19:54.468539Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T18:19:53.972744Z","time spent":"495.76448ms","remote":"127.0.0.1:52976","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-01T18:19:54.499714Z","caller":"traceutil/trace.go:171","msg":"trace[2020309321] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"526.722017ms","start":"2026-09-01T18:19:53.972968Z","end":"2026-09-01T18:19:54.49969Z","steps":["trace[2020309321] 'process raft request' (duration: 526.574604ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T18:19:54.499862Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T18:19:53.972952Z","time spent":"526.833761ms","remote":"127.0.0.1:52976","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-01T18:19:54.499965Z","caller":"traceutil/trace.go:171","msg":"trace[663846644] linearizableReadLoop","detail":"{readStateIndex:656; appliedIndex:654; }","duration":"464.861059ms","start":"2026-09-01T18:19:54.03509Z","end":"2026-09-01T18:19:54.499951Z","steps":["trace[663846644] 'read index received' (duration: 248.406144ms)","trace[663846644] 'applied index is now lower than readState.Index' (duration: 216.453815ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T18:19:54.500033Z","caller":"traceutil/trace.go:171","msg":"trace[817449290] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"346.200118ms","start":"2026-09-01T18:19:54.153822Z","end":"2026-09-01T18:19:54.500023Z","steps":["trace[817449290] 'process raft request' (duration: 345.820879ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T18:19:54.500094Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T18:19:54.153797Z","time spent":"346.26004ms","remote":"127.0.0.1:52976","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-01T18:19:54.500267Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"465.121534ms","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-09-01T18:19:54.500362Z","caller":"traceutil/trace.go:171","msg":"trace[1094513367] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:631; }","duration":"465.298728ms","start":"2026-09-01T18:19:54.035037Z","end":"2026-09-01T18:19:54.500336Z","steps":["trace[1094513367] 'agreement among raft nodes before linearized reading' (duration: 465.046063ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T18:19:54.500413Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T18:19:54.035017Z","time spent":"465.38455ms","remote":"127.0.0.1:52976","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-09-01T18:19:54.512669Z","caller":"traceutil/trace.go:171","msg":"trace[1103538587] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"166.635396ms","start":"2026-09-01T18:19:54.346017Z","end":"2026-09-01T18:19:54.512652Z","steps":["trace[1103538587] 'process raft request' (duration: 165.892898ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T18:19:54.513176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"326.007516ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-09-01T18:19:54.513257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.226166ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-d28pb\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-09-01T18:19:54.513268Z","caller":"traceutil/trace.go:171","msg":"trace[793416811] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:632; }","duration":"326.199641ms","start":"2026-09-01T18:19:54.187043Z","end":"2026-09-01T18:19:54.513243Z","steps":["trace[793416811] 'agreement among raft nodes before linearized reading' (duration: 325.588127ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T18:19:54.513316Z","caller":"traceutil/trace.go:171","msg":"trace[1444903818] range","detail":"{range_begin:/registry/pods/kube-system/cilium-d28pb; range_end:; response_count:1; response_revision:632; }","duration":"278.304727ms","start":"2026-09-01T18:19:54.234994Z","end":"2026-09-01T18:19:54.513299Z","steps":["trace[1444903818] 'agreement among raft nodes before linearized reading' (duration: 277.818736ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T18:19:54.513317Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T18:19:54.187017Z","time spent":"326.291173ms","remote":"127.0.0.1:52976","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-09-01T18:20:11.596911Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.406099ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-hkzr4\" ","response":"range_response_count:1 size:3964"} {"level":"info","ts":"2026-09-01T18:20:11.597654Z","caller":"traceutil/trace.go:171","msg":"trace[1428174469] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-hkzr4; range_end:; response_count:1; response_revision:808; }","duration":"256.212564ms","start":"2026-09-01T18:20:11.34141Z","end":"2026-09-01T18:20:11.597622Z","steps":["trace[1428174469] 'range keys from in-memory index tree' (duration: 255.157583ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T18:20:11.597162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.456447ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.75\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-09-01T18:20:11.597743Z","caller":"traceutil/trace.go:171","msg":"trace[286342959] range","detail":"{range_begin:/registry/masterleases/162.253.55.75; range_end:; response_count:1; response_revision:808; }","duration":"242.116909ms","start":"2026-09-01T18:20:11.355608Z","end":"2026-09-01T18:20:11.597725Z","steps":["trace[286342959] 'range keys from in-memory index tree' (duration: 241.275013ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T18:21:35.807811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.060512ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-28babca5-22da-4b04-9f31-2c6c46df7e12\" ","response":"range_response_count:1 size:3626"} {"level":"info","ts":"2026-09-01T18:21:35.807909Z","caller":"traceutil/trace.go:171","msg":"trace[1540736016] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-28babca5-22da-4b04-9f31-2c6c46df7e12; range_end:; response_count:1; response_revision:1915; }","duration":"285.190503ms","start":"2026-09-01T18:21:35.522688Z","end":"2026-09-01T18:21:35.807879Z","steps":["trace[1540736016] 'range keys from in-memory index tree' (duration: 284.88517ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T18:21:35.808651Z","caller":"traceutil/trace.go:171","msg":"trace[41351763] transaction","detail":"{read_only:false; response_revision:1916; number_of_response:1; }","duration":"125.099733ms","start":"2026-09-01T18:21:35.683526Z","end":"2026-09-01T18:21:35.808626Z","steps":["trace[41351763] 'process raft request' (duration: 110.213881ms)","trace[41351763] 'compare' (duration: 13.906911ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T18:22:10.845889Z","caller":"traceutil/trace.go:171","msg":"trace[1608532859] transaction","detail":"{read_only:false; response_revision:2153; number_of_response:1; }","duration":"126.474536ms","start":"2026-09-01T18:22:10.719398Z","end":"2026-09-01T18:22:10.845873Z","steps":["trace[1608532859] 'process raft request' (duration: 126.363875ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T18:22:11.179494Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.491998ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-01T18:22:11.179591Z","caller":"traceutil/trace.go:171","msg":"trace[1579795881] linearizableReadLoop","detail":"{readStateIndex:2236; appliedIndex:2235; }","duration":"317.430006ms","start":"2026-09-01T18:22:10.862145Z","end":"2026-09-01T18:22:11.179575Z","steps":["trace[1579795881] 'read index received' (duration: 120.755476ms)","trace[1579795881] 'applied index is now lower than readState.Index' (duration: 196.67349ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T18:22:11.179697Z","caller":"traceutil/trace.go:171","msg":"trace[706172858] transaction","detail":"{read_only:false; response_revision:2154; number_of_response:1; }","duration":"358.572064ms","start":"2026-09-01T18:22:10.821089Z","end":"2026-09-01T18:22:11.179662Z","steps":["trace[706172858] 'process raft request' (duration: 161.814123ms)","trace[706172858] 'compare' (duration: 196.143195ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T18:22:11.179778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.631608ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-01T18:22:11.180076Z","caller":"traceutil/trace.go:171","msg":"trace[600378950] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2154; }","duration":"317.930752ms","start":"2026-09-01T18:22:10.862104Z","end":"2026-09-01T18:22:11.180035Z","steps":["trace[600378950] 'agreement among raft nodes before linearized reading' (duration: 317.645479ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T18:22:11.180017Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T18:22:10.821075Z","time spent":"358.856787ms","remote":"127.0.0.1:52976","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-01T18:22:11.180229Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T18:22:10.862085Z","time spent":"318.081894ms","remote":"127.0.0.1:52716","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-09-01T18:22:11.205032Z","caller":"traceutil/trace.go:171","msg":"trace[615072526] transaction","detail":"{read_only:false; response_revision:2155; number_of_response:1; }","duration":"199.313617ms","start":"2026-09-01T18:22:11.005693Z","end":"2026-09-01T18:22:11.205007Z","steps":["trace[615072526] 'process raft request' (duration: 199.177355ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T18:22:11.210868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.876218ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-controller\" ","response":"range_response_count:1 size:1988"} {"level":"warn","ts":"2026-09-01T18:22:11.210887Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.906804ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-01T18:22:11.210914Z","caller":"traceutil/trace.go:171","msg":"trace[808638854] range","detail":"{range_begin:/registry/services/specs/ingress-nginx/ingress-nginx-controller; range_end:; response_count:1; response_revision:2156; }","duration":"106.96048ms","start":"2026-09-01T18:22:11.103941Z","end":"2026-09-01T18:22:11.210901Z","steps":["trace[808638854] 'agreement among raft nodes before linearized reading' (duration: 106.829977ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T18:22:11.210942Z","caller":"traceutil/trace.go:171","msg":"trace[2089031568] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:2156; }","duration":"330.029067ms","start":"2026-09-01T18:22:10.880897Z","end":"2026-09-01T18:22:11.210926Z","steps":["trace[2089031568] 'agreement among raft nodes before linearized reading' (duration: 329.900795ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T18:22:11.210994Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T18:22:10.880879Z","time spent":"330.104207ms","remote":"127.0.0.1:58018","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"warn","ts":"2026-09-01T18:22:11.211218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.754463ms","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-09-01T18:22:11.211263Z","caller":"traceutil/trace.go:171","msg":"trace[74106710] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2156; }","duration":"301.823834ms","start":"2026-09-01T18:22:10.909426Z","end":"2026-09-01T18:22:11.21125Z","steps":["trace[74106710] 'agreement among raft nodes before linearized reading' (duration: 301.683513ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T18:22:11.211293Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T18:22:10.909413Z","time spent":"301.872964ms","remote":"127.0.0.1:52976","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-09-01T18:22:11.374416Z","caller":"traceutil/trace.go:171","msg":"trace[1046006807] linearizableReadLoop","detail":"{readStateIndex:2240; appliedIndex:2238; }","duration":"150.861854ms","start":"2026-09-01T18:22:11.223519Z","end":"2026-09-01T18:22:11.374381Z","steps":["trace[1046006807] 'read index received' (duration: 16.420819ms)","trace[1046006807] 'applied index is now lower than readState.Index' (duration: 134.439865ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T18:22:11.374491Z","caller":"traceutil/trace.go:171","msg":"trace[505151959] transaction","detail":"{read_only:false; response_revision:2158; number_of_response:1; }","duration":"154.941536ms","start":"2026-09-01T18:22:11.219511Z","end":"2026-09-01T18:22:11.374453Z","steps":["trace[505151959] 'process raft request' (duration: 148.405019ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T18:22:11.374701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.157287ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-09-01T18:22:11.374787Z","caller":"traceutil/trace.go:171","msg":"trace[2144400504] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2158; }","duration":"151.28945ms","start":"2026-09-01T18:22:11.223478Z","end":"2026-09-01T18:22:11.374768Z","steps":["trace[2144400504] 'agreement among raft nodes before linearized reading' (duration: 151.075557ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T18:22:11.375047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.074906ms","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-09-01T18:22:11.375249Z","caller":"traceutil/trace.go:171","msg":"trace[772521467] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2158; }","duration":"148.351049ms","start":"2026-09-01T18:22:11.226883Z","end":"2026-09-01T18:22:11.375234Z","steps":["trace[772521467] 'agreement among raft nodes before linearized reading' (duration: 147.870594ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T18:22:11.37536Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.368879ms","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-09-01T18:22:11.375419Z","caller":"traceutil/trace.go:171","msg":"trace[471555723] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2158; }","duration":"146.45211ms","start":"2026-09-01T18:22:11.228953Z","end":"2026-09-01T18:22:11.375405Z","steps":["trace[471555723] 'agreement among raft nodes before linearized reading' (duration: 146.281618ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T18:23:20.017564Z","caller":"traceutil/trace.go:171","msg":"trace[240738231] linearizableReadLoop","detail":"{readStateIndex:2728; appliedIndex:2727; }","duration":"275.354093ms","start":"2026-09-01T18:23:19.742189Z","end":"2026-09-01T18:23:20.017543Z","steps":["trace[240738231] 'read index received' (duration: 274.273748ms)","trace[240738231] 'applied index is now lower than readState.Index' (duration: 1.079495ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T18:23:20.017589Z","caller":"traceutil/trace.go:171","msg":"trace[595491434] transaction","detail":"{read_only:false; response_revision:2630; number_of_response:1; }","duration":"188.736829ms","start":"2026-09-01T18:23:19.828817Z","end":"2026-09-01T18:23:20.017554Z","steps":["trace[595491434] 'process raft request' (duration: 188.623633ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T18:23:20.017708Z","caller":"traceutil/trace.go:171","msg":"trace[420849385] transaction","detail":"{read_only:false; response_revision:2629; number_of_response:1; }","duration":"302.31566ms","start":"2026-09-01T18:23:19.715369Z","end":"2026-09-01T18:23:20.017685Z","steps":["trace[420849385] 'process raft request' (duration: 301.082548ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T18:23:20.017798Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T18:23:19.715346Z","time spent":"302.386983ms","remote":"127.0.0.1:52976","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":544,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-01T18:23:20.017912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.449626ms","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-09-01T18:23:20.017933Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.731438ms","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-09-01T18:23:20.017968Z","caller":"traceutil/trace.go:171","msg":"trace[1946839663] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2630; }","duration":"270.544039ms","start":"2026-09-01T18:23:19.747412Z","end":"2026-09-01T18:23:20.017956Z","steps":["trace[1946839663] 'agreement among raft nodes before linearized reading' (duration: 270.370532ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T18:23:20.017985Z","caller":"traceutil/trace.go:171","msg":"trace[1676756357] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2630; }","duration":"275.793521ms","start":"2026-09-01T18:23:19.742178Z","end":"2026-09-01T18:23:20.017972Z","steps":["trace[1676756357] 'agreement among raft nodes before linearized reading' (duration: 275.613203ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T18:23:20.018019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.284098ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-01T18:23:20.018049Z","caller":"traceutil/trace.go:171","msg":"trace[95070406] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2630; }","duration":"160.340381ms","start":"2026-09-01T18:23:19.8577Z","end":"2026-09-01T18:23:20.018041Z","steps":["trace[95070406] 'agreement among raft nodes before linearized reading' (duration: 160.301569ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T18:23:20.018109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.455012ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-09-01T18:23:20.017986Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.046353ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12212"} {"level":"info","ts":"2026-09-01T18:23:20.018142Z","caller":"traceutil/trace.go:171","msg":"trace[1438537037] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2630; }","duration":"250.515474ms","start":"2026-09-01T18:23:19.767619Z","end":"2026-09-01T18:23:20.018134Z","steps":["trace[1438537037] 'agreement among raft nodes before linearized reading' (duration: 250.432301ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T18:23:20.018155Z","caller":"traceutil/trace.go:171","msg":"trace[41057829] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2630; }","duration":"231.243151ms","start":"2026-09-01T18:23:19.786903Z","end":"2026-09-01T18:23:20.018146Z","steps":["trace[41057829] 'agreement among raft nodes before linearized reading' (duration: 231.014051ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T18:23:20.018205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.66201ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-09-01T18:23:20.018285Z","caller":"traceutil/trace.go:171","msg":"trace[1690037620] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2630; }","duration":"250.780195ms","start":"2026-09-01T18:23:19.767489Z","end":"2026-09-01T18:23:20.018269Z","steps":["trace[1690037620] 'agreement among raft nodes before linearized reading' (duration: 250.598908ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T18:23:51.384704Z","caller":"traceutil/trace.go:171","msg":"trace[369972921] transaction","detail":"{read_only:false; response_revision:2803; number_of_response:1; }","duration":"126.044194ms","start":"2026-09-01T18:23:51.258623Z","end":"2026-09-01T18:23:51.384667Z","steps":["trace[369972921] 'process raft request' (duration: 125.792366ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T18:23:51.682097Z","caller":"traceutil/trace.go:171","msg":"trace[2096434016] transaction","detail":"{read_only:false; response_revision:2805; number_of_response:1; }","duration":"102.93289ms","start":"2026-09-01T18:23:51.579125Z","end":"2026-09-01T18:23:51.682058Z","steps":["trace[2096434016] 'process raft request' (duration: 43.924886ms)","trace[2096434016] 'compare' (duration: 58.399593ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T18:28:31.538887Z","caller":"traceutil/trace.go:171","msg":"trace[1321925740] transaction","detail":"{read_only:false; response_revision:4964; number_of_response:1; }","duration":"142.647297ms","start":"2026-09-01T18:28:31.396209Z","end":"2026-09-01T18:28:31.538856Z","steps":["trace[1321925740] 'process raft request' (duration: 69.217751ms)","trace[1321925740] 'compare' (duration: 73.235022ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T18:28:35.252406Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.331603ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-01T18:28:35.252655Z","caller":"traceutil/trace.go:171","msg":"trace[1773435916] linearizableReadLoop","detail":"{readStateIndex:5240; appliedIndex:5239; }","duration":"301.779462ms","start":"2026-09-01T18:28:34.950847Z","end":"2026-09-01T18:28:35.252627Z","steps":["trace[1773435916] 'read index received' (duration: 109.003702ms)","trace[1773435916] 'applied index is now lower than readState.Index' (duration: 192.77404ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T18:28:35.252692Z","caller":"traceutil/trace.go:171","msg":"trace[1881245162] transaction","detail":"{read_only:false; response_revision:5047; number_of_response:1; }","duration":"369.745159ms","start":"2026-09-01T18:28:34.882911Z","end":"2026-09-01T18:28:35.252656Z","steps":["trace[1881245162] 'process raft request' (duration: 177.081531ms)","trace[1881245162] 'compare' (duration: 192.238462ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T18:28:35.252851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.989426ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/monitoring/kube-prometheus-stack-prometheus-node-exporter-ptfgw-tls\" ","response":"range_response_count:1 size:1966"} {"level":"warn","ts":"2026-09-01T18:28:35.25286Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T18:28:34.882891Z","time spent":"369.892272ms","remote":"127.0.0.1:52976","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-01T18:28:35.252892Z","caller":"traceutil/trace.go:171","msg":"trace[1472087549] range","detail":"{range_begin:/registry/cert-manager.io/certificates/monitoring/kube-prometheus-stack-prometheus-node-exporter-ptfgw-tls; range_end:; response_count:1; response_revision:5048; }","duration":"302.071746ms","start":"2026-09-01T18:28:34.950809Z","end":"2026-09-01T18:28:35.25288Z","steps":["trace[1472087549] 'agreement among raft nodes before linearized reading' (duration: 301.917084ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T18:28:35.252927Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T18:28:34.950792Z","time spent":"302.124487ms","remote":"127.0.0.1:50708","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":1,"response size":1989,"request content":"key:\"/registry/cert-manager.io/certificates/monitoring/kube-prometheus-stack-prometheus-node-exporter-ptfgw-tls\" "} {"level":"info","ts":"2026-09-01T18:28:51.428872Z","caller":"traceutil/trace.go:171","msg":"trace[24500276] transaction","detail":"{read_only:false; response_revision:5249; number_of_response:1; }","duration":"114.315399ms","start":"2026-09-01T18:28:51.314521Z","end":"2026-09-01T18:28:51.428837Z","steps":["trace[24500276] 'process raft request' (duration: 114.103776ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T18:28:51.555411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.133678ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:40"} {"level":"info","ts":"2026-09-01T18:29:08.214255Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2892} {"level":"info","ts":"2026-09-01T18:29:08.29675Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2892,"took":"80.937509ms","hash":718781735,"current-db-size-bytes":52436992,"current-db-size":"52 MB","current-db-size-in-use-bytes":27574272,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-09-01T18:29:08.296834Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":718781735,"revision":2892,"compact-revision":-1} {"level":"warn","ts":"2026-09-01T18:29:32.958707Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.075517ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-01T18:29:32.958824Z","caller":"traceutil/trace.go:171","msg":"trace[373270686] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5604; }","duration":"100.26736ms","start":"2026-09-01T18:29:32.858528Z","end":"2026-09-01T18:29:32.958795Z","steps":["trace[373270686] 'range keys from in-memory index tree' (duration: 99.996836ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T18:34:08.220653Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5363} {"level":"info","ts":"2026-09-01T18:34:08.338229Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5363,"took":"115.993985ms","hash":2913505427,"current-db-size-bytes":52436992,"current-db-size":"52 MB","current-db-size-in-use-bytes":18898944,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-09-01T18:34:08.338294Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2913505427,"revision":5363,"compact-revision":2892}