{"level":"warn","ts":"2026-04-13T20:51:37.560871Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-13T20:51:37.560982Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.49: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.49:2380","--initial-cluster=instance=https://199.204.45.49:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.49:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.49: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-04-13T20:51:37.561072Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-13T20:51:37.561087Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.49:2380"]} {"level":"info","ts":"2026-04-13T20:51:37.561112Z","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-04-13T20:51:37.561827Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.49:2379"]} {"level":"info","ts":"2026-04-13T20:51:37.561901Z","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":16,"max-cpu-available":16,"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.49:2380"],"listen-peer-urls":["https://199.204.45.49:2380"],"advertise-client-urls":["https://199.204.45.49:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.49:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.49: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-04-13T20:51:37.585823Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"23.621668ms"} {"level":"info","ts":"2026-04-13T20:51:37.630755Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"d0ba3c4de8c6ef7a","cluster-id":"e76701b877f442ac"} {"level":"info","ts":"2026-04-13T20:51:37.630897Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0ba3c4de8c6ef7a switched to configuration voters=()"} {"level":"info","ts":"2026-04-13T20:51:37.63093Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0ba3c4de8c6ef7a became follower at term 0"} {"level":"info","ts":"2026-04-13T20:51:37.630953Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft d0ba3c4de8c6ef7a [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-13T20:51:37.630973Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0ba3c4de8c6ef7a became follower at term 1"} {"level":"info","ts":"2026-04-13T20:51:37.631048Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0ba3c4de8c6ef7a switched to configuration voters=(15040400210872692602)"} {"level":"warn","ts":"2026-04-13T20:51:37.651094Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-13T20:51:37.653084Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-13T20:51:37.655181Z","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-04-13T20:51:37.659653Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"d0ba3c4de8c6ef7a","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-13T20:51:37.661161Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"d0ba3c4de8c6ef7a","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-13T20:51:37.661607Z","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-04-13T20:51:37.661816Z","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-04-13T20:51:37.661838Z","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-04-13T20:51:37.662928Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0ba3c4de8c6ef7a switched to configuration voters=(15040400210872692602)"} {"level":"info","ts":"2026-04-13T20:51:37.663097Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"e76701b877f442ac","local-member-id":"d0ba3c4de8c6ef7a","added-peer-id":"d0ba3c4de8c6ef7a","added-peer-peer-urls":["https://199.204.45.49:2380"]} {"level":"info","ts":"2026-04-13T20:51:37.664419Z","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-04-13T20:51:37.664553Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.49:2380"} {"level":"info","ts":"2026-04-13T20:51:37.664601Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.49:2380"} {"level":"info","ts":"2026-04-13T20:51:37.664821Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"d0ba3c4de8c6ef7a","initial-advertise-peer-urls":["https://199.204.45.49:2380"],"listen-peer-urls":["https://199.204.45.49:2380"],"advertise-client-urls":["https://199.204.45.49:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.49:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-13T20:51:37.664903Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-13T20:51:38.53137Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0ba3c4de8c6ef7a is starting a new election at term 1"} {"level":"info","ts":"2026-04-13T20:51:38.531443Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0ba3c4de8c6ef7a became pre-candidate at term 1"} {"level":"info","ts":"2026-04-13T20:51:38.531488Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0ba3c4de8c6ef7a received MsgPreVoteResp from d0ba3c4de8c6ef7a at term 1"} {"level":"info","ts":"2026-04-13T20:51:38.531509Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0ba3c4de8c6ef7a became candidate at term 2"} {"level":"info","ts":"2026-04-13T20:51:38.531523Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0ba3c4de8c6ef7a received MsgVoteResp from d0ba3c4de8c6ef7a at term 2"} {"level":"info","ts":"2026-04-13T20:51:38.531538Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0ba3c4de8c6ef7a became leader at term 2"} {"level":"info","ts":"2026-04-13T20:51:38.531552Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: d0ba3c4de8c6ef7a elected leader d0ba3c4de8c6ef7a at term 2"} {"level":"info","ts":"2026-04-13T20:51:38.539857Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-13T20:51:38.542262Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"d0ba3c4de8c6ef7a","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.49:2379]}","request-path":"/0/members/d0ba3c4de8c6ef7a/attributes","cluster-id":"e76701b877f442ac","publish-timeout":"7s"} {"level":"info","ts":"2026-04-13T20:51:38.542472Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-13T20:51:38.54253Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-13T20:51:38.54283Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-13T20:51:38.54296Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-13T20:51:38.546219Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.49:2379"} {"level":"info","ts":"2026-04-13T20:51:38.546351Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-13T20:51:38.548967Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"e76701b877f442ac","local-member-id":"d0ba3c4de8c6ef7a","cluster-version":"3.5"} {"level":"info","ts":"2026-04-13T20:51:38.54913Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-13T20:51:38.549172Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-13T20:51:54.39738Z","caller":"traceutil/trace.go:171","msg":"trace[429425748] linearizableReadLoop","detail":"{readStateIndex:382; appliedIndex:381; }","duration":"125.660979ms","start":"2026-04-13T20:51:54.271693Z","end":"2026-04-13T20:51:54.397354Z","steps":["trace[429425748] 'read index received' (duration: 125.432204ms)","trace[429425748] 'applied index is now lower than readState.Index' (duration: 227.775µs)"],"step_count":2} {"level":"info","ts":"2026-04-13T20:51:54.397455Z","caller":"traceutil/trace.go:171","msg":"trace[980559244] transaction","detail":"{read_only:false; response_revision:370; number_of_response:1; }","duration":"308.101552ms","start":"2026-04-13T20:51:54.089314Z","end":"2026-04-13T20:51:54.397415Z","steps":["trace[980559244] 'process raft request' (duration: 307.888207ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T20:51:54.397711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.873454ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-04-13T20:51:54.397821Z","caller":"traceutil/trace.go:171","msg":"trace[1441059130] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:370; }","duration":"126.188482ms","start":"2026-04-13T20:51:54.271613Z","end":"2026-04-13T20:51:54.397802Z","steps":["trace[1441059130] 'agreement among raft nodes before linearized reading' (duration: 125.877265ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T20:51:54.398051Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T20:51:54.089281Z","time spent":"308.253126ms","remote":"127.0.0.1:58452","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T20:51:54.536649Z","caller":"traceutil/trace.go:171","msg":"trace[1099961027] transaction","detail":"{read_only:false; response_revision:371; number_of_response:1; }","duration":"134.238496ms","start":"2026-04-13T20:51:54.402362Z","end":"2026-04-13T20:51:54.536601Z","steps":["trace[1099961027] 'process raft request' (duration: 106.631922ms)","trace[1099961027] 'compare' (duration: 27.376307ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T20:52:17.958288Z","caller":"traceutil/trace.go:171","msg":"trace[123241296] linearizableReadLoop","detail":"{readStateIndex:601; appliedIndex:600; }","duration":"347.773665ms","start":"2026-04-13T20:52:17.610487Z","end":"2026-04-13T20:52:17.958261Z","steps":["trace[123241296] 'read index received' (duration: 333.412873ms)","trace[123241296] 'applied index is now lower than readState.Index' (duration: 14.359662ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T20:52:17.958372Z","caller":"traceutil/trace.go:171","msg":"trace[31412967] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"382.302368ms","start":"2026-04-13T20:52:17.57602Z","end":"2026-04-13T20:52:17.958322Z","steps":["trace[31412967] 'process raft request' (duration: 367.872214ms)","trace[31412967] 'compare' (duration: 14.177889ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T20:52:17.958522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.155794ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-rm2nr\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-04-13T20:52:17.958563Z","caller":"traceutil/trace.go:171","msg":"trace[842922849] range","detail":"{range_begin:/registry/pods/kube-system/cilium-rm2nr; range_end:; response_count:1; response_revision:580; }","duration":"228.259786ms","start":"2026-04-13T20:52:17.730291Z","end":"2026-04-13T20:52:17.958551Z","steps":["trace[842922849] 'agreement among raft nodes before linearized reading' (duration: 228.137663ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T20:52:17.958561Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"348.041111ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-04-13T20:52:17.958644Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T20:52:17.575996Z","time spent":"382.553843ms","remote":"127.0.0.1:58668","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-13T20:52:17.958665Z","caller":"traceutil/trace.go:171","msg":"trace[1205310046] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:580; }","duration":"348.196573ms","start":"2026-04-13T20:52:17.610442Z","end":"2026-04-13T20:52:17.958638Z","steps":["trace[1205310046] 'agreement among raft nodes before linearized reading' (duration: 347.99221ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T20:52:17.95872Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T20:52:17.610414Z","time spent":"348.295496ms","remote":"127.0.0.1:58452","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-13T20:52:33.700325Z","caller":"traceutil/trace.go:171","msg":"trace[829541754] transaction","detail":"{read_only:false; response_revision:745; number_of_response:1; }","duration":"196.595717ms","start":"2026-04-13T20:52:33.503695Z","end":"2026-04-13T20:52:33.70029Z","steps":["trace[829541754] 'process raft request' (duration: 196.390723ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T20:53:02.085879Z","caller":"traceutil/trace.go:171","msg":"trace[489001714] transaction","detail":"{read_only:false; response_revision:1138; number_of_response:1; }","duration":"218.843248ms","start":"2026-04-13T20:53:01.867008Z","end":"2026-04-13T20:53:02.085852Z","steps":["trace[489001714] 'process raft request' (duration: 218.662995ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T20:54:40.85263Z","caller":"traceutil/trace.go:171","msg":"trace[290780705] transaction","detail":"{read_only:false; response_revision:2148; number_of_response:1; }","duration":"132.552961ms","start":"2026-04-13T20:54:40.720031Z","end":"2026-04-13T20:54:40.852584Z","steps":["trace[290780705] 'process raft request' (duration: 132.47788ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T20:54:40.852648Z","caller":"traceutil/trace.go:171","msg":"trace[1030496918] transaction","detail":"{read_only:false; response_revision:2147; number_of_response:1; }","duration":"133.404087ms","start":"2026-04-13T20:54:40.71918Z","end":"2026-04-13T20:54:40.852584Z","steps":["trace[1030496918] 'process raft request' (duration: 112.411251ms)","trace[1030496918] 'compare' (duration: 20.777342ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T20:58:43.14214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.271232ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/clusterissuers/\" range_end:\"/registry/cert-manager.io/clusterissuers0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-13T20:58:43.142227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.680551ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"} {"level":"info","ts":"2026-04-13T20:58:43.142317Z","caller":"traceutil/trace.go:171","msg":"trace[2104362068] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:3833; }","duration":"227.819265ms","start":"2026-04-13T20:58:42.914469Z","end":"2026-04-13T20:58:43.142289Z","steps":["trace[2104362068] 'range keys from in-memory index tree' (duration: 227.442207ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T20:58:43.142261Z","caller":"traceutil/trace.go:171","msg":"trace[990945412] transaction","detail":"{read_only:false; response_revision:3834; number_of_response:1; }","duration":"176.610331ms","start":"2026-04-13T20:58:42.965594Z","end":"2026-04-13T20:58:43.142204Z","steps":["trace[990945412] 'process raft request' (duration: 81.553077ms)","trace[990945412] 'compare' (duration: 94.87632ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T20:58:43.142262Z","caller":"traceutil/trace.go:171","msg":"trace[628705828] range","detail":"{range_begin:/registry/cert-manager.io/clusterissuers/; range_end:/registry/cert-manager.io/clusterissuers0; response_count:0; response_revision:3833; }","duration":"206.462155ms","start":"2026-04-13T20:58:42.935773Z","end":"2026-04-13T20:58:43.142235Z","steps":["trace[628705828] 'count revisions from in-memory index tree' (duration: 206.149509ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:00:32.024483Z","caller":"traceutil/trace.go:171","msg":"trace[1861574870] linearizableReadLoop","detail":"{readStateIndex:5518; appliedIndex:5517; }","duration":"166.578969ms","start":"2026-04-13T21:00:31.857875Z","end":"2026-04-13T21:00:32.024454Z","steps":["trace[1861574870] 'read index received' (duration: 82.632781ms)","trace[1861574870] 'applied index is now lower than readState.Index' (duration: 83.945148ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T21:00:32.024555Z","caller":"traceutil/trace.go:171","msg":"trace[1336803206] transaction","detail":"{read_only:false; response_revision:5318; number_of_response:1; }","duration":"262.127338ms","start":"2026-04-13T21:00:31.762339Z","end":"2026-04-13T21:00:32.024467Z","steps":["trace[1336803206] 'process raft request' (duration: 178.279613ms)","trace[1336803206] 'compare' (duration: 83.515319ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T21:00:32.024823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.922235ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-f61c7319-5c43-42ff-bfed-037dc9593778\" ","response":"range_response_count:1 size:3645"} {"level":"info","ts":"2026-04-13T21:00:32.024939Z","caller":"traceutil/trace.go:171","msg":"trace[489044708] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-f61c7319-5c43-42ff-bfed-037dc9593778; range_end:; response_count:1; response_revision:5318; }","duration":"167.093029ms","start":"2026-04-13T21:00:31.857819Z","end":"2026-04-13T21:00:32.024912Z","steps":["trace[489044708] 'agreement among raft nodes before linearized reading' (duration: 166.712911ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:00:32.23955Z","caller":"traceutil/trace.go:171","msg":"trace[1780352045] transaction","detail":"{read_only:false; response_revision:5319; number_of_response:1; }","duration":"161.061418ms","start":"2026-04-13T21:00:32.078416Z","end":"2026-04-13T21:00:32.239477Z","steps":["trace[1780352045] 'process raft request' (duration: 119.155861ms)","trace[1780352045] 'compare' (duration: 41.293076ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T21:00:32.657948Z","caller":"traceutil/trace.go:171","msg":"trace[1683049418] transaction","detail":"{read_only:false; response_revision:5325; number_of_response:1; }","duration":"129.414966ms","start":"2026-04-13T21:00:32.528498Z","end":"2026-04-13T21:00:32.657913Z","steps":["trace[1683049418] 'process raft request' (duration: 129.205742ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:00:32.68659Z","caller":"traceutil/trace.go:171","msg":"trace[2137048679] transaction","detail":"{read_only:false; response_revision:5326; number_of_response:1; }","duration":"104.577161ms","start":"2026-04-13T21:00:32.581989Z","end":"2026-04-13T21:00:32.686566Z","steps":["trace[2137048679] 'process raft request' (duration: 104.386227ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:00:59.771818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.539592ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T21:00:59.771915Z","caller":"traceutil/trace.go:171","msg":"trace[359526124] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5646; }","duration":"125.687047ms","start":"2026-04-13T21:00:59.646208Z","end":"2026-04-13T21:00:59.771895Z","steps":["trace[359526124] 'range keys from in-memory index tree' (duration: 125.44679ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:00:59.772103Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.281698ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-13T21:00:59.772249Z","caller":"traceutil/trace.go:171","msg":"trace[1749497894] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5646; }","duration":"259.489425ms","start":"2026-04-13T21:00:59.512734Z","end":"2026-04-13T21:00:59.772223Z","steps":["trace[1749497894] 'range keys from in-memory index tree' (duration: 258.966047ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:01:00.035012Z","caller":"traceutil/trace.go:171","msg":"trace[1460712532] transaction","detail":"{read_only:false; response_revision:5647; number_of_response:1; }","duration":"257.728604ms","start":"2026-04-13T21:00:59.777244Z","end":"2026-04-13T21:01:00.034972Z","steps":["trace[1460712532] 'process raft request' (duration: 257.515497ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:01:00.318096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.234538ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-13T21:01:00.318302Z","caller":"traceutil/trace.go:171","msg":"trace[1850385150] transaction","detail":"{read_only:false; response_revision:5651; number_of_response:1; }","duration":"110.635104ms","start":"2026-04-13T21:01:00.207646Z","end":"2026-04-13T21:01:00.318282Z","steps":["trace[1850385150] 'compare' (duration: 100.054981ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:01:00.350678Z","caller":"traceutil/trace.go:171","msg":"trace[946555618] transaction","detail":"{read_only:false; response_revision:5655; number_of_response:1; }","duration":"138.988625ms","start":"2026-04-13T21:01:00.211665Z","end":"2026-04-13T21:01:00.350654Z","steps":["trace[946555618] 'process raft request' (duration: 138.895441ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:01:00.350612Z","caller":"traceutil/trace.go:171","msg":"trace[973541879] transaction","detail":"{read_only:false; response_revision:5652; number_of_response:1; }","duration":"142.738492ms","start":"2026-04-13T21:01:00.20783Z","end":"2026-04-13T21:01:00.350569Z","steps":["trace[973541879] 'process raft request' (duration: 142.4118ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:01:00.351049Z","caller":"traceutil/trace.go:171","msg":"trace[1715384261] transaction","detail":"{read_only:false; response_revision:5653; number_of_response:1; }","duration":"142.521764ms","start":"2026-04-13T21:01:00.208515Z","end":"2026-04-13T21:01:00.351037Z","steps":["trace[1715384261] 'process raft request' (duration: 141.909323ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:01:00.351132Z","caller":"traceutil/trace.go:171","msg":"trace[777017864] transaction","detail":"{read_only:false; response_revision:5654; number_of_response:1; }","duration":"142.295327ms","start":"2026-04-13T21:01:00.208769Z","end":"2026-04-13T21:01:00.351064Z","steps":["trace[777017864] 'process raft request' (duration: 141.727558ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:01:00.486132Z","caller":"traceutil/trace.go:171","msg":"trace[406937511] transaction","detail":"{read_only:false; response_revision:5658; number_of_response:1; }","duration":"123.982569ms","start":"2026-04-13T21:01:00.362105Z","end":"2026-04-13T21:01:00.486087Z","steps":["trace[406937511] 'process raft request' (duration: 63.826502ms)","trace[406937511] 'compare' (duration: 60.001012ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T21:01:38.572236Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2983} {"level":"info","ts":"2026-04-13T21:01:38.635888Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2983,"took":"61.983495ms","hash":3218490075,"current-db-size-bytes":56594432,"current-db-size":"57 MB","current-db-size-in-use-bytes":33247232,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-04-13T21:01:38.635951Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3218490075,"revision":2983,"compact-revision":-1} {"level":"info","ts":"2026-04-13T21:06:38.578872Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6011} {"level":"info","ts":"2026-04-13T21:06:38.665068Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6011,"took":"84.155703ms","hash":3387696502,"current-db-size-bytes":56594432,"current-db-size":"57 MB","current-db-size-in-use-bytes":25075712,"current-db-size-in-use":"25 MB"} {"level":"info","ts":"2026-04-13T21:06:38.665181Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3387696502,"revision":6011,"compact-revision":2983} {"level":"info","ts":"2026-04-13T21:07:01.263261Z","caller":"traceutil/trace.go:171","msg":"trace[2018889901] transaction","detail":"{read_only:false; response_revision:8245; number_of_response:1; }","duration":"151.042203ms","start":"2026-04-13T21:07:01.112163Z","end":"2026-04-13T21:07:01.263205Z","steps":["trace[2018889901] 'process raft request' (duration: 68.533588ms)","trace[2018889901] 'compare' (duration: 81.698191ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T21:07:01.263388Z","caller":"traceutil/trace.go:171","msg":"trace[1800018790] transaction","detail":"{read_only:false; response_revision:8246; number_of_response:1; }","duration":"151.108805ms","start":"2026-04-13T21:07:01.112245Z","end":"2026-04-13T21:07:01.263354Z","steps":["trace[1800018790] 'process raft request' (duration: 150.81546ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:07:01.263607Z","caller":"traceutil/trace.go:171","msg":"trace[40291754] transaction","detail":"{read_only:false; response_revision:8247; number_of_response:1; }","duration":"146.999985ms","start":"2026-04-13T21:07:01.116542Z","end":"2026-04-13T21:07:01.263542Z","steps":["trace[40291754] 'process raft request' (duration: 146.6874ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:07:20.797579Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.289597ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T21:07:20.797721Z","caller":"traceutil/trace.go:171","msg":"trace[1442070418] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8477; }","duration":"150.504521ms","start":"2026-04-13T21:07:20.647188Z","end":"2026-04-13T21:07:20.797693Z","steps":["trace[1442070418] 'range keys from in-memory index tree' (duration: 150.160596ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:07:20.797948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.62419ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-13T21:07:20.798084Z","caller":"traceutil/trace.go:171","msg":"trace[1796756253] transaction","detail":"{read_only:false; response_revision:8478; number_of_response:1; }","duration":"149.768798ms","start":"2026-04-13T21:07:20.648295Z","end":"2026-04-13T21:07:20.798063Z","steps":["trace[1796756253] 'process raft request' (duration: 13.884093ms)","trace[1796756253] 'compare' (duration: 135.032769ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T21:07:21.852916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.555454ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T21:07:21.853026Z","caller":"traceutil/trace.go:171","msg":"trace[813994373] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8484; }","duration":"205.724157ms","start":"2026-04-13T21:07:21.647275Z","end":"2026-04-13T21:07:21.852999Z","steps":["trace[813994373] 'range keys from in-memory index tree' (duration: 205.438801ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:07:21.885343Z","caller":"traceutil/trace.go:171","msg":"trace[615430978] linearizableReadLoop","detail":"{readStateIndex:8788; appliedIndex:8787; }","duration":"110.444671ms","start":"2026-04-13T21:07:21.774853Z","end":"2026-04-13T21:07:21.885297Z","steps":["trace[615430978] 'read index received' (duration: 110.166836ms)","trace[615430978] 'applied index is now lower than readState.Index' (duration: 275.725µs)"],"step_count":2} {"level":"info","ts":"2026-04-13T21:07:21.88543Z","caller":"traceutil/trace.go:171","msg":"trace[627821105] transaction","detail":"{read_only:false; response_revision:8485; number_of_response:1; }","duration":"236.359635ms","start":"2026-04-13T21:07:21.649014Z","end":"2026-04-13T21:07:21.885374Z","steps":["trace[627821105] 'process raft request' (duration: 235.946767ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:07:21.885732Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.841339ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.49\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-04-13T21:07:21.885847Z","caller":"traceutil/trace.go:171","msg":"trace[2098142256] range","detail":"{range_begin:/registry/masterleases/199.204.45.49; range_end:; response_count:1; response_revision:8485; }","duration":"111.039492ms","start":"2026-04-13T21:07:21.774786Z","end":"2026-04-13T21:07:21.885825Z","steps":["trace[2098142256] 'agreement among raft nodes before linearized reading' (duration: 110.657976ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:07:51.417267Z","caller":"traceutil/trace.go:171","msg":"trace[355235348] transaction","detail":"{read_only:false; response_revision:8695; number_of_response:1; }","duration":"181.1833ms","start":"2026-04-13T21:07:51.236053Z","end":"2026-04-13T21:07:51.417236Z","steps":["trace[355235348] 'process raft request' (duration: 144.500722ms)","trace[355235348] 'compare' (duration: 36.560736ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T21:07:51.421371Z","caller":"traceutil/trace.go:171","msg":"trace[1671671500] linearizableReadLoop","detail":"{readStateIndex:9009; appliedIndex:9006; }","duration":"122.353339ms","start":"2026-04-13T21:07:51.29898Z","end":"2026-04-13T21:07:51.421334Z","steps":["trace[1671671500] 'read index received' (duration: 81.667138ms)","trace[1671671500] 'applied index is now lower than readState.Index' (duration: 40.684641ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T21:07:51.421526Z","caller":"traceutil/trace.go:171","msg":"trace[172045059] transaction","detail":"{read_only:false; response_revision:8697; number_of_response:1; }","duration":"122.576563ms","start":"2026-04-13T21:07:51.298935Z","end":"2026-04-13T21:07:51.421511Z","steps":["trace[172045059] 'process raft request' (duration: 122.332869ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:07:51.42163Z","caller":"traceutil/trace.go:171","msg":"trace[1289709965] transaction","detail":"{read_only:false; response_revision:8696; number_of_response:1; }","duration":"185.07121ms","start":"2026-04-13T21:07:51.236523Z","end":"2026-04-13T21:07:51.421594Z","steps":["trace[1289709965] 'process raft request' (duration: 184.52636ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:07:51.422086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.857147ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-04-13T21:07:51.422147Z","caller":"traceutil/trace.go:171","msg":"trace[740441063] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8697; }","duration":"123.203654ms","start":"2026-04-13T21:07:51.298928Z","end":"2026-04-13T21:07:51.422132Z","steps":["trace[740441063] 'agreement among raft nodes before linearized reading' (duration: 122.781036ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:07:51.422186Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.139584ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-04-13T21:07:51.422358Z","caller":"traceutil/trace.go:171","msg":"trace[1793613603] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8697; }","duration":"122.342408ms","start":"2026-04-13T21:07:51.299992Z","end":"2026-04-13T21:07:51.422334Z","steps":["trace[1793613603] 'agreement among raft nodes before linearized reading' (duration: 122.015132ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:07:53.963906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.592664ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T21:07:53.964073Z","caller":"traceutil/trace.go:171","msg":"trace[766776324] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:8712; }","duration":"110.86096ms","start":"2026-04-13T21:07:53.853162Z","end":"2026-04-13T21:07:53.964023Z","steps":["trace[766776324] 'count revisions from in-memory index tree' (duration: 110.428821ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:07:54.542379Z","caller":"traceutil/trace.go:171","msg":"trace[1898743527] linearizableReadLoop","detail":"{readStateIndex:9029; appliedIndex:9027; }","duration":"184.273766ms","start":"2026-04-13T21:07:54.358071Z","end":"2026-04-13T21:07:54.542344Z","steps":["trace[1898743527] 'read index received' (duration: 16.179445ms)","trace[1898743527] 'applied index is now lower than readState.Index' (duration: 168.092421ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T21:07:54.542557Z","caller":"traceutil/trace.go:171","msg":"trace[1775585057] transaction","detail":"{read_only:false; response_revision:8716; number_of_response:1; }","duration":"239.532262ms","start":"2026-04-13T21:07:54.302963Z","end":"2026-04-13T21:07:54.542495Z","steps":["trace[1775585057] 'process raft request' (duration: 195.99729ms)","trace[1775585057] 'compare' (duration: 43.212486ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T21:07:54.542668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.549631ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:559"} {"level":"info","ts":"2026-04-13T21:07:54.54273Z","caller":"traceutil/trace.go:171","msg":"trace[277108846] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:8716; }","duration":"184.692794ms","start":"2026-04-13T21:07:54.358017Z","end":"2026-04-13T21:07:54.54271Z","steps":["trace[277108846] 'agreement among raft nodes before linearized reading' (duration: 184.46175ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:08:04.393739Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.391837ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-13T21:08:04.393864Z","caller":"traceutil/trace.go:171","msg":"trace[1267000048] transaction","detail":"{read_only:false; response_revision:8811; number_of_response:1; }","duration":"284.176566ms","start":"2026-04-13T21:08:04.109665Z","end":"2026-04-13T21:08:04.393842Z","steps":["trace[1267000048] 'process raft request' (duration: 160.537425ms)","trace[1267000048] 'compare' (duration: 123.269705ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T21:08:22.341348Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002456.wal"} {"level":"info","ts":"2026-04-13T21:09:10.555238Z","caller":"traceutil/trace.go:171","msg":"trace[903322416] transaction","detail":"{read_only:false; response_revision:9500; number_of_response:1; }","duration":"121.049147ms","start":"2026-04-13T21:09:10.434148Z","end":"2026-04-13T21:09:10.555197Z","steps":["trace[903322416] 'process raft request' (duration: 120.825263ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:09:34.347109Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"d0ba3c4de8c6ef7a","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-13T21:09:34.355287Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-04-13T21:09:34.355407Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-04-13T21:11:38.587641Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8081} {"level":"info","ts":"2026-04-13T21:11:38.654165Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8081,"took":"64.048952ms","hash":3665926486,"current-db-size-bytes":56594432,"current-db-size":"57 MB","current-db-size-in-use-bytes":28012544,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-04-13T21:11:38.654232Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3665926486,"revision":8081,"compact-revision":6011} {"level":"info","ts":"2026-04-13T21:16:38.601086Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10490} {"level":"info","ts":"2026-04-13T21:16:38.69785Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10490,"took":"93.728042ms","hash":1262886645,"current-db-size-bytes":56594432,"current-db-size":"57 MB","current-db-size-in-use-bytes":21704704,"current-db-size-in-use":"22 MB"} {"level":"info","ts":"2026-04-13T21:16:38.697937Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1262886645,"revision":10490,"compact-revision":8081}