{"level":"warn","ts":"2026-09-01T04:06:57.406158Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-01T04:06:57.406342Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.20:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://162.253.55.20:2380","--initial-cluster=controller=https://162.253.55.20:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.20:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.20:2380","--name=controller","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-09-01T04:06:57.406461Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-01T04:06:57.40648Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.20:2380"]} {"level":"info","ts":"2026-09-01T04:06:57.406526Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-09-01T04:06:57.407746Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.20:2379"]} {"level":"info","ts":"2026-09-01T04:06:57.407929Z","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":"controller","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://162.253.55.20:2380"],"listen-peer-urls":["https://162.253.55.20:2380"],"advertise-client-urls":["https://162.253.55.20:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.20:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"controller=https://162.253.55.20:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-09-01T04:06:57.414684Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.412616ms"} {"level":"info","ts":"2026-09-01T04:06:57.423637Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"eae99266654eff69","cluster-id":"6d4184aac664e4ac"} {"level":"info","ts":"2026-09-01T04:06:57.423748Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"eae99266654eff69 switched to configuration voters=()"} {"level":"info","ts":"2026-09-01T04:06:57.423766Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"eae99266654eff69 became follower at term 0"} {"level":"info","ts":"2026-09-01T04:06:57.423774Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft eae99266654eff69 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-01T04:06:57.423784Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"eae99266654eff69 became follower at term 1"} {"level":"info","ts":"2026-09-01T04:06:57.423816Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"eae99266654eff69 switched to configuration voters=(16927221642932715369)"} {"level":"warn","ts":"2026-09-01T04:06:57.433094Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-01T04:06:57.434824Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-01T04:06:57.437155Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-09-01T04:06:57.439269Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"eae99266654eff69","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-01T04:06:57.439512Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"eae99266654eff69","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-01T04:06:57.439501Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-09-01T04:06:57.439646Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-09-01T04:06:57.43966Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-09-01T04:06:57.441074Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"eae99266654eff69 switched to configuration voters=(16927221642932715369)"} {"level":"info","ts":"2026-09-01T04:06:57.441199Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"6d4184aac664e4ac","local-member-id":"eae99266654eff69","added-peer-id":"eae99266654eff69","added-peer-peer-urls":["https://162.253.55.20:2380"]} {"level":"info","ts":"2026-09-01T04:06:57.443133Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-09-01T04:06:57.443169Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.20:2380"} {"level":"info","ts":"2026-09-01T04:06:57.443196Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.20:2380"} {"level":"info","ts":"2026-09-01T04:06:57.44342Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"eae99266654eff69","initial-advertise-peer-urls":["https://162.253.55.20:2380"],"listen-peer-urls":["https://162.253.55.20:2380"],"advertise-client-urls":["https://162.253.55.20:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.20:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-01T04:06:57.443463Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-01T04:06:57.724883Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"eae99266654eff69 is starting a new election at term 1"} {"level":"info","ts":"2026-09-01T04:06:57.724934Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"eae99266654eff69 became pre-candidate at term 1"} {"level":"info","ts":"2026-09-01T04:06:57.724975Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"eae99266654eff69 received MsgPreVoteResp from eae99266654eff69 at term 1"} {"level":"info","ts":"2026-09-01T04:06:57.724989Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"eae99266654eff69 became candidate at term 2"} {"level":"info","ts":"2026-09-01T04:06:57.724997Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"eae99266654eff69 received MsgVoteResp from eae99266654eff69 at term 2"} {"level":"info","ts":"2026-09-01T04:06:57.725008Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"eae99266654eff69 became leader at term 2"} {"level":"info","ts":"2026-09-01T04:06:57.725017Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: eae99266654eff69 elected leader eae99266654eff69 at term 2"} {"level":"info","ts":"2026-09-01T04:06:57.726948Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-01T04:06:57.727309Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"eae99266654eff69","local-member-attributes":"{Name:controller ClientURLs:[https://162.253.55.20:2379]}","request-path":"/0/members/eae99266654eff69/attributes","cluster-id":"6d4184aac664e4ac","publish-timeout":"7s"} {"level":"info","ts":"2026-09-01T04:06:57.727422Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-01T04:06:57.727864Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"6d4184aac664e4ac","local-member-id":"eae99266654eff69","cluster-version":"3.5"} {"level":"info","ts":"2026-09-01T04:06:57.727916Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-01T04:06:57.727933Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-01T04:06:57.727473Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-01T04:06:57.729775Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-01T04:06:57.731426Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-01T04:06:57.731492Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-01T04:06:57.733305Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.20:2379"} {"level":"info","ts":"2026-09-01T04:07:15.448412Z","caller":"traceutil/trace.go:171","msg":"trace[1631034542] transaction","detail":"{read_only:false; response_revision:445; number_of_response:1; }","duration":"154.223763ms","start":"2026-09-01T04:07:15.294137Z","end":"2026-09-01T04:07:15.448361Z","steps":["trace[1631034542] 'process raft request' (duration: 154.050557ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:07:15.871493Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.301652ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-09-01T04:07:15.871633Z","caller":"traceutil/trace.go:171","msg":"trace[1430328806] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:445; }","duration":"123.487089ms","start":"2026-09-01T04:07:15.748121Z","end":"2026-09-01T04:07:15.871608Z","steps":["trace[1430328806] 'range keys from in-memory index tree' (duration: 123.211639ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:07:15.871715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.468572ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-09-01T04:07:15.871769Z","caller":"traceutil/trace.go:171","msg":"trace[282496456] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:445; }","duration":"129.549635ms","start":"2026-09-01T04:07:15.742205Z","end":"2026-09-01T04:07:15.871754Z","steps":["trace[282496456] 'range keys from in-memory index tree' (duration: 129.41813ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:07:16.241441Z","caller":"traceutil/trace.go:171","msg":"trace[456136556] linearizableReadLoop","detail":"{readStateIndex:462; appliedIndex:461; }","duration":"211.93317ms","start":"2026-09-01T04:07:16.029484Z","end":"2026-09-01T04:07:16.241417Z","steps":["trace[456136556] 'read index received' (duration: 177.959116ms)","trace[456136556] 'applied index is now lower than readState.Index' (duration: 33.973033ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T04:07:16.241566Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.053344ms","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-09-01T04:07:16.241602Z","caller":"traceutil/trace.go:171","msg":"trace[535694195] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:448; }","duration":"212.139347ms","start":"2026-09-01T04:07:16.029453Z","end":"2026-09-01T04:07:16.241592Z","steps":["trace[535694195] 'agreement among raft nodes before linearized reading' (duration: 212.048474ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:07:16.241833Z","caller":"traceutil/trace.go:171","msg":"trace[1738247736] transaction","detail":"{read_only:false; response_revision:448; number_of_response:1; }","duration":"361.435486ms","start":"2026-09-01T04:07:15.880353Z","end":"2026-09-01T04:07:16.241788Z","steps":["trace[1738247736] 'process raft request' (duration: 327.140281ms)","trace[1738247736] 'compare' (duration: 33.780266ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T04:07:16.243671Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:07:15.880326Z","time spent":"361.825731ms","remote":"127.0.0.1:52178","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4123,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-01T04:07:31.552477Z","caller":"traceutil/trace.go:171","msg":"trace[179618045] transaction","detail":"{read_only:false; response_revision:607; number_of_response:1; }","duration":"279.463706ms","start":"2026-09-01T04:07:31.272994Z","end":"2026-09-01T04:07:31.552458Z","steps":["trace[179618045] 'process raft request' (duration: 279.3084ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:07:31.598576Z","caller":"traceutil/trace.go:171","msg":"trace[1593474865] transaction","detail":"{read_only:false; response_revision:608; number_of_response:1; }","duration":"323.078167ms","start":"2026-09-01T04:07:31.275453Z","end":"2026-09-01T04:07:31.598532Z","steps":["trace[1593474865] 'process raft request' (duration: 322.741365ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:07:31.598652Z","caller":"traceutil/trace.go:171","msg":"trace[630673910] transaction","detail":"{read_only:false; response_revision:609; number_of_response:1; }","duration":"256.40909ms","start":"2026-09-01T04:07:31.342212Z","end":"2026-09-01T04:07:31.598621Z","steps":["trace[630673910] 'process raft request' (duration: 256.15286ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:07:31.598733Z","caller":"traceutil/trace.go:171","msg":"trace[420941077] transaction","detail":"{read_only:false; response_revision:610; number_of_response:1; }","duration":"223.248617ms","start":"2026-09-01T04:07:31.375455Z","end":"2026-09-01T04:07:31.598704Z","steps":["trace[420941077] 'process raft request' (duration: 223.043019ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:07:31.598991Z","caller":"traceutil/trace.go:171","msg":"trace[1835209900] transaction","detail":"{read_only:false; response_revision:611; number_of_response:1; }","duration":"130.507173ms","start":"2026-09-01T04:07:31.468408Z","end":"2026-09-01T04:07:31.598915Z","steps":["trace[1835209900] 'process raft request' (duration: 130.176001ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:07:31.600163Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:07:31.275444Z","time spent":"323.273324ms","remote":"127.0.0.1:52006","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4580,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-01T04:07:38.393536Z","caller":"traceutil/trace.go:171","msg":"trace[84946592] transaction","detail":"{read_only:false; response_revision:683; number_of_response:1; }","duration":"165.200165ms","start":"2026-09-01T04:07:38.22832Z","end":"2026-09-01T04:07:38.39352Z","steps":["trace[84946592] 'process raft request' (duration: 165.034299ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:07:38.670263Z","caller":"traceutil/trace.go:171","msg":"trace[1986975145] transaction","detail":"{read_only:false; response_revision:685; number_of_response:1; }","duration":"126.836038ms","start":"2026-09-01T04:07:38.543407Z","end":"2026-09-01T04:07:38.670243Z","steps":["trace[1986975145] 'process raft request' (duration: 126.718314ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:08:26.681591Z","caller":"traceutil/trace.go:171","msg":"trace[1836066480] linearizableReadLoop","detail":"{readStateIndex:1242; appliedIndex:1241; }","duration":"153.693124ms","start":"2026-09-01T04:08:26.527857Z","end":"2026-09-01T04:08:26.681551Z","steps":["trace[1836066480] 'read index received' (duration: 153.390584ms)","trace[1836066480] 'applied index is now lower than readState.Index' (duration: 300.43µs)"],"step_count":2} {"level":"info","ts":"2026-09-01T04:08:26.681683Z","caller":"traceutil/trace.go:171","msg":"trace[1083897276] transaction","detail":"{read_only:false; response_revision:1204; number_of_response:1; }","duration":"167.871687ms","start":"2026-09-01T04:08:26.513758Z","end":"2026-09-01T04:08:26.68163Z","steps":["trace[1083897276] 'process raft request' (duration: 167.482604ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:08:26.681909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.029066ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-09-01T04:08:26.681977Z","caller":"traceutil/trace.go:171","msg":"trace[496202779] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1204; }","duration":"154.192151ms","start":"2026-09-01T04:08:26.527768Z","end":"2026-09-01T04:08:26.68196Z","steps":["trace[496202779] 'agreement among raft nodes before linearized reading' (duration: 153.953763ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:09:25.077802Z","caller":"traceutil/trace.go:171","msg":"trace[2138772324] transaction","detail":"{read_only:false; response_revision:1914; number_of_response:1; }","duration":"292.28304ms","start":"2026-09-01T04:09:24.785494Z","end":"2026-09-01T04:09:25.077777Z","steps":["trace[2138772324] 'process raft request' (duration: 292.109495ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:09:25.109202Z","caller":"traceutil/trace.go:171","msg":"trace[1550055835] transaction","detail":"{read_only:false; response_revision:1915; number_of_response:1; }","duration":"199.850825ms","start":"2026-09-01T04:09:24.909322Z","end":"2026-09-01T04:09:25.109173Z","steps":["trace[1550055835] 'process raft request' (duration: 199.604417ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:09:25.109131Z","caller":"traceutil/trace.go:171","msg":"trace[1534036700] linearizableReadLoop","detail":"{readStateIndex:1993; appliedIndex:1991; }","duration":"108.735823ms","start":"2026-09-01T04:09:25.000361Z","end":"2026-09-01T04:09:25.109096Z","steps":["trace[1534036700] 'read index received' (duration: 77.227601ms)","trace[1534036700] 'applied index is now lower than readState.Index' (duration: 31.506892ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T04:09:25.109477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.324397ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-09-01T04:09:25.109505Z","caller":"traceutil/trace.go:171","msg":"trace[1323854821] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1915; }","duration":"105.396969ms","start":"2026-09-01T04:09:25.0041Z","end":"2026-09-01T04:09:25.109497Z","steps":["trace[1323854821] 'agreement among raft nodes before linearized reading' (duration: 105.250425ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:09:25.109528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.139125ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-09-01T04:09:25.109626Z","caller":"traceutil/trace.go:171","msg":"trace[1609219352] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1915; }","duration":"109.295049ms","start":"2026-09-01T04:09:25.00031Z","end":"2026-09-01T04:09:25.109605Z","steps":["trace[1609219352] 'agreement among raft nodes before linearized reading' (duration: 108.9908ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:09:25.109515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.130023ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-09-01T04:09:25.111621Z","caller":"traceutil/trace.go:171","msg":"trace[1548111239] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1915; }","duration":"109.272379ms","start":"2026-09-01T04:09:25.002329Z","end":"2026-09-01T04:09:25.111601Z","steps":["trace[1548111239] 'agreement among raft nodes before linearized reading' (duration: 106.992609ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:09:25.628936Z","caller":"traceutil/trace.go:171","msg":"trace[1888863386] transaction","detail":"{read_only:false; response_revision:1916; number_of_response:1; }","duration":"514.241683ms","start":"2026-09-01T04:09:25.11467Z","end":"2026-09-01T04:09:25.628911Z","steps":["trace[1888863386] 'process raft request' (duration: 514.045537ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:09:25.629118Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:09:25.114651Z","time spent":"514.385028ms","remote":"127.0.0.1:52274","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":466,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-01T04:09:25.630394Z","caller":"traceutil/trace.go:171","msg":"trace[127432226] transaction","detail":"{read_only:false; response_revision:1918; number_of_response:1; }","duration":"514.655317ms","start":"2026-09-01T04:09:25.115662Z","end":"2026-09-01T04:09:25.630317Z","steps":["trace[127432226] 'process raft request' (duration: 514.567604ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:09:25.63059Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:09:25.115638Z","time spent":"514.850223ms","remote":"127.0.0.1:52274","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-01T04:09:25.630682Z","caller":"traceutil/trace.go:171","msg":"trace[2035918827] transaction","detail":"{read_only:false; response_revision:1919; number_of_response:1; }","duration":"482.642979ms","start":"2026-09-01T04:09:25.148019Z","end":"2026-09-01T04:09:25.630662Z","steps":["trace[2035918827] 'process raft request' (duration: 482.260297ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:09:25.630787Z","caller":"traceutil/trace.go:171","msg":"trace[246598432] transaction","detail":"{read_only:false; response_revision:1917; number_of_response:1; }","duration":"515.140322ms","start":"2026-09-01T04:09:25.115636Z","end":"2026-09-01T04:09:25.630777Z","steps":["trace[246598432] 'process raft request' (duration: 514.461691ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:09:25.630804Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:09:25.147995Z","time spent":"482.751113ms","remote":"127.0.0.1:52274","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-01T04:09:25.630829Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:09:25.115614Z","time spent":"515.194823ms","remote":"127.0.0.1:52274","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":420,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-01T04:09:25.631067Z","caller":"traceutil/trace.go:171","msg":"trace[1147812285] linearizableReadLoop","detail":"{readStateIndex:1998; appliedIndex:1993; }","duration":"300.955367ms","start":"2026-09-01T04:09:25.330101Z","end":"2026-09-01T04:09:25.631056Z","steps":["trace[1147812285] 'read index received' (duration: 298.647186ms)","trace[1147812285] 'applied index is now lower than readState.Index' (duration: 2.306931ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T04:09:25.631186Z","caller":"traceutil/trace.go:171","msg":"trace[230451917] transaction","detail":"{read_only:false; response_revision:1920; number_of_response:1; }","duration":"308.667145ms","start":"2026-09-01T04:09:25.322513Z","end":"2026-09-01T04:09:25.63118Z","steps":["trace[230451917] 'process raft request' (duration: 308.049646ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:09:25.631224Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:09:25.32249Z","time spent":"308.709327ms","remote":"127.0.0.1:52274","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-01T04:09:25.631406Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.301999ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-01T04:09:25.631437Z","caller":"traceutil/trace.go:171","msg":"trace[1585867834] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; response_count:0; response_revision:1920; }","duration":"301.36007ms","start":"2026-09-01T04:09:25.330071Z","end":"2026-09-01T04:09:25.631431Z","steps":["trace[1585867834] 'agreement among raft nodes before linearized reading' (duration: 301.269707ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:09:25.631456Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:09:25.330055Z","time spent":"301.396952ms","remote":"127.0.0.1:52490","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":12,"response size":30,"request content":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true "} {"level":"warn","ts":"2026-09-01T04:09:25.631665Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.88395ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"} {"level":"info","ts":"2026-09-01T04:09:25.631681Z","caller":"traceutil/trace.go:171","msg":"trace[434371442] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1920; }","duration":"184.933682ms","start":"2026-09-01T04:09:25.446743Z","end":"2026-09-01T04:09:25.631676Z","steps":["trace[434371442] 'agreement among raft nodes before linearized reading' (duration: 184.827598ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:09:37.375024Z","caller":"traceutil/trace.go:171","msg":"trace[2068333623] transaction","detail":"{read_only:false; response_revision:2019; number_of_response:1; }","duration":"219.130999ms","start":"2026-09-01T04:09:37.155853Z","end":"2026-09-01T04:09:37.374984Z","steps":["trace[2068333623] 'process raft request' (duration: 214.141717ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:10:00.185452Z","caller":"traceutil/trace.go:171","msg":"trace[824842490] transaction","detail":"{read_only:false; response_revision:2160; number_of_response:1; }","duration":"177.097891ms","start":"2026-09-01T04:10:00.008333Z","end":"2026-09-01T04:10:00.185431Z","steps":["trace[824842490] 'process raft request' (duration: 101.262246ms)","trace[824842490] 'compare' (duration: 75.66723ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T04:10:00.185627Z","caller":"traceutil/trace.go:171","msg":"trace[791127556] transaction","detail":"{read_only:false; response_revision:2161; number_of_response:1; }","duration":"176.669468ms","start":"2026-09-01T04:10:00.008946Z","end":"2026-09-01T04:10:00.185616Z","steps":["trace[791127556] 'process raft request' (duration: 176.424501ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:10:00.185666Z","caller":"traceutil/trace.go:171","msg":"trace[190193153] transaction","detail":"{read_only:false; response_revision:2162; number_of_response:1; }","duration":"176.207375ms","start":"2026-09-01T04:10:00.009453Z","end":"2026-09-01T04:10:00.18566Z","steps":["trace[190193153] 'process raft request' (duration: 176.123322ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:12:18.946688Z","caller":"traceutil/trace.go:171","msg":"trace[399834169] transaction","detail":"{read_only:false; response_revision:3004; number_of_response:1; }","duration":"109.030093ms","start":"2026-09-01T04:12:18.837635Z","end":"2026-09-01T04:12:18.946665Z","steps":["trace[399834169] 'process raft request' (duration: 108.892219ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:12:19.096182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.881848ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"} {"level":"info","ts":"2026-09-01T04:12:19.096286Z","caller":"traceutil/trace.go:171","msg":"trace[1263436270] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:3004; }","duration":"124.030402ms","start":"2026-09-01T04:12:18.972238Z","end":"2026-09-01T04:12:19.096269Z","steps":["trace[1263436270] 'range keys from in-memory index tree' (duration: 123.682944ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:12:19.096758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.89744ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-09-01T04:12:19.09683Z","caller":"traceutil/trace.go:171","msg":"trace[896753522] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:3004; }","duration":"100.992381ms","start":"2026-09-01T04:12:18.995819Z","end":"2026-09-01T04:12:19.096811Z","steps":["trace[896753522] 'range keys from in-memory index tree' (duration: 100.582331ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:12:24.771701Z","caller":"traceutil/trace.go:171","msg":"trace[1303934212] transaction","detail":"{read_only:false; response_revision:3035; number_of_response:1; }","duration":"166.37967ms","start":"2026-09-01T04:12:24.605293Z","end":"2026-09-01T04:12:24.771673Z","steps":["trace[1303934212] 'process raft request' (duration: 122.717466ms)","trace[1303934212] 'compare' (duration: 43.361786ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T04:13:57.9936Z","caller":"traceutil/trace.go:171","msg":"trace[328930725] transaction","detail":"{read_only:false; response_revision:3522; number_of_response:1; }","duration":"116.921815ms","start":"2026-09-01T04:13:57.876612Z","end":"2026-09-01T04:13:57.993534Z","steps":["trace[328930725] 'process raft request' (duration: 88.892198ms)","trace[328930725] 'compare' (duration: 27.866083ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T04:14:36.361914Z","caller":"traceutil/trace.go:171","msg":"trace[1084681655] transaction","detail":"{read_only:false; response_revision:3717; number_of_response:1; }","duration":"123.63163ms","start":"2026-09-01T04:14:36.238217Z","end":"2026-09-01T04:14:36.361849Z","steps":["trace[1084681655] 'process raft request' (duration: 46.692641ms)","trace[1084681655] 'compare' (duration: 76.234072ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T04:15:48.457974Z","caller":"traceutil/trace.go:171","msg":"trace[1811414881] transaction","detail":"{read_only:false; response_revision:4319; number_of_response:1; }","duration":"102.289164ms","start":"2026-09-01T04:15:48.355651Z","end":"2026-09-01T04:15:48.45794Z","steps":["trace[1811414881] 'process raft request' (duration: 101.990067ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:16:58.160065Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2894} {"level":"info","ts":"2026-09-01T04:16:58.317542Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2894,"took":"156.017598ms","hash":1834598680,"current-db-size-bytes":37519360,"current-db-size":"38 MB","current-db-size-in-use-bytes":12230656,"current-db-size-in-use":"12 MB"} {"level":"info","ts":"2026-09-01T04:16:58.317699Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1834598680,"revision":2894,"compact-revision":-1} {"level":"info","ts":"2026-09-01T04:19:27.509269Z","caller":"traceutil/trace.go:171","msg":"trace[1270512225] transaction","detail":"{read_only:false; response_revision:5883; number_of_response:1; }","duration":"125.236985ms","start":"2026-09-01T04:19:27.384015Z","end":"2026-09-01T04:19:27.509252Z","steps":["trace[1270512225] 'process raft request' (duration: 124.423217ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:21:58.165602Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":4810} {"level":"info","ts":"2026-09-01T04:21:58.272249Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":4810,"took":"105.65525ms","hash":4178571637,"current-db-size-bytes":37519360,"current-db-size":"38 MB","current-db-size-in-use-bytes":14311424,"current-db-size-in-use":"14 MB"} {"level":"info","ts":"2026-09-01T04:21:58.272303Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4178571637,"revision":4810,"compact-revision":2894}