{"level":"warn","ts":"2026-06-08T06:14:03.716852Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-08T06:14:03.716971Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.23: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.23:2380","--initial-cluster=instance=https://199.204.45.23:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.23:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.23: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-06-08T06:14:03.717037Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-08T06:14:03.717045Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.23:2380"]} {"level":"info","ts":"2026-06-08T06:14:03.717062Z","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-06-08T06:14:03.717768Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.23:2379"]} {"level":"info","ts":"2026-06-08T06:14:03.717868Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.23:2380"],"listen-peer-urls":["https://199.204.45.23:2380"],"advertise-client-urls":["https://199.204.45.23:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.23:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.23: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-06-08T06:14:03.724068Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.937368ms"} {"level":"info","ts":"2026-06-08T06:14:03.729814Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"51a5c416a4d98c86","cluster-id":"ade2045974c19907"} {"level":"info","ts":"2026-06-08T06:14:03.72989Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 switched to configuration voters=()"} {"level":"info","ts":"2026-06-08T06:14:03.729907Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 became follower at term 0"} {"level":"info","ts":"2026-06-08T06:14:03.729915Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 51a5c416a4d98c86 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-08T06:14:03.729924Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 became follower at term 1"} {"level":"info","ts":"2026-06-08T06:14:03.729962Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 switched to configuration voters=(5883324089763466374)"} {"level":"warn","ts":"2026-06-08T06:14:03.739855Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-08T06:14:03.741136Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-08T06:14:03.74226Z","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-06-08T06:14:03.744645Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"51a5c416a4d98c86","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-08T06:14:03.745749Z","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-06-08T06:14:03.745815Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"51a5c416a4d98c86","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-08T06:14:03.745853Z","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-06-08T06:14:03.745872Z","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-06-08T06:14:03.750026Z","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-06-08T06:14:03.750146Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 switched to configuration voters=(5883324089763466374)"} {"level":"info","ts":"2026-06-08T06:14:03.750248Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"51a5c416a4d98c86","initial-advertise-peer-urls":["https://199.204.45.23:2380"],"listen-peer-urls":["https://199.204.45.23:2380"],"advertise-client-urls":["https://199.204.45.23:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.23:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-08T06:14:03.750261Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"ade2045974c19907","local-member-id":"51a5c416a4d98c86","added-peer-id":"51a5c416a4d98c86","added-peer-peer-urls":["https://199.204.45.23:2380"]} {"level":"info","ts":"2026-06-08T06:14:03.750283Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-08T06:14:03.7503Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.23:2380"} {"level":"info","ts":"2026-06-08T06:14:03.750318Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.23:2380"} {"level":"info","ts":"2026-06-08T06:14:04.631486Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 is starting a new election at term 1"} {"level":"info","ts":"2026-06-08T06:14:04.631544Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 became pre-candidate at term 1"} {"level":"info","ts":"2026-06-08T06:14:04.63158Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 received MsgPreVoteResp from 51a5c416a4d98c86 at term 1"} {"level":"info","ts":"2026-06-08T06:14:04.631599Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 became candidate at term 2"} {"level":"info","ts":"2026-06-08T06:14:04.63161Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 received MsgVoteResp from 51a5c416a4d98c86 at term 2"} {"level":"info","ts":"2026-06-08T06:14:04.631635Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 became leader at term 2"} {"level":"info","ts":"2026-06-08T06:14:04.631649Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 51a5c416a4d98c86 elected leader 51a5c416a4d98c86 at term 2"} {"level":"info","ts":"2026-06-08T06:14:04.632525Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-08T06:14:04.63307Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-08T06:14:04.633073Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"51a5c416a4d98c86","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.23:2379]}","request-path":"/0/members/51a5c416a4d98c86/attributes","cluster-id":"ade2045974c19907","publish-timeout":"7s"} {"level":"info","ts":"2026-06-08T06:14:04.633101Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-08T06:14:04.633377Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-08T06:14:04.63341Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-08T06:14:04.633677Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"ade2045974c19907","local-member-id":"51a5c416a4d98c86","cluster-version":"3.5"} {"level":"info","ts":"2026-06-08T06:14:04.633823Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-08T06:14:04.633884Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-08T06:14:04.635161Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-08T06:14:04.642111Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.23:2379"} {"level":"info","ts":"2026-06-08T06:14:06.239839Z","caller":"traceutil/trace.go:171","msg":"trace[442784167] transaction","detail":"{read_only:false; response_revision:71; number_of_response:1; }","duration":"120.977636ms","start":"2026-06-08T06:14:06.118822Z","end":"2026-06-08T06:14:06.2398Z","steps":["trace[442784167] 'process raft request' (duration: 120.852543ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T06:14:08.304179Z","caller":"traceutil/trace.go:171","msg":"trace[2091004628] transaction","detail":"{read_only:false; response_revision:206; number_of_response:1; }","duration":"260.949321ms","start":"2026-06-08T06:14:08.043182Z","end":"2026-06-08T06:14:08.304131Z","steps":["trace[2091004628] 'process raft request' (duration: 260.769366ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T06:14:11.403291Z","caller":"traceutil/trace.go:171","msg":"trace[42186873] transaction","detail":"{read_only:false; response_revision:318; number_of_response:1; }","duration":"111.59844ms","start":"2026-06-08T06:14:11.29167Z","end":"2026-06-08T06:14:11.403268Z","steps":["trace[42186873] 'process raft request' (duration: 111.450046ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T06:14:44.832087Z","caller":"traceutil/trace.go:171","msg":"trace[824761765] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"103.776227ms","start":"2026-06-08T06:14:44.728286Z","end":"2026-06-08T06:14:44.832063Z","steps":["trace[824761765] 'process raft request' (duration: 103.660634ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T06:14:44.838821Z","caller":"traceutil/trace.go:171","msg":"trace[1717150761] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"106.796264ms","start":"2026-06-08T06:14:44.732007Z","end":"2026-06-08T06:14:44.838803Z","steps":["trace[1717150761] 'process raft request' (duration: 106.179551ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T06:14:44.838912Z","caller":"traceutil/trace.go:171","msg":"trace[251953681] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"106.778513ms","start":"2026-06-08T06:14:44.732127Z","end":"2026-06-08T06:14:44.838906Z","steps":["trace[251953681] 'process raft request' (duration: 106.141309ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T06:14:44.838958Z","caller":"traceutil/trace.go:171","msg":"trace[1423285862] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"103.568072ms","start":"2026-06-08T06:14:44.735384Z","end":"2026-06-08T06:14:44.838952Z","steps":["trace[1423285862] 'process raft request' (duration: 102.910648ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T06:14:46.434166Z","caller":"traceutil/trace.go:171","msg":"trace[1233038725] transaction","detail":"{read_only:false; response_revision:611; number_of_response:1; }","duration":"107.3965ms","start":"2026-06-08T06:14:46.326564Z","end":"2026-06-08T06:14:46.43396Z","steps":["trace[1233038725] 'process raft request' (duration: 65.131402ms)","trace[1233038725] 'compare' (duration: 42.131425ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T06:14:51.994088Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.339747ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-08T06:14:51.994205Z","caller":"traceutil/trace.go:171","msg":"trace[327129318] linearizableReadLoop","detail":"{readStateIndex:669; appliedIndex:668; }","duration":"554.151395ms","start":"2026-06-08T06:14:51.440039Z","end":"2026-06-08T06:14:51.99419Z","steps":["trace[327129318] 'read index received' (duration: 263.062431ms)","trace[327129318] 'applied index is now lower than readState.Index' (duration: 291.087654ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T06:14:51.994241Z","caller":"traceutil/trace.go:171","msg":"trace[1002409453] transaction","detail":"{read_only:false; response_revision:645; number_of_response:1; }","duration":"593.082358ms","start":"2026-06-08T06:14:51.401126Z","end":"2026-06-08T06:14:51.994208Z","steps":["trace[1002409453] 'process raft request' (duration: 302.055906ms)","trace[1002409453] 'compare' (duration: 290.192614ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T06:14:51.994368Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T06:14:51.401113Z","time spent":"593.194572ms","remote":"127.0.0.1:51270","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2735,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-08T06:14:51.994765Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"554.718498ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-kpxkk\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-06-08T06:14:51.99489Z","caller":"traceutil/trace.go:171","msg":"trace[744633930] range","detail":"{range_begin:/registry/pods/kube-system/cilium-kpxkk; range_end:; response_count:1; response_revision:645; }","duration":"554.84439ms","start":"2026-06-08T06:14:51.440027Z","end":"2026-06-08T06:14:51.994871Z","steps":["trace[744633930] 'agreement among raft nodes before linearized reading' (duration: 554.205886ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T06:14:51.994931Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T06:14:51.43997Z","time spent":"554.948452ms","remote":"127.0.0.1:51270","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16984,"request content":"key:\"/registry/pods/kube-system/cilium-kpxkk\" "} {"level":"warn","ts":"2026-06-08T06:15:07.072514Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.053622ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-08T06:15:07.072595Z","caller":"traceutil/trace.go:171","msg":"trace[1443680479] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:799; }","duration":"292.187004ms","start":"2026-06-08T06:15:06.78039Z","end":"2026-06-08T06:15:07.072577Z","steps":["trace[1443680479] 'range keys from in-memory index tree' (duration: 291.893987ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T06:15:39.249512Z","caller":"traceutil/trace.go:171","msg":"trace[150348731] transaction","detail":"{read_only:false; response_revision:1213; number_of_response:1; }","duration":"218.067399ms","start":"2026-06-08T06:15:39.031423Z","end":"2026-06-08T06:15:39.249491Z","steps":["trace[150348731] 'process raft request' (duration: 217.73299ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T06:16:27.884975Z","caller":"traceutil/trace.go:171","msg":"trace[1242507055] transaction","detail":"{read_only:false; response_revision:1887; number_of_response:1; }","duration":"277.608032ms","start":"2026-06-08T06:16:27.607343Z","end":"2026-06-08T06:16:27.884951Z","steps":["trace[1242507055] 'process raft request' (duration: 277.465948ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T06:16:28.036585Z","caller":"traceutil/trace.go:171","msg":"trace[630482094] linearizableReadLoop","detail":"{readStateIndex:1966; appliedIndex:1963; }","duration":"140.670444ms","start":"2026-06-08T06:16:27.895889Z","end":"2026-06-08T06:16:28.03656Z","steps":["trace[630482094] 'read index received' (duration: 92.88003ms)","trace[630482094] 'applied index is now lower than readState.Index' (duration: 47.789484ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T06:16:28.036624Z","caller":"traceutil/trace.go:171","msg":"trace[1526284939] transaction","detail":"{read_only:false; response_revision:1889; number_of_response:1; }","duration":"266.419272ms","start":"2026-06-08T06:16:27.770183Z","end":"2026-06-08T06:16:28.036602Z","steps":["trace[1526284939] 'process raft request' (duration: 266.271527ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T06:16:28.036714Z","caller":"traceutil/trace.go:171","msg":"trace[1967955243] transaction","detail":"{read_only:false; response_revision:1890; number_of_response:1; }","duration":"152.431932ms","start":"2026-06-08T06:16:27.884271Z","end":"2026-06-08T06:16:28.036703Z","steps":["trace[1967955243] 'process raft request' (duration: 152.239907ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T06:16:28.036617Z","caller":"traceutil/trace.go:171","msg":"trace[1629880102] transaction","detail":"{read_only:false; response_revision:1888; number_of_response:1; }","duration":"277.662285ms","start":"2026-06-08T06:16:27.758895Z","end":"2026-06-08T06:16:28.036557Z","steps":["trace[1629880102] 'process raft request' (duration: 229.952524ms)","trace[1629880102] 'compare' (duration: 47.458464ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T06:16:28.037045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.113796ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-507d7c70-33d7-41d4-8468-8c894479318d\" ","response":"range_response_count:1 size:3626"} {"level":"info","ts":"2026-06-08T06:16:28.037144Z","caller":"traceutil/trace.go:171","msg":"trace[776868181] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-507d7c70-33d7-41d4-8468-8c894479318d; range_end:; response_count:1; response_revision:1890; }","duration":"141.273481ms","start":"2026-06-08T06:16:27.895851Z","end":"2026-06-08T06:16:28.037125Z","steps":["trace[776868181] 'agreement among raft nodes before linearized reading' (duration: 140.969713ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T06:16:28.182544Z","caller":"traceutil/trace.go:171","msg":"trace[1131801556] transaction","detail":"{read_only:false; response_revision:1891; number_of_response:1; }","duration":"137.834397ms","start":"2026-06-08T06:16:28.044675Z","end":"2026-06-08T06:16:28.182509Z","steps":["trace[1131801556] 'process raft request' (duration: 116.77725ms)","trace[1131801556] 'compare' (duration: 20.876262ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T06:16:41.376944Z","caller":"traceutil/trace.go:171","msg":"trace[560405747] linearizableReadLoop","detail":"{readStateIndex:2079; appliedIndex:2078; }","duration":"299.043213ms","start":"2026-06-08T06:16:41.07788Z","end":"2026-06-08T06:16:41.376924Z","steps":["trace[560405747] 'read index received' (duration: 298.860727ms)","trace[560405747] 'applied index is now lower than readState.Index' (duration: 181.466µs)"],"step_count":2} {"level":"info","ts":"2026-06-08T06:16:41.377061Z","caller":"traceutil/trace.go:171","msg":"trace[1061259339] transaction","detail":"{read_only:false; response_revision:2001; number_of_response:1; }","duration":"305.7158ms","start":"2026-06-08T06:16:41.071334Z","end":"2026-06-08T06:16:41.37705Z","steps":["trace[1061259339] 'process raft request' (duration: 305.451803ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T06:16:41.377294Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T06:16:41.071319Z","time spent":"305.762762ms","remote":"127.0.0.1:51352","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-08T06:16:41.377285Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.768439ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T06:16:41.377356Z","caller":"traceutil/trace.go:171","msg":"trace[414526702] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2001; }","duration":"187.873041ms","start":"2026-06-08T06:16:41.189464Z","end":"2026-06-08T06:16:41.377337Z","steps":["trace[414526702] 'agreement among raft nodes before linearized reading' (duration: 187.759408ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T06:16:41.377617Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.715702ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:558"} {"level":"info","ts":"2026-06-08T06:16:41.377705Z","caller":"traceutil/trace.go:171","msg":"trace[786848187] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:2001; }","duration":"299.884756ms","start":"2026-06-08T06:16:41.077798Z","end":"2026-06-08T06:16:41.377682Z","steps":["trace[786848187] 'agreement among raft nodes before linearized reading' (duration: 299.615038ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T06:16:56.412104Z","caller":"traceutil/trace.go:171","msg":"trace[215574035] linearizableReadLoop","detail":"{readStateIndex:2183; appliedIndex:2181; }","duration":"221.82944ms","start":"2026-06-08T06:16:56.190259Z","end":"2026-06-08T06:16:56.412088Z","steps":["trace[215574035] 'read index received' (duration: 132.02554ms)","trace[215574035] 'applied index is now lower than readState.Index' (duration: 89.80346ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T06:16:56.412191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.920603ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T06:16:56.412208Z","caller":"traceutil/trace.go:171","msg":"trace[1139133725] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2102; }","duration":"221.994504ms","start":"2026-06-08T06:16:56.190208Z","end":"2026-06-08T06:16:56.412203Z","steps":["trace[1139133725] 'agreement among raft nodes before linearized reading' (duration: 221.942083ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T06:16:56.412226Z","caller":"traceutil/trace.go:171","msg":"trace[474176389] transaction","detail":"{read_only:false; response_revision:2101; number_of_response:1; }","duration":"282.806392ms","start":"2026-06-08T06:16:56.12934Z","end":"2026-06-08T06:16:56.412146Z","steps":["trace[474176389] 'process raft request' (duration: 192.976731ms)","trace[474176389] 'compare' (duration: 89.659806ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T06:16:56.412325Z","caller":"traceutil/trace.go:171","msg":"trace[951872727] transaction","detail":"{read_only:false; response_revision:2102; number_of_response:1; }","duration":"278.279083ms","start":"2026-06-08T06:16:56.13404Z","end":"2026-06-08T06:16:56.412319Z","steps":["trace[951872727] 'process raft request' (duration: 278.022536ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T06:16:56.413626Z","caller":"traceutil/trace.go:171","msg":"trace[612943947] transaction","detail":"{read_only:false; response_revision:2103; number_of_response:1; }","duration":"151.235835ms","start":"2026-06-08T06:16:56.262379Z","end":"2026-06-08T06:16:56.413614Z","steps":["trace[612943947] 'process raft request' (duration: 150.993688ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T06:16:58.385481Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.305342ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T06:16:58.385596Z","caller":"traceutil/trace.go:171","msg":"trace[1872669985] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2112; }","duration":"195.468336ms","start":"2026-06-08T06:16:58.190098Z","end":"2026-06-08T06:16:58.385566Z","steps":["trace[1872669985] 'range keys from in-memory index tree' (duration: 195.22619ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T06:16:58.387803Z","caller":"traceutil/trace.go:171","msg":"trace[859362944] transaction","detail":"{read_only:false; response_revision:2113; number_of_response:1; }","duration":"192.376927ms","start":"2026-06-08T06:16:58.195403Z","end":"2026-06-08T06:16:58.38778Z","steps":["trace[859362944] 'process raft request' (duration: 192.143661ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T06:18:14.693487Z","caller":"traceutil/trace.go:171","msg":"trace[1640861286] transaction","detail":"{read_only:false; response_revision:2625; number_of_response:1; }","duration":"152.819126ms","start":"2026-06-08T06:18:14.540637Z","end":"2026-06-08T06:18:14.693456Z","steps":["trace[1640861286] 'process raft request' (duration: 152.6234ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T06:18:47.366887Z","caller":"traceutil/trace.go:171","msg":"trace[108653363] transaction","detail":"{read_only:false; response_revision:2806; number_of_response:1; }","duration":"107.012691ms","start":"2026-06-08T06:18:47.25985Z","end":"2026-06-08T06:18:47.366863Z","steps":["trace[108653363] 'process raft request' (duration: 106.868367ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T06:18:47.572857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.534826ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.23\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-06-08T06:18:47.572933Z","caller":"traceutil/trace.go:171","msg":"trace[1296321781] range","detail":"{range_begin:/registry/masterleases/199.204.45.23; range_end:; response_count:1; response_revision:2806; }","duration":"120.663799ms","start":"2026-06-08T06:18:47.45225Z","end":"2026-06-08T06:18:47.572914Z","steps":["trace[1296321781] 'range keys from in-memory index tree' (duration: 120.382562ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T06:22:35.186821Z","caller":"traceutil/trace.go:171","msg":"trace[1927289282] transaction","detail":"{read_only:false; response_revision:4717; number_of_response:1; }","duration":"168.823696ms","start":"2026-06-08T06:22:35.01797Z","end":"2026-06-08T06:22:35.186794Z","steps":["trace[1927289282] 'process raft request' (duration: 168.667142ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T06:22:35.374628Z","caller":"traceutil/trace.go:171","msg":"trace[1011075662] linearizableReadLoop","detail":"{readStateIndex:4898; appliedIndex:4896; }","duration":"199.303539ms","start":"2026-06-08T06:22:35.175301Z","end":"2026-06-08T06:22:35.374604Z","steps":["trace[1011075662] 'read index received' (duration: 11.444054ms)","trace[1011075662] 'applied index is now lower than readState.Index' (duration: 187.858345ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T06:22:35.374743Z","caller":"traceutil/trace.go:171","msg":"trace[348042738] transaction","detail":"{read_only:false; response_revision:4718; number_of_response:1; }","duration":"350.145486ms","start":"2026-06-08T06:22:35.024587Z","end":"2026-06-08T06:22:35.374732Z","steps":["trace[348042738] 'process raft request' (duration: 349.869519ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T06:22:35.374837Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T06:22:35.024565Z","time spent":"350.205558ms","remote":"127.0.0.1:51158","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":936,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-08T06:22:35.375151Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.470823ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/openstack/rabbitmq-keystone-default-user\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T06:22:35.375231Z","caller":"traceutil/trace.go:171","msg":"trace[1484434801] range","detail":"{range_begin:/registry/secrets/openstack/rabbitmq-keystone-default-user; range_end:; response_count:0; response_revision:4718; }","duration":"181.621248ms","start":"2026-06-08T06:22:35.193596Z","end":"2026-06-08T06:22:35.375217Z","steps":["trace[1484434801] 'agreement among raft nodes before linearized reading' (duration: 181.468684ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T06:22:35.375175Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.881314ms","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-06-08T06:22:35.375306Z","caller":"traceutil/trace.go:171","msg":"trace[977386014] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4718; }","duration":"200.07471ms","start":"2026-06-08T06:22:35.175221Z","end":"2026-06-08T06:22:35.375295Z","steps":["trace[977386014] 'agreement among raft nodes before linearized reading' (duration: 199.831653ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T06:22:35.736138Z","caller":"traceutil/trace.go:171","msg":"trace[881900991] linearizableReadLoop","detail":"{readStateIndex:4915; appliedIndex:4914; }","duration":"114.382307ms","start":"2026-06-08T06:22:35.621735Z","end":"2026-06-08T06:22:35.736117Z","steps":["trace[881900991] 'read index received' (duration: 55.294875ms)","trace[881900991] 'applied index is now lower than readState.Index' (duration: 59.086562ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T06:22:35.736295Z","caller":"traceutil/trace.go:171","msg":"trace[1704863337] transaction","detail":"{read_only:false; response_revision:4735; number_of_response:1; }","duration":"114.950212ms","start":"2026-06-08T06:22:35.621334Z","end":"2026-06-08T06:22:35.736284Z","steps":["trace[1704863337] 'process raft request' (duration: 109.198019ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T06:22:35.736444Z","caller":"traceutil/trace.go:171","msg":"trace[930360875] transaction","detail":"{read_only:false; response_revision:4736; number_of_response:1; }","duration":"114.582861ms","start":"2026-06-08T06:22:35.621819Z","end":"2026-06-08T06:22:35.736401Z","steps":["trace[930360875] 'process raft request' (duration: 114.223701ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T06:22:35.736681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.929482ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager\" ","response":"range_response_count:1 size:3958"} {"level":"info","ts":"2026-06-08T06:22:35.736727Z","caller":"traceutil/trace.go:171","msg":"trace[864985306] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager; range_end:; response_count:1; response_revision:4736; }","duration":"115.014184ms","start":"2026-06-08T06:22:35.621702Z","end":"2026-06-08T06:22:35.736716Z","steps":["trace[864985306] 'agreement among raft nodes before linearized reading' (duration: 114.822979ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T06:22:35.741164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.270449ms","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-06-08T06:22:35.741224Z","caller":"traceutil/trace.go:171","msg":"trace[498440214] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4738; }","duration":"111.377452ms","start":"2026-06-08T06:22:35.629834Z","end":"2026-06-08T06:22:35.741211Z","steps":["trace[498440214] 'agreement among raft nodes before linearized reading' (duration: 111.188966ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T06:22:35.898213Z","caller":"traceutil/trace.go:171","msg":"trace[1919000577] transaction","detail":"{read_only:false; response_revision:4740; number_of_response:1; }","duration":"152.015501ms","start":"2026-06-08T06:22:35.746162Z","end":"2026-06-08T06:22:35.898178Z","steps":["trace[1919000577] 'process raft request' (duration: 151.791414ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T06:22:35.898267Z","caller":"traceutil/trace.go:171","msg":"trace[1923033492] linearizableReadLoop","detail":"{readStateIndex:4920; appliedIndex:4919; }","duration":"151.786624ms","start":"2026-06-08T06:22:35.746455Z","end":"2026-06-08T06:22:35.898242Z","steps":["trace[1923033492] 'read index received' (duration: 16.741234ms)","trace[1923033492] 'applied index is now lower than readState.Index' (duration: 135.0443ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T06:22:35.898462Z","caller":"traceutil/trace.go:171","msg":"trace[107745256] transaction","detail":"{read_only:false; response_revision:4741; number_of_response:1; }","duration":"151.419314ms","start":"2026-06-08T06:22:35.747009Z","end":"2026-06-08T06:22:35.898428Z","steps":["trace[107745256] 'process raft request' (duration: 151.099505ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T06:22:35.898467Z","caller":"traceutil/trace.go:171","msg":"trace[1771100768] transaction","detail":"{read_only:false; response_revision:4742; number_of_response:1; }","duration":"142.217264ms","start":"2026-06-08T06:22:35.756237Z","end":"2026-06-08T06:22:35.898455Z","steps":["trace[1771100768] 'process raft request' (duration: 141.923066ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T06:22:35.898652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.156705ms","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-06-08T06:22:35.899733Z","caller":"traceutil/trace.go:171","msg":"trace[1419367670] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4742; }","duration":"153.277787ms","start":"2026-06-08T06:22:35.746439Z","end":"2026-06-08T06:22:35.899716Z","steps":["trace[1419367670] 'agreement among raft nodes before linearized reading' (duration: 152.035231ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T06:22:35.899127Z","caller":"traceutil/trace.go:171","msg":"trace[920719031] transaction","detail":"{read_only:false; response_revision:4743; number_of_response:1; }","duration":"127.138537ms","start":"2026-06-08T06:22:35.771974Z","end":"2026-06-08T06:22:35.899112Z","steps":["trace[920719031] 'process raft request' (duration: 126.921071ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T06:22:35.899267Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.206665ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2082"} {"level":"info","ts":"2026-06-08T06:22:35.900018Z","caller":"traceutil/trace.go:171","msg":"trace[2064341469] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4743; }","duration":"130.004619ms","start":"2026-06-08T06:22:35.770004Z","end":"2026-06-08T06:22:35.900009Z","steps":["trace[2064341469] 'agreement among raft nodes before linearized reading' (duration: 129.115823ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T06:22:35.902657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.195152ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated\" ","response":"range_response_count:1 size:1343"} {"level":"info","ts":"2026-06-08T06:22:35.90271Z","caller":"traceutil/trace.go:171","msg":"trace[1570853609] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated; range_end:; response_count:1; response_revision:4743; }","duration":"149.290525ms","start":"2026-06-08T06:22:35.753405Z","end":"2026-06-08T06:22:35.902695Z","steps":["trace[1570853609] 'agreement among raft nodes before linearized reading' (duration: 145.569129ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T06:22:36.009456Z","caller":"traceutil/trace.go:171","msg":"trace[357777993] transaction","detail":"{read_only:false; response_revision:4745; number_of_response:1; }","duration":"101.492921ms","start":"2026-06-08T06:22:35.907933Z","end":"2026-06-08T06:22:36.009426Z","steps":["trace[357777993] 'process raft request' (duration: 101.252285ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T06:24:04.658934Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2896} {"level":"info","ts":"2026-06-08T06:24:04.73856Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2896,"took":"77.654129ms","hash":4074829106,"current-db-size-bytes":54022144,"current-db-size":"54 MB","current-db-size-in-use-bytes":29138944,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-06-08T06:24:04.738634Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4074829106,"revision":2896,"compact-revision":-1} {"level":"info","ts":"2026-06-08T06:29:04.665519Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5572} {"level":"info","ts":"2026-06-08T06:29:04.771377Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5572,"took":"104.498912ms","hash":2294788626,"current-db-size-bytes":54022144,"current-db-size":"54 MB","current-db-size-in-use-bytes":18460672,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-06-08T06:29:04.771434Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2294788626,"revision":5572,"compact-revision":2896}