{"level":"warn","ts":"2026-08-21T02:21:40.379407Z","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-21T02:21:40.379498Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.118: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.19.213.118:2380","--initial-cluster=instance=https://199.19.213.118:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.118:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.118: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-21T02:21:40.379561Z","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-21T02:21:40.379573Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.118:2380"]} {"level":"info","ts":"2026-08-21T02:21:40.379591Z","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-21T02:21:40.380157Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.118:2379"]} {"level":"info","ts":"2026-08-21T02:21:40.380248Z","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.19.213.118:2380"],"listen-peer-urls":["https://199.19.213.118:2380"],"advertise-client-urls":["https://199.19.213.118:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.118:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.118: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-21T02:21:40.38551Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.053481ms"} {"level":"info","ts":"2026-08-21T02:21:40.391755Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"511d8c552db01fa8","cluster-id":"8d545d29b73b98f3"} {"level":"info","ts":"2026-08-21T02:21:40.391834Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"511d8c552db01fa8 switched to configuration voters=()"} {"level":"info","ts":"2026-08-21T02:21:40.39186Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"511d8c552db01fa8 became follower at term 0"} {"level":"info","ts":"2026-08-21T02:21:40.391874Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 511d8c552db01fa8 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-21T02:21:40.391883Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"511d8c552db01fa8 became follower at term 1"} {"level":"info","ts":"2026-08-21T02:21:40.391921Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"511d8c552db01fa8 switched to configuration voters=(5844982188863397800)"} {"level":"warn","ts":"2026-08-21T02:21:40.399377Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-21T02:21:40.401248Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-21T02:21:40.404952Z","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-21T02:21:40.406897Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"511d8c552db01fa8","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-21T02:21:40.407218Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"511d8c552db01fa8","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-21T02:21:40.407419Z","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-21T02:21:40.407553Z","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-21T02:21:40.407569Z","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-21T02:21:40.408502Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"511d8c552db01fa8 switched to configuration voters=(5844982188863397800)"} {"level":"info","ts":"2026-08-21T02:21:40.4088Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"8d545d29b73b98f3","local-member-id":"511d8c552db01fa8","added-peer-id":"511d8c552db01fa8","added-peer-peer-urls":["https://199.19.213.118:2380"]} {"level":"info","ts":"2026-08-21T02:21:40.4125Z","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-21T02:21:40.41262Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.118:2380"} {"level":"info","ts":"2026-08-21T02:21:40.412792Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.118:2380"} {"level":"info","ts":"2026-08-21T02:21:40.413306Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-21T02:21:40.413219Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"511d8c552db01fa8","initial-advertise-peer-urls":["https://199.19.213.118:2380"],"listen-peer-urls":["https://199.19.213.118:2380"],"advertise-client-urls":["https://199.19.213.118:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.118:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-21T02:21:40.792923Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"511d8c552db01fa8 is starting a new election at term 1"} {"level":"info","ts":"2026-08-21T02:21:40.79297Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"511d8c552db01fa8 became pre-candidate at term 1"} {"level":"info","ts":"2026-08-21T02:21:40.792987Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"511d8c552db01fa8 received MsgPreVoteResp from 511d8c552db01fa8 at term 1"} {"level":"info","ts":"2026-08-21T02:21:40.793014Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"511d8c552db01fa8 became candidate at term 2"} {"level":"info","ts":"2026-08-21T02:21:40.793025Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"511d8c552db01fa8 received MsgVoteResp from 511d8c552db01fa8 at term 2"} {"level":"info","ts":"2026-08-21T02:21:40.793037Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"511d8c552db01fa8 became leader at term 2"} {"level":"info","ts":"2026-08-21T02:21:40.793049Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 511d8c552db01fa8 elected leader 511d8c552db01fa8 at term 2"} {"level":"info","ts":"2026-08-21T02:21:40.793702Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"511d8c552db01fa8","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.118:2379]}","request-path":"/0/members/511d8c552db01fa8/attributes","cluster-id":"8d545d29b73b98f3","publish-timeout":"7s"} {"level":"info","ts":"2026-08-21T02:21:40.793764Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-21T02:21:40.793794Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-21T02:21:40.793846Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-21T02:21:40.794389Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-21T02:21:40.7956Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.118:2379"} {"level":"info","ts":"2026-08-21T02:21:40.797185Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-08-21T02:21:40.793718Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-21T02:21:40.798184Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"8d545d29b73b98f3","local-member-id":"511d8c552db01fa8","cluster-version":"3.5"} {"level":"info","ts":"2026-08-21T02:21:40.798292Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-21T02:21:40.798364Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"warn","ts":"2026-08-21T02:21:47.363827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.020584ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/generic-garbage-collector\" ","response":"range_response_count:1 size:216"} {"level":"warn","ts":"2026-08-21T02:21:47.363918Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.41386ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-08-21T02:21:47.363972Z","caller":"traceutil/trace.go:171","msg":"trace[1147099160] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/generic-garbage-collector; range_end:; response_count:1; response_revision:277; }","duration":"199.284331ms","start":"2026-08-21T02:21:47.164666Z","end":"2026-08-21T02:21:47.36395Z","steps":["trace[1147099160] 'range keys from in-memory index tree' (duration: 198.795781ms)"],"step_count":1} {"level":"info","ts":"2026-08-21T02:21:47.363992Z","caller":"traceutil/trace.go:171","msg":"trace[985501951] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:277; }","duration":"149.669554ms","start":"2026-08-21T02:21:47.214303Z","end":"2026-08-21T02:21:47.363973Z","steps":["trace[985501951] 'range keys from in-memory index tree' (duration: 149.300397ms)"],"step_count":1} {"level":"warn","ts":"2026-08-21T02:21:47.653188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.110675ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-08-21T02:21:47.653312Z","caller":"traceutil/trace.go:171","msg":"trace[1781673836] transaction","detail":"{read_only:false; response_revision:279; number_of_response:1; }","duration":"188.173689ms","start":"2026-08-21T02:21:47.465083Z","end":"2026-08-21T02:21:47.653257Z","steps":["trace[1781673836] 'process raft request' (duration: 53.649006ms)","trace[1781673836] 'compare' (duration: 133.995783ms)"],"step_count":2} {"level":"info","ts":"2026-08-21T02:22:26.827884Z","caller":"traceutil/trace.go:171","msg":"trace[808811261] transaction","detail":"{read_only:false; response_revision:607; number_of_response:1; }","duration":"171.951435ms","start":"2026-08-21T02:22:26.655899Z","end":"2026-08-21T02:22:26.82785Z","steps":["trace[808811261] 'process raft request' (duration: 162.342604ms)"],"step_count":1} {"level":"info","ts":"2026-08-21T02:24:08.802035Z","caller":"traceutil/trace.go:171","msg":"trace[10525018] transaction","detail":"{read_only:false; response_revision:1873; number_of_response:1; }","duration":"178.756091ms","start":"2026-08-21T02:24:08.623246Z","end":"2026-08-21T02:24:08.802002Z","steps":["trace[10525018] 'process raft request' (duration: 178.494956ms)"],"step_count":1} {"level":"info","ts":"2026-08-21T02:24:09.222216Z","caller":"traceutil/trace.go:171","msg":"trace[1158773190] transaction","detail":"{read_only:false; response_revision:1875; number_of_response:1; }","duration":"120.33886ms","start":"2026-08-21T02:24:09.101844Z","end":"2026-08-21T02:24:09.222183Z","steps":["trace[1158773190] 'process raft request' (duration: 119.8839ms)"],"step_count":1} {"level":"info","ts":"2026-08-21T02:24:09.222226Z","caller":"traceutil/trace.go:171","msg":"trace[1516151865] transaction","detail":"{read_only:false; response_revision:1876; number_of_response:1; }","duration":"103.123306ms","start":"2026-08-21T02:24:09.11908Z","end":"2026-08-21T02:24:09.222204Z","steps":["trace[1516151865] 'process raft request' (duration: 102.821249ms)"],"step_count":1} {"level":"info","ts":"2026-08-21T02:24:43.156023Z","caller":"traceutil/trace.go:171","msg":"trace[1679816704] transaction","detail":"{read_only:false; response_revision:2110; number_of_response:1; }","duration":"154.643463ms","start":"2026-08-21T02:24:43.001342Z","end":"2026-08-21T02:24:43.155986Z","steps":["trace[1679816704] 'process raft request' (duration: 154.378408ms)"],"step_count":1} {"level":"info","ts":"2026-08-21T02:24:43.558268Z","caller":"traceutil/trace.go:171","msg":"trace[804140117] linearizableReadLoop","detail":"{readStateIndex:2200; appliedIndex:2198; }","duration":"186.91119ms","start":"2026-08-21T02:24:43.371338Z","end":"2026-08-21T02:24:43.558249Z","steps":["trace[804140117] 'read index received' (duration: 108.62644ms)","trace[804140117] 'applied index is now lower than readState.Index' (duration: 78.28403ms)"],"step_count":2} {"level":"info","ts":"2026-08-21T02:24:43.558432Z","caller":"traceutil/trace.go:171","msg":"trace[1380085502] transaction","detail":"{read_only:false; response_revision:2114; number_of_response:1; }","duration":"192.994653ms","start":"2026-08-21T02:24:43.365414Z","end":"2026-08-21T02:24:43.558409Z","steps":["trace[1380085502] 'process raft request' (duration: 192.747837ms)"],"step_count":1} {"level":"info","ts":"2026-08-21T02:24:43.558424Z","caller":"traceutil/trace.go:171","msg":"trace[977981895] transaction","detail":"{read_only:false; response_revision:2113; number_of_response:1; }","duration":"195.701317ms","start":"2026-08-21T02:24:43.362698Z","end":"2026-08-21T02:24:43.5584Z","steps":["trace[977981895] 'process raft request' (duration: 117.315634ms)","trace[977981895] 'compare' (duration: 77.975614ms)"],"step_count":2} {"level":"warn","ts":"2026-08-21T02:24:43.558574Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.217007ms","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-21T02:24:43.55871Z","caller":"traceutil/trace.go:171","msg":"trace[573236918] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2114; }","duration":"187.36212ms","start":"2026-08-21T02:24:43.371293Z","end":"2026-08-21T02:24:43.558656Z","steps":["trace[573236918] 'agreement among raft nodes before linearized reading' (duration: 187.037663ms)"],"step_count":1} {"level":"warn","ts":"2026-08-21T02:24:43.92888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.593887ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-21T02:24:43.929584Z","caller":"traceutil/trace.go:171","msg":"trace[1568924809] linearizableReadLoop","detail":"{readStateIndex:2202; appliedIndex:2200; }","duration":"124.687313ms","start":"2026-08-21T02:24:43.804391Z","end":"2026-08-21T02:24:43.929078Z","steps":["trace[1568924809] 'read index received' (duration: 15.532653ms)","trace[1568924809] 'applied index is now lower than readState.Index' (duration: 109.153729ms)"],"step_count":2} {"level":"info","ts":"2026-08-21T02:24:43.929663Z","caller":"traceutil/trace.go:171","msg":"trace[503055722] transaction","detail":"{read_only:false; response_revision:2115; number_of_response:1; }","duration":"367.854071ms","start":"2026-08-21T02:24:43.56178Z","end":"2026-08-21T02:24:43.929634Z","steps":["trace[503055722] 'process raft request' (duration: 129.289074ms)","trace[503055722] 'compare' (duration: 237.486725ms)"],"step_count":2} {"level":"info","ts":"2026-08-21T02:24:43.929793Z","caller":"traceutil/trace.go:171","msg":"trace[1024508854] transaction","detail":"{read_only:false; response_revision:2116; number_of_response:1; }","duration":"365.946983ms","start":"2026-08-21T02:24:43.563769Z","end":"2026-08-21T02:24:43.929716Z","steps":["trace[1024508854] 'process raft request' (duration: 365.240479ms)"],"step_count":1} {"level":"warn","ts":"2026-08-21T02:24:43.929721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.325325ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-21T02:24:43.92999Z","caller":"traceutil/trace.go:171","msg":"trace[2046763533] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2116; }","duration":"125.627871ms","start":"2026-08-21T02:24:43.80435Z","end":"2026-08-21T02:24:43.929977Z","steps":["trace[2046763533] 'agreement among raft nodes before linearized reading' (duration: 125.305465ms)"],"step_count":1} {"level":"warn","ts":"2026-08-21T02:24:43.929788Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.160809ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-21T02:24:43.930084Z","caller":"traceutil/trace.go:171","msg":"trace[425615029] range","detail":"{range_begin:/registry/roles/; range_end:/registry/roles0; response_count:0; response_revision:2116; }","duration":"107.480006ms","start":"2026-08-21T02:24:43.822592Z","end":"2026-08-21T02:24:43.930072Z","steps":["trace[425615029] 'agreement among raft nodes before linearized reading' (duration: 107.15477ms)"],"step_count":1} {"level":"warn","ts":"2026-08-21T02:24:43.93005Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-21T02:24:43.563739Z","time spent":"366.188837ms","remote":"127.0.0.1:51966","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-21T02:24:43.929939Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-21T02:24:43.561762Z","time spent":"368.078545ms","remote":"127.0.0.1:51966","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-21T02:24:44.224995Z","caller":"traceutil/trace.go:171","msg":"trace[396060064] transaction","detail":"{read_only:false; response_revision:2119; number_of_response:1; }","duration":"196.797099ms","start":"2026-08-21T02:24:44.028177Z","end":"2026-08-21T02:24:44.224974Z","steps":["trace[396060064] 'process raft request' (duration: 196.740198ms)"],"step_count":1} {"level":"info","ts":"2026-08-21T02:24:44.225206Z","caller":"traceutil/trace.go:171","msg":"trace[1961219161] transaction","detail":"{read_only:false; response_revision:2118; number_of_response:1; }","duration":"212.882111ms","start":"2026-08-21T02:24:44.012301Z","end":"2026-08-21T02:24:44.225183Z","steps":["trace[1961219161] 'process raft request' (duration: 140.331275ms)","trace[1961219161] 'compare' (duration: 72.161897ms)"],"step_count":2} {"level":"info","ts":"2026-08-21T02:24:44.225299Z","caller":"traceutil/trace.go:171","msg":"trace[1428900993] linearizableReadLoop","detail":"{readStateIndex:2205; appliedIndex:2204; }","duration":"210.712839ms","start":"2026-08-21T02:24:44.014553Z","end":"2026-08-21T02:24:44.225265Z","steps":["trace[1428900993] 'read index received' (duration: 138.303506ms)","trace[1428900993] 'applied index is now lower than readState.Index' (duration: 72.399893ms)"],"step_count":2} {"level":"warn","ts":"2026-08-21T02:24:44.225627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.057395ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:422"} {"level":"info","ts":"2026-08-21T02:24:44.225693Z","caller":"traceutil/trace.go:171","msg":"trace[947048839] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:2119; }","duration":"211.148448ms","start":"2026-08-21T02:24:44.014528Z","end":"2026-08-21T02:24:44.225676Z","steps":["trace[947048839] 'agreement among raft nodes before linearized reading' (duration: 210.817551ms)"],"step_count":1} {"level":"warn","ts":"2026-08-21T02:26:32.77638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.806717ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-21T02:26:32.776471Z","caller":"traceutil/trace.go:171","msg":"trace[1473740317] transaction","detail":"{read_only:false; response_revision:2807; number_of_response:1; }","duration":"188.219673ms","start":"2026-08-21T02:26:32.588236Z","end":"2026-08-21T02:26:32.776456Z","steps":["trace[1473740317] 'process raft request' (duration: 57.264044ms)","trace[1473740317] 'compare' (duration: 130.583272ms)"],"step_count":2} {"level":"warn","ts":"2026-08-21T02:30:27.880592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.556562ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusterbackups/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusterbackups0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-21T02:30:27.880677Z","caller":"traceutil/trace.go:171","msg":"trace[677275832] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusterbackups/; range_end:/registry/pxc.percona.com/perconaxtradbclusterbackups0; response_count:0; response_revision:4811; }","duration":"102.688715ms","start":"2026-08-21T02:30:27.777971Z","end":"2026-08-21T02:30:27.88066Z","steps":["trace[677275832] 'count revisions from in-memory index tree' (duration: 102.451439ms)"],"step_count":1} {"level":"warn","ts":"2026-08-21T02:30:42.080279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.920254ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-21T02:30:42.080446Z","caller":"traceutil/trace.go:171","msg":"trace[473917802] linearizableReadLoop","detail":"{readStateIndex:5178; appliedIndex:5177; }","duration":"324.08336ms","start":"2026-08-21T02:30:41.756346Z","end":"2026-08-21T02:30:42.080429Z","steps":["trace[473917802] 'read index received' (duration: 139.654745ms)","trace[473917802] 'applied index is now lower than readState.Index' (duration: 184.427415ms)"],"step_count":2} {"level":"info","ts":"2026-08-21T02:30:42.080516Z","caller":"traceutil/trace.go:171","msg":"trace[1736117343] transaction","detail":"{read_only:false; response_revision:4984; number_of_response:1; }","duration":"324.813623ms","start":"2026-08-21T02:30:41.755654Z","end":"2026-08-21T02:30:42.080467Z","steps":["trace[1736117343] 'process raft request' (duration: 140.41152ms)","trace[1736117343] 'compare' (duration: 183.824042ms)"],"step_count":2} {"level":"warn","ts":"2026-08-21T02:30:42.080646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.291414ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-08-21T02:30:42.080751Z","caller":"traceutil/trace.go:171","msg":"trace[708098872] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4984; }","duration":"324.412526ms","start":"2026-08-21T02:30:41.756327Z","end":"2026-08-21T02:30:42.08074Z","steps":["trace[708098872] 'agreement among raft nodes before linearized reading' (duration: 324.213542ms)"],"step_count":1} {"level":"warn","ts":"2026-08-21T02:30:42.080793Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-21T02:30:41.755626Z","time spent":"325.043359ms","remote":"127.0.0.1:51966","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-21T02:30:42.080672Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.878041ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-21T02:30:42.080805Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-21T02:30:41.75632Z","time spent":"324.473957ms","remote":"127.0.0.1:51966","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-08-21T02:30:42.081272Z","caller":"traceutil/trace.go:171","msg":"trace[1412622209] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4984; }","duration":"278.122936ms","start":"2026-08-21T02:30:41.802726Z","end":"2026-08-21T02:30:42.080849Z","steps":["trace[1412622209] 'agreement among raft nodes before linearized reading' (duration: 277.880931ms)"],"step_count":1} {"level":"info","ts":"2026-08-21T02:30:42.240005Z","caller":"traceutil/trace.go:171","msg":"trace[125871411] transaction","detail":"{read_only:false; response_revision:4986; number_of_response:1; }","duration":"153.777772ms","start":"2026-08-21T02:30:42.086191Z","end":"2026-08-21T02:30:42.239969Z","steps":["trace[125871411] 'process raft request' (duration: 99.418998ms)","trace[125871411] 'compare' (duration: 54.214401ms)"],"step_count":2} {"level":"info","ts":"2026-08-21T02:31:20.371159Z","caller":"traceutil/trace.go:171","msg":"trace[1201585868] transaction","detail":"{read_only:false; response_revision:5336; number_of_response:1; }","duration":"100.931711ms","start":"2026-08-21T02:31:20.270186Z","end":"2026-08-21T02:31:20.371118Z","steps":["trace[1201585868] 'process raft request' (duration: 100.087264ms)"],"step_count":1} {"level":"info","ts":"2026-08-21T02:31:41.022859Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2852} {"level":"info","ts":"2026-08-21T02:31:41.111667Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2852,"took":"87.739923ms","hash":922492849,"current-db-size-bytes":53776384,"current-db-size":"54 MB","current-db-size-in-use-bytes":29118464,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-08-21T02:31:41.111845Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":922492849,"revision":2852,"compact-revision":-1} {"level":"info","ts":"2026-08-21T02:36:41.029046Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5497} {"level":"info","ts":"2026-08-21T02:36:41.110215Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5497,"took":"79.579545ms","hash":2039107882,"current-db-size-bytes":53776384,"current-db-size":"54 MB","current-db-size-in-use-bytes":18665472,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-08-21T02:36:41.110277Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2039107882,"revision":5497,"compact-revision":2852}