{"level":"warn","ts":"2026-10-16T09:08:21.332723Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-16T09:08:21.333046Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.22: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.22:2380","--initial-cluster=instance=https://162.253.55.22:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.22:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.22: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-10-16T09:08:21.333137Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-16T09:08:21.333153Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.22:2380"]} {"level":"info","ts":"2026-10-16T09:08:21.333176Z","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-10-16T09:08:21.333895Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.22:2379"]} {"level":"info","ts":"2026-10-16T09:08:21.333973Z","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.22:2380"],"listen-peer-urls":["https://162.253.55.22:2380"],"advertise-client-urls":["https://162.253.55.22:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.22:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.22: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-10-16T09:08:21.338055Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.82197ms"} {"level":"info","ts":"2026-10-16T09:08:21.344557Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"8608f4af3693a53b","cluster-id":"c541111188849f0e"} {"level":"info","ts":"2026-10-16T09:08:21.344642Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8608f4af3693a53b switched to configuration voters=()"} {"level":"info","ts":"2026-10-16T09:08:21.344665Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8608f4af3693a53b became follower at term 0"} {"level":"info","ts":"2026-10-16T09:08:21.344682Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 8608f4af3693a53b [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-10-16T09:08:21.34469Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8608f4af3693a53b became follower at term 1"} {"level":"info","ts":"2026-10-16T09:08:21.34475Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8608f4af3693a53b switched to configuration voters=(9658238434268128571)"} {"level":"warn","ts":"2026-10-16T09:08:21.352316Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-10-16T09:08:21.354037Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-10-16T09:08:21.355346Z","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-10-16T09:08:21.357948Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"8608f4af3693a53b","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-10-16T09:08:21.358132Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"8608f4af3693a53b","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-10-16T09:08:21.358423Z","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-10-16T09:08:21.358536Z","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-10-16T09:08:21.358555Z","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-10-16T09:08:21.359942Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8608f4af3693a53b switched to configuration voters=(9658238434268128571)"} {"level":"info","ts":"2026-10-16T09:08:21.360224Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"c541111188849f0e","local-member-id":"8608f4af3693a53b","added-peer-id":"8608f4af3693a53b","added-peer-peer-urls":["https://162.253.55.22:2380"]} {"level":"info","ts":"2026-10-16T09:08:21.362124Z","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-10-16T09:08:21.362569Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"8608f4af3693a53b","initial-advertise-peer-urls":["https://162.253.55.22:2380"],"listen-peer-urls":["https://162.253.55.22:2380"],"advertise-client-urls":["https://162.253.55.22:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.22:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-10-16T09:08:21.362602Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-10-16T09:08:21.362693Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.22:2380"} {"level":"info","ts":"2026-10-16T09:08:21.362712Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.22:2380"} {"level":"info","ts":"2026-10-16T09:08:22.145257Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8608f4af3693a53b is starting a new election at term 1"} {"level":"info","ts":"2026-10-16T09:08:22.145345Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8608f4af3693a53b became pre-candidate at term 1"} {"level":"info","ts":"2026-10-16T09:08:22.145401Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8608f4af3693a53b received MsgPreVoteResp from 8608f4af3693a53b at term 1"} {"level":"info","ts":"2026-10-16T09:08:22.145426Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8608f4af3693a53b became candidate at term 2"} {"level":"info","ts":"2026-10-16T09:08:22.145444Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8608f4af3693a53b received MsgVoteResp from 8608f4af3693a53b at term 2"} {"level":"info","ts":"2026-10-16T09:08:22.145463Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8608f4af3693a53b became leader at term 2"} {"level":"info","ts":"2026-10-16T09:08:22.145484Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 8608f4af3693a53b elected leader 8608f4af3693a53b at term 2"} {"level":"info","ts":"2026-10-16T09:08:22.146921Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-10-16T09:08:22.147843Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-16T09:08:22.147848Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"8608f4af3693a53b","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.22:2379]}","request-path":"/0/members/8608f4af3693a53b/attributes","cluster-id":"c541111188849f0e","publish-timeout":"7s"} {"level":"info","ts":"2026-10-16T09:08:22.148298Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-10-16T09:08:22.148374Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-10-16T09:08:22.148291Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-16T09:08:22.148535Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"c541111188849f0e","local-member-id":"8608f4af3693a53b","cluster-version":"3.5"} {"level":"info","ts":"2026-10-16T09:08:22.14868Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-10-16T09:08:22.148728Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-10-16T09:08:22.150973Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-10-16T09:08:22.151482Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.22:2379"} {"level":"info","ts":"2026-10-16T09:08:24.967937Z","caller":"traceutil/trace.go:171","msg":"trace[269067642] linearizableReadLoop","detail":"{readStateIndex:77; appliedIndex:76; }","duration":"239.226772ms","start":"2026-10-16T09:08:24.728674Z","end":"2026-10-16T09:08:24.967901Z","steps":["trace[269067642] 'read index received' (duration: 239.105ms)","trace[269067642] 'applied index is now lower than readState.Index' (duration: 120.352µs)"],"step_count":2} {"level":"warn","ts":"2026-10-16T09:08:24.968207Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.499848ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:aggregate-to-admin\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-10-16T09:08:24.968279Z","caller":"traceutil/trace.go:171","msg":"trace[412613030] range","detail":"{range_begin:/registry/clusterroles/system:aggregate-to-admin; range_end:; response_count:0; response_revision:73; }","duration":"239.663041ms","start":"2026-10-16T09:08:24.728601Z","end":"2026-10-16T09:08:24.968264Z","steps":["trace[412613030] 'agreement among raft nodes before linearized reading' (duration: 239.501837ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T09:08:24.968064Z","caller":"traceutil/trace.go:171","msg":"trace[597123657] transaction","detail":"{read_only:false; response_revision:73; number_of_response:1; }","duration":"240.996648ms","start":"2026-10-16T09:08:24.726993Z","end":"2026-10-16T09:08:24.96799Z","steps":["trace[597123657] 'process raft request' (duration: 240.745453ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T09:08:24.968429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.821159ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/kube-system/\" range_end:\"/registry/limitranges/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-10-16T09:08:24.968442Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.495152ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-10-16T09:08:24.968632Z","caller":"traceutil/trace.go:171","msg":"trace[240436501] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:73; }","duration":"138.739097ms","start":"2026-10-16T09:08:24.829851Z","end":"2026-10-16T09:08:24.96859Z","steps":["trace[240436501] 'agreement among raft nodes before linearized reading' (duration: 138.452202ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T09:08:24.968536Z","caller":"traceutil/trace.go:171","msg":"trace[241813445] range","detail":"{range_begin:/registry/limitranges/kube-system/; range_end:/registry/limitranges/kube-system0; response_count:0; response_revision:73; }","duration":"161.997353ms","start":"2026-10-16T09:08:24.806514Z","end":"2026-10-16T09:08:24.968512Z","steps":["trace[241813445] 'agreement among raft nodes before linearized reading' (duration: 161.684416ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T09:08:25.304323Z","caller":"traceutil/trace.go:171","msg":"trace[67816017] linearizableReadLoop","detail":"{readStateIndex:78; appliedIndex:77; }","duration":"325.019486ms","start":"2026-10-16T09:08:24.979213Z","end":"2026-10-16T09:08:25.304233Z","steps":["trace[67816017] 'read index received' (duration: 324.671448ms)","trace[67816017] 'applied index is now lower than readState.Index' (duration: 346.908µs)"],"step_count":2} {"level":"info","ts":"2026-10-16T09:08:25.304462Z","caller":"traceutil/trace.go:171","msg":"trace[353601473] transaction","detail":"{read_only:false; response_revision:74; number_of_response:1; }","duration":"329.949186ms","start":"2026-10-16T09:08:24.974426Z","end":"2026-10-16T09:08:25.304375Z","steps":["trace[353601473] 'process raft request' (duration: 329.516718ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T09:08:25.304686Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.434174ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:aggregate-to-edit\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-10-16T09:08:25.304757Z","caller":"traceutil/trace.go:171","msg":"trace[1663746926] range","detail":"{range_begin:/registry/clusterroles/system:aggregate-to-edit; range_end:; response_count:0; response_revision:74; }","duration":"325.533646ms","start":"2026-10-16T09:08:24.979205Z","end":"2026-10-16T09:08:25.304739Z","steps":["trace[1663746926] 'agreement among raft nodes before linearized reading' (duration: 325.299391ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T09:08:25.304871Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T09:08:24.979189Z","time spent":"325.653709ms","remote":"127.0.0.1:47186","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":0,"response size":28,"request content":"key:\"/registry/clusterroles/system:aggregate-to-edit\" "} {"level":"warn","ts":"2026-10-16T09:08:25.306325Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T09:08:24.974401Z","time spent":"330.401806ms","remote":"127.0.0.1:47038","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2905,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-16T09:08:25.327477Z","caller":"traceutil/trace.go:171","msg":"trace[684872371] transaction","detail":"{read_only:false; response_revision:75; number_of_response:1; }","duration":"346.415101ms","start":"2026-10-16T09:08:24.981031Z","end":"2026-10-16T09:08:25.327446Z","steps":["trace[684872371] 'process raft request' (duration: 338.382248ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T09:08:25.327593Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T09:08:24.981006Z","time spent":"346.533584ms","remote":"127.0.0.1:47202","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-16T09:09:06.277872Z","caller":"traceutil/trace.go:171","msg":"trace[1406974442] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"160.454399ms","start":"2026-10-16T09:09:06.117381Z","end":"2026-10-16T09:09:06.277836Z","steps":["trace[1406974442] 'process raft request' (duration: 160.130593ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T09:09:07.785122Z","caller":"traceutil/trace.go:171","msg":"trace[410761821] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"109.614767ms","start":"2026-10-16T09:09:07.67548Z","end":"2026-10-16T09:09:07.785094Z","steps":["trace[410761821] 'process raft request' (duration: 109.492504ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T09:09:07.790206Z","caller":"traceutil/trace.go:171","msg":"trace[91543788] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"114.448679ms","start":"2026-10-16T09:09:07.675735Z","end":"2026-10-16T09:09:07.790184Z","steps":["trace[91543788] 'process raft request' (duration: 114.237945ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T09:09:07.790311Z","caller":"traceutil/trace.go:171","msg":"trace[850486381] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"113.934801ms","start":"2026-10-16T09:09:07.676355Z","end":"2026-10-16T09:09:07.79029Z","steps":["trace[850486381] 'process raft request' (duration: 113.803779ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T09:09:07.790361Z","caller":"traceutil/trace.go:171","msg":"trace[572050156] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"114.142054ms","start":"2026-10-16T09:09:07.676181Z","end":"2026-10-16T09:09:07.790323Z","steps":["trace[572050156] 'process raft request' (duration: 113.960021ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T09:09:07.790417Z","caller":"traceutil/trace.go:171","msg":"trace[2123599420] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"113.924331ms","start":"2026-10-16T09:09:07.676466Z","end":"2026-10-16T09:09:07.790391Z","steps":["trace[2123599420] 'process raft request' (duration: 113.714897ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T09:09:07.790499Z","caller":"traceutil/trace.go:171","msg":"trace[1513292413] transaction","detail":"{read_only:false; number_of_response:1; response_revision:523; }","duration":"113.988291ms","start":"2026-10-16T09:09:07.676499Z","end":"2026-10-16T09:09:07.790487Z","steps":["trace[1513292413] 'process raft request' (duration: 113.725497ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T09:09:07.79045Z","caller":"traceutil/trace.go:171","msg":"trace[1996971771] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"114.437889ms","start":"2026-10-16T09:09:07.675988Z","end":"2026-10-16T09:09:07.790426Z","steps":["trace[1996971771] 'process raft request' (duration: 114.129614ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T09:09:07.796538Z","caller":"traceutil/trace.go:171","msg":"trace[819938914] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"115.203872ms","start":"2026-10-16T09:09:07.681314Z","end":"2026-10-16T09:09:07.796518Z","steps":["trace[819938914] 'process raft request' (duration: 108.943074ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T09:09:07.797077Z","caller":"traceutil/trace.go:171","msg":"trace[699788319] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"109.78035ms","start":"2026-10-16T09:09:07.687282Z","end":"2026-10-16T09:09:07.797062Z","steps":["trace[699788319] 'process raft request' (duration: 109.721048ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T09:09:07.797339Z","caller":"traceutil/trace.go:171","msg":"trace[1555895868] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"115.925995ms","start":"2026-10-16T09:09:07.681401Z","end":"2026-10-16T09:09:07.797327Z","steps":["trace[1555895868] 'process raft request' (duration: 114.876887ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T09:09:07.797564Z","caller":"traceutil/trace.go:171","msg":"trace[1563723947] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"116.070237ms","start":"2026-10-16T09:09:07.68148Z","end":"2026-10-16T09:09:07.79755Z","steps":["trace[1563723947] 'process raft request' (duration: 115.453966ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T09:09:13.964222Z","caller":"traceutil/trace.go:171","msg":"trace[519237854] transaction","detail":"{read_only:false; response_revision:611; number_of_response:1; }","duration":"177.250007ms","start":"2026-10-16T09:09:13.786931Z","end":"2026-10-16T09:09:13.964181Z","steps":["trace[519237854] 'process raft request' (duration: 176.608676ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T09:09:14.250683Z","caller":"traceutil/trace.go:171","msg":"trace[1017904178] linearizableReadLoop","detail":"{readStateIndex:637; appliedIndex:636; }","duration":"132.8722ms","start":"2026-10-16T09:09:14.11778Z","end":"2026-10-16T09:09:14.250652Z","steps":["trace[1017904178] 'read index received' (duration: 132.634376ms)","trace[1017904178] 'applied index is now lower than readState.Index' (duration: 236.854µs)"],"step_count":2} {"level":"info","ts":"2026-10-16T09:09:14.250735Z","caller":"traceutil/trace.go:171","msg":"trace[2026469187] transaction","detail":"{read_only:false; response_revision:612; number_of_response:1; }","duration":"215.031995ms","start":"2026-10-16T09:09:14.035664Z","end":"2026-10-16T09:09:14.250696Z","steps":["trace[2026469187] 'process raft request' (duration: 214.815581ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T09:09:14.250926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.112684ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-sg5ms\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-10-16T09:09:14.251017Z","caller":"traceutil/trace.go:171","msg":"trace[35073969] range","detail":"{range_begin:/registry/pods/kube-system/cilium-sg5ms; range_end:; response_count:1; response_revision:612; }","duration":"133.253827ms","start":"2026-10-16T09:09:14.117737Z","end":"2026-10-16T09:09:14.250991Z","steps":["trace[35073969] 'agreement among raft nodes before linearized reading' (duration: 133.025973ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T09:09:14.897449Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"502.842995ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-16T09:09:14.897752Z","caller":"traceutil/trace.go:171","msg":"trace[2005794053] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"624.753171ms","start":"2026-10-16T09:09:14.272919Z","end":"2026-10-16T09:09:14.897672Z","steps":["trace[2005794053] 'process raft request' (duration: 120.98254ms)","trace[2005794053] 'compare' (duration: 502.715603ms)"],"step_count":2} {"level":"warn","ts":"2026-10-16T09:09:14.898005Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T09:09:14.272871Z","time spent":"624.998615ms","remote":"127.0.0.1:47038","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-16T09:09:14.898028Z","caller":"traceutil/trace.go:171","msg":"trace[278254652] linearizableReadLoop","detail":"{readStateIndex:638; appliedIndex:637; }","duration":"553.595352ms","start":"2026-10-16T09:09:14.344346Z","end":"2026-10-16T09:09:14.897942Z","steps":["trace[278254652] 'read index received' (duration: 49.474574ms)","trace[278254652] 'applied index is now lower than readState.Index' (duration: 504.115788ms)"],"step_count":2} {"level":"warn","ts":"2026-10-16T09:09:14.898313Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"553.948627ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-10-16T09:09:14.898368Z","caller":"traceutil/trace.go:171","msg":"trace[623925564] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:613; }","duration":"554.056439ms","start":"2026-10-16T09:09:14.344295Z","end":"2026-10-16T09:09:14.898352Z","steps":["trace[623925564] 'agreement among raft nodes before linearized reading' (duration: 553.843635ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T09:09:14.898411Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T09:09:14.344274Z","time spent":"554.12514ms","remote":"127.0.0.1:47102","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-10-16T09:09:14.899286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"545.21082ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-10-16T09:09:14.899351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.343928ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-16T09:09:14.899266Z","caller":"traceutil/trace.go:171","msg":"trace[323174023] transaction","detail":"{read_only:false; response_revision:614; number_of_response:1; }","duration":"225.582432ms","start":"2026-10-16T09:09:14.673658Z","end":"2026-10-16T09:09:14.89924Z","steps":["trace[323174023] 'process raft request' (duration: 224.27737ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T09:09:14.899377Z","caller":"traceutil/trace.go:171","msg":"trace[1796695795] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:614; }","duration":"545.324471ms","start":"2026-10-16T09:09:14.354037Z","end":"2026-10-16T09:09:14.899361Z","steps":["trace[1796695795] 'agreement among raft nodes before linearized reading' (duration: 545.043877ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T09:09:14.899397Z","caller":"traceutil/trace.go:171","msg":"trace[1259768831] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:614; }","duration":"168.414609ms","start":"2026-10-16T09:09:14.730969Z","end":"2026-10-16T09:09:14.899384Z","steps":["trace[1259768831] 'agreement among raft nodes before linearized reading' (duration: 168.319027ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T09:09:14.899425Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T09:09:14.354026Z","time spent":"545.386922ms","remote":"127.0.0.1:47102","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-10-16T09:09:16.429073Z","caller":"traceutil/trace.go:171","msg":"trace[763466958] transaction","detail":"{read_only:false; response_revision:647; number_of_response:1; }","duration":"111.741094ms","start":"2026-10-16T09:09:16.317297Z","end":"2026-10-16T09:09:16.429039Z","steps":["trace[763466958] 'process raft request' (duration: 111.53558ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T09:09:29.783056Z","caller":"traceutil/trace.go:171","msg":"trace[1473361002] linearizableReadLoop","detail":"{readStateIndex:807; appliedIndex:806; }","duration":"257.933175ms","start":"2026-10-16T09:09:29.5251Z","end":"2026-10-16T09:09:29.783033Z","steps":["trace[1473361002] 'read index received' (duration: 257.728272ms)","trace[1473361002] 'applied index is now lower than readState.Index' (duration: 204.223µs)"],"step_count":2} {"level":"info","ts":"2026-10-16T09:09:29.783162Z","caller":"traceutil/trace.go:171","msg":"trace[1138624935] transaction","detail":"{read_only:false; response_revision:777; number_of_response:1; }","duration":"265.807173ms","start":"2026-10-16T09:09:29.517306Z","end":"2026-10-16T09:09:29.783113Z","steps":["trace[1138624935] 'process raft request' (duration: 265.583649ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T09:09:29.783279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.147049ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-10-16T09:09:29.783321Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.368906ms","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-10-16T09:09:29.78336Z","caller":"traceutil/trace.go:171","msg":"trace[226115699] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:777; }","duration":"258.279921ms","start":"2026-10-16T09:09:29.525042Z","end":"2026-10-16T09:09:29.783322Z","steps":["trace[226115699] 'agreement among raft nodes before linearized reading' (duration: 258.140189ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T09:09:29.78338Z","caller":"traceutil/trace.go:171","msg":"trace[1072613196] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:777; }","duration":"249.468968ms","start":"2026-10-16T09:09:29.533901Z","end":"2026-10-16T09:09:29.783369Z","steps":["trace[1072613196] 'agreement among raft nodes before linearized reading' (duration: 249.272305ms)"],"step_count":1}