{"level":"warn","ts":"2026-09-19T00:55:27.852719Z","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-19T00:55:27.852816Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.19: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.19:2380","--initial-cluster=instance=https://162.253.55.19:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.19:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.19: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-19T00:55:27.852937Z","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-19T00:55:27.852951Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.19:2380"]} {"level":"info","ts":"2026-09-19T00:55:27.852969Z","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-19T00:55:27.853586Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.19:2379"]} {"level":"info","ts":"2026-09-19T00:55:27.853677Z","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.19:2380"],"listen-peer-urls":["https://162.253.55.19:2380"],"advertise-client-urls":["https://162.253.55.19:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.19:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.19: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-19T00:55:27.85842Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.525776ms"} {"level":"info","ts":"2026-09-19T00:55:27.864584Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"ded76e421897a43d","cluster-id":"8853d1107d87769b"} {"level":"info","ts":"2026-09-19T00:55:27.864665Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ded76e421897a43d switched to configuration voters=()"} {"level":"info","ts":"2026-09-19T00:55:27.864682Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ded76e421897a43d became follower at term 0"} {"level":"info","ts":"2026-09-19T00:55:27.864689Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft ded76e421897a43d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-19T00:55:27.864699Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ded76e421897a43d became follower at term 1"} {"level":"info","ts":"2026-09-19T00:55:27.864772Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ded76e421897a43d switched to configuration voters=(16057424226572280893)"} {"level":"warn","ts":"2026-09-19T00:55:27.872169Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-19T00:55:27.8736Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-19T00:55:27.874867Z","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-19T00:55:27.879205Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"ded76e421897a43d","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-19T00:55:27.879369Z","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-19T00:55:27.879464Z","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-19T00:55:27.879472Z","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-19T00:55:27.879714Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"ded76e421897a43d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-19T00:55:27.880683Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ded76e421897a43d switched to configuration voters=(16057424226572280893)"} {"level":"info","ts":"2026-09-19T00:55:27.881366Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"8853d1107d87769b","local-member-id":"ded76e421897a43d","added-peer-id":"ded76e421897a43d","added-peer-peer-urls":["https://162.253.55.19:2380"]} {"level":"info","ts":"2026-09-19T00:55:27.882564Z","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-19T00:55:27.882696Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.19:2380"} {"level":"info","ts":"2026-09-19T00:55:27.882744Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.19:2380"} {"level":"info","ts":"2026-09-19T00:55:27.882949Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"ded76e421897a43d","initial-advertise-peer-urls":["https://162.253.55.19:2380"],"listen-peer-urls":["https://162.253.55.19:2380"],"advertise-client-urls":["https://162.253.55.19:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.19:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-19T00:55:27.882997Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-19T00:55:28.065211Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ded76e421897a43d is starting a new election at term 1"} {"level":"info","ts":"2026-09-19T00:55:28.065269Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ded76e421897a43d became pre-candidate at term 1"} {"level":"info","ts":"2026-09-19T00:55:28.065304Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ded76e421897a43d received MsgPreVoteResp from ded76e421897a43d at term 1"} {"level":"info","ts":"2026-09-19T00:55:28.06533Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ded76e421897a43d became candidate at term 2"} {"level":"info","ts":"2026-09-19T00:55:28.065341Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ded76e421897a43d received MsgVoteResp from ded76e421897a43d at term 2"} {"level":"info","ts":"2026-09-19T00:55:28.065449Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ded76e421897a43d became leader at term 2"} {"level":"info","ts":"2026-09-19T00:55:28.065464Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: ded76e421897a43d elected leader ded76e421897a43d at term 2"} {"level":"info","ts":"2026-09-19T00:55:28.068467Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-19T00:55:28.069352Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"ded76e421897a43d","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.19:2379]}","request-path":"/0/members/ded76e421897a43d/attributes","cluster-id":"8853d1107d87769b","publish-timeout":"7s"} {"level":"info","ts":"2026-09-19T00:55:28.069469Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-19T00:55:28.069556Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-19T00:55:28.069793Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-19T00:55:28.069818Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-19T00:55:28.069995Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"8853d1107d87769b","local-member-id":"ded76e421897a43d","cluster-version":"3.5"} {"level":"info","ts":"2026-09-19T00:55:28.070114Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-19T00:55:28.07015Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-19T00:55:28.07358Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.19:2379"} {"level":"info","ts":"2026-09-19T00:55:28.073694Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-19T00:55:37.89597Z","caller":"traceutil/trace.go:171","msg":"trace[225184369] transaction","detail":"{read_only:false; response_revision:345; number_of_response:1; }","duration":"168.811299ms","start":"2026-09-19T00:55:37.727131Z","end":"2026-09-19T00:55:37.895942Z","steps":["trace[225184369] 'process raft request' (duration: 168.664645ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T00:55:38.278111Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.549273ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-19T00:55:38.27822Z","caller":"traceutil/trace.go:171","msg":"trace[1415870005] linearizableReadLoop","detail":"{readStateIndex:359; appliedIndex:357; }","duration":"509.013947ms","start":"2026-09-19T00:55:37.769193Z","end":"2026-09-19T00:55:38.278207Z","steps":["trace[1415870005] 'read index received' (duration: 126.665112ms)","trace[1415870005] 'applied index is now lower than readState.Index' (duration: 382.347985ms)"],"step_count":2} {"level":"warn","ts":"2026-09-19T00:55:38.278328Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"465.735893ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-node-lease/instance\" ","response":"range_response_count:1 size:535"} {"level":"info","ts":"2026-09-19T00:55:38.278353Z","caller":"traceutil/trace.go:171","msg":"trace[2030780312] range","detail":"{range_begin:/registry/leases/kube-node-lease/instance; range_end:; response_count:1; response_revision:346; }","duration":"465.791975ms","start":"2026-09-19T00:55:37.812553Z","end":"2026-09-19T00:55:38.278345Z","steps":["trace[2030780312] 'agreement among raft nodes before linearized reading' (duration: 465.740874ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T00:55:38.278306Z","caller":"traceutil/trace.go:171","msg":"trace[916660687] transaction","detail":"{read_only:false; response_revision:346; number_of_response:1; }","duration":"546.495153ms","start":"2026-09-19T00:55:37.731761Z","end":"2026-09-19T00:55:38.278256Z","steps":["trace[916660687] 'process raft request' (duration: 382.232698ms)","trace[916660687] 'compare' (duration: 163.421119ms)"],"step_count":2} {"level":"warn","ts":"2026-09-19T00:55:38.278382Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T00:55:37.812531Z","time spent":"465.845167ms","remote":"127.0.0.1:50014","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":559,"request content":"key:\"/registry/leases/kube-node-lease/instance\" "} {"level":"warn","ts":"2026-09-19T00:55:38.278421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"408.806718ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" ","response":"range_response_count:1 size:218"} {"level":"info","ts":"2026-09-19T00:55:38.278459Z","caller":"traceutil/trace.go:171","msg":"trace[867830082] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/service-account-controller; range_end:; response_count:1; response_revision:346; }","duration":"408.878ms","start":"2026-09-19T00:55:37.869567Z","end":"2026-09-19T00:55:38.278445Z","steps":["trace[867830082] 'agreement among raft nodes before linearized reading' (duration: 408.816458ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T00:55:38.278487Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T00:55:37.869544Z","time spent":"408.936532ms","remote":"127.0.0.1:49966","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":1,"response size":242,"request content":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" "} {"level":"warn","ts":"2026-09-19T00:55:38.278512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"459.059362ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" ","response":"range_response_count:1 size:203"} {"level":"warn","ts":"2026-09-19T00:55:38.278479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.761395ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-09-19T00:55:38.278531Z","caller":"traceutil/trace.go:171","msg":"trace[925567557] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpoint-controller; range_end:; response_count:1; response_revision:346; }","duration":"459.103763ms","start":"2026-09-19T00:55:37.819422Z","end":"2026-09-19T00:55:38.278526Z","steps":["trace[925567557] 'agreement among raft nodes before linearized reading' (duration: 459.063652ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T00:55:38.278548Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T00:55:37.819411Z","time spent":"459.132934ms","remote":"127.0.0.1:49966","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":227,"request content":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" "} {"level":"warn","ts":"2026-09-19T00:55:38.278538Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T00:55:37.73174Z","time spent":"546.674288ms","remote":"127.0.0.1:50014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-19T00:55:38.27856Z","caller":"traceutil/trace.go:171","msg":"trace[640585429] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:1; response_revision:346; }","duration":"308.93816ms","start":"2026-09-19T00:55:37.969601Z","end":"2026-09-19T00:55:38.278539Z","steps":["trace[640585429] 'agreement among raft nodes before linearized reading' (duration: 308.723574ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T00:55:38.278609Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T00:55:37.969572Z","time spent":"309.027243ms","remote":"127.0.0.1:49966","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":231,"request content":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" "} {"level":"warn","ts":"2026-09-19T00:55:38.278719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"358.797752ms","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":"info","ts":"2026-09-19T00:55:38.278754Z","caller":"traceutil/trace.go:171","msg":"trace[1076575304] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/root-ca-cert-publisher; range_end:; response_count:1; response_revision:346; }","duration":"358.864834ms","start":"2026-09-19T00:55:37.919879Z","end":"2026-09-19T00:55:38.278744Z","steps":["trace[1076575304] 'agreement among raft nodes before linearized reading' (duration: 358.806723ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T00:55:38.278787Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T00:55:37.919862Z","time spent":"358.917826ms","remote":"127.0.0.1:49966","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":233,"request content":"key:\"/registry/serviceaccounts/kube-system/root-ca-cert-publisher\" "} {"level":"warn","ts":"2026-09-19T00:55:38.278851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.836457ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-09-19T00:55:38.278895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.489967ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" ","response":"range_response_count:1 size:234"} {"level":"info","ts":"2026-09-19T00:55:38.2789Z","caller":"traceutil/trace.go:171","msg":"trace[415007706] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:346; }","duration":"369.9239ms","start":"2026-09-19T00:55:37.908962Z","end":"2026-09-19T00:55:38.278886Z","steps":["trace[415007706] 'agreement among raft nodes before linearized reading' (duration: 369.795726ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T00:55:38.278927Z","caller":"traceutil/trace.go:171","msg":"trace[1565182728] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller; range_end:; response_count:1; response_revision:346; }","duration":"107.57648ms","start":"2026-09-19T00:55:38.17134Z","end":"2026-09-19T00:55:38.278916Z","steps":["trace[1565182728] 'agreement among raft nodes before linearized reading' (duration: 107.519288ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T00:55:38.278932Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T00:55:37.908938Z","time spent":"369.987321ms","remote":"127.0.0.1:50014","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-09-19T00:55:38.278343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"509.151301ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" ","response":"range_response_count:1 size:193"} {"level":"warn","ts":"2026-09-19T00:55:38.279069Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.323908ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" ","response":"range_response_count:1 size:207"} {"level":"warn","ts":"2026-09-19T00:55:38.279089Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"466.428605ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:1 size:664"} {"level":"info","ts":"2026-09-19T00:55:38.279095Z","caller":"traceutil/trace.go:171","msg":"trace[146342704] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/deployment-controller; range_end:; response_count:1; response_revision:346; }","duration":"259.384ms","start":"2026-09-19T00:55:38.019702Z","end":"2026-09-19T00:55:38.279086Z","steps":["trace[146342704] 'agreement among raft nodes before linearized reading' (duration: 259.337819ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T00:55:38.279105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.535175ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/node-controller\" ","response":"range_response_count:1 size:195"} {"level":"info","ts":"2026-09-19T00:55:38.279123Z","caller":"traceutil/trace.go:171","msg":"trace[2063795725] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:1; response_revision:346; }","duration":"466.532849ms","start":"2026-09-19T00:55:37.81258Z","end":"2026-09-19T00:55:38.279113Z","steps":["trace[2063795725] 'agreement among raft nodes before linearized reading' (duration: 466.463037ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T00:55:38.279167Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T00:55:37.812557Z","time spent":"466.600651ms","remote":"127.0.0.1:50156","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":1,"response size":688,"request content":"key:\"/registry/csinodes/instance\" "} {"level":"info","ts":"2026-09-19T00:55:38.279028Z","caller":"traceutil/trace.go:171","msg":"trace[675114081] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-controller; range_end:; response_count:1; response_revision:346; }","duration":"509.878744ms","start":"2026-09-19T00:55:37.769129Z","end":"2026-09-19T00:55:38.279007Z","steps":["trace[675114081] 'agreement among raft nodes before linearized reading' (duration: 509.159992ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T00:55:38.279152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.806235ms","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-19T00:55:38.279175Z","caller":"traceutil/trace.go:171","msg":"trace[1543009779] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/node-controller; range_end:; response_count:1; response_revision:346; }","duration":"208.626169ms","start":"2026-09-19T00:55:38.070525Z","end":"2026-09-19T00:55:38.279151Z","steps":["trace[1543009779] 'agreement among raft nodes before linearized reading' (duration: 208.440522ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T00:55:38.279209Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T00:55:37.769097Z","time spent":"510.09658ms","remote":"127.0.0.1:49966","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":217,"request content":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" "} {"level":"info","ts":"2026-09-19T00:55:38.279227Z","caller":"traceutil/trace.go:171","msg":"trace[1852029635] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/certificate-controller; range_end:; response_count:1; response_revision:346; }","duration":"157.92956ms","start":"2026-09-19T00:55:38.121276Z","end":"2026-09-19T00:55:38.279205Z","steps":["trace[1852029635] 'agreement among raft nodes before linearized reading' (duration: 157.734883ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T00:55:38.452792Z","caller":"traceutil/trace.go:171","msg":"trace[2077988911] linearizableReadLoop","detail":"{readStateIndex:360; appliedIndex:359; }","duration":"167.928878ms","start":"2026-09-19T00:55:38.284832Z","end":"2026-09-19T00:55:38.452761Z","steps":["trace[2077988911] 'read index received' (duration: 164.397429ms)","trace[2077988911] 'applied index is now lower than readState.Index' (duration: 3.529819ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T00:55:38.452848Z","caller":"traceutil/trace.go:171","msg":"trace[1976014801] transaction","detail":"{read_only:false; response_revision:347; number_of_response:1; }","duration":"168.00105ms","start":"2026-09-19T00:55:38.284809Z","end":"2026-09-19T00:55:38.45281Z","steps":["trace[1976014801] 'process raft request' (duration: 164.319877ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T00:55:38.453116Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.240488ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4196"} {"level":"info","ts":"2026-09-19T00:55:38.453455Z","caller":"traceutil/trace.go:171","msg":"trace[796955802] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:347; }","duration":"168.597279ms","start":"2026-09-19T00:55:38.284798Z","end":"2026-09-19T00:55:38.453396Z","steps":["trace[796955802] 'agreement among raft nodes before linearized reading' (duration: 168.063543ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T00:55:38.462178Z","caller":"traceutil/trace.go:171","msg":"trace[772068015] transaction","detail":"{read_only:false; response_revision:348; number_of_response:1; }","duration":"174.162901ms","start":"2026-09-19T00:55:38.287994Z","end":"2026-09-19T00:55:38.462157Z","steps":["trace[772068015] 'process raft request' (duration: 173.974566ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T00:55:38.462527Z","caller":"traceutil/trace.go:171","msg":"trace[771449894] transaction","detail":"{read_only:false; response_revision:350; number_of_response:1; }","duration":"174.270955ms","start":"2026-09-19T00:55:38.288235Z","end":"2026-09-19T00:55:38.462506Z","steps":["trace[771449894] 'process raft request' (duration: 174.12338ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T00:55:38.46277Z","caller":"traceutil/trace.go:171","msg":"trace[1532522609] transaction","detail":"{read_only:false; response_revision:349; number_of_response:1; }","duration":"174.74272ms","start":"2026-09-19T00:55:38.288015Z","end":"2026-09-19T00:55:38.462758Z","steps":["trace[1532522609] 'process raft request' (duration: 174.09441ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T00:55:38.462906Z","caller":"traceutil/trace.go:171","msg":"trace[530076066] transaction","detail":"{read_only:false; response_revision:352; number_of_response:1; }","duration":"174.419209ms","start":"2026-09-19T00:55:38.288477Z","end":"2026-09-19T00:55:38.462897Z","steps":["trace[530076066] 'process raft request' (duration: 173.968435ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T00:55:38.463116Z","caller":"traceutil/trace.go:171","msg":"trace[225830011] transaction","detail":"{read_only:false; response_revision:353; number_of_response:1; }","duration":"173.398168ms","start":"2026-09-19T00:55:38.289709Z","end":"2026-09-19T00:55:38.463107Z","steps":["trace[225830011] 'process raft request' (duration: 172.78668ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T00:55:38.463228Z","caller":"traceutil/trace.go:171","msg":"trace[1761293215] transaction","detail":"{read_only:false; response_revision:357; number_of_response:1; }","duration":"170.395446ms","start":"2026-09-19T00:55:38.292821Z","end":"2026-09-19T00:55:38.463217Z","steps":["trace[1761293215] 'process raft request' (duration: 169.851379ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T00:55:38.463315Z","caller":"traceutil/trace.go:171","msg":"trace[2053813154] transaction","detail":"{read_only:false; response_revision:354; number_of_response:1; }","duration":"173.513301ms","start":"2026-09-19T00:55:38.289786Z","end":"2026-09-19T00:55:38.463299Z","steps":["trace[2053813154] 'process raft request' (duration: 172.754508ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T00:55:38.463398Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.443593ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4368"} {"level":"info","ts":"2026-09-19T00:55:38.463433Z","caller":"traceutil/trace.go:171","msg":"trace[847847501] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:358; }","duration":"178.538836ms","start":"2026-09-19T00:55:38.284885Z","end":"2026-09-19T00:55:38.463424Z","steps":["trace[847847501] 'agreement among raft nodes before linearized reading' (duration: 178.448133ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T00:55:38.463566Z","caller":"traceutil/trace.go:171","msg":"trace[1382501036] transaction","detail":"{read_only:false; response_revision:355; number_of_response:1; }","duration":"173.573013ms","start":"2026-09-19T00:55:38.289975Z","end":"2026-09-19T00:55:38.463548Z","steps":["trace[1382501036] 'process raft request' (duration: 172.606903ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T00:55:38.463707Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.169776ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" ","response":"range_response_count:1 size:203"} {"level":"info","ts":"2026-09-19T00:55:38.463736Z","caller":"traceutil/trace.go:171","msg":"trace[924193443] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpoint-controller; range_end:; response_count:1; response_revision:358; }","duration":"178.218126ms","start":"2026-09-19T00:55:38.285511Z","end":"2026-09-19T00:55:38.463729Z","steps":["trace[924193443] 'agreement among raft nodes before linearized reading' (duration: 178.163075ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T00:55:38.463796Z","caller":"traceutil/trace.go:171","msg":"trace[698613278] transaction","detail":"{read_only:false; response_revision:356; number_of_response:1; }","duration":"172.595402ms","start":"2026-09-19T00:55:38.291186Z","end":"2026-09-19T00:55:38.463781Z","steps":["trace[698613278] 'process raft request' (duration: 171.430266ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T00:55:38.463977Z","caller":"traceutil/trace.go:171","msg":"trace[503132330] transaction","detail":"{read_only:false; response_revision:351; number_of_response:1; }","duration":"175.351368ms","start":"2026-09-19T00:55:38.288357Z","end":"2026-09-19T00:55:38.463708Z","steps":["trace[503132330] 'process raft request' (duration: 174.057488ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T00:56:07.824652Z","caller":"traceutil/trace.go:171","msg":"trace[816450118] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"119.211613ms","start":"2026-09-19T00:56:07.705425Z","end":"2026-09-19T00:56:07.824637Z","steps":["trace[816450118] 'process raft request' (duration: 118.852386ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T00:56:07.824781Z","caller":"traceutil/trace.go:171","msg":"trace[151333180] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"102.062598ms","start":"2026-09-19T00:56:07.7227Z","end":"2026-09-19T00:56:07.824763Z","steps":["trace[151333180] 'process raft request' (duration: 101.669141ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T00:56:08.309165Z","caller":"traceutil/trace.go:171","msg":"trace[189889569] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"564.005392ms","start":"2026-09-19T00:56:07.745109Z","end":"2026-09-19T00:56:08.309115Z","steps":["trace[189889569] 'process raft request' (duration: 563.890947ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T00:56:08.309481Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T00:56:07.745097Z","time spent":"564.261003ms","remote":"127.0.0.1:49820","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-19T00:56:08.309644Z","caller":"traceutil/trace.go:171","msg":"trace[1107825078] linearizableReadLoop","detail":"{readStateIndex:566; appliedIndex:554; }","duration":"516.833694ms","start":"2026-09-19T00:56:07.792787Z","end":"2026-09-19T00:56:08.30962Z","steps":["trace[1107825078] 'read index received' (duration: 31.451139ms)","trace[1107825078] 'applied index is now lower than readState.Index' (duration: 485.380845ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T00:56:08.309737Z","caller":"traceutil/trace.go:171","msg":"trace[561120225] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"567.531573ms","start":"2026-09-19T00:56:07.742155Z","end":"2026-09-19T00:56:08.309687Z","steps":["trace[561120225] 'process raft request' (duration: 566.632492ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T00:56:08.309823Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T00:56:07.74213Z","time spent":"567.662099ms","remote":"127.0.0.1:49820","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-19T00:56:08.309895Z","caller":"traceutil/trace.go:171","msg":"trace[1047582023] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"563.245077ms","start":"2026-09-19T00:56:07.746639Z","end":"2026-09-19T00:56:08.309884Z","steps":["trace[1047582023] 'process raft request' (duration: 562.404339ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T00:56:08.309961Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T00:56:07.746629Z","time spent":"563.29488ms","remote":"127.0.0.1:50328","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":995,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-19T00:56:08.310063Z","caller":"traceutil/trace.go:171","msg":"trace[846578840] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"555.844239ms","start":"2026-09-19T00:56:07.754188Z","end":"2026-09-19T00:56:08.310032Z","steps":["trace[846578840] 'process raft request' (duration: 555.245691ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T00:56:08.31018Z","caller":"traceutil/trace.go:171","msg":"trace[175170965] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"520.410357ms","start":"2026-09-19T00:56:07.789755Z","end":"2026-09-19T00:56:08.310165Z","steps":["trace[175170965] 'process raft request' (duration: 519.726406ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T00:56:08.310214Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T00:56:07.754172Z","time spent":"555.972195ms","remote":"127.0.0.1:49820","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-19T00:56:08.310255Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T00:56:07.789713Z","time spent":"520.507251ms","remote":"127.0.0.1:49820","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-19T00:56:08.310364Z","caller":"traceutil/trace.go:171","msg":"trace[1382650842] transaction","detail":"{read_only:false; response_revision:545; number_of_response:1; }","duration":"491.029225ms","start":"2026-09-19T00:56:07.819326Z","end":"2026-09-19T00:56:08.310355Z","steps":["trace[1382650842] 'process raft request' (duration: 490.222167ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T00:56:08.31041Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T00:56:07.819302Z","time spent":"491.086947ms","remote":"127.0.0.1:49820","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-19T00:56:08.31043Z","caller":"traceutil/trace.go:171","msg":"trace[1728915730] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"561.841183ms","start":"2026-09-19T00:56:07.748575Z","end":"2026-09-19T00:56:08.310416Z","steps":["trace[1728915730] 'process raft request' (duration: 560.512442ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T00:56:08.310512Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T00:56:07.748566Z","time spent":"561.901517ms","remote":"127.0.0.1:49820","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7317,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-19T00:56:08.310776Z","caller":"traceutil/trace.go:171","msg":"trace[1926546334] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"557.412392ms","start":"2026-09-19T00:56:07.753333Z","end":"2026-09-19T00:56:08.310746Z","steps":["trace[1926546334] 'process raft request' (duration: 556.051688ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T00:56:08.310889Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T00:56:07.75332Z","time spent":"557.530016ms","remote":"127.0.0.1:49820","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-19T00:56:08.310899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"518.04944ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-19T00:56:08.313258Z","caller":"traceutil/trace.go:171","msg":"trace[1881061636] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:545; }","duration":"520.452431ms","start":"2026-09-19T00:56:07.792781Z","end":"2026-09-19T00:56:08.313233Z","steps":["trace[1881061636] 'agreement among raft nodes before linearized reading' (duration: 517.935835ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T00:56:08.311276Z","caller":"traceutil/trace.go:171","msg":"trace[625330530] transaction","detail":"{read_only:false; number_of_response:1; response_revision:540; }","duration":"561.342181ms","start":"2026-09-19T00:56:07.74992Z","end":"2026-09-19T00:56:08.311262Z","steps":["trace[625330530] 'process raft request' (duration: 559.238544ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T00:56:08.311287Z","caller":"traceutil/trace.go:171","msg":"trace[1818284287] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"558.556254ms","start":"2026-09-19T00:56:07.752707Z","end":"2026-09-19T00:56:08.311263Z","steps":["trace[1818284287] 'process raft request' (duration: 556.598024ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T00:56:08.313364Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T00:56:07.792748Z","time spent":"520.600238ms","remote":"127.0.0.1:49796","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-09-19T00:56:08.313483Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T00:56:07.75267Z","time spent":"560.718384ms","remote":"127.0.0.1:49820","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-19T00:56:08.313488Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T00:56:07.749911Z","time spent":"563.506412ms","remote":"127.0.0.1:49820","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":102,"response count":0,"response size":7367,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-19T00:56:08.330764Z","caller":"traceutil/trace.go:171","msg":"trace[1123744655] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"382.504968ms","start":"2026-09-19T00:56:07.94824Z","end":"2026-09-19T00:56:08.330745Z","steps":["trace[1123744655] 'process raft request' (duration: 382.431555ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T00:56:08.330903Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T00:56:07.948194Z","time spent":"382.648955ms","remote":"127.0.0.1:49820","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-19T00:56:08.331149Z","caller":"traceutil/trace.go:171","msg":"trace[1582675531] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"493.82516ms","start":"2026-09-19T00:56:07.837311Z","end":"2026-09-19T00:56:08.331136Z","steps":["trace[1582675531] 'process raft request' (duration: 493.288145ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T00:56:08.331232Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T00:56:07.837301Z","time spent":"493.882852ms","remote":"127.0.0.1:49820","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30393,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-19T00:56:08.331281Z","caller":"traceutil/trace.go:171","msg":"trace[1498805709] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"498.311426ms","start":"2026-09-19T00:56:07.832909Z","end":"2026-09-19T00:56:08.33122Z","steps":["trace[1498805709] 'process raft request' (duration: 497.618904ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T00:56:08.331485Z","caller":"traceutil/trace.go:171","msg":"trace[1166538633] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"500.739797ms","start":"2026-09-19T00:56:07.830736Z","end":"2026-09-19T00:56:08.331476Z","steps":["trace[1166538633] 'process raft request' (duration: 498.887452ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T00:56:08.331545Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T00:56:07.830714Z","time spent":"500.79696ms","remote":"127.0.0.1:50328","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1004,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-19T00:56:08.331528Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T00:56:07.832881Z","time spent":"498.520795ms","remote":"127.0.0.1:50328","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":998,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-19T00:56:08.331777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.223158ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-09-19T00:56:08.331814Z","caller":"traceutil/trace.go:171","msg":"trace[445865177] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:549; }","duration":"252.320573ms","start":"2026-09-19T00:56:08.079485Z","end":"2026-09-19T00:56:08.331806Z","steps":["trace[445865177] 'agreement among raft nodes before linearized reading' (duration: 252.25853ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T00:56:09.895821Z","caller":"traceutil/trace.go:171","msg":"trace[523045983] linearizableReadLoop","detail":"{readStateIndex:662; appliedIndex:661; }","duration":"288.60012ms","start":"2026-09-19T00:56:09.607194Z","end":"2026-09-19T00:56:09.895794Z","steps":["trace[523045983] 'read index received' (duration: 287.968941ms)","trace[523045983] 'applied index is now lower than readState.Index' (duration: 630.109µs)"],"step_count":2} {"level":"info","ts":"2026-09-19T00:56:09.895931Z","caller":"traceutil/trace.go:171","msg":"trace[1309417740] transaction","detail":"{read_only:false; response_revision:638; number_of_response:1; }","duration":"294.369878ms","start":"2026-09-19T00:56:09.601507Z","end":"2026-09-19T00:56:09.895877Z","steps":["trace[1309417740] 'process raft request' (duration: 293.776221ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T00:56:09.896112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.886734ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/udproutes.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:31126"} {"level":"info","ts":"2026-09-19T00:56:09.896164Z","caller":"traceutil/trace.go:171","msg":"trace[67570375] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/udproutes.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:638; }","duration":"289.00397ms","start":"2026-09-19T00:56:09.607143Z","end":"2026-09-19T00:56:09.896147Z","steps":["trace[67570375] 'agreement among raft nodes before linearized reading' (duration: 288.796399ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T00:56:09.896279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.493601ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-19T00:56:09.896345Z","caller":"traceutil/trace.go:171","msg":"trace[992267368] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io; range_end:; response_count:0; response_revision:638; }","duration":"197.651788ms","start":"2026-09-19T00:56:09.698675Z","end":"2026-09-19T00:56:09.896327Z","steps":["trace[992267368] 'agreement among raft nodes before linearized reading' (duration: 197.513102ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T00:56:09.896492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.692895ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-19T00:56:09.896544Z","caller":"traceutil/trace.go:171","msg":"trace[1035755991] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:638; }","duration":"103.815551ms","start":"2026-09-19T00:56:09.792714Z","end":"2026-09-19T00:56:09.896529Z","steps":["trace[1035755991] 'agreement among raft nodes before linearized reading' (duration: 103.702006ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T00:56:16.51606Z","caller":"traceutil/trace.go:171","msg":"trace[1793367777] transaction","detail":"{read_only:false; response_revision:701; number_of_response:1; }","duration":"118.26504ms","start":"2026-09-19T00:56:16.397766Z","end":"2026-09-19T00:56:16.516031Z","steps":["trace[1793367777] 'process raft request' (duration: 118.091462ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T00:56:16.516604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.247814ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-09-19T00:56:16.516684Z","caller":"traceutil/trace.go:171","msg":"trace[788563908] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:701; }","duration":"100.406431ms","start":"2026-09-19T00:56:16.41626Z","end":"2026-09-19T00:56:16.516667Z","steps":["trace[788563908] 'agreement among raft nodes before linearized reading' (duration: 99.729218ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T00:56:16.643851Z","caller":"traceutil/trace.go:171","msg":"trace[1308230531] transaction","detail":"{read_only:false; response_revision:702; number_of_response:1; }","duration":"116.391316ms","start":"2026-09-19T00:56:16.527404Z","end":"2026-09-19T00:56:16.643795Z","steps":["trace[1308230531] 'process raft request' (duration: 100.929507ms)","trace[1308230531] 'compare' (duration: 15.26804ms)"],"step_count":2} {"level":"warn","ts":"2026-09-19T00:56:16.644597Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.17929ms","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-19T00:56:16.644668Z","caller":"traceutil/trace.go:171","msg":"trace[1834906584] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:702; }","duration":"100.337919ms","start":"2026-09-19T00:56:16.544316Z","end":"2026-09-19T00:56:16.644654Z","steps":["trace[1834906584] 'agreement among raft nodes before linearized reading' (duration: 100.159829ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T00:56:16.852816Z","caller":"traceutil/trace.go:171","msg":"trace[195457178] linearizableReadLoop","detail":"{readStateIndex:728; appliedIndex:727; }","duration":"138.895263ms","start":"2026-09-19T00:56:16.713864Z","end":"2026-09-19T00:56:16.85276Z","steps":["trace[195457178] 'read index received' (duration: 109.652985ms)","trace[195457178] 'applied index is now lower than readState.Index' (duration: 29.240568ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T00:56:16.852894Z","caller":"traceutil/trace.go:171","msg":"trace[2101595137] transaction","detail":"{read_only:false; response_revision:703; number_of_response:1; }","duration":"202.230363ms","start":"2026-09-19T00:56:16.650646Z","end":"2026-09-19T00:56:16.852877Z","steps":["trace[2101595137] 'process raft request' (duration: 172.960685ms)","trace[2101595137] 'compare' (duration: 29.004525ms)"],"step_count":2} {"level":"warn","ts":"2026-09-19T00:56:16.853268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.123323ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-09-19T00:56:16.853341Z","caller":"traceutil/trace.go:171","msg":"trace[1948031319] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:703; }","duration":"106.215548ms","start":"2026-09-19T00:56:16.747103Z","end":"2026-09-19T00:56:16.853319Z","steps":["trace[1948031319] 'agreement among raft nodes before linearized reading' (duration: 106.074301ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T00:56:16.853255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.283652ms","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-19T00:56:16.853466Z","caller":"traceutil/trace.go:171","msg":"trace[772151130] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:703; }","duration":"139.656169ms","start":"2026-09-19T00:56:16.713798Z","end":"2026-09-19T00:56:16.853455Z","steps":["trace[772151130] 'agreement among raft nodes before linearized reading' (duration: 139.175466ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T00:56:17.603737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.688092ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-09-19T00:56:17.603861Z","caller":"traceutil/trace.go:171","msg":"trace[1768820243] linearizableReadLoop","detail":"{readStateIndex:731; appliedIndex:730; }","duration":"314.307467ms","start":"2026-09-19T00:56:17.289534Z","end":"2026-09-19T00:56:17.603842Z","steps":["trace[1768820243] 'read index received' (duration: 66.484258ms)","trace[1768820243] 'applied index is now lower than readState.Index' (duration: 247.821268ms)"],"step_count":2} {"level":"warn","ts":"2026-09-19T00:56:17.604037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.479606ms","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-19T00:56:17.604072Z","caller":"traceutil/trace.go:171","msg":"trace[1069654590] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:705; }","duration":"314.57571ms","start":"2026-09-19T00:56:17.289487Z","end":"2026-09-19T00:56:17.604062Z","steps":["trace[1069654590] 'agreement among raft nodes before linearized reading' (duration: 314.400482ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T00:56:17.604103Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T00:56:17.289459Z","time spent":"314.635503ms","remote":"127.0.0.1:50014","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-09-19T00:56:35.313079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"360.418766ms","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-19T00:56:35.313204Z","caller":"traceutil/trace.go:171","msg":"trace[34555776] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:824; }","duration":"360.616856ms","start":"2026-09-19T00:56:34.952563Z","end":"2026-09-19T00:56:35.31318Z","steps":["trace[34555776] 'range keys from in-memory index tree' (duration: 360.217915ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T00:56:35.31325Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T00:56:34.952546Z","time spent":"360.69421ms","remote":"127.0.0.1:50014","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-09-19T00:56:35.313264Z","caller":"traceutil/trace.go:171","msg":"trace[1985926585] linearizableReadLoop","detail":"{readStateIndex:856; appliedIndex:855; }","duration":"323.547983ms","start":"2026-09-19T00:56:34.989681Z","end":"2026-09-19T00:56:35.313229Z","steps":["trace[1985926585] 'read index received' (duration: 262.466223ms)","trace[1985926585] 'applied index is now lower than readState.Index' (duration: 61.08031ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T00:56:35.313395Z","caller":"traceutil/trace.go:171","msg":"trace[82201029] transaction","detail":"{read_only:false; response_revision:825; number_of_response:1; }","duration":"359.312766ms","start":"2026-09-19T00:56:34.954062Z","end":"2026-09-19T00:56:35.313375Z","steps":["trace[82201029] 'process raft request' (duration: 298.094749ms)","trace[82201029] 'compare' (duration: 60.931401ms)"],"step_count":2} {"level":"warn","ts":"2026-09-19T00:56:35.313586Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.550721ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-19T00:56:35.313646Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T00:56:34.954044Z","time spent":"359.498997ms","remote":"127.0.0.1:50014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-19T00:56:35.31366Z","caller":"traceutil/trace.go:171","msg":"trace[1634504035] range","detail":"{range_begin:/registry/poddisruptionbudgets/; range_end:/registry/poddisruptionbudgets0; response_count:0; response_revision:825; }","duration":"295.672728ms","start":"2026-09-19T00:56:35.017972Z","end":"2026-09-19T00:56:35.313644Z","steps":["trace[1634504035] 'agreement among raft nodes before linearized reading' (duration: 295.575713ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T00:56:35.313871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.172458ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-09-19T00:56:35.313943Z","caller":"traceutil/trace.go:171","msg":"trace[207247415] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:825; }","duration":"324.307806ms","start":"2026-09-19T00:56:34.98962Z","end":"2026-09-19T00:56:35.313928Z","steps":["trace[207247415] 'agreement among raft nodes before linearized reading' (duration: 324.067653ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T00:56:35.313986Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T00:56:34.989578Z","time spent":"324.39643ms","remote":"127.0.0.1:50014","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-09-19T00:57:07.136552Z","caller":"traceutil/trace.go:171","msg":"trace[505396849] transaction","detail":"{read_only:false; response_revision:1057; number_of_response:1; }","duration":"113.681935ms","start":"2026-09-19T00:57:07.022834Z","end":"2026-09-19T00:57:07.136516Z","steps":["trace[505396849] 'process raft request' (duration: 113.473872ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T00:57:07.18722Z","caller":"traceutil/trace.go:171","msg":"trace[1783449156] transaction","detail":"{read_only:false; response_revision:1058; number_of_response:1; }","duration":"136.035197ms","start":"2026-09-19T00:57:07.051089Z","end":"2026-09-19T00:57:07.187124Z","steps":["trace[1783449156] 'process raft request' (duration: 127.147242ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T00:57:07.396454Z","caller":"traceutil/trace.go:171","msg":"trace[1478138890] transaction","detail":"{read_only:false; number_of_response:1; response_revision:1061; }","duration":"125.514631ms","start":"2026-09-19T00:57:07.270899Z","end":"2026-09-19T00:57:07.396414Z","steps":["trace[1478138890] 'process raft request' (duration: 120.550486ms)"],"step_count":1}