{"level":"warn","ts":"2026-07-01T07:20:58.658376Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-01T07:20:58.658499Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.248: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.248:2380","--initial-cluster=instance=https://199.204.45.248:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.248:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.248: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-07-01T07:20:58.658594Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-01T07:20:58.658626Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.248:2380"]} {"level":"info","ts":"2026-07-01T07:20:58.658648Z","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-07-01T07:20:58.659495Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.248:2379"]} {"level":"info","ts":"2026-07-01T07:20:58.659583Z","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.248:2380"],"listen-peer-urls":["https://199.204.45.248:2380"],"advertise-client-urls":["https://199.204.45.248:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.248:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.248: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-07-01T07:20:58.663429Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.583733ms"} {"level":"info","ts":"2026-07-01T07:20:58.674371Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"39582465ceaa2f67","cluster-id":"87fd8ddedde3be45"} {"level":"info","ts":"2026-07-01T07:20:58.674472Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 switched to configuration voters=()"} {"level":"info","ts":"2026-07-01T07:20:58.674503Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became follower at term 0"} {"level":"info","ts":"2026-07-01T07:20:58.674518Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 39582465ceaa2f67 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-01T07:20:58.674528Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became follower at term 1"} {"level":"info","ts":"2026-07-01T07:20:58.674569Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 switched to configuration voters=(4132092677789986663)"} {"level":"warn","ts":"2026-07-01T07:20:58.686659Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-01T07:20:58.689232Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-01T07:20:58.690311Z","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-07-01T07:20:58.694942Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"39582465ceaa2f67","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-01T07:20:58.695158Z","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-07-01T07:20:58.695284Z","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-07-01T07:20:58.695296Z","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-07-01T07:20:58.695501Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"39582465ceaa2f67","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-01T07:20:58.698516Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 switched to configuration voters=(4132092677789986663)"} {"level":"info","ts":"2026-07-01T07:20:58.699248Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"87fd8ddedde3be45","local-member-id":"39582465ceaa2f67","added-peer-id":"39582465ceaa2f67","added-peer-peer-urls":["https://199.204.45.248:2380"]} {"level":"info","ts":"2026-07-01T07:20:58.700825Z","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-07-01T07:20:58.700969Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.248:2380"} {"level":"info","ts":"2026-07-01T07:20:58.701016Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.248:2380"} {"level":"info","ts":"2026-07-01T07:20:58.701168Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"39582465ceaa2f67","initial-advertise-peer-urls":["https://199.204.45.248:2380"],"listen-peer-urls":["https://199.204.45.248:2380"],"advertise-client-urls":["https://199.204.45.248:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.248:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-01T07:20:58.701213Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-01T07:20:59.176833Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 is starting a new election at term 1"} {"level":"info","ts":"2026-07-01T07:20:59.176954Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became pre-candidate at term 1"} {"level":"info","ts":"2026-07-01T07:20:59.177003Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 received MsgPreVoteResp from 39582465ceaa2f67 at term 1"} {"level":"info","ts":"2026-07-01T07:20:59.177093Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became candidate at term 2"} {"level":"info","ts":"2026-07-01T07:20:59.177129Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 received MsgVoteResp from 39582465ceaa2f67 at term 2"} {"level":"info","ts":"2026-07-01T07:20:59.177188Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became leader at term 2"} {"level":"info","ts":"2026-07-01T07:20:59.177216Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 39582465ceaa2f67 elected leader 39582465ceaa2f67 at term 2"} {"level":"info","ts":"2026-07-01T07:20:59.190703Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-01T07:20:59.19964Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"39582465ceaa2f67","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.248:2379]}","request-path":"/0/members/39582465ceaa2f67/attributes","cluster-id":"87fd8ddedde3be45","publish-timeout":"7s"} {"level":"info","ts":"2026-07-01T07:20:59.199698Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-01T07:20:59.199985Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-01T07:20:59.200031Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-01T07:20:59.200234Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"87fd8ddedde3be45","local-member-id":"39582465ceaa2f67","cluster-version":"3.5"} {"level":"info","ts":"2026-07-01T07:20:59.200436Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-01T07:20:59.200506Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-01T07:20:59.203619Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-01T07:20:59.215139Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-01T07:20:59.220156Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.248:2379"} {"level":"info","ts":"2026-07-01T07:21:22.866711Z","caller":"traceutil/trace.go:171","msg":"trace[1792451998] transaction","detail":"{read_only:false; response_revision:436; number_of_response:1; }","duration":"101.713049ms","start":"2026-07-01T07:21:22.764968Z","end":"2026-07-01T07:21:22.866681Z","steps":["trace[1792451998] 'process raft request' (duration: 101.493478ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:21:22.890194Z","caller":"traceutil/trace.go:171","msg":"trace[1336322724] transaction","detail":"{read_only:false; response_revision:437; number_of_response:1; }","duration":"125.072969ms","start":"2026-07-01T07:21:22.765091Z","end":"2026-07-01T07:21:22.890164Z","steps":["trace[1336322724] 'process raft request' (duration: 124.786377ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:21:22.890086Z","caller":"traceutil/trace.go:171","msg":"trace[947360204] linearizableReadLoop","detail":"{readStateIndex:453; appliedIndex:451; }","duration":"118.368438ms","start":"2026-07-01T07:21:22.771683Z","end":"2026-07-01T07:21:22.890051Z","steps":["trace[947360204] 'read index received' (duration: 94.894098ms)","trace[947360204] 'applied index is now lower than readState.Index' (duration: 23.47283ms)"],"step_count":2} {"level":"warn","ts":"2026-07-01T07:21:22.890422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.699912ms","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-07-01T07:21:22.890542Z","caller":"traceutil/trace.go:171","msg":"trace[1154272249] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:437; }","duration":"118.876393ms","start":"2026-07-01T07:21:22.771647Z","end":"2026-07-01T07:21:22.890523Z","steps":["trace[1154272249] 'agreement among raft nodes before linearized reading' (duration: 118.631641ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:21:37.298478Z","caller":"traceutil/trace.go:171","msg":"trace[1362343208] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"120.820337ms","start":"2026-07-01T07:21:37.17762Z","end":"2026-07-01T07:21:37.29844Z","steps":["trace[1362343208] 'process raft request' (duration: 120.615385ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:21:37.310053Z","caller":"traceutil/trace.go:171","msg":"trace[968519503] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"131.587438ms","start":"2026-07-01T07:21:37.178447Z","end":"2026-07-01T07:21:37.310035Z","steps":["trace[968519503] 'process raft request' (duration: 131.375626ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:21:37.310199Z","caller":"traceutil/trace.go:171","msg":"trace[1807813191] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"124.747478ms","start":"2026-07-01T07:21:37.185424Z","end":"2026-07-01T07:21:37.310171Z","steps":["trace[1807813191] 'process raft request' (duration: 124.529125ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:21:37.310346Z","caller":"traceutil/trace.go:171","msg":"trace[1683714469] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"131.81078ms","start":"2026-07-01T07:21:37.178529Z","end":"2026-07-01T07:21:37.31034Z","steps":["trace[1683714469] 'process raft request' (duration: 131.390815ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:21:37.310471Z","caller":"traceutil/trace.go:171","msg":"trace[115244418] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"107.326611ms","start":"2026-07-01T07:21:37.203137Z","end":"2026-07-01T07:21:37.310464Z","steps":["trace[115244418] 'process raft request' (duration: 106.967946ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:21:37.310534Z","caller":"traceutil/trace.go:171","msg":"trace[1784660588] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"124.385385ms","start":"2026-07-01T07:21:37.186144Z","end":"2026-07-01T07:21:37.310529Z","steps":["trace[1784660588] 'process raft request' (duration: 123.854287ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:21:37.310746Z","caller":"traceutil/trace.go:171","msg":"trace[561174698] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"119.742593ms","start":"2026-07-01T07:21:37.19099Z","end":"2026-07-01T07:21:37.310733Z","steps":["trace[561174698] 'process raft request' (duration: 119.073084ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:21:37.310869Z","caller":"traceutil/trace.go:171","msg":"trace[413357455] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"102.522219ms","start":"2026-07-01T07:21:37.208338Z","end":"2026-07-01T07:21:37.31086Z","steps":["trace[413357455] 'process raft request' (duration: 101.829159ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:21:43.496459Z","caller":"traceutil/trace.go:171","msg":"trace[1448005842] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"229.384134ms","start":"2026-07-01T07:21:43.267018Z","end":"2026-07-01T07:21:43.496402Z","steps":["trace[1448005842] 'process raft request' (duration: 226.738986ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:21:43.704948Z","caller":"traceutil/trace.go:171","msg":"trace[522193419] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"150.91604ms","start":"2026-07-01T07:21:43.55398Z","end":"2026-07-01T07:21:43.704896Z","steps":["trace[522193419] 'process raft request' (duration: 75.769774ms)","trace[522193419] 'compare' (duration: 74.924403ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T07:21:44.220011Z","caller":"traceutil/trace.go:171","msg":"trace[1348763403] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"111.100789ms","start":"2026-07-01T07:21:44.108885Z","end":"2026-07-01T07:21:44.219986Z","steps":["trace[1348763403] 'process raft request' (duration: 110.584322ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:21:45.486429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.054219ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-07-01T07:21:45.486559Z","caller":"traceutil/trace.go:171","msg":"trace[1479768170] transaction","detail":"{read_only:false; response_revision:649; number_of_response:1; }","duration":"118.152208ms","start":"2026-07-01T07:21:45.368389Z","end":"2026-07-01T07:21:45.486541Z","steps":["trace[1479768170] 'process raft request' (duration: 17.312977ms)","trace[1479768170] 'compare' (duration: 99.855357ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T07:21:59.475339Z","caller":"traceutil/trace.go:171","msg":"trace[1274160003] transaction","detail":"{read_only:false; response_revision:805; number_of_response:1; }","duration":"130.559074ms","start":"2026-07-01T07:21:59.344745Z","end":"2026-07-01T07:21:59.475304Z","steps":["trace[1274160003] 'process raft request' (duration: 130.31702ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:22:31.94513Z","caller":"traceutil/trace.go:171","msg":"trace[2085738820] transaction","detail":"{read_only:false; response_revision:1216; number_of_response:1; }","duration":"107.979362ms","start":"2026-07-01T07:22:31.837103Z","end":"2026-07-01T07:22:31.945082Z","steps":["trace[2085738820] 'process raft request' (duration: 107.733486ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:22:54.963351Z","caller":"traceutil/trace.go:171","msg":"trace[1374829926] linearizableReadLoop","detail":"{readStateIndex:1520; appliedIndex:1519; }","duration":"177.907399ms","start":"2026-07-01T07:22:54.785416Z","end":"2026-07-01T07:22:54.963323Z","steps":["trace[1374829926] 'read index received' (duration: 177.581261ms)","trace[1374829926] 'applied index is now lower than readState.Index' (duration: 324.957µs)"],"step_count":2} {"level":"info","ts":"2026-07-01T07:22:54.963426Z","caller":"traceutil/trace.go:171","msg":"trace[355570756] transaction","detail":"{read_only:false; response_revision:1476; number_of_response:1; }","duration":"261.485195ms","start":"2026-07-01T07:22:54.701914Z","end":"2026-07-01T07:22:54.963399Z","steps":["trace[355570756] 'process raft request' (duration: 261.226079ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:22:54.963714Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.254547ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-01T07:22:54.96387Z","caller":"traceutil/trace.go:171","msg":"trace[2030262522] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1476; }","duration":"178.483083ms","start":"2026-07-01T07:22:54.785358Z","end":"2026-07-01T07:22:54.963841Z","steps":["trace[2030262522] 'agreement among raft nodes before linearized reading' (duration: 178.130544ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:23:19.70544Z","caller":"traceutil/trace.go:171","msg":"trace[963459859] transaction","detail":"{read_only:false; response_revision:1877; number_of_response:1; }","duration":"142.312872ms","start":"2026-07-01T07:23:19.56309Z","end":"2026-07-01T07:23:19.705403Z","steps":["trace[963459859] 'process raft request' (duration: 82.976066ms)","trace[963459859] 'compare' (duration: 58.955666ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T07:23:20.071562Z","caller":"traceutil/trace.go:171","msg":"trace[1598050037] transaction","detail":"{read_only:false; response_revision:1878; number_of_response:1; }","duration":"300.444218ms","start":"2026-07-01T07:23:19.771075Z","end":"2026-07-01T07:23:20.071519Z","steps":["trace[1598050037] 'process raft request' (duration: 241.564701ms)","trace[1598050037] 'compare' (duration: 58.416545ms)"],"step_count":2} {"level":"warn","ts":"2026-07-01T07:23:20.072134Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:23:19.771046Z","time spent":"300.634413ms","remote":"127.0.0.1:52652","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3729,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-01T07:23:20.521429Z","caller":"traceutil/trace.go:171","msg":"trace[1120702057] transaction","detail":"{read_only:false; response_revision:1879; number_of_response:1; }","duration":"272.751206ms","start":"2026-07-01T07:23:20.248643Z","end":"2026-07-01T07:23:20.521394Z","steps":["trace[1120702057] 'process raft request' (duration: 272.505739ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:23:20.566942Z","caller":"traceutil/trace.go:171","msg":"trace[1721262858] linearizableReadLoop","detail":"{readStateIndex:1953; appliedIndex:1950; }","duration":"135.718642ms","start":"2026-07-01T07:23:20.431197Z","end":"2026-07-01T07:23:20.566915Z","steps":["trace[1721262858] 'read index received' (duration: 90.013818ms)","trace[1721262858] 'applied index is now lower than readState.Index' (duration: 45.703804ms)"],"step_count":2} {"level":"warn","ts":"2026-07-01T07:23:20.567185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.955468ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-07-01T07:23:20.56704Z","caller":"traceutil/trace.go:171","msg":"trace[1362353532] transaction","detail":"{read_only:false; response_revision:1880; number_of_response:1; }","duration":"316.542979ms","start":"2026-07-01T07:23:20.250452Z","end":"2026-07-01T07:23:20.566995Z","steps":["trace[1362353532] 'process raft request' (duration: 298.671384ms)","trace[1362353532] 'compare' (duration: 17.569627ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T07:23:20.567239Z","caller":"traceutil/trace.go:171","msg":"trace[226260982] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1881; }","duration":"136.081431ms","start":"2026-07-01T07:23:20.431141Z","end":"2026-07-01T07:23:20.567222Z","steps":["trace[226260982] 'agreement among raft nodes before linearized reading' (duration: 135.875416ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:23:20.567234Z","caller":"traceutil/trace.go:171","msg":"trace[54564564] transaction","detail":"{read_only:false; response_revision:1881; number_of_response:1; }","duration":"207.090006ms","start":"2026-07-01T07:23:20.360074Z","end":"2026-07-01T07:23:20.567164Z","steps":["trace[54564564] 'process raft request' (duration: 206.787288ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:23:20.567558Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:23:20.250434Z","time spent":"317.001911ms","remote":"127.0.0.1:52714","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":538,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-01T07:23:48.79731Z","caller":"traceutil/trace.go:171","msg":"trace[2042388878] linearizableReadLoop","detail":"{readStateIndex:2170; appliedIndex:2169; }","duration":"108.852506ms","start":"2026-07-01T07:23:48.68842Z","end":"2026-07-01T07:23:48.797272Z","steps":["trace[2042388878] 'read index received' (duration: 108.466086ms)","trace[2042388878] 'applied index is now lower than readState.Index' (duration: 384.8µs)"],"step_count":2} {"level":"info","ts":"2026-07-01T07:23:48.797408Z","caller":"traceutil/trace.go:171","msg":"trace[1849300858] transaction","detail":"{read_only:false; response_revision:2091; number_of_response:1; }","duration":"115.277217ms","start":"2026-07-01T07:23:48.682095Z","end":"2026-07-01T07:23:48.797372Z","steps":["trace[1849300858] 'process raft request' (duration: 114.901167ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:23:48.797868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.413091ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-07-01T07:23:48.797946Z","caller":"traceutil/trace.go:171","msg":"trace[505706812] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2091; }","duration":"109.566765ms","start":"2026-07-01T07:23:48.68836Z","end":"2026-07-01T07:23:48.797927Z","steps":["trace[505706812] 'agreement among raft nodes before linearized reading' (duration: 109.126224ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:23:50.002808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.622755ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-07-01T07:23:50.002909Z","caller":"traceutil/trace.go:171","msg":"trace[1882457465] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2098; }","duration":"197.788759ms","start":"2026-07-01T07:23:49.805098Z","end":"2026-07-01T07:23:50.002887Z","steps":["trace[1882457465] 'range keys from in-memory index tree' (duration: 197.374509ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:23:50.003252Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.10018ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-01T07:23:50.003281Z","caller":"traceutil/trace.go:171","msg":"trace[451473540] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2098; }","duration":"218.182861ms","start":"2026-07-01T07:23:49.785089Z","end":"2026-07-01T07:23:50.003271Z","steps":["trace[451473540] 'range keys from in-memory index tree' (duration: 218.016447ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:29:36.333899Z","caller":"traceutil/trace.go:171","msg":"trace[1213853798] transaction","detail":"{read_only:false; response_revision:4716; number_of_response:1; }","duration":"410.166949ms","start":"2026-07-01T07:29:35.923701Z","end":"2026-07-01T07:29:36.333868Z","steps":["trace[1213853798] 'process raft request' (duration: 409.344028ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:29:36.334073Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:29:35.923689Z","time spent":"410.304392ms","remote":"127.0.0.1:52548","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":911,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-01T07:29:36.334474Z","caller":"traceutil/trace.go:171","msg":"trace[294649713] linearizableReadLoop","detail":"{readStateIndex:4893; appliedIndex:4891; }","duration":"409.145014ms","start":"2026-07-01T07:29:35.925313Z","end":"2026-07-01T07:29:36.334458Z","steps":["trace[294649713] 'read index received' (duration: 15.997006ms)","trace[294649713] 'applied index is now lower than readState.Index' (duration: 393.146948ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T07:29:36.334571Z","caller":"traceutil/trace.go:171","msg":"trace[1695260604] transaction","detail":"{read_only:false; response_revision:4717; number_of_response:1; }","duration":"402.648393ms","start":"2026-07-01T07:29:35.931912Z","end":"2026-07-01T07:29:36.33456Z","steps":["trace[1695260604] 'process raft request' (duration: 401.892144ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:29:36.334659Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:29:35.931897Z","time spent":"402.704034ms","remote":"127.0.0.1:59222","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6497,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-01T07:29:36.334826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"409.499692ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/monitoring/alertmanager-operated\" ","response":"range_response_count:1 size:1285"} {"level":"info","ts":"2026-07-01T07:29:36.334891Z","caller":"traceutil/trace.go:171","msg":"trace[1963265153] range","detail":"{range_begin:/registry/services/specs/monitoring/alertmanager-operated; range_end:; response_count:1; response_revision:4717; }","duration":"409.620135ms","start":"2026-07-01T07:29:35.925255Z","end":"2026-07-01T07:29:36.334876Z","steps":["trace[1963265153] 'agreement among raft nodes before linearized reading' (duration: 409.353808ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:29:36.334933Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:29:35.925249Z","time spent":"409.674836ms","remote":"127.0.0.1:52660","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":1308,"request content":"key:\"/registry/services/specs/monitoring/alertmanager-operated\" "} {"level":"info","ts":"2026-07-01T07:29:36.338249Z","caller":"traceutil/trace.go:171","msg":"trace[6284075] transaction","detail":"{read_only:false; response_revision:4719; number_of_response:1; }","duration":"105.041712ms","start":"2026-07-01T07:29:36.233194Z","end":"2026-07-01T07:29:36.338236Z","steps":["trace[6284075] 'process raft request' (duration: 104.889478ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:29:36.338269Z","caller":"traceutil/trace.go:171","msg":"trace[1598016517] transaction","detail":"{read_only:false; response_revision:4718; number_of_response:1; }","duration":"108.628011ms","start":"2026-07-01T07:29:36.229625Z","end":"2026-07-01T07:29:36.338253Z","steps":["trace[1598016517] 'process raft request' (duration: 108.338294ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:29:36.338391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.456052ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-01T07:29:36.338467Z","caller":"traceutil/trace.go:171","msg":"trace[270302771] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4719; }","duration":"170.583806ms","start":"2026-07-01T07:29:36.167865Z","end":"2026-07-01T07:29:36.338449Z","steps":["trace[270302771] 'agreement among raft nodes before linearized reading' (duration: 170.423622ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:29:36.340923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.241489ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2206973"} {"level":"info","ts":"2026-07-01T07:29:36.341012Z","caller":"traceutil/trace.go:171","msg":"trace[1456106981] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:4719; }","duration":"250.383632ms","start":"2026-07-01T07:29:36.090608Z","end":"2026-07-01T07:29:36.340992Z","steps":["trace[1456106981] 'agreement among raft nodes before linearized reading' (duration: 247.586873ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:29:42.148127Z","caller":"traceutil/trace.go:171","msg":"trace[1552263458] transaction","detail":"{read_only:false; response_revision:4777; number_of_response:1; }","duration":"129.011726ms","start":"2026-07-01T07:29:42.019086Z","end":"2026-07-01T07:29:42.148097Z","steps":["trace[1552263458] 'process raft request' (duration: 128.838602ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:29:42.394222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.830898ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.248\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-07-01T07:29:42.394325Z","caller":"traceutil/trace.go:171","msg":"trace[356690150] range","detail":"{range_begin:/registry/masterleases/199.204.45.248; range_end:; response_count:1; response_revision:4777; }","duration":"159.028004ms","start":"2026-07-01T07:29:42.235275Z","end":"2026-07-01T07:29:42.394303Z","steps":["trace[356690150] 'range keys from in-memory index tree' (duration: 158.542681ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:29:49.183294Z","caller":"traceutil/trace.go:171","msg":"trace[1300879366] transaction","detail":"{read_only:false; response_revision:4934; number_of_response:1; }","duration":"129.384489ms","start":"2026-07-01T07:29:49.053877Z","end":"2026-07-01T07:29:49.183262Z","steps":["trace[1300879366] 'process raft request' (duration: 129.195424ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:29:49.22038Z","caller":"traceutil/trace.go:171","msg":"trace[1684855070] transaction","detail":"{read_only:false; response_revision:4935; number_of_response:1; }","duration":"164.239709ms","start":"2026-07-01T07:29:49.056108Z","end":"2026-07-01T07:29:49.220348Z","steps":["trace[1684855070] 'process raft request' (duration: 164.073365ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:29:49.421495Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.108386ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-01T07:29:49.421609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.968336ms","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-07-01T07:29:49.421688Z","caller":"traceutil/trace.go:171","msg":"trace[935265717] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4935; }","duration":"183.087319ms","start":"2026-07-01T07:29:49.238582Z","end":"2026-07-01T07:29:49.42167Z","steps":["trace[935265717] 'range keys from in-memory index tree' (duration: 182.772421ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:29:49.421614Z","caller":"traceutil/trace.go:171","msg":"trace[1242812872] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:4935; }","duration":"124.289061ms","start":"2026-07-01T07:29:49.297294Z","end":"2026-07-01T07:29:49.421583Z","steps":["trace[1242812872] 'count revisions from in-memory index tree' (duration: 124.028594ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:29:49.421753Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.204124ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-cfe25f3d-f182-4306-ab9b-c66059a38dd5\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-07-01T07:29:49.422151Z","caller":"traceutil/trace.go:171","msg":"trace[724334505] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-cfe25f3d-f182-4306-ab9b-c66059a38dd5; range_end:; response_count:1; response_revision:4935; }","duration":"133.912931ms","start":"2026-07-01T07:29:49.28819Z","end":"2026-07-01T07:29:49.422103Z","steps":["trace[724334505] 'range keys from in-memory index tree' (duration: 133.021379ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:30:59.237885Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2896} {"level":"info","ts":"2026-07-01T07:30:59.333112Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2896,"took":"92.764263ms","hash":438667572,"current-db-size-bytes":53673984,"current-db-size":"54 MB","current-db-size-in-use-bytes":28807168,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-07-01T07:30:59.333173Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":438667572,"revision":2896,"compact-revision":-1} {"level":"info","ts":"2026-07-01T07:35:59.244967Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5534} {"level":"info","ts":"2026-07-01T07:35:59.340106Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5534,"took":"93.188939ms","hash":1235912723,"current-db-size-bytes":53673984,"current-db-size":"54 MB","current-db-size-in-use-bytes":18624512,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-07-01T07:35:59.340201Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1235912723,"revision":5534,"compact-revision":2896}