{"level":"warn","ts":"2026-09-18T15:16:15.133522Z","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-18T15:16:15.133621Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.174: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.174:2380","--initial-cluster=instance=https://162.253.55.174:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.174:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.174: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-18T15:16:15.133719Z","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-18T15:16:15.133732Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.174:2380"]} {"level":"info","ts":"2026-09-18T15:16:15.133759Z","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-18T15:16:15.134682Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.174:2379"]} {"level":"info","ts":"2026-09-18T15:16:15.134812Z","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.174:2380"],"listen-peer-urls":["https://162.253.55.174:2380"],"advertise-client-urls":["https://162.253.55.174:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.174:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.174: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-18T15:16:15.143045Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"7.066176ms"} {"level":"info","ts":"2026-09-18T15:16:15.169325Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"757b052826ed9e87","cluster-id":"6c32c51160b3149f"} {"level":"info","ts":"2026-09-18T15:16:15.169419Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"757b052826ed9e87 switched to configuration voters=()"} {"level":"info","ts":"2026-09-18T15:16:15.169446Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"757b052826ed9e87 became follower at term 0"} {"level":"info","ts":"2026-09-18T15:16:15.169462Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 757b052826ed9e87 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-18T15:16:15.169475Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"757b052826ed9e87 became follower at term 1"} {"level":"info","ts":"2026-09-18T15:16:15.169671Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"757b052826ed9e87 switched to configuration voters=(8465365594582916743)"} {"level":"warn","ts":"2026-09-18T15:16:15.178491Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-18T15:16:15.179941Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-18T15:16:15.18156Z","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-18T15:16:15.183806Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"757b052826ed9e87","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-18T15:16:15.184099Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"757b052826ed9e87","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-18T15:16:15.184289Z","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-18T15:16:15.184376Z","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-18T15:16:15.184389Z","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-18T15:16:15.19109Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"757b052826ed9e87 switched to configuration voters=(8465365594582916743)"} {"level":"info","ts":"2026-09-18T15:16:15.191255Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"6c32c51160b3149f","local-member-id":"757b052826ed9e87","added-peer-id":"757b052826ed9e87","added-peer-peer-urls":["https://162.253.55.174:2380"]} {"level":"info","ts":"2026-09-18T15:16:15.191872Z","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-18T15:16:15.191942Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.174:2380"} {"level":"info","ts":"2026-09-18T15:16:15.192517Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"757b052826ed9e87","initial-advertise-peer-urls":["https://162.253.55.174:2380"],"listen-peer-urls":["https://162.253.55.174:2380"],"advertise-client-urls":["https://162.253.55.174:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.174:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-18T15:16:15.19257Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-18T15:16:15.192008Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.174:2380"} {"level":"info","ts":"2026-09-18T15:16:15.570308Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"757b052826ed9e87 is starting a new election at term 1"} {"level":"info","ts":"2026-09-18T15:16:15.57037Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"757b052826ed9e87 became pre-candidate at term 1"} {"level":"info","ts":"2026-09-18T15:16:15.570397Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"757b052826ed9e87 received MsgPreVoteResp from 757b052826ed9e87 at term 1"} {"level":"info","ts":"2026-09-18T15:16:15.570411Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"757b052826ed9e87 became candidate at term 2"} {"level":"info","ts":"2026-09-18T15:16:15.570418Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"757b052826ed9e87 received MsgVoteResp from 757b052826ed9e87 at term 2"} {"level":"info","ts":"2026-09-18T15:16:15.570429Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"757b052826ed9e87 became leader at term 2"} {"level":"info","ts":"2026-09-18T15:16:15.570438Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 757b052826ed9e87 elected leader 757b052826ed9e87 at term 2"} {"level":"info","ts":"2026-09-18T15:16:15.57163Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"757b052826ed9e87","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.174:2379]}","request-path":"/0/members/757b052826ed9e87/attributes","cluster-id":"6c32c51160b3149f","publish-timeout":"7s"} {"level":"info","ts":"2026-09-18T15:16:15.571659Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-18T15:16:15.571703Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-18T15:16:15.571813Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-18T15:16:15.572808Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"6c32c51160b3149f","local-member-id":"757b052826ed9e87","cluster-version":"3.5"} {"level":"info","ts":"2026-09-18T15:16:15.572966Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-18T15:16:15.573032Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-18T15:16:15.572998Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-18T15:16:15.573054Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-18T15:16:15.573745Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.174:2379"} {"level":"info","ts":"2026-09-18T15:16:15.57722Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-09-18T15:16:24.306331Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.388969ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" ","response":"range_response_count:1 size:197"} {"level":"info","ts":"2026-09-18T15:16:24.306416Z","caller":"traceutil/trace.go:171","msg":"trace[1245854824] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/bootstrap-signer; range_end:; response_count:1; response_revision:302; }","duration":"115.547823ms","start":"2026-09-18T15:16:24.190843Z","end":"2026-09-18T15:16:24.306391Z","steps":["trace[1245854824] 'range keys from in-memory index tree' (duration: 115.261974ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:16:24.613753Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.48527ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-09-18T15:16:24.613888Z","caller":"traceutil/trace.go:171","msg":"trace[1769389426] linearizableReadLoop","detail":"{readStateIndex:315; appliedIndex:314; }","duration":"223.586336ms","start":"2026-09-18T15:16:24.390286Z","end":"2026-09-18T15:16:24.613872Z","steps":["trace[1769389426] 'read index received' (duration: 57.492707ms)","trace[1769389426] 'applied index is now lower than readState.Index' (duration: 166.092209ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T15:16:24.613991Z","caller":"traceutil/trace.go:171","msg":"trace[478291192] transaction","detail":"{read_only:false; response_revision:304; number_of_response:1; }","duration":"256.094531ms","start":"2026-09-18T15:16:24.357803Z","end":"2026-09-18T15:16:24.613898Z","steps":["trace[478291192] 'process raft request' (duration: 90.025773ms)","trace[478291192] 'compare' (duration: 165.322824ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T15:16:24.614171Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.650701ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/root-ca-cert-publisher\" ","response":"range_response_count:1 size:209"} {"level":"warn","ts":"2026-09-18T15:16:24.61421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.1979ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" ","response":"range_response_count:1 size:214"} {"level":"info","ts":"2026-09-18T15:16:24.614278Z","caller":"traceutil/trace.go:171","msg":"trace[931185321] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslice-controller; range_end:; response_count:1; response_revision:304; }","duration":"123.291253ms","start":"2026-09-18T15:16:24.490973Z","end":"2026-09-18T15:16:24.614265Z","steps":["trace[931185321] 'agreement among raft nodes before linearized reading' (duration: 123.178419ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:16:24.614346Z","caller":"traceutil/trace.go:171","msg":"trace[563288757] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/root-ca-cert-publisher; range_end:; response_count:1; response_revision:304; }","duration":"173.848827ms","start":"2026-09-18T15:16:24.440407Z","end":"2026-09-18T15:16:24.614256Z","steps":["trace[563288757] 'agreement among raft nodes before linearized reading' (duration: 173.589979ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:16:24.614072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.775022ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-09-18T15:16:24.614478Z","caller":"traceutil/trace.go:171","msg":"trace[432519092] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/certificate-controller; range_end:; response_count:1; response_revision:304; }","duration":"224.227426ms","start":"2026-09-18T15:16:24.39024Z","end":"2026-09-18T15:16:24.614468Z","steps":["trace[432519092] 'agreement among raft nodes before linearized reading' (duration: 223.72918ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:16:25.264317Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.154963ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-09-18T15:16:25.264726Z","caller":"traceutil/trace.go:171","msg":"trace[1943705737] transaction","detail":"{read_only:false; response_revision:307; number_of_response:1; }","duration":"642.337473ms","start":"2026-09-18T15:16:24.622357Z","end":"2026-09-18T15:16:25.264695Z","steps":["trace[1943705737] 'process raft request' (duration: 642.082785ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:16:25.264839Z","caller":"traceutil/trace.go:171","msg":"trace[875004926] transaction","detail":"{read_only:false; response_revision:308; number_of_response:1; }","duration":"642.164318ms","start":"2026-09-18T15:16:24.622634Z","end":"2026-09-18T15:16:25.264798Z","steps":["trace[875004926] 'process raft request' (duration: 641.92056ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:16:25.264923Z","caller":"traceutil/trace.go:171","msg":"trace[1006314395] transaction","detail":"{read_only:false; response_revision:309; number_of_response:1; }","duration":"642.193709ms","start":"2026-09-18T15:16:24.622671Z","end":"2026-09-18T15:16:25.264864Z","steps":["trace[1006314395] 'process raft request' (duration: 641.974092ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:16:25.264967Z","caller":"traceutil/trace.go:171","msg":"trace[474976941] transaction","detail":"{read_only:false; response_revision:310; number_of_response:1; }","duration":"639.903035ms","start":"2026-09-18T15:16:24.62504Z","end":"2026-09-18T15:16:25.264943Z","steps":["trace[474976941] 'process raft request' (duration: 639.720849ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:16:25.264953Z","caller":"traceutil/trace.go:171","msg":"trace[1320223892] linearizableReadLoop","detail":"{readStateIndex:322; appliedIndex:315; }","duration":"624.029254ms","start":"2026-09-18T15:16:24.640831Z","end":"2026-09-18T15:16:25.26486Z","steps":["trace[1320223892] 'read index received' (duration: 10.368634ms)","trace[1320223892] 'applied index is now lower than readState.Index' (duration: 613.65959ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T15:16:25.265012Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:16:24.622617Z","time spent":"642.285642ms","remote":"127.0.0.1:51320","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1723,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-18T15:16:25.265263Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"624.420007ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" ","response":"range_response_count:1 size:234"} {"level":"warn","ts":"2026-09-18T15:16:25.265322Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"573.959775ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" ","response":"range_response_count:1 size:197"} {"level":"info","ts":"2026-09-18T15:16:25.265312Z","caller":"traceutil/trace.go:171","msg":"trace[1740984275] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller; range_end:; response_count:1; response_revision:311; }","duration":"624.50102ms","start":"2026-09-18T15:16:24.640798Z","end":"2026-09-18T15:16:25.265299Z","steps":["trace[1740984275] 'agreement among raft nodes before linearized reading' (duration: 624.386737ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:16:25.265362Z","caller":"traceutil/trace.go:171","msg":"trace[786139082] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/bootstrap-signer; range_end:; response_count:1; response_revision:311; }","duration":"574.042698ms","start":"2026-09-18T15:16:24.691309Z","end":"2026-09-18T15:16:25.265351Z","steps":["trace[786139082] 'agreement among raft nodes before linearized reading' (duration: 573.967845ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:16:25.265377Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:16:24.640782Z","time spent":"624.584062ms","remote":"127.0.0.1:51454","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":256,"request content":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" "} {"level":"warn","ts":"2026-09-18T15:16:25.265386Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:16:24.691286Z","time spent":"574.09339ms","remote":"127.0.0.1:51454","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":219,"request content":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" "} {"level":"info","ts":"2026-09-18T15:16:25.26545Z","caller":"traceutil/trace.go:171","msg":"trace[1080296026] transaction","detail":"{read_only:false; response_revision:311; number_of_response:1; }","duration":"638.484049ms","start":"2026-09-18T15:16:24.626948Z","end":"2026-09-18T15:16:25.265433Z","steps":["trace[1080296026] 'process raft request' (duration: 637.85977ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:16:25.265563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.801796ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"warn","ts":"2026-09-18T15:16:25.265556Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:16:24.626932Z","time spent":"638.566371ms","remote":"127.0.0.1:51422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4355,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-18T15:16:25.265513Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:16:24.625024Z","time spent":"639.994337ms","remote":"127.0.0.1:51494","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1251,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-18T15:16:25.265592Z","caller":"traceutil/trace.go:171","msg":"trace[681939016] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:311; }","duration":"199.873399ms","start":"2026-09-18T15:16:25.065711Z","end":"2026-09-18T15:16:25.265585Z","steps":["trace[681939016] 'agreement among raft nodes before linearized reading' (duration: 199.823758ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:16:25.265607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"525.494097ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-09-18T15:16:25.265717Z","caller":"traceutil/trace.go:171","msg":"trace[1000531959] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replicaset-controller; range_end:; response_count:1; response_revision:311; }","duration":"525.652693ms","start":"2026-09-18T15:16:24.740051Z","end":"2026-09-18T15:16:25.265703Z","steps":["trace[1000531959] 'agreement among raft nodes before linearized reading' (duration: 525.450536ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:16:25.265773Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:16:24.622651Z","time spent":"642.361184ms","remote":"127.0.0.1:51654","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3691,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-18T15:16:25.265792Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:16:24.740028Z","time spent":"525.749326ms","remote":"127.0.0.1:51454","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":229,"request content":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" "} {"level":"warn","ts":"2026-09-18T15:16:25.264819Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:16:24.622337Z","time spent":"642.442437ms","remote":"127.0.0.1:51672","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2150,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-18T15:16:25.266197Z","caller":"traceutil/trace.go:171","msg":"trace[1255817408] transaction","detail":"{read_only:false; response_revision:306; number_of_response:1; }","duration":"646.018532ms","start":"2026-09-18T15:16:24.620029Z","end":"2026-09-18T15:16:25.266047Z","steps":["trace[1255817408] 'process raft request' (duration: 543.039119ms)","trace[1255817408] 'compare' (duration: 100.921276ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T15:16:25.266458Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:16:24.620002Z","time spent":"646.384913ms","remote":"127.0.0.1:51510","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1050,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-18T15:16:25.828238Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.812422ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-18T15:16:25.828312Z","caller":"traceutil/trace.go:171","msg":"trace[1902163888] linearizableReadLoop","detail":"{readStateIndex:323; appliedIndex:322; }","duration":"555.654136ms","start":"2026-09-18T15:16:25.272644Z","end":"2026-09-18T15:16:25.828299Z","steps":["trace[1902163888] 'read index received' (duration: 293.704689ms)","trace[1902163888] 'applied index is now lower than readState.Index' (duration: 261.948467ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T15:16:25.828375Z","caller":"traceutil/trace.go:171","msg":"trace[1846970825] transaction","detail":"{read_only:false; response_revision:312; number_of_response:1; }","duration":"556.11608ms","start":"2026-09-18T15:16:25.272252Z","end":"2026-09-18T15:16:25.828368Z","steps":["trace[1846970825] 'process raft request' (duration: 294.116032ms)","trace[1846970825] 'compare' (duration: 261.74174ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T15:16:25.828456Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:16:25.272219Z","time spent":"556.210953ms","remote":"127.0.0.1:51506","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-18T15:16:25.828483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"555.830211ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-09-18T15:16:25.829258Z","caller":"traceutil/trace.go:171","msg":"trace[1287298056] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replicaset-controller; range_end:; response_count:1; response_revision:312; }","duration":"556.602046ms","start":"2026-09-18T15:16:25.272637Z","end":"2026-09-18T15:16:25.829239Z","steps":["trace[1287298056] 'agreement among raft nodes before linearized reading' (duration: 555.804651ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:16:25.829392Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:16:25.27259Z","time spent":"556.783773ms","remote":"127.0.0.1:51454","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":229,"request content":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" "} {"level":"info","ts":"2026-09-18T15:16:25.832607Z","caller":"traceutil/trace.go:171","msg":"trace[296867400] transaction","detail":"{read_only:false; response_revision:315; number_of_response:1; }","duration":"556.482422ms","start":"2026-09-18T15:16:25.276115Z","end":"2026-09-18T15:16:25.832597Z","steps":["trace[296867400] 'process raft request' (duration: 556.42417ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:16:25.832668Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:16:25.2761Z","time spent":"556.539153ms","remote":"127.0.0.1:51320","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2163,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-18T15:16:25.832702Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"557.68417ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/coredns\" ","response":"range_response_count:1 size:3706"} {"level":"info","ts":"2026-09-18T15:16:25.832695Z","caller":"traceutil/trace.go:171","msg":"trace[2001224304] transaction","detail":"{read_only:false; response_revision:313; number_of_response:1; }","duration":"559.593061ms","start":"2026-09-18T15:16:25.273083Z","end":"2026-09-18T15:16:25.832676Z","steps":["trace[2001224304] 'process raft request' (duration: 559.364964ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:16:25.832726Z","caller":"traceutil/trace.go:171","msg":"trace[133965932] range","detail":"{range_begin:/registry/deployments/kube-system/coredns; range_end:; response_count:1; response_revision:319; }","duration":"557.708962ms","start":"2026-09-18T15:16:25.27501Z","end":"2026-09-18T15:16:25.832719Z","steps":["trace[133965932] 'agreement among raft nodes before linearized reading' (duration: 557.65452ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:16:25.832783Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:16:25.274977Z","time spent":"557.798944ms","remote":"127.0.0.1:51654","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":3728,"request content":"key:\"/registry/deployments/kube-system/coredns\" "} {"level":"warn","ts":"2026-09-18T15:16:25.832783Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:16:25.273064Z","time spent":"559.675143ms","remote":"127.0.0.1:51432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3378,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-18T15:16:25.832838Z","caller":"traceutil/trace.go:171","msg":"trace[1693525144] transaction","detail":"{read_only:false; response_revision:314; number_of_response:1; }","duration":"559.700195ms","start":"2026-09-18T15:16:25.27311Z","end":"2026-09-18T15:16:25.832811Z","steps":["trace[1693525144] 'process raft request' (duration: 559.400145ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:16:25.832884Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:16:25.273089Z","time spent":"559.775197ms","remote":"127.0.0.1:51320","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1739,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-18T15:16:25.832957Z","caller":"traceutil/trace.go:171","msg":"trace[1932629275] transaction","detail":"{read_only:false; response_revision:319; number_of_response:1; }","duration":"552.452034ms","start":"2026-09-18T15:16:25.280495Z","end":"2026-09-18T15:16:25.832947Z","steps":["trace[1932629275] 'process raft request' (duration: 552.142733ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:16:25.832825Z","caller":"traceutil/trace.go:171","msg":"trace[1672190480] transaction","detail":"{read_only:false; response_revision:318; number_of_response:1; }","duration":"553.198807ms","start":"2026-09-18T15:16:25.279603Z","end":"2026-09-18T15:16:25.832802Z","steps":["trace[1672190480] 'process raft request' (duration: 553.012661ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:16:25.833027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"364.055181ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-09-18T15:16:25.833031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.541667ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-09-18T15:16:25.833068Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:16:25.279585Z","time spent":"553.459637ms","remote":"127.0.0.1:51566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2094,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-18T15:16:25.833099Z","caller":"traceutil/trace.go:171","msg":"trace[833289654] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:319; }","duration":"316.65926ms","start":"2026-09-18T15:16:25.516424Z","end":"2026-09-18T15:16:25.833083Z","steps":["trace[833289654] 'agreement among raft nodes before linearized reading' (duration: 316.539926ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:16:25.833136Z","caller":"traceutil/trace.go:171","msg":"trace[1957426613] transaction","detail":"{read_only:false; response_revision:316; number_of_response:1; }","duration":"555.519851ms","start":"2026-09-18T15:16:25.277608Z","end":"2026-09-18T15:16:25.833128Z","steps":["trace[1957426613] 'process raft request' (duration: 554.954903ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:16:25.833149Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:16:25.516402Z","time spent":"316.734983ms","remote":"127.0.0.1:51506","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-09-18T15:16:25.83306Z","caller":"traceutil/trace.go:171","msg":"trace[1832163557] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:319; }","duration":"364.205405ms","start":"2026-09-18T15:16:25.468847Z","end":"2026-09-18T15:16:25.833053Z","steps":["trace[1832163557] 'agreement among raft nodes before linearized reading' (duration: 364.128463ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:16:25.833188Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:16:25.277593Z","time spent":"555.560433ms","remote":"127.0.0.1:51494","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2263,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-18T15:16:25.833208Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:16:25.468814Z","time spent":"364.387821ms","remote":"127.0.0.1:51506","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-09-18T15:16:25.833033Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:16:25.280481Z","time spent":"552.501086ms","remote":"127.0.0.1:51566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2191,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-18T15:16:25.8333Z","caller":"traceutil/trace.go:171","msg":"trace[368025632] transaction","detail":"{read_only:false; response_revision:317; number_of_response:1; }","duration":"554.489839ms","start":"2026-09-18T15:16:25.278595Z","end":"2026-09-18T15:16:25.833085Z","steps":["trace[368025632] 'process raft request' (duration: 553.991163ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:16:25.833407Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:16:25.278549Z","time spent":"554.776748ms","remote":"127.0.0.1:51566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":899,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-18T15:16:40.637654Z","caller":"traceutil/trace.go:171","msg":"trace[1137291908] transaction","detail":"{read_only:false; response_revision:396; number_of_response:1; }","duration":"161.97346ms","start":"2026-09-18T15:16:40.475657Z","end":"2026-09-18T15:16:40.63763Z","steps":["trace[1137291908] 'process raft request' (duration: 161.923708ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:16:40.637691Z","caller":"traceutil/trace.go:171","msg":"trace[175791176] transaction","detail":"{read_only:false; response_revision:395; number_of_response:1; }","duration":"162.969478ms","start":"2026-09-18T15:16:40.474683Z","end":"2026-09-18T15:16:40.637652Z","steps":["trace[175791176] 'process raft request' (duration: 101.733361ms)","trace[175791176] 'compare' (duration: 61.027422ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T15:16:40.853343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.008104ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-18T15:16:40.85345Z","caller":"traceutil/trace.go:171","msg":"trace[1325098655] transaction","detail":"{read_only:false; response_revision:404; number_of_response:1; }","duration":"185.148784ms","start":"2026-09-18T15:16:40.668282Z","end":"2026-09-18T15:16:40.853431Z","steps":["trace[1325098655] 'process raft request' (duration: 80.941664ms)","trace[1325098655] 'compare' (duration: 103.776868ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T15:16:40.864196Z","caller":"traceutil/trace.go:171","msg":"trace[110992344] transaction","detail":"{read_only:false; response_revision:405; number_of_response:1; }","duration":"159.82179ms","start":"2026-09-18T15:16:40.704357Z","end":"2026-09-18T15:16:40.864179Z","steps":["trace[110992344] 'process raft request' (duration: 159.726217ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:16:51.383722Z","caller":"traceutil/trace.go:171","msg":"trace[2103492369] transaction","detail":"{read_only:false; response_revision:445; number_of_response:1; }","duration":"119.370768ms","start":"2026-09-18T15:16:51.264335Z","end":"2026-09-18T15:16:51.383705Z","steps":["trace[2103492369] 'process raft request' (duration: 119.241965ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:16:52.423706Z","caller":"traceutil/trace.go:171","msg":"trace[356865191] transaction","detail":"{read_only:false; response_revision:449; number_of_response:1; }","duration":"130.435013ms","start":"2026-09-18T15:16:52.293244Z","end":"2026-09-18T15:16:52.423679Z","steps":["trace[356865191] 'process raft request' (duration: 101.969607ms)","trace[356865191] 'compare' (duration: 28.373053ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T15:16:54.94726Z","caller":"traceutil/trace.go:171","msg":"trace[332050290] transaction","detail":"{read_only:false; response_revision:488; number_of_response:1; }","duration":"143.467919ms","start":"2026-09-18T15:16:54.803773Z","end":"2026-09-18T15:16:54.947241Z","steps":["trace[332050290] 'process raft request' (duration: 143.373857ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:16:55.086287Z","caller":"traceutil/trace.go:171","msg":"trace[843560501] transaction","detail":"{read_only:false; response_revision:489; number_of_response:1; }","duration":"280.007269ms","start":"2026-09-18T15:16:54.806255Z","end":"2026-09-18T15:16:55.086262Z","steps":["trace[843560501] 'process raft request' (duration: 279.69781ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:16:55.086451Z","caller":"traceutil/trace.go:171","msg":"trace[32511322] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"270.822385ms","start":"2026-09-18T15:16:54.815602Z","end":"2026-09-18T15:16:55.086425Z","steps":["trace[32511322] 'process raft request' (duration: 270.610359ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:16:55.086636Z","caller":"traceutil/trace.go:171","msg":"trace[773380300] transaction","detail":"{read_only:false; response_revision:490; number_of_response:1; }","duration":"279.920287ms","start":"2026-09-18T15:16:54.806707Z","end":"2026-09-18T15:16:55.086627Z","steps":["trace[773380300] 'process raft request' (duration: 279.437145ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:16:55.086682Z","caller":"traceutil/trace.go:171","msg":"trace[783372837] transaction","detail":"{read_only:false; response_revision:492; number_of_response:1; }","duration":"255.276738ms","start":"2026-09-18T15:16:54.831389Z","end":"2026-09-18T15:16:55.086666Z","steps":["trace[783372837] 'process raft request' (duration: 254.882428ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:16:55.086711Z","caller":"traceutil/trace.go:171","msg":"trace[419144789] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"237.015461ms","start":"2026-09-18T15:16:54.849678Z","end":"2026-09-18T15:16:55.086694Z","steps":["trace[419144789] 'process raft request' (duration: 236.746875ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:16:55.086716Z","caller":"traceutil/trace.go:171","msg":"trace[767481311] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"243.749484ms","start":"2026-09-18T15:16:54.842958Z","end":"2026-09-18T15:16:55.086708Z","steps":["trace[767481311] 'process raft request' (duration: 243.394225ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:16:55.086775Z","caller":"traceutil/trace.go:171","msg":"trace[1130590286] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"224.448011ms","start":"2026-09-18T15:16:54.862312Z","end":"2026-09-18T15:16:55.08676Z","steps":["trace[1130590286] 'process raft request' (duration: 224.171334ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:16:55.086797Z","caller":"traceutil/trace.go:171","msg":"trace[2027716992] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"218.014178ms","start":"2026-09-18T15:16:54.868777Z","end":"2026-09-18T15:16:55.086791Z","steps":["trace[2027716992] 'process raft request' (duration: 217.758631ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:16:55.086645Z","caller":"traceutil/trace.go:171","msg":"trace[911840862] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"251.708357ms","start":"2026-09-18T15:16:54.834924Z","end":"2026-09-18T15:16:55.086632Z","steps":["trace[911840862] 'process raft request' (duration: 251.389069ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:16:55.086807Z","caller":"traceutil/trace.go:171","msg":"trace[730711410] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"199.578968ms","start":"2026-09-18T15:16:54.887213Z","end":"2026-09-18T15:16:55.086791Z","steps":["trace[730711410] 'process raft request' (duration: 199.512466ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:16:55.104271Z","caller":"traceutil/trace.go:171","msg":"trace[1165155190] transaction","detail":"{read_only:false; response_revision:501; number_of_response:1; }","duration":"101.174133ms","start":"2026-09-18T15:16:55.003078Z","end":"2026-09-18T15:16:55.104252Z","steps":["trace[1165155190] 'process raft request' (duration: 101.02503ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:16:55.104563Z","caller":"traceutil/trace.go:171","msg":"trace[1457736136] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"152.270157ms","start":"2026-09-18T15:16:54.952282Z","end":"2026-09-18T15:16:55.104552Z","steps":["trace[1457736136] 'process raft request' (duration: 151.118387ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:16:55.106081Z","caller":"traceutil/trace.go:171","msg":"trace[662446455] transaction","detail":"{read_only:false; response_revision:500; number_of_response:1; }","duration":"153.160239ms","start":"2026-09-18T15:16:54.952887Z","end":"2026-09-18T15:16:55.106047Z","steps":["trace[662446455] 'process raft request' (duration: 151.128748ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:16:55.106398Z","caller":"traceutil/trace.go:171","msg":"trace[1545186643] transaction","detail":"{read_only:false; number_of_response:1; response_revision:500; }","duration":"152.576784ms","start":"2026-09-18T15:16:54.953811Z","end":"2026-09-18T15:16:55.106387Z","steps":["trace[1545186643] 'process raft request' (duration: 150.250445ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:16:55.470005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.210203ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-09-18T15:16:55.470154Z","caller":"traceutil/trace.go:171","msg":"trace[2043743923] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"260.837619ms","start":"2026-09-18T15:16:55.209302Z","end":"2026-09-18T15:16:55.47014Z","steps":["trace[2043743923] 'process raft request' (duration: 120.419801ms)","trace[2043743923] 'compare' (duration: 140.09254ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T15:16:55.470726Z","caller":"traceutil/trace.go:171","msg":"trace[2085329860] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"217.04765ms","start":"2026-09-18T15:16:55.253652Z","end":"2026-09-18T15:16:55.470699Z","steps":["trace[2085329860] 'process raft request' (duration: 216.818384ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:16:55.471171Z","caller":"traceutil/trace.go:171","msg":"trace[1634172622] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"190.956519ms","start":"2026-09-18T15:16:55.280201Z","end":"2026-09-18T15:16:55.471157Z","steps":["trace[1634172622] 'process raft request' (duration: 190.818925ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:16:55.471182Z","caller":"traceutil/trace.go:171","msg":"trace[1868105911] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"211.941951ms","start":"2026-09-18T15:16:55.25922Z","end":"2026-09-18T15:16:55.471162Z","steps":["trace[1868105911] 'process raft request' (duration: 211.429968ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:17:00.724412Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.751408ms","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-18T15:17:00.72452Z","caller":"traceutil/trace.go:171","msg":"trace[1869054810] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:587; }","duration":"270.892473ms","start":"2026-09-18T15:17:00.453603Z","end":"2026-09-18T15:17:00.724496Z","steps":["trace[1869054810] 'range keys from in-memory index tree' (duration: 270.677706ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:17:00.724447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.947157ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T15:17:00.724587Z","caller":"traceutil/trace.go:171","msg":"trace[929554599] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:587; }","duration":"283.132253ms","start":"2026-09-18T15:17:00.441438Z","end":"2026-09-18T15:17:00.724571Z","steps":["trace[929554599] 'range keys from in-memory index tree' (duration: 282.858196ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:17:00.74436Z","caller":"traceutil/trace.go:171","msg":"trace[1920744868] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"133.749119ms","start":"2026-09-18T15:17:00.61058Z","end":"2026-09-18T15:17:00.74433Z","steps":["trace[1920744868] 'process raft request' (duration: 133.229066ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:17:01.881345Z","caller":"traceutil/trace.go:171","msg":"trace[2096568586] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"189.320183ms","start":"2026-09-18T15:17:01.691997Z","end":"2026-09-18T15:17:01.881317Z","steps":["trace[2096568586] 'process raft request' (duration: 185.003098ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:17:01.906499Z","caller":"traceutil/trace.go:171","msg":"trace[960899129] transaction","detail":"{read_only:false; response_revision:598; number_of_response:1; }","duration":"122.952966ms","start":"2026-09-18T15:17:01.783522Z","end":"2026-09-18T15:17:01.906475Z","steps":["trace[960899129] 'process raft request' (duration: 122.833384ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:17:02.530177Z","caller":"traceutil/trace.go:171","msg":"trace[84668812] linearizableReadLoop","detail":"{readStateIndex:624; appliedIndex:623; }","duration":"351.720015ms","start":"2026-09-18T15:17:02.178428Z","end":"2026-09-18T15:17:02.530148Z","steps":["trace[84668812] 'read index received' (duration: 306.799677ms)","trace[84668812] 'applied index is now lower than readState.Index' (duration: 44.919218ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T15:17:02.530513Z","caller":"traceutil/trace.go:171","msg":"trace[636509831] transaction","detail":"{read_only:false; response_revision:599; number_of_response:1; }","duration":"568.203383ms","start":"2026-09-18T15:17:01.962277Z","end":"2026-09-18T15:17:02.53048Z","steps":["trace[636509831] 'process raft request' (duration: 522.916686ms)","trace[636509831] 'compare' (duration: 44.764164ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T15:17:02.530545Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.907828ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-09-18T15:17:02.530648Z","caller":"traceutil/trace.go:171","msg":"trace[1211879349] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:599; }","duration":"309.031631ms","start":"2026-09-18T15:17:02.221575Z","end":"2026-09-18T15:17:02.530607Z","steps":["trace[1211879349] 'agreement among raft nodes before linearized reading' (duration: 308.825016ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:17:02.530674Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:17:01.962253Z","time spent":"568.355636ms","remote":"127.0.0.1:51480","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-18T15:17:02.53091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.95051ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-09-18T15:17:02.53092Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:17:02.221553Z","time spent":"309.129174ms","remote":"127.0.0.1:51506","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-09-18T15:17:02.531009Z","caller":"traceutil/trace.go:171","msg":"trace[629995169] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:599; }","duration":"157.038152ms","start":"2026-09-18T15:17:02.373911Z","end":"2026-09-18T15:17:02.530949Z","steps":["trace[629995169] 'agreement among raft nodes before linearized reading' (duration: 156.893738ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:17:02.531042Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"352.609876ms","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-18T15:17:02.531126Z","caller":"traceutil/trace.go:171","msg":"trace[2104203842] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:599; }","duration":"352.74251ms","start":"2026-09-18T15:17:02.178365Z","end":"2026-09-18T15:17:02.531108Z","steps":["trace[2104203842] 'agreement among raft nodes before linearized reading' (duration: 351.96324ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:17:02.531155Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:17:02.178342Z","time spent":"352.804691ms","remote":"127.0.0.1:51506","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":499,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-09-18T15:17:03.950886Z","caller":"traceutil/trace.go:171","msg":"trace[1078008958] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"151.250068ms","start":"2026-09-18T15:17:03.799603Z","end":"2026-09-18T15:17:03.950853Z","steps":["trace[1078008958] 'process raft request' (duration: 150.953511ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:17:03.96725Z","caller":"traceutil/trace.go:171","msg":"trace[1533228519] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"167.288625ms","start":"2026-09-18T15:17:03.799925Z","end":"2026-09-18T15:17:03.967214Z","steps":["trace[1533228519] 'process raft request' (duration: 167.08826ms)"],"step_count":1}