{"level":"warn","ts":"2026-09-01T03:46:37.059562Z","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-01T03:46:37.059672Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.119: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.119:2380","--initial-cluster=instance=https://162.253.55.119:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.119:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.119: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-01T03:46:37.059755Z","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-01T03:46:37.059767Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.119:2380"]} {"level":"info","ts":"2026-09-01T03:46:37.059786Z","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-01T03:46:37.060566Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.119:2379"]} {"level":"info","ts":"2026-09-01T03:46:37.060657Z","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.119:2380"],"listen-peer-urls":["https://162.253.55.119:2380"],"advertise-client-urls":["https://162.253.55.119:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.119:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.119: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-01T03:46:37.065823Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.906084ms"} {"level":"info","ts":"2026-09-01T03:46:37.077941Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"2f0e00eb3c3ee1b","cluster-id":"8e467f099f65c603"} {"level":"info","ts":"2026-09-01T03:46:37.07802Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2f0e00eb3c3ee1b switched to configuration voters=()"} {"level":"info","ts":"2026-09-01T03:46:37.078044Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2f0e00eb3c3ee1b became follower at term 0"} {"level":"info","ts":"2026-09-01T03:46:37.078057Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 2f0e00eb3c3ee1b [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-01T03:46:37.078066Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2f0e00eb3c3ee1b became follower at term 1"} {"level":"info","ts":"2026-09-01T03:46:37.078102Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2f0e00eb3c3ee1b switched to configuration voters=(211915536236539419)"} {"level":"warn","ts":"2026-09-01T03:46:37.087713Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-01T03:46:37.089063Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-01T03:46:37.090427Z","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-01T03:46:37.092579Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"2f0e00eb3c3ee1b","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-01T03:46:37.09301Z","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-01T03:46:37.093073Z","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-01T03:46:37.093088Z","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-01T03:46:37.093135Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"2f0e00eb3c3ee1b","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-01T03:46:37.097093Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2f0e00eb3c3ee1b switched to configuration voters=(211915536236539419)"} {"level":"info","ts":"2026-09-01T03:46:37.097282Z","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-01T03:46:37.097496Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"2f0e00eb3c3ee1b","initial-advertise-peer-urls":["https://162.253.55.119:2380"],"listen-peer-urls":["https://162.253.55.119:2380"],"advertise-client-urls":["https://162.253.55.119:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.119:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-01T03:46:37.097521Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-01T03:46:37.097636Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.119:2380"} {"level":"info","ts":"2026-09-01T03:46:37.097659Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.119:2380"} {"level":"info","ts":"2026-09-01T03:46:37.097658Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"8e467f099f65c603","local-member-id":"2f0e00eb3c3ee1b","added-peer-id":"2f0e00eb3c3ee1b","added-peer-peer-urls":["https://162.253.55.119:2380"]} {"level":"info","ts":"2026-09-01T03:46:37.279055Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2f0e00eb3c3ee1b is starting a new election at term 1"} {"level":"info","ts":"2026-09-01T03:46:37.279159Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2f0e00eb3c3ee1b became pre-candidate at term 1"} {"level":"info","ts":"2026-09-01T03:46:37.27922Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2f0e00eb3c3ee1b received MsgPreVoteResp from 2f0e00eb3c3ee1b at term 1"} {"level":"info","ts":"2026-09-01T03:46:37.279256Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2f0e00eb3c3ee1b became candidate at term 2"} {"level":"info","ts":"2026-09-01T03:46:37.279612Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2f0e00eb3c3ee1b received MsgVoteResp from 2f0e00eb3c3ee1b at term 2"} {"level":"info","ts":"2026-09-01T03:46:37.279631Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2f0e00eb3c3ee1b became leader at term 2"} {"level":"info","ts":"2026-09-01T03:46:37.279645Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 2f0e00eb3c3ee1b elected leader 2f0e00eb3c3ee1b at term 2"} {"level":"info","ts":"2026-09-01T03:46:37.281956Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"2f0e00eb3c3ee1b","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.119:2379]}","request-path":"/0/members/2f0e00eb3c3ee1b/attributes","cluster-id":"8e467f099f65c603","publish-timeout":"7s"} {"level":"info","ts":"2026-09-01T03:46:37.281989Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-01T03:46:37.282251Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-01T03:46:37.282643Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-01T03:46:37.282684Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-01T03:46:37.285092Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-01T03:46:37.285257Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-01T03:46:37.287829Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.119:2379"} {"level":"info","ts":"2026-09-01T03:46:37.289988Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"8e467f099f65c603","local-member-id":"2f0e00eb3c3ee1b","cluster-version":"3.5"} {"level":"info","ts":"2026-09-01T03:46:37.290086Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-01T03:46:37.290305Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-01T03:46:39.833488Z","caller":"traceutil/trace.go:171","msg":"trace[1934059722] transaction","detail":"{read_only:false; response_revision:82; number_of_response:1; }","duration":"105.87612ms","start":"2026-09-01T03:46:39.727579Z","end":"2026-09-01T03:46:39.833456Z","steps":["trace[1934059722] 'process raft request' (duration: 58.726669ms)","trace[1934059722] 'compare' (duration: 46.995516ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T03:46:40.295902Z","caller":"traceutil/trace.go:171","msg":"trace[1101622974] transaction","detail":"{read_only:false; response_revision:122; number_of_response:1; }","duration":"127.553185ms","start":"2026-09-01T03:46:40.168308Z","end":"2026-09-01T03:46:40.295862Z","steps":["trace[1101622974] 'process raft request' (duration: 114.617127ms)","trace[1101622974] 'compare' (duration: 12.701991ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T03:46:40.296115Z","caller":"traceutil/trace.go:171","msg":"trace[36719341] transaction","detail":"{read_only:false; response_revision:123; number_of_response:1; }","duration":"126.305484ms","start":"2026-09-01T03:46:40.169518Z","end":"2026-09-01T03:46:40.295823Z","steps":["trace[36719341] 'process raft request' (duration: 126.255022ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T03:46:42.431907Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.269034ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-09-01T03:46:42.43237Z","caller":"traceutil/trace.go:171","msg":"trace[1814217095] transaction","detail":"{read_only:false; response_revision:264; number_of_response:1; }","duration":"408.406391ms","start":"2026-09-01T03:46:42.023928Z","end":"2026-09-01T03:46:42.432335Z","steps":["trace[1814217095] 'process raft request' (duration: 112.982891ms)","trace[1814217095] 'compare' (duration: 294.13177ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T03:46:42.432649Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T03:46:42.023909Z","time spent":"408.652568ms","remote":"127.0.0.1:49548","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":197,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-01T03:46:42.853542Z","caller":"traceutil/trace.go:171","msg":"trace[1839346444] transaction","detail":"{read_only:false; response_revision:265; number_of_response:1; }","duration":"412.275954ms","start":"2026-09-01T03:46:42.441249Z","end":"2026-09-01T03:46:42.853525Z","steps":["trace[1839346444] 'process raft request' (duration: 407.871454ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T03:46:42.853317Z","caller":"traceutil/trace.go:171","msg":"trace[1536708397] linearizableReadLoop","detail":"{readStateIndex:270; appliedIndex:269; }","duration":"411.604942ms","start":"2026-09-01T03:46:42.441664Z","end":"2026-09-01T03:46:42.853269Z","steps":["trace[1536708397] 'read index received' (duration: 407.45688ms)","trace[1536708397] 'applied index is now lower than readState.Index' (duration: 4.146792ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T03:46:42.853924Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"412.19604ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-09-01T03:46:42.854049Z","caller":"traceutil/trace.go:171","msg":"trace[912663916] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:265; }","duration":"412.366206ms","start":"2026-09-01T03:46:42.44162Z","end":"2026-09-01T03:46:42.853986Z","steps":["trace[912663916] 'agreement among raft nodes before linearized reading' (duration: 412.013174ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T03:46:42.854132Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T03:46:42.441604Z","time spent":"412.514271ms","remote":"127.0.0.1:49466","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":374,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-09-01T03:46:42.854147Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T03:46:42.441223Z","time spent":"412.387677ms","remote":"127.0.0.1:49520","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4003,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-01T03:46:43.047179Z","caller":"traceutil/trace.go:171","msg":"trace[6490730] transaction","detail":"{read_only:false; response_revision:266; number_of_response:1; }","duration":"189.330527ms","start":"2026-09-01T03:46:42.857811Z","end":"2026-09-01T03:46:43.047141Z","steps":["trace[6490730] 'process raft request' (duration: 131.112975ms)","trace[6490730] 'compare' (duration: 57.774068ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T03:46:43.047622Z","caller":"traceutil/trace.go:171","msg":"trace[152863696] linearizableReadLoop","detail":"{readStateIndex:271; appliedIndex:270; }","duration":"189.085198ms","start":"2026-09-01T03:46:42.858494Z","end":"2026-09-01T03:46:43.047579Z","steps":["trace[152863696] 'read index received' (duration: 130.365821ms)","trace[152863696] 'applied index is now lower than readState.Index' (duration: 58.717017ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T03:46:43.047873Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.354547ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/bootstrap-token-ow6xhu\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-01T03:46:43.047955Z","caller":"traceutil/trace.go:171","msg":"trace[1403361230] range","detail":"{range_begin:/registry/secrets/kube-system/bootstrap-token-ow6xhu; range_end:; response_count:0; response_revision:266; }","duration":"189.48276ms","start":"2026-09-01T03:46:42.858451Z","end":"2026-09-01T03:46:43.047933Z","steps":["trace[1403361230] 'agreement among raft nodes before linearized reading' (duration: 189.280464ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T03:46:43.047941Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.995919ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-01T03:46:43.048149Z","caller":"traceutil/trace.go:171","msg":"trace[744334619] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:0; response_revision:266; }","duration":"144.239567ms","start":"2026-09-01T03:46:42.903875Z","end":"2026-09-01T03:46:43.048114Z","steps":["trace[744334619] 'agreement among raft nodes before linearized reading' (duration: 143.974739ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T03:46:43.04822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.627402ms","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-01T03:46:43.048344Z","caller":"traceutil/trace.go:171","msg":"trace[414953650] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:266; }","duration":"110.803307ms","start":"2026-09-01T03:46:42.937508Z","end":"2026-09-01T03:46:43.048311Z","steps":["trace[414953650] 'agreement among raft nodes before linearized reading' (duration: 110.479377ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T03:46:47.383989Z","caller":"traceutil/trace.go:171","msg":"trace[1858189051] transaction","detail":"{read_only:false; response_revision:376; number_of_response:1; }","duration":"104.483599ms","start":"2026-09-01T03:46:47.279477Z","end":"2026-09-01T03:46:47.38396Z","steps":["trace[1858189051] 'process raft request' (duration: 74.821794ms)","trace[1858189051] 'compare' (duration: 29.48986ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T03:46:47.475259Z","caller":"traceutil/trace.go:171","msg":"trace[1624684428] linearizableReadLoop","detail":"{readStateIndex:386; appliedIndex:382; }","duration":"145.331798ms","start":"2026-09-01T03:46:47.329897Z","end":"2026-09-01T03:46:47.475229Z","steps":["trace[1624684428] 'read index received' (duration: 24.385924ms)","trace[1624684428] 'applied index is now lower than readState.Index' (duration: 120.944704ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T03:46:47.475295Z","caller":"traceutil/trace.go:171","msg":"trace[229533614] transaction","detail":"{read_only:false; response_revision:378; number_of_response:1; }","duration":"194.197562ms","start":"2026-09-01T03:46:47.281072Z","end":"2026-09-01T03:46:47.475269Z","steps":["trace[229533614] 'process raft request' (duration: 193.995616ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T03:46:47.475259Z","caller":"traceutil/trace.go:171","msg":"trace[126319688] transaction","detail":"{read_only:false; response_revision:377; number_of_response:1; }","duration":"194.246814ms","start":"2026-09-01T03:46:47.280956Z","end":"2026-09-01T03:46:47.475203Z","steps":["trace[126319688] 'process raft request' (duration: 193.970805ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T03:46:47.475391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.481543ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/kube-proxy\" ","response":"range_response_count:1 size:185"} {"level":"info","ts":"2026-09-01T03:46:47.475423Z","caller":"traceutil/trace.go:171","msg":"trace[833722738] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/kube-proxy; range_end:; response_count:1; response_revision:379; }","duration":"145.568196ms","start":"2026-09-01T03:46:47.329845Z","end":"2026-09-01T03:46:47.475413Z","steps":["trace[833722738] 'agreement among raft nodes before linearized reading' (duration: 145.486233ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T03:46:47.475381Z","caller":"traceutil/trace.go:171","msg":"trace[430270286] transaction","detail":"{read_only:false; response_revision:379; number_of_response:1; }","duration":"186.51347ms","start":"2026-09-01T03:46:47.288844Z","end":"2026-09-01T03:46:47.475357Z","steps":["trace[430270286] 'process raft request' (duration: 186.333715ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T03:46:47.708098Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.737932ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-09-01T03:46:47.708222Z","caller":"traceutil/trace.go:171","msg":"trace[17930556] transaction","detail":"{read_only:false; response_revision:380; number_of_response:1; }","duration":"227.554558ms","start":"2026-09-01T03:46:47.480646Z","end":"2026-09-01T03:46:47.708201Z","steps":["trace[17930556] 'process raft request' (duration: 82.644801ms)","trace[17930556] 'compare' (duration: 144.563776ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T03:46:47.716415Z","caller":"traceutil/trace.go:171","msg":"trace[440598496] transaction","detail":"{read_only:false; response_revision:382; number_of_response:1; }","duration":"232.331ms","start":"2026-09-01T03:46:47.484064Z","end":"2026-09-01T03:46:47.716395Z","steps":["trace[440598496] 'process raft request' (duration: 232.147034ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T03:46:47.716628Z","caller":"traceutil/trace.go:171","msg":"trace[2079283320] transaction","detail":"{read_only:false; response_revision:383; number_of_response:1; }","duration":"230.97728ms","start":"2026-09-01T03:46:47.485637Z","end":"2026-09-01T03:46:47.716615Z","steps":["trace[2079283320] 'process raft request' (duration: 230.67855ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T03:46:47.717887Z","caller":"traceutil/trace.go:171","msg":"trace[564245719] transaction","detail":"{read_only:false; response_revision:381; number_of_response:1; }","duration":"234.175756ms","start":"2026-09-01T03:46:47.482166Z","end":"2026-09-01T03:46:47.716341Z","steps":["trace[564245719] 'process raft request' (duration: 233.892218ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T03:47:19.200212Z","caller":"traceutil/trace.go:171","msg":"trace[426014260] transaction","detail":"{read_only:false; response_revision:500; number_of_response:1; }","duration":"204.150904ms","start":"2026-09-01T03:47:18.99604Z","end":"2026-09-01T03:47:19.200191Z","steps":["trace[426014260] 'process raft request' (duration: 203.916929ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T03:47:19.462583Z","caller":"traceutil/trace.go:171","msg":"trace[888288855] transaction","detail":"{read_only:false; response_revision:501; number_of_response:1; }","duration":"225.997058ms","start":"2026-09-01T03:47:19.236552Z","end":"2026-09-01T03:47:19.462549Z","steps":["trace[888288855] 'process raft request' (duration: 225.855095ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T03:47:19.487462Z","caller":"traceutil/trace.go:171","msg":"trace[798285554] linearizableReadLoop","detail":"{readStateIndex:518; appliedIndex:516; }","duration":"196.88221ms","start":"2026-09-01T03:47:19.290556Z","end":"2026-09-01T03:47:19.487439Z","steps":["trace[798285554] 'read index received' (duration: 171.874713ms)","trace[798285554] 'applied index is now lower than readState.Index' (duration: 25.006527ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T03:47:19.487602Z","caller":"traceutil/trace.go:171","msg":"trace[59667884] transaction","detail":"{read_only:false; response_revision:502; number_of_response:1; }","duration":"250.904243ms","start":"2026-09-01T03:47:19.236662Z","end":"2026-09-01T03:47:19.487566Z","steps":["trace[59667884] 'process raft request' (duration: 250.622396ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T03:47:19.487723Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.936144ms","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-01T03:47:19.487787Z","caller":"traceutil/trace.go:171","msg":"trace[1443336998] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:502; }","duration":"191.057016ms","start":"2026-09-01T03:47:19.296712Z","end":"2026-09-01T03:47:19.487769Z","steps":["trace[1443336998] 'agreement among raft nodes before linearized reading' (duration: 190.883472ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T03:47:19.4878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.199867ms","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-01T03:47:19.487843Z","caller":"traceutil/trace.go:171","msg":"trace[934948132] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:502; }","duration":"197.31944ms","start":"2026-09-01T03:47:19.29051Z","end":"2026-09-01T03:47:19.48783Z","steps":["trace[934948132] 'agreement among raft nodes before linearized reading' (duration: 197.054794ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T03:47:21.692384Z","caller":"traceutil/trace.go:171","msg":"trace[1752132636] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"100.592402ms","start":"2026-09-01T03:47:21.591744Z","end":"2026-09-01T03:47:21.692336Z","steps":["trace[1752132636] 'process raft request' (duration: 100.48361ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T03:47:21.692664Z","caller":"traceutil/trace.go:171","msg":"trace[539505588] linearizableReadLoop","detail":"{readStateIndex:560; appliedIndex:558; }","duration":"101.022832ms","start":"2026-09-01T03:47:21.591622Z","end":"2026-09-01T03:47:21.692644Z","steps":["trace[539505588] 'read index received' (duration: 77.670202ms)","trace[539505588] 'applied index is now lower than readState.Index' (duration: 23.35198ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T03:47:21.692875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.235787ms","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-01T03:47:21.692921Z","caller":"traceutil/trace.go:171","msg":"trace[174546153] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:552; }","duration":"101.311188ms","start":"2026-09-01T03:47:21.591597Z","end":"2026-09-01T03:47:21.692908Z","steps":["trace[174546153] 'agreement among raft nodes before linearized reading' (duration: 101.112353ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T03:47:21.693371Z","caller":"traceutil/trace.go:171","msg":"trace[1407900857] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"102.907624ms","start":"2026-09-01T03:47:21.590427Z","end":"2026-09-01T03:47:21.693334Z","steps":["trace[1407900857] 'process raft request' (duration: 101.709198ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T03:47:22.334379Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"553.836748ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-09-01T03:47:22.334611Z","caller":"traceutil/trace.go:171","msg":"trace[1698674792] transaction","detail":"{read_only:false; response_revision:553; number_of_response:1; }","duration":"660.616409ms","start":"2026-09-01T03:47:21.673966Z","end":"2026-09-01T03:47:22.334582Z","steps":["trace[1698674792] 'process raft request' (duration: 106.481354ms)","trace[1698674792] 'compare' (duration: 553.645124ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T03:47:22.334663Z","caller":"traceutil/trace.go:171","msg":"trace[868932652] linearizableReadLoop","detail":"{readStateIndex:572; appliedIndex:569; }","duration":"641.933311ms","start":"2026-09-01T03:47:21.692714Z","end":"2026-09-01T03:47:22.334647Z","steps":["trace[868932652] 'read index received' (duration: 87.816817ms)","trace[868932652] 'applied index is now lower than readState.Index' (duration: 554.115564ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T03:47:22.334839Z","caller":"traceutil/trace.go:171","msg":"trace[501881800] transaction","detail":"{read_only:false; response_revision:554; number_of_response:1; }","duration":"658.981622ms","start":"2026-09-01T03:47:21.675747Z","end":"2026-09-01T03:47:22.334728Z","steps":["trace[501881800] 'process raft request' (duration: 658.756147ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T03:47:22.334871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"732.345477ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-01T03:47:22.334895Z","caller":"traceutil/trace.go:171","msg":"trace[1679113958] transaction","detail":"{read_only:false; number_of_response:1; response_revision:554; }","duration":"657.919348ms","start":"2026-09-01T03:47:21.676875Z","end":"2026-09-01T03:47:22.334794Z","steps":["trace[1679113958] 'process raft request' (duration: 657.719504ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T03:47:22.334928Z","caller":"traceutil/trace.go:171","msg":"trace[464627666] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:554; }","duration":"732.393198ms","start":"2026-09-01T03:47:21.602513Z","end":"2026-09-01T03:47:22.334906Z","steps":["trace[464627666] 'agreement among raft nodes before linearized reading' (duration: 732.234784ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T03:47:22.334978Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T03:47:21.602492Z","time spent":"732.477029ms","remote":"127.0.0.1:49364","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-09-01T03:47:22.334846Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"733.337989ms","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-01T03:47:22.335057Z","caller":"traceutil/trace.go:171","msg":"trace[898503493] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:554; }","duration":"733.582385ms","start":"2026-09-01T03:47:21.601459Z","end":"2026-09-01T03:47:22.335041Z","steps":["trace[898503493] 'agreement among raft nodes before linearized reading' (duration: 733.289138ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T03:47:22.335067Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T03:47:21.676868Z","time spent":"658.104292ms","remote":"127.0.0.1:49400","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":102,"response count":0,"response size":6937,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-01T03:47:22.335153Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T03:47:21.601445Z","time spent":"733.650766ms","remote":"127.0.0.1:49620","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-09-01T03:47:22.335185Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T03:47:21.675739Z","time spent":"659.154066ms","remote":"127.0.0.1:49400","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6888,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-01T03:47:22.334708Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T03:47:21.673953Z","time spent":"660.713411ms","remote":"127.0.0.1:49906","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":995,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-01T03:47:22.336895Z","caller":"traceutil/trace.go:171","msg":"trace[433364435] transaction","detail":"{read_only:false; response_revision:556; number_of_response:1; }","duration":"635.202502ms","start":"2026-09-01T03:47:21.701673Z","end":"2026-09-01T03:47:22.336875Z","steps":["trace[433364435] 'process raft request' (duration: 634.760012ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T03:47:22.336983Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T03:47:21.701667Z","time spent":"635.274773ms","remote":"127.0.0.1:49906","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":980,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-01T03:47:22.336965Z","caller":"traceutil/trace.go:171","msg":"trace[492884543] transaction","detail":"{read_only:false; response_revision:557; number_of_response:1; }","duration":"632.789077ms","start":"2026-09-01T03:47:21.70416Z","end":"2026-09-01T03:47:22.336949Z","steps":["trace[492884543] 'process raft request' (duration: 632.402019ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T03:47:22.33708Z","caller":"traceutil/trace.go:171","msg":"trace[1433577555] transaction","detail":"{read_only:false; response_revision:555; number_of_response:1; }","duration":"635.481168ms","start":"2026-09-01T03:47:21.701579Z","end":"2026-09-01T03:47:22.33706Z","steps":["trace[1433577555] 'process raft request' (duration: 634.626119ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T03:47:22.337169Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T03:47:21.701561Z","time spent":"635.561569ms","remote":"127.0.0.1:49906","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1004,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-01T03:47:22.337389Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T03:47:21.70414Z","time spent":"632.952451ms","remote":"127.0.0.1:49400","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10063,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-01T03:47:22.337495Z","caller":"traceutil/trace.go:171","msg":"trace[364147156] transaction","detail":"{read_only:false; response_revision:558; number_of_response:1; }","duration":"629.979725ms","start":"2026-09-01T03:47:21.707496Z","end":"2026-09-01T03:47:22.337475Z","steps":["trace[364147156] 'process raft request' (duration: 629.28877ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T03:47:22.337719Z","caller":"traceutil/trace.go:171","msg":"trace[1110924143] transaction","detail":"{read_only:false; response_revision:559; number_of_response:1; }","duration":"629.838552ms","start":"2026-09-01T03:47:21.707865Z","end":"2026-09-01T03:47:22.337704Z","steps":["trace[1110924143] 'process raft request' (duration: 629.104916ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T03:47:22.337812Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T03:47:21.707846Z","time spent":"629.915804ms","remote":"127.0.0.1:49400","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30393,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-01T03:47:22.33834Z","caller":"traceutil/trace.go:171","msg":"trace[1096295404] transaction","detail":"{read_only:false; response_revision:563; number_of_response:1; }","duration":"623.224903ms","start":"2026-09-01T03:47:21.7151Z","end":"2026-09-01T03:47:22.338325Z","steps":["trace[1096295404] 'process raft request' (duration: 623.110301ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T03:47:22.338461Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T03:47:21.715084Z","time spent":"623.330246ms","remote":"127.0.0.1:49400","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28739,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-01T03:47:22.33851Z","caller":"traceutil/trace.go:171","msg":"trace[842444224] transaction","detail":"{read_only:false; response_revision:560; number_of_response:1; }","duration":"628.092592ms","start":"2026-09-01T03:47:21.710405Z","end":"2026-09-01T03:47:22.338497Z","steps":["trace[842444224] 'process raft request' (duration: 627.149661ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T03:47:22.338603Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T03:47:21.710338Z","time spent":"628.210575ms","remote":"127.0.0.1:49906","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":998,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-01T03:47:22.338465Z","caller":"traceutil/trace.go:171","msg":"trace[42898544] transaction","detail":"{read_only:false; response_revision:561; number_of_response:1; }","duration":"626.714261ms","start":"2026-09-01T03:47:21.711733Z","end":"2026-09-01T03:47:22.338447Z","steps":["trace[42898544] 'process raft request' (duration: 626.20521ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T03:47:22.33899Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T03:47:21.711722Z","time spent":"627.222594ms","remote":"127.0.0.1:49620","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-01T03:47:22.340027Z","caller":"traceutil/trace.go:171","msg":"trace[330263929] transaction","detail":"{read_only:false; response_revision:562; number_of_response:1; }","duration":"627.310955ms","start":"2026-09-01T03:47:21.711804Z","end":"2026-09-01T03:47:22.339115Z","steps":["trace[330263929] 'process raft request' (duration: 626.250391ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T03:47:22.340154Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T03:47:21.711798Z","time spent":"628.281396ms","remote":"127.0.0.1:49400","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30374,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-01T03:47:22.337593Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T03:47:21.707458Z","time spent":"630.099937ms","remote":"127.0.0.1:49906","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":998,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-01T03:47:22.368756Z","caller":"traceutil/trace.go:171","msg":"trace[2084480075] transaction","detail":"{read_only:false; response_revision:564; number_of_response:1; }","duration":"567.925827ms","start":"2026-09-01T03:47:21.800804Z","end":"2026-09-01T03:47:22.368729Z","steps":["trace[2084480075] 'process raft request' (duration: 567.464877ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T03:47:22.3689Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T03:47:21.800778Z","time spent":"568.052239ms","remote":"127.0.0.1:49400","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-01T03:47:22.369489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.612236ms","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-01T03:47:22.369646Z","caller":"traceutil/trace.go:171","msg":"trace[2144252241] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:564; }","duration":"256.77733ms","start":"2026-09-01T03:47:22.112783Z","end":"2026-09-01T03:47:22.36956Z","steps":["trace[2144252241] 'agreement among raft nodes before linearized reading' (duration: 256.213437ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T03:47:22.533987Z","caller":"traceutil/trace.go:171","msg":"trace[448044402] transaction","detail":"{read_only:false; response_revision:572; number_of_response:1; }","duration":"111.787232ms","start":"2026-09-01T03:47:22.422168Z","end":"2026-09-01T03:47:22.533955Z","steps":["trace[448044402] 'process raft request' (duration: 57.893061ms)","trace[448044402] 'compare' (duration: 53.773459ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T03:47:22.536745Z","caller":"traceutil/trace.go:171","msg":"trace[747883904] transaction","detail":"{read_only:false; response_revision:573; number_of_response:1; }","duration":"104.308627ms","start":"2026-09-01T03:47:22.432428Z","end":"2026-09-01T03:47:22.536737Z","steps":["trace[747883904] 'process raft request' (duration: 104.062042ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T03:47:26.049805Z","caller":"traceutil/trace.go:171","msg":"trace[894186119] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"106.595185ms","start":"2026-09-01T03:47:25.943161Z","end":"2026-09-01T03:47:26.049756Z","steps":["trace[894186119] 'process raft request' (duration: 86.966144ms)","trace[894186119] 'compare' (duration: 19.458878ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T03:47:26.608255Z","caller":"traceutil/trace.go:171","msg":"trace[1273333276] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"141.619439ms","start":"2026-09-01T03:47:26.466598Z","end":"2026-09-01T03:47:26.608218Z","steps":["trace[1273333276] 'process raft request' (duration: 98.409831ms)","trace[1273333276] 'compare' (duration: 42.071113ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T03:47:27.312534Z","caller":"traceutil/trace.go:171","msg":"trace[1060511483] transaction","detail":"{read_only:false; response_revision:637; number_of_response:1; }","duration":"118.083005ms","start":"2026-09-01T03:47:27.194425Z","end":"2026-09-01T03:47:27.312508Z","steps":["trace[1060511483] 'process raft request' (duration: 116.398238ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T03:47:29.642549Z","caller":"traceutil/trace.go:171","msg":"trace[511340838] transaction","detail":"{read_only:false; response_revision:652; number_of_response:1; }","duration":"333.062458ms","start":"2026-09-01T03:47:29.309432Z","end":"2026-09-01T03:47:29.642494Z","steps":["trace[511340838] 'process raft request' (duration: 332.345333ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T03:47:29.64275Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T03:47:29.309402Z","time spent":"333.262012ms","remote":"127.0.0.1:49460","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036313,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-01T03:47:29.765595Z","caller":"traceutil/trace.go:171","msg":"trace[1081556253] transaction","detail":"{read_only:false; response_revision:654; number_of_response:1; }","duration":"114.675626ms","start":"2026-09-01T03:47:29.6509Z","end":"2026-09-01T03:47:29.765575Z","steps":["trace[1081556253] 'process raft request' (duration: 72.880079ms)","trace[1081556253] 'compare' (duration: 41.596663ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T03:47:30.32248Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17157483518426979170,"retry-timeout":"500ms"} {"level":"info","ts":"2026-09-01T03:47:30.433062Z","caller":"traceutil/trace.go:171","msg":"trace[1045800403] linearizableReadLoop","detail":"{readStateIndex:677; appliedIndex:676; }","duration":"610.592075ms","start":"2026-09-01T03:47:29.822432Z","end":"2026-09-01T03:47:30.433024Z","steps":["trace[1045800403] 'read index received' (duration: 569.696183ms)","trace[1045800403] 'applied index is now lower than readState.Index' (duration: 40.894562ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T03:47:30.433105Z","caller":"traceutil/trace.go:171","msg":"trace[38055480] transaction","detail":"{read_only:false; response_revision:656; number_of_response:1; }","duration":"650.851729ms","start":"2026-09-01T03:47:29.782217Z","end":"2026-09-01T03:47:30.433068Z","steps":["trace[38055480] 'process raft request' (duration: 610.006537ms)","trace[38055480] 'compare' (duration: 40.384402ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T03:47:30.433446Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"610.85314ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/job-controller\" ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-09-01T03:47:30.433799Z","caller":"traceutil/trace.go:171","msg":"trace[1677947296] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/job-controller; range_end:; response_count:1; response_revision:656; }","duration":"611.36781ms","start":"2026-09-01T03:47:29.822395Z","end":"2026-09-01T03:47:30.433763Z","steps":["trace[1677947296] 'agreement among raft nodes before linearized reading' (duration: 610.788948ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T03:47:30.433882Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T03:47:29.822381Z","time spent":"611.473533ms","remote":"127.0.0.1:49548","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":216,"request content":"key:\"/registry/serviceaccounts/kube-system/job-controller\" "} {"level":"warn","ts":"2026-09-01T03:47:30.434032Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T03:47:29.782185Z","time spent":"651.41173ms","remote":"127.0.0.1:49524","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-01T03:47:46.678942Z","caller":"traceutil/trace.go:171","msg":"trace[330814064] transaction","detail":"{read_only:false; response_revision:822; number_of_response:1; }","duration":"103.148098ms","start":"2026-09-01T03:47:46.575765Z","end":"2026-09-01T03:47:46.678913Z","steps":["trace[330814064] 'process raft request' (duration: 102.601638ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T03:47:58.770847Z","caller":"traceutil/trace.go:171","msg":"trace[1378287842] transaction","detail":"{read_only:false; response_revision:957; number_of_response:1; }","duration":"122.9615ms","start":"2026-09-01T03:47:58.647861Z","end":"2026-09-01T03:47:58.770823Z","steps":["trace[1378287842] 'process raft request' (duration: 122.809047ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T03:47:59.08652Z","caller":"traceutil/trace.go:171","msg":"trace[257571075] transaction","detail":"{read_only:false; response_revision:972; number_of_response:1; }","duration":"101.103861ms","start":"2026-09-01T03:47:58.985387Z","end":"2026-09-01T03:47:59.08649Z","steps":["trace[257571075] 'process raft request' (duration: 100.910238ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T03:49:11.467465Z","caller":"traceutil/trace.go:171","msg":"trace[544759201] transaction","detail":"{read_only:false; response_revision:1234; number_of_response:1; }","duration":"128.736767ms","start":"2026-09-01T03:49:11.3387Z","end":"2026-09-01T03:49:11.467437Z","steps":["trace[544759201] 'process raft request' (duration: 115.488442ms)","trace[544759201] 'compare' (duration: 13.123253ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T03:49:45.655467Z","caller":"traceutil/trace.go:171","msg":"trace[1894107267] transaction","detail":"{read_only:false; response_revision:1384; number_of_response:1; }","duration":"100.478762ms","start":"2026-09-01T03:49:45.554941Z","end":"2026-09-01T03:49:45.65542Z","steps":["trace[1894107267] 'process raft request' (duration: 62.029438ms)","trace[1894107267] 'compare' (duration: 38.303812ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T03:50:17.959114Z","caller":"traceutil/trace.go:171","msg":"trace[153473104] transaction","detail":"{read_only:false; response_revision:1493; number_of_response:1; }","duration":"143.687383ms","start":"2026-09-01T03:50:17.8154Z","end":"2026-09-01T03:50:17.959087Z","steps":["trace[153473104] 'process raft request' (duration: 143.522215ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T03:50:17.975554Z","caller":"traceutil/trace.go:171","msg":"trace[1458024407] linearizableReadLoop","detail":"{readStateIndex:1555; appliedIndex:1553; }","duration":"125.191106ms","start":"2026-09-01T03:50:17.850339Z","end":"2026-09-01T03:50:17.97553Z","steps":["trace[1458024407] 'read index received' (duration: 108.648227ms)","trace[1458024407] 'applied index is now lower than readState.Index' (duration: 16.541969ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T03:50:17.975607Z","caller":"traceutil/trace.go:171","msg":"trace[112921805] transaction","detail":"{read_only:false; response_revision:1494; number_of_response:1; }","duration":"136.086632ms","start":"2026-09-01T03:50:17.839498Z","end":"2026-09-01T03:50:17.975585Z","steps":["trace[112921805] 'process raft request' (duration: 135.888692ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T03:50:17.9758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.443088ms","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-01T03:50:17.975864Z","caller":"traceutil/trace.go:171","msg":"trace[1182208753] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1494; }","duration":"125.543004ms","start":"2026-09-01T03:50:17.850304Z","end":"2026-09-01T03:50:17.975847Z","steps":["trace[1182208753] 'agreement among raft nodes before linearized reading' (duration: 125.356205ms)"],"step_count":1}