{"level":"warn","ts":"2026-09-19T01:07:15.456447Z","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-19T01:07:15.45659Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.123: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.123:2380","--initial-cluster=instance=https://162.253.55.123:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.123:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.123: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-09-19T01:07:15.456706Z","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-19T01:07:15.456731Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.123:2380"]} {"level":"info","ts":"2026-09-19T01:07:15.456769Z","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-19T01:07:15.457829Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.123:2379"]} {"level":"info","ts":"2026-09-19T01:07:15.457963Z","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://162.253.55.123:2380"],"listen-peer-urls":["https://162.253.55.123:2380"],"advertise-client-urls":["https://162.253.55.123:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.123:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.123: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-19T01:07:15.462535Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.153382ms"} {"level":"info","ts":"2026-09-19T01:07:15.473732Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"dd65ba9af29ebfc9","cluster-id":"67ca29879725fb76"} {"level":"info","ts":"2026-09-19T01:07:15.473829Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dd65ba9af29ebfc9 switched to configuration voters=()"} {"level":"info","ts":"2026-09-19T01:07:15.47386Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dd65ba9af29ebfc9 became follower at term 0"} {"level":"info","ts":"2026-09-19T01:07:15.473879Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft dd65ba9af29ebfc9 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-19T01:07:15.473895Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dd65ba9af29ebfc9 became follower at term 1"} {"level":"info","ts":"2026-09-19T01:07:15.473952Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dd65ba9af29ebfc9 switched to configuration voters=(15953362429688070089)"} {"level":"warn","ts":"2026-09-19T01:07:15.485483Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-19T01:07:15.487672Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-19T01:07:15.490808Z","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-19T01:07:15.493099Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"dd65ba9af29ebfc9","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-19T01:07:15.496373Z","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-19T01:07:15.496933Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dd65ba9af29ebfc9 switched to configuration voters=(15953362429688070089)"} {"level":"info","ts":"2026-09-19T01:07:15.496542Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"dd65ba9af29ebfc9","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-19T01:07:15.497887Z","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-19T01:07:15.497998Z","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-19T01:07:15.498202Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"67ca29879725fb76","local-member-id":"dd65ba9af29ebfc9","added-peer-id":"dd65ba9af29ebfc9","added-peer-peer-urls":["https://162.253.55.123:2380"]} {"level":"info","ts":"2026-09-19T01:07:15.498993Z","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-19T01:07:15.4991Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.123:2380"} {"level":"info","ts":"2026-09-19T01:07:15.499142Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.123:2380"} {"level":"info","ts":"2026-09-19T01:07:15.499366Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-19T01:07:15.4995Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"dd65ba9af29ebfc9","initial-advertise-peer-urls":["https://162.253.55.123:2380"],"listen-peer-urls":["https://162.253.55.123:2380"],"advertise-client-urls":["https://162.253.55.123:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.123:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-19T01:07:16.374665Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dd65ba9af29ebfc9 is starting a new election at term 1"} {"level":"info","ts":"2026-09-19T01:07:16.374742Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dd65ba9af29ebfc9 became pre-candidate at term 1"} {"level":"info","ts":"2026-09-19T01:07:16.374795Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dd65ba9af29ebfc9 received MsgPreVoteResp from dd65ba9af29ebfc9 at term 1"} {"level":"info","ts":"2026-09-19T01:07:16.37483Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dd65ba9af29ebfc9 became candidate at term 2"} {"level":"info","ts":"2026-09-19T01:07:16.374847Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dd65ba9af29ebfc9 received MsgVoteResp from dd65ba9af29ebfc9 at term 2"} {"level":"info","ts":"2026-09-19T01:07:16.374864Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dd65ba9af29ebfc9 became leader at term 2"} {"level":"info","ts":"2026-09-19T01:07:16.374884Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: dd65ba9af29ebfc9 elected leader dd65ba9af29ebfc9 at term 2"} {"level":"info","ts":"2026-09-19T01:07:16.37665Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"dd65ba9af29ebfc9","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.123:2379]}","request-path":"/0/members/dd65ba9af29ebfc9/attributes","cluster-id":"67ca29879725fb76","publish-timeout":"7s"} {"level":"info","ts":"2026-09-19T01:07:16.376637Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-19T01:07:16.376885Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-19T01:07:16.377293Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-19T01:07:16.377319Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-19T01:07:16.380289Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-19T01:07:16.38041Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.123:2379"} {"level":"info","ts":"2026-09-19T01:07:16.387572Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-19T01:07:16.38856Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"67ca29879725fb76","local-member-id":"dd65ba9af29ebfc9","cluster-version":"3.5"} {"level":"info","ts":"2026-09-19T01:07:16.388676Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-19T01:07:16.388717Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-19T01:07:38.757886Z","caller":"traceutil/trace.go:171","msg":"trace[1459325729] transaction","detail":"{read_only:false; response_revision:388; number_of_response:1; }","duration":"102.816636ms","start":"2026-09-19T01:07:38.65504Z","end":"2026-09-19T01:07:38.757856Z","steps":["trace[1459325729] 'process raft request' (duration: 102.671932ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:07:54.185356Z","caller":"traceutil/trace.go:171","msg":"trace[189076889] transaction","detail":"{read_only:false; response_revision:490; number_of_response:1; }","duration":"132.97533ms","start":"2026-09-19T01:07:54.052358Z","end":"2026-09-19T01:07:54.185333Z","steps":["trace[189076889] 'process raft request' (duration: 132.834186ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:07:54.195936Z","caller":"traceutil/trace.go:171","msg":"trace[133095963] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"118.487678ms","start":"2026-09-19T01:07:54.07741Z","end":"2026-09-19T01:07:54.195898Z","steps":["trace[133095963] 'process raft request' (duration: 118.087107ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:07:54.196313Z","caller":"traceutil/trace.go:171","msg":"trace[2086571338] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"113.835962ms","start":"2026-09-19T01:07:54.08245Z","end":"2026-09-19T01:07:54.196286Z","steps":["trace[2086571338] 'process raft request' (duration: 113.255496ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:07:54.196354Z","caller":"traceutil/trace.go:171","msg":"trace[1136983696] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"134.845131ms","start":"2026-09-19T01:07:54.061493Z","end":"2026-09-19T01:07:54.196338Z","steps":["trace[1136983696] 'process raft request' (duration: 133.767902ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:07:54.196478Z","caller":"traceutil/trace.go:171","msg":"trace[1893261075] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"118.997962ms","start":"2026-09-19T01:07:54.07747Z","end":"2026-09-19T01:07:54.196468Z","steps":["trace[1893261075] 'process raft request' (duration: 118.085037ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:07:54.196446Z","caller":"traceutil/trace.go:171","msg":"trace[822705338] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"103.955877ms","start":"2026-09-19T01:07:54.092454Z","end":"2026-09-19T01:07:54.19641Z","steps":["trace[822705338] 'process raft request' (duration: 103.307899ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:07:54.196554Z","caller":"traceutil/trace.go:171","msg":"trace[1340050942] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"116.556226ms","start":"2026-09-19T01:07:54.07999Z","end":"2026-09-19T01:07:54.196546Z","steps":["trace[1340050942] 'process raft request' (duration: 115.613661ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:07:54.196602Z","caller":"traceutil/trace.go:171","msg":"trace[1723885757] transaction","detail":"{read_only:false; response_revision:492; number_of_response:1; }","duration":"135.019016ms","start":"2026-09-19T01:07:54.061573Z","end":"2026-09-19T01:07:54.196592Z","steps":["trace[1723885757] 'process raft request' (duration: 133.870504ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:07:54.196644Z","caller":"traceutil/trace.go:171","msg":"trace[1294508234] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"116.527566ms","start":"2026-09-19T01:07:54.080106Z","end":"2026-09-19T01:07:54.196633Z","steps":["trace[1294508234] 'process raft request' (duration: 115.547239ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:07:54.469027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.094317ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-09-19T01:07:54.469171Z","caller":"traceutil/trace.go:171","msg":"trace[1605981639] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"223.411402ms","start":"2026-09-19T01:07:54.245735Z","end":"2026-09-19T01:07:54.469146Z","steps":["trace[1605981639] 'process raft request' (duration: 37.529103ms)","trace[1605981639] 'compare' (duration: 184.854111ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T01:07:54.473447Z","caller":"traceutil/trace.go:171","msg":"trace[98778684] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"224.778498ms","start":"2026-09-19T01:07:54.248612Z","end":"2026-09-19T01:07:54.473391Z","steps":["trace[98778684] 'process raft request' (duration: 223.617257ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:07:54.474559Z","caller":"traceutil/trace.go:171","msg":"trace[1916406100] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"224.938153ms","start":"2026-09-19T01:07:54.249578Z","end":"2026-09-19T01:07:54.474516Z","steps":["trace[1916406100] 'process raft request' (duration: 223.38512ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:07:54.477113Z","caller":"traceutil/trace.go:171","msg":"trace[1977710907] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"214.700416ms","start":"2026-09-19T01:07:54.262395Z","end":"2026-09-19T01:07:54.477095Z","steps":["trace[1977710907] 'process raft request' (duration: 214.569273ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:07:54.477139Z","caller":"traceutil/trace.go:171","msg":"trace[564681906] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"226.396711ms","start":"2026-09-19T01:07:54.250703Z","end":"2026-09-19T01:07:54.4771Z","steps":["trace[564681906] 'process raft request' (duration: 225.878727ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:07:54.477166Z","caller":"traceutil/trace.go:171","msg":"trace[134530969] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"222.953419ms","start":"2026-09-19T01:07:54.25418Z","end":"2026-09-19T01:07:54.477133Z","steps":["trace[134530969] 'process raft request' (duration: 222.543758ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:07:54.477214Z","caller":"traceutil/trace.go:171","msg":"trace[1249658628] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"222.676462ms","start":"2026-09-19T01:07:54.254527Z","end":"2026-09-19T01:07:54.477204Z","steps":["trace[1249658628] 'process raft request' (duration: 222.287591ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:07:54.477231Z","caller":"traceutil/trace.go:171","msg":"trace[158472737] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"201.938162ms","start":"2026-09-19T01:07:54.275258Z","end":"2026-09-19T01:07:54.477196Z","steps":["trace[158472737] 'process raft request' (duration: 201.768227ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:07:54.484061Z","caller":"traceutil/trace.go:171","msg":"trace[1890701929] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"193.926974ms","start":"2026-09-19T01:07:54.290112Z","end":"2026-09-19T01:07:54.484039Z","steps":["trace[1890701929] 'process raft request' (duration: 193.816871ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:07:56.965081Z","caller":"traceutil/trace.go:171","msg":"trace[1096296038] transaction","detail":"{read_only:false; response_revision:568; number_of_response:1; }","duration":"192.591909ms","start":"2026-09-19T01:07:56.772457Z","end":"2026-09-19T01:07:56.965049Z","steps":["trace[1096296038] 'process raft request' (duration: 190.481362ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:08:00.851134Z","caller":"traceutil/trace.go:171","msg":"trace[644607196] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"103.080403ms","start":"2026-09-19T01:08:00.748029Z","end":"2026-09-19T01:08:00.851109Z","steps":["trace[644607196] 'process raft request' (duration: 102.514297ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:08:01.115782Z","caller":"traceutil/trace.go:171","msg":"trace[423160531] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"358.259383ms","start":"2026-09-19T01:08:00.757489Z","end":"2026-09-19T01:08:01.115748Z","steps":["trace[423160531] 'process raft request' (duration: 286.277969ms)","trace[423160531] 'compare' (duration: 71.780359ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T01:08:01.115901Z","caller":"traceutil/trace.go:171","msg":"trace[2137564905] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"202.594939ms","start":"2026-09-19T01:08:00.913278Z","end":"2026-09-19T01:08:01.115873Z","steps":["trace[2137564905] 'process raft request' (duration: 202.388654ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:08:01.116139Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:08:00.757471Z","time spent":"358.392405ms","remote":"127.0.0.1:47644","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-19T01:08:01.505723Z","caller":"traceutil/trace.go:171","msg":"trace[2146199593] linearizableReadLoop","detail":"{readStateIndex:617; appliedIndex:616; }","duration":"312.794884ms","start":"2026-09-19T01:08:01.192909Z","end":"2026-09-19T01:08:01.505704Z","steps":["trace[2146199593] 'read index received' (duration: 312.596898ms)","trace[2146199593] 'applied index is now lower than readState.Index' (duration: 197.286µs)"],"step_count":2} {"level":"info","ts":"2026-09-19T01:08:01.505752Z","caller":"traceutil/trace.go:171","msg":"trace[403798668] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"329.806863ms","start":"2026-09-19T01:08:01.175916Z","end":"2026-09-19T01:08:01.505723Z","steps":["trace[403798668] 'process raft request' (duration: 329.660599ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:08:01.50588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.951278ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-09-19T01:08:01.505906Z","caller":"traceutil/trace.go:171","msg":"trace[778626605] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:591; }","duration":"313.01275ms","start":"2026-09-19T01:08:01.192885Z","end":"2026-09-19T01:08:01.505898Z","steps":["trace[778626605] 'agreement among raft nodes before linearized reading' (duration: 312.914177ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:08:01.50593Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:08:01.192873Z","time spent":"313.050611ms","remote":"127.0.0.1:47748","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-09-19T01:08:01.505923Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:08:01.175891Z","time spent":"329.919487ms","remote":"127.0.0.1:47748","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-19T01:08:01.505925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.529791ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-09-19T01:08:01.50598Z","caller":"traceutil/trace.go:171","msg":"trace[831304233] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:591; }","duration":"194.625883ms","start":"2026-09-19T01:08:01.311341Z","end":"2026-09-19T01:08:01.505967Z","steps":["trace[831304233] 'agreement among raft nodes before linearized reading' (duration: 194.49613ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:08:01.967634Z","caller":"traceutil/trace.go:171","msg":"trace[756807463] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"457.749617ms","start":"2026-09-19T01:08:01.509858Z","end":"2026-09-19T01:08:01.967608Z","steps":["trace[756807463] 'process raft request' (duration: 436.153974ms)","trace[756807463] 'compare' (duration: 20.874343ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T01:08:01.967721Z","caller":"traceutil/trace.go:171","msg":"trace[629657029] linearizableReadLoop","detail":"{readStateIndex:620; appliedIndex:618; }","duration":"180.606165ms","start":"2026-09-19T01:08:01.787102Z","end":"2026-09-19T01:08:01.967708Z","steps":["trace[629657029] 'read index received' (duration: 158.856158ms)","trace[629657029] 'applied index is now lower than readState.Index' (duration: 21.748077ms)"],"step_count":2} {"level":"warn","ts":"2026-09-19T01:08:01.967784Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:08:01.509841Z","time spent":"457.8602ms","remote":"127.0.0.1:47748","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-19T01:08:01.967815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.713458ms","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-09-19T01:08:01.967836Z","caller":"traceutil/trace.go:171","msg":"trace[64994193] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:594; }","duration":"180.735239ms","start":"2026-09-19T01:08:01.787093Z","end":"2026-09-19T01:08:01.967828Z","steps":["trace[64994193] 'agreement among raft nodes before linearized reading' (duration: 180.650406ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:08:01.96811Z","caller":"traceutil/trace.go:171","msg":"trace[2028186054] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"455.99239ms","start":"2026-09-19T01:08:01.511903Z","end":"2026-09-19T01:08:01.967895Z","steps":["trace[2028186054] 'process raft request' (duration: 455.433725ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:08:01.968266Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:08:01.511878Z","time spent":"456.304658ms","remote":"127.0.0.1:47554","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036205,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-19T01:08:02.30449Z","caller":"traceutil/trace.go:171","msg":"trace[1457695569] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"255.641382ms","start":"2026-09-19T01:08:02.048826Z","end":"2026-09-19T01:08:02.304468Z","steps":["trace[1457695569] 'process raft request' (duration: 255.59677ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:08:02.304504Z","caller":"traceutil/trace.go:171","msg":"trace[923440486] transaction","detail":"{read_only:false; response_revision:595; number_of_response:1; }","duration":"331.1647ms","start":"2026-09-19T01:08:01.973309Z","end":"2026-09-19T01:08:02.304474Z","steps":["trace[923440486] 'process raft request' (duration: 247.322416ms)","trace[923440486] 'compare' (duration: 83.670609ms)"],"step_count":2} {"level":"warn","ts":"2026-09-19T01:08:02.304739Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:08:01.973287Z","time spent":"331.384406ms","remote":"127.0.0.1:47748","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-19T01:08:17.721999Z","caller":"traceutil/trace.go:171","msg":"trace[2134338887] linearizableReadLoop","detail":"{readStateIndex:786; appliedIndex:785; }","duration":"127.696618ms","start":"2026-09-19T01:08:17.594274Z","end":"2026-09-19T01:08:17.721971Z","steps":["trace[2134338887] 'read index received' (duration: 127.459002ms)","trace[2134338887] 'applied index is now lower than readState.Index' (duration: 236.326µs)"],"step_count":2} {"level":"info","ts":"2026-09-19T01:08:17.722108Z","caller":"traceutil/trace.go:171","msg":"trace[65639336] transaction","detail":"{read_only:false; response_revision:756; number_of_response:1; }","duration":"133.849233ms","start":"2026-09-19T01:08:17.588225Z","end":"2026-09-19T01:08:17.722074Z","steps":["trace[65639336] 'process raft request' (duration: 133.593666ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:08:17.722339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.066788ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-09-19T01:08:17.722377Z","caller":"traceutil/trace.go:171","msg":"trace[1107193497] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:756; }","duration":"128.168051ms","start":"2026-09-19T01:08:17.594198Z","end":"2026-09-19T01:08:17.722366Z","steps":["trace[1107193497] 'agreement among raft nodes before linearized reading' (duration: 127.932545ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:08:17.722415Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.940914ms","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-09-19T01:08:17.72248Z","caller":"traceutil/trace.go:171","msg":"trace[940313597] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:756; }","duration":"118.058418ms","start":"2026-09-19T01:08:17.604404Z","end":"2026-09-19T01:08:17.722463Z","steps":["trace[940313597] 'agreement among raft nodes before linearized reading' (duration: 117.813811ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:09:28.497658Z","caller":"traceutil/trace.go:171","msg":"trace[1999204445] linearizableReadLoop","detail":"{readStateIndex:1189; appliedIndex:1188; }","duration":"329.665387ms","start":"2026-09-19T01:09:28.167968Z","end":"2026-09-19T01:09:28.497633Z","steps":["trace[1999204445] 'read index received' (duration: 329.557264ms)","trace[1999204445] 'applied index is now lower than readState.Index' (duration: 107.053µs)"],"step_count":2} {"level":"info","ts":"2026-09-19T01:09:28.497983Z","caller":"traceutil/trace.go:171","msg":"trace[931352222] transaction","detail":"{read_only:false; response_revision:1141; number_of_response:1; }","duration":"425.275362ms","start":"2026-09-19T01:09:28.072695Z","end":"2026-09-19T01:09:28.497971Z","steps":["trace[931352222] 'process raft request' (duration: 424.773218ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:09:28.498082Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:09:28.072678Z","time spent":"425.336413ms","remote":"127.0.0.1:47748","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-19T01:09:28.498347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.378778ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-09-19T01:09:28.498377Z","caller":"traceutil/trace.go:171","msg":"trace[505018072] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1141; }","duration":"330.432868ms","start":"2026-09-19T01:09:28.167934Z","end":"2026-09-19T01:09:28.498367Z","steps":["trace[505018072] 'agreement among raft nodes before linearized reading' (duration: 330.302435ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:09:28.498401Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:09:28.16791Z","time spent":"330.48493ms","remote":"127.0.0.1:47748","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-09-19T01:09:28.539279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.844741ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-19T01:09:28.539124Z","caller":"traceutil/trace.go:171","msg":"trace[712369804] transaction","detail":"{read_only:false; response_revision:1142; number_of_response:1; }","duration":"104.130823ms","start":"2026-09-19T01:09:28.434967Z","end":"2026-09-19T01:09:28.539098Z","steps":["trace[712369804] 'process raft request' (duration: 104.032261ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:09:28.539313Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"359.244098ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-09-19T01:09:28.539335Z","caller":"traceutil/trace.go:171","msg":"trace[1187419604] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:1142; }","duration":"222.926244ms","start":"2026-09-19T01:09:28.316394Z","end":"2026-09-19T01:09:28.53932Z","steps":["trace[1187419604] 'agreement among raft nodes before linearized reading' (duration: 222.804ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:09:28.539369Z","caller":"traceutil/trace.go:171","msg":"trace[969803468] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1142; }","duration":"359.363181ms","start":"2026-09-19T01:09:28.179993Z","end":"2026-09-19T01:09:28.539356Z","steps":["trace[969803468] 'agreement among raft nodes before linearized reading' (duration: 359.201226ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:09:28.539403Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:09:28.17998Z","time spent":"359.414653ms","remote":"127.0.0.1:47748","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-09-19T01:09:44.781289Z","caller":"traceutil/trace.go:171","msg":"trace[171574378] transaction","detail":"{read_only:false; response_revision:1215; number_of_response:1; }","duration":"154.803532ms","start":"2026-09-19T01:09:44.626438Z","end":"2026-09-19T01:09:44.781241Z","steps":["trace[171574378] 'process raft request' (duration: 57.198265ms)","trace[171574378] 'compare' (duration: 97.474884ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T01:09:44.781378Z","caller":"traceutil/trace.go:171","msg":"trace[1107708198] linearizableReadLoop","detail":"{readStateIndex:1266; appliedIndex:1265; }","duration":"151.720229ms","start":"2026-09-19T01:09:44.629522Z","end":"2026-09-19T01:09:44.781242Z","steps":["trace[1107708198] 'read index received' (duration: 54.125153ms)","trace[1107708198] 'applied index is now lower than readState.Index' (duration: 97.591796ms)"],"step_count":2} {"level":"warn","ts":"2026-09-19T01:09:44.849919Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.370835ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-09-19T01:09:44.849996Z","caller":"traceutil/trace.go:171","msg":"trace[921221228] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1215; }","duration":"220.482798ms","start":"2026-09-19T01:09:44.629493Z","end":"2026-09-19T01:09:44.849976Z","steps":["trace[921221228] 'agreement among raft nodes before linearized reading' (duration: 151.751401ms)","trace[921221228] 'range keys from in-memory index tree' (duration: 68.533973ms)"],"step_count":2} {"level":"warn","ts":"2026-09-19T01:09:45.226026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.564649ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:1 size:664"} {"level":"info","ts":"2026-09-19T01:09:45.226096Z","caller":"traceutil/trace.go:171","msg":"trace[85383908] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:1; response_revision:1218; }","duration":"341.677672ms","start":"2026-09-19T01:09:44.884402Z","end":"2026-09-19T01:09:45.22608Z","steps":["trace[85383908] 'range keys from in-memory index tree' (duration: 341.483266ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:09:45.226132Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:09:44.884386Z","time spent":"341.738323ms","remote":"127.0.0.1:47868","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":1,"response size":687,"request content":"key:\"/registry/csinodes/instance\" "} {"level":"info","ts":"2026-09-19T01:09:45.226307Z","caller":"traceutil/trace.go:171","msg":"trace[1088060100] transaction","detail":"{read_only:false; response_revision:1219; number_of_response:1; }","duration":"260.622962ms","start":"2026-09-19T01:09:44.965626Z","end":"2026-09-19T01:09:45.226249Z","steps":["trace[1088060100] 'process raft request' (duration: 176.54662ms)","trace[1088060100] 'compare' (duration: 83.747553ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T01:09:45.455674Z","caller":"traceutil/trace.go:171","msg":"trace[319501179] transaction","detail":"{read_only:false; response_revision:1220; number_of_response:1; }","duration":"226.12356ms","start":"2026-09-19T01:09:45.229498Z","end":"2026-09-19T01:09:45.455622Z","steps":["trace[319501179] 'process raft request' (duration: 215.798631ms)","trace[319501179] 'compare' (duration: 10.217156ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T01:09:46.730811Z","caller":"traceutil/trace.go:171","msg":"trace[771449550] linearizableReadLoop","detail":"{readStateIndex:1274; appliedIndex:1273; }","duration":"115.502571ms","start":"2026-09-19T01:09:46.615292Z","end":"2026-09-19T01:09:46.730795Z","steps":["trace[771449550] 'read index received' (duration: 16.508006ms)","trace[771449550] 'applied index is now lower than readState.Index' (duration: 98.993995ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T01:09:46.730905Z","caller":"traceutil/trace.go:171","msg":"trace[409974729] transaction","detail":"{read_only:false; response_revision:1222; number_of_response:1; }","duration":"126.827287ms","start":"2026-09-19T01:09:46.604069Z","end":"2026-09-19T01:09:46.730897Z","steps":["trace[409974729] 'process raft request' (duration: 27.804551ms)","trace[409974729] 'compare' (duration: 98.673286ms)"],"step_count":2} {"level":"warn","ts":"2026-09-19T01:09:46.731238Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.928123ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-09-19T01:09:46.731332Z","caller":"traceutil/trace.go:171","msg":"trace[1160755125] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1222; }","duration":"116.080148ms","start":"2026-09-19T01:09:46.615236Z","end":"2026-09-19T01:09:46.731316Z","steps":["trace[1160755125] 'agreement among raft nodes before linearized reading' (duration: 115.894242ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:09:46.962637Z","caller":"traceutil/trace.go:171","msg":"trace[1179058071] transaction","detail":"{read_only:false; response_revision:1225; number_of_response:1; }","duration":"152.563472ms","start":"2026-09-19T01:09:46.810046Z","end":"2026-09-19T01:09:46.96261Z","steps":["trace[1179058071] 'process raft request' (duration: 152.373757ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:09:47.2571Z","caller":"traceutil/trace.go:171","msg":"trace[277197206] transaction","detail":"{read_only:false; response_revision:1227; number_of_response:1; }","duration":"285.851674ms","start":"2026-09-19T01:09:46.971226Z","end":"2026-09-19T01:09:47.257078Z","steps":["trace[277197206] 'process raft request' (duration: 187.993909ms)","trace[277197206] 'compare' (duration: 97.723851ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T01:09:59.56254Z","caller":"traceutil/trace.go:171","msg":"trace[434255517] transaction","detail":"{read_only:false; response_revision:1315; number_of_response:1; }","duration":"238.117604ms","start":"2026-09-19T01:09:59.324362Z","end":"2026-09-19T01:09:59.562479Z","steps":["trace[434255517] 'process raft request' (duration: 237.847467ms)"],"step_count":1}