{"level":"warn","ts":"2026-09-22T03:43:14.816709Z","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-22T03:43:14.816825Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.196: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.196:2380","--initial-cluster=instance=https://162.253.55.196:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.196:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.196: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-22T03:43:14.816906Z","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-22T03:43:14.816922Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.196:2380"]} {"level":"info","ts":"2026-09-22T03:43:14.816948Z","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-22T03:43:14.817707Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.196:2379"]} {"level":"info","ts":"2026-09-22T03:43:14.817813Z","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.196:2380"],"listen-peer-urls":["https://162.253.55.196:2380"],"advertise-client-urls":["https://162.253.55.196:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.196:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.196: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-22T03:43:14.823628Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.579994ms"} {"level":"info","ts":"2026-09-22T03:43:14.830075Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"40c23df05199fc95","cluster-id":"a4d434936ffe8e8"} {"level":"info","ts":"2026-09-22T03:43:14.830148Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"40c23df05199fc95 switched to configuration voters=()"} {"level":"info","ts":"2026-09-22T03:43:14.830168Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"40c23df05199fc95 became follower at term 0"} {"level":"info","ts":"2026-09-22T03:43:14.830182Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 40c23df05199fc95 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-22T03:43:14.830196Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"40c23df05199fc95 became follower at term 1"} {"level":"info","ts":"2026-09-22T03:43:14.830239Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"40c23df05199fc95 switched to configuration voters=(4666360266279746709)"} {"level":"warn","ts":"2026-09-22T03:43:14.836864Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-22T03:43:14.840103Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-22T03:43:14.841406Z","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-22T03:43:14.843955Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"40c23df05199fc95","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-22T03:43:14.844783Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"40c23df05199fc95","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-22T03:43:14.844957Z","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-22T03:43:14.845033Z","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-22T03:43:14.845041Z","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-22T03:43:14.853208Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"40c23df05199fc95 switched to configuration voters=(4666360266279746709)"} {"level":"info","ts":"2026-09-22T03:43:14.853329Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"a4d434936ffe8e8","local-member-id":"40c23df05199fc95","added-peer-id":"40c23df05199fc95","added-peer-peer-urls":["https://162.253.55.196:2380"]} {"level":"info","ts":"2026-09-22T03:43:14.854181Z","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-22T03:43:14.854434Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"40c23df05199fc95","initial-advertise-peer-urls":["https://162.253.55.196:2380"],"listen-peer-urls":["https://162.253.55.196:2380"],"advertise-client-urls":["https://162.253.55.196:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.196:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-22T03:43:14.85446Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-22T03:43:14.854584Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.196:2380"} {"level":"info","ts":"2026-09-22T03:43:14.854595Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.196:2380"} {"level":"info","ts":"2026-09-22T03:43:15.530724Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"40c23df05199fc95 is starting a new election at term 1"} {"level":"info","ts":"2026-09-22T03:43:15.5308Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"40c23df05199fc95 became pre-candidate at term 1"} {"level":"info","ts":"2026-09-22T03:43:15.530843Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"40c23df05199fc95 received MsgPreVoteResp from 40c23df05199fc95 at term 1"} {"level":"info","ts":"2026-09-22T03:43:15.530875Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"40c23df05199fc95 became candidate at term 2"} {"level":"info","ts":"2026-09-22T03:43:15.530895Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"40c23df05199fc95 received MsgVoteResp from 40c23df05199fc95 at term 2"} {"level":"info","ts":"2026-09-22T03:43:15.53092Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"40c23df05199fc95 became leader at term 2"} {"level":"info","ts":"2026-09-22T03:43:15.530941Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 40c23df05199fc95 elected leader 40c23df05199fc95 at term 2"} {"level":"info","ts":"2026-09-22T03:43:15.53342Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-22T03:43:15.53483Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"40c23df05199fc95","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.196:2379]}","request-path":"/0/members/40c23df05199fc95/attributes","cluster-id":"a4d434936ffe8e8","publish-timeout":"7s"} {"level":"info","ts":"2026-09-22T03:43:15.534841Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-22T03:43:15.534925Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-22T03:43:15.537591Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-22T03:43:15.53765Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-22T03:43:15.53827Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-22T03:43:15.540331Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.196:2379"} {"level":"info","ts":"2026-09-22T03:43:15.541029Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"a4d434936ffe8e8","local-member-id":"40c23df05199fc95","cluster-version":"3.5"} {"level":"info","ts":"2026-09-22T03:43:15.54116Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-22T03:43:15.541206Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-22T03:43:20.804664Z","caller":"traceutil/trace.go:171","msg":"trace[1189703673] transaction","detail":"{read_only:false; response_revision:235; number_of_response:1; }","duration":"154.845439ms","start":"2026-09-22T03:43:20.649798Z","end":"2026-09-22T03:43:20.804644Z","steps":["trace[1189703673] 'process raft request' (duration: 154.714365ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T03:43:20.808221Z","caller":"traceutil/trace.go:171","msg":"trace[1690380481] transaction","detail":"{read_only:false; number_of_response:0; response_revision:235; }","duration":"156.600137ms","start":"2026-09-22T03:43:20.65159Z","end":"2026-09-22T03:43:20.80819Z","steps":["trace[1690380481] 'process raft request' (duration: 156.400082ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T03:43:20.808324Z","caller":"traceutil/trace.go:171","msg":"trace[1877134676] transaction","detail":"{read_only:false; response_revision:240; number_of_response:1; }","duration":"114.863121ms","start":"2026-09-22T03:43:20.693442Z","end":"2026-09-22T03:43:20.808306Z","steps":["trace[1877134676] 'process raft request' (duration: 114.791279ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T03:43:20.808315Z","caller":"traceutil/trace.go:171","msg":"trace[2069735661] transaction","detail":"{read_only:false; response_revision:238; number_of_response:1; }","duration":"154.324744ms","start":"2026-09-22T03:43:20.653953Z","end":"2026-09-22T03:43:20.808278Z","steps":["trace[2069735661] 'process raft request' (duration: 154.218392ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T03:43:20.808252Z","caller":"traceutil/trace.go:171","msg":"trace[707897988] transaction","detail":"{read_only:false; response_revision:237; number_of_response:1; }","duration":"154.409246ms","start":"2026-09-22T03:43:20.653819Z","end":"2026-09-22T03:43:20.808228Z","steps":["trace[707897988] 'process raft request' (duration: 154.324814ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T03:43:20.80847Z","caller":"traceutil/trace.go:171","msg":"trace[295084148] transaction","detail":"{read_only:false; response_revision:236; number_of_response:1; }","duration":"155.891348ms","start":"2026-09-22T03:43:20.652567Z","end":"2026-09-22T03:43:20.808458Z","steps":["trace[295084148] 'process raft request' (duration: 155.502377ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T03:43:20.808972Z","caller":"traceutil/trace.go:171","msg":"trace[820601693] transaction","detail":"{read_only:false; response_revision:239; number_of_response:1; }","duration":"153.543252ms","start":"2026-09-22T03:43:20.654837Z","end":"2026-09-22T03:43:20.80838Z","steps":["trace[820601693] 'process raft request' (duration: 153.372458ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T03:43:23.424115Z","caller":"traceutil/trace.go:171","msg":"trace[1179570752] linearizableReadLoop","detail":"{readStateIndex:291; appliedIndex:290; }","duration":"216.51202ms","start":"2026-09-22T03:43:23.207568Z","end":"2026-09-22T03:43:23.42408Z","steps":["trace[1179570752] 'read index received' (duration: 216.360016ms)","trace[1179570752] 'applied index is now lower than readState.Index' (duration: 150.434µs)"],"step_count":2} {"level":"info","ts":"2026-09-22T03:43:23.424184Z","caller":"traceutil/trace.go:171","msg":"trace[1412638409] transaction","detail":"{read_only:false; response_revision:279; number_of_response:1; }","duration":"229.071238ms","start":"2026-09-22T03:43:23.19507Z","end":"2026-09-22T03:43:23.424141Z","steps":["trace[1412638409] 'process raft request' (duration: 228.78661ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T03:43:23.424436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.808549ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-09-22T03:43:23.424625Z","caller":"traceutil/trace.go:171","msg":"trace[723331186] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:279; }","duration":"217.038755ms","start":"2026-09-22T03:43:23.207556Z","end":"2026-09-22T03:43:23.424594Z","steps":["trace[723331186] 'agreement among raft nodes before linearized reading' (duration: 216.671574ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T03:43:23.464597Z","caller":"traceutil/trace.go:171","msg":"trace[26012922] transaction","detail":"{read_only:false; response_revision:280; number_of_response:1; }","duration":"181.265163ms","start":"2026-09-22T03:43:23.283304Z","end":"2026-09-22T03:43:23.464569Z","steps":["trace[26012922] 'process raft request' (duration: 181.179431ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T03:43:23.46485Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.945041ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-09-22T03:43:23.46494Z","caller":"traceutil/trace.go:171","msg":"trace[605727844] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:280; }","duration":"121.045895ms","start":"2026-09-22T03:43:23.343871Z","end":"2026-09-22T03:43:23.464917Z","steps":["trace[605727844] 'agreement among raft nodes before linearized reading' (duration: 120.848209ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T03:43:23.464995Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.633937ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/generic-garbage-collector\" ","response":"range_response_count:1 size:216"} {"level":"info","ts":"2026-09-22T03:43:23.465054Z","caller":"traceutil/trace.go:171","msg":"trace[506017027] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/generic-garbage-collector; range_end:; response_count:1; response_revision:280; }","duration":"232.716029ms","start":"2026-09-22T03:43:23.232321Z","end":"2026-09-22T03:43:23.465037Z","steps":["trace[506017027] 'agreement among raft nodes before linearized reading' (duration: 232.357299ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T03:43:23.680342Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.119727ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-22T03:43:23.680578Z","caller":"traceutil/trace.go:171","msg":"trace[252938817] transaction","detail":"{read_only:false; response_revision:282; number_of_response:1; }","duration":"209.27852ms","start":"2026-09-22T03:43:23.471283Z","end":"2026-09-22T03:43:23.680561Z","steps":["trace[252938817] 'process raft request' (duration: 209.208888ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T03:43:23.680548Z","caller":"traceutil/trace.go:171","msg":"trace[767931850] transaction","detail":"{read_only:false; response_revision:281; number_of_response:1; }","duration":"251.248993ms","start":"2026-09-22T03:43:23.429267Z","end":"2026-09-22T03:43:23.680516Z","steps":["trace[767931850] 'process raft request' (duration: 116.280452ms)","trace[767931850] 'compare' (duration: 133.972303ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T03:43:23.680645Z","caller":"traceutil/trace.go:171","msg":"trace[465588612] linearizableReadLoop","detail":"{readStateIndex:293; appliedIndex:292; }","duration":"211.46481ms","start":"2026-09-22T03:43:23.469137Z","end":"2026-09-22T03:43:23.680602Z","steps":["trace[465588612] 'read index received' (duration: 76.427208ms)","trace[465588612] 'applied index is now lower than readState.Index' (duration: 135.032892ms)"],"step_count":2} {"level":"warn","ts":"2026-09-22T03:43:23.6808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.652475ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/node-controller\" ","response":"range_response_count:1 size:195"} {"level":"info","ts":"2026-09-22T03:43:23.680845Z","caller":"traceutil/trace.go:171","msg":"trace[536214010] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/node-controller; range_end:; response_count:1; response_revision:282; }","duration":"211.742248ms","start":"2026-09-22T03:43:23.469085Z","end":"2026-09-22T03:43:23.680827Z","steps":["trace[536214010] 'agreement among raft nodes before linearized reading' (duration: 211.660726ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T03:43:23.680888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.960136ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-09-22T03:43:23.680942Z","caller":"traceutil/trace.go:171","msg":"trace[77097123] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:282; }","duration":"159.075488ms","start":"2026-09-22T03:43:23.521851Z","end":"2026-09-22T03:43:23.680926Z","steps":["trace[77097123] 'agreement among raft nodes before linearized reading' (duration: 158.985436ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T03:43:57.132064Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.640447ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-09-22T03:43:57.13218Z","caller":"traceutil/trace.go:171","msg":"trace[73033844] transaction","detail":"{read_only:false; response_revision:555; number_of_response:1; }","duration":"362.179204ms","start":"2026-09-22T03:43:56.769982Z","end":"2026-09-22T03:43:57.132161Z","steps":["trace[73033844] 'process raft request' (duration: 96.365171ms)","trace[73033844] 'compare' (duration: 265.23165ms)"],"step_count":2} {"level":"warn","ts":"2026-09-22T03:43:57.132228Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T03:43:56.769955Z","time spent":"362.253257ms","remote":"127.0.0.1:48818","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":569094,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-22T03:43:57.133219Z","caller":"traceutil/trace.go:171","msg":"trace[1647070882] linearizableReadLoop","detail":"{readStateIndex:582; appliedIndex:581; }","duration":"135.536421ms","start":"2026-09-22T03:43:56.997658Z","end":"2026-09-22T03:43:57.133195Z","steps":["trace[1647070882] 'read index received' (duration: 135.284451ms)","trace[1647070882] 'applied index is now lower than readState.Index' (duration: 250.97µs)"],"step_count":2} {"level":"warn","ts":"2026-09-22T03:43:57.133372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.662036ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-22T03:43:57.133402Z","caller":"traceutil/trace.go:171","msg":"trace[127823435] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:556; }","duration":"135.7805ms","start":"2026-09-22T03:43:56.997613Z","end":"2026-09-22T03:43:57.133393Z","steps":["trace[127823435] 'agreement among raft nodes before linearized reading' (duration: 135.675126ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T03:43:57.133634Z","caller":"traceutil/trace.go:171","msg":"trace[1617588282] transaction","detail":"{read_only:false; response_revision:556; number_of_response:1; }","duration":"336.457309ms","start":"2026-09-22T03:43:56.797144Z","end":"2026-09-22T03:43:57.133602Z","steps":["trace[1617588282] 'process raft request' (duration: 335.906487ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T03:43:57.133793Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T03:43:56.797129Z","time spent":"336.574134ms","remote":"127.0.0.1:48818","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":74754,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-22T03:44:01.868907Z","caller":"traceutil/trace.go:171","msg":"trace[68488090] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"169.905379ms","start":"2026-09-22T03:44:01.698975Z","end":"2026-09-22T03:44:01.86888Z","steps":["trace[68488090] 'process raft request' (duration: 163.257649ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T03:44:02.212999Z","caller":"traceutil/trace.go:171","msg":"trace[1104545196] linearizableReadLoop","detail":"{readStateIndex:621; appliedIndex:620; }","duration":"296.704642ms","start":"2026-09-22T03:44:01.916271Z","end":"2026-09-22T03:44:02.212976Z","steps":["trace[1104545196] 'read index received' (duration: 296.621719ms)","trace[1104545196] 'applied index is now lower than readState.Index' (duration: 81.793µs)"],"step_count":2} {"level":"info","ts":"2026-09-22T03:44:02.213106Z","caller":"traceutil/trace.go:171","msg":"trace[1513317271] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"297.969942ms","start":"2026-09-22T03:44:01.915122Z","end":"2026-09-22T03:44:02.213092Z","steps":["trace[1513317271] 'process raft request' (duration: 297.721922ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T03:44:02.213293Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.997674ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-09-22T03:44:02.21341Z","caller":"traceutil/trace.go:171","msg":"trace[603957023] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:594; }","duration":"297.15549ms","start":"2026-09-22T03:44:01.916238Z","end":"2026-09-22T03:44:02.213394Z","steps":["trace[603957023] 'agreement among raft nodes before linearized reading' (duration: 296.91161ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T03:44:02.369952Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"440.701185ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-09-22T03:44:02.3701Z","caller":"traceutil/trace.go:171","msg":"trace[493842173] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:595; }","duration":"440.880012ms","start":"2026-09-22T03:44:01.929178Z","end":"2026-09-22T03:44:02.370058Z","steps":["trace[493842173] 'agreement among raft nodes before linearized reading' (duration: 440.344191ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T03:44:02.370155Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T03:44:01.929171Z","time spent":"440.969776ms","remote":"127.0.0.1:49046","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-09-22T03:44:02.37034Z","caller":"traceutil/trace.go:171","msg":"trace[1888067141] transaction","detail":"{read_only:false; response_revision:595; number_of_response:1; }","duration":"337.58073ms","start":"2026-09-22T03:44:02.032722Z","end":"2026-09-22T03:44:02.370303Z","steps":["trace[1888067141] 'process raft request' (duration: 334.682267ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T03:44:02.370486Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T03:44:02.032671Z","time spent":"337.724695ms","remote":"127.0.0.1:48872","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036265,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-22T03:44:02.370672Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"373.947317ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-22T03:44:02.370795Z","caller":"traceutil/trace.go:171","msg":"trace[1922303377] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:595; }","duration":"374.093642ms","start":"2026-09-22T03:44:01.996651Z","end":"2026-09-22T03:44:02.370745Z","steps":["trace[1922303377] 'agreement among raft nodes before linearized reading' (duration: 373.706127ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T03:44:02.370846Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T03:44:01.996633Z","time spent":"374.202177ms","remote":"127.0.0.1:48734","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-09-22T03:44:02.371845Z","caller":"traceutil/trace.go:171","msg":"trace[653397658] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"153.991564ms","start":"2026-09-22T03:44:02.217826Z","end":"2026-09-22T03:44:02.371817Z","steps":["trace[653397658] 'process raft request' (duration: 153.850288ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T03:44:02.372644Z","caller":"traceutil/trace.go:171","msg":"trace[773572649] linearizableReadLoop","detail":"{readStateIndex:622; appliedIndex:621; }","duration":"156.419579ms","start":"2026-09-22T03:44:02.213058Z","end":"2026-09-22T03:44:02.369478Z","steps":["trace[773572649] 'read index received' (duration: 154.101809ms)","trace[773572649] 'applied index is now lower than readState.Index' (duration: 2.31502ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T03:44:19.190378Z","caller":"traceutil/trace.go:171","msg":"trace[765023731] transaction","detail":"{read_only:false; response_revision:760; number_of_response:1; }","duration":"168.726865ms","start":"2026-09-22T03:44:19.021634Z","end":"2026-09-22T03:44:19.19036Z","steps":["trace[765023731] 'process raft request' (duration: 168.60836ms)"],"step_count":1}