{"level":"warn","ts":"2026-10-19T01:54:15.307855Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-19T01:54:15.307951Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.36: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.36:2380","--initial-cluster=instance=https://162.253.55.36:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.36:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.36:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-10-19T01:54:15.30802Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-19T01:54:15.308032Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.36:2380"]} {"level":"info","ts":"2026-10-19T01:54:15.30809Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-10-19T01:54:15.308711Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.36:2379"]} {"level":"info","ts":"2026-10-19T01:54:15.30878Z","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.36:2380"],"listen-peer-urls":["https://162.253.55.36:2380"],"advertise-client-urls":["https://162.253.55.36:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.36:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.36:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-10-19T01:54:15.311921Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.939784ms"} {"level":"info","ts":"2026-10-19T01:54:15.320546Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"cb89ec34a9687f0b","cluster-id":"d8e0d5e222e856c9"} {"level":"info","ts":"2026-10-19T01:54:15.320601Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cb89ec34a9687f0b switched to configuration voters=()"} {"level":"info","ts":"2026-10-19T01:54:15.32062Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cb89ec34a9687f0b became follower at term 0"} {"level":"info","ts":"2026-10-19T01:54:15.320629Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft cb89ec34a9687f0b [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-10-19T01:54:15.320638Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cb89ec34a9687f0b became follower at term 1"} {"level":"info","ts":"2026-10-19T01:54:15.320667Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cb89ec34a9687f0b switched to configuration voters=(14666513372433383179)"} {"level":"warn","ts":"2026-10-19T01:54:15.334765Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-10-19T01:54:15.336869Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-10-19T01:54:15.33832Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-10-19T01:54:15.340507Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"cb89ec34a9687f0b","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-10-19T01:54:15.340939Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"cb89ec34a9687f0b","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-10-19T01:54:15.340982Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-10-19T01:54:15.345512Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-10-19T01:54:15.345537Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-10-19T01:54:15.345884Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cb89ec34a9687f0b switched to configuration voters=(14666513372433383179)"} {"level":"info","ts":"2026-10-19T01:54:15.346018Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"d8e0d5e222e856c9","local-member-id":"cb89ec34a9687f0b","added-peer-id":"cb89ec34a9687f0b","added-peer-peer-urls":["https://162.253.55.36:2380"]} {"level":"info","ts":"2026-10-19T01:54:15.347475Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-10-19T01:54:15.347538Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.36:2380"} {"level":"info","ts":"2026-10-19T01:54:15.347588Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.36:2380"} {"level":"info","ts":"2026-10-19T01:54:15.347663Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"cb89ec34a9687f0b","initial-advertise-peer-urls":["https://162.253.55.36:2380"],"listen-peer-urls":["https://162.253.55.36:2380"],"advertise-client-urls":["https://162.253.55.36:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.36:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-10-19T01:54:15.34771Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-10-19T01:54:15.721532Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cb89ec34a9687f0b is starting a new election at term 1"} {"level":"info","ts":"2026-10-19T01:54:15.721609Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cb89ec34a9687f0b became pre-candidate at term 1"} {"level":"info","ts":"2026-10-19T01:54:15.721641Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cb89ec34a9687f0b received MsgPreVoteResp from cb89ec34a9687f0b at term 1"} {"level":"info","ts":"2026-10-19T01:54:15.721674Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cb89ec34a9687f0b became candidate at term 2"} {"level":"info","ts":"2026-10-19T01:54:15.721705Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cb89ec34a9687f0b received MsgVoteResp from cb89ec34a9687f0b at term 2"} {"level":"info","ts":"2026-10-19T01:54:15.721722Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cb89ec34a9687f0b became leader at term 2"} {"level":"info","ts":"2026-10-19T01:54:15.721742Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: cb89ec34a9687f0b elected leader cb89ec34a9687f0b at term 2"} {"level":"info","ts":"2026-10-19T01:54:15.72297Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-10-19T01:54:15.723962Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"cb89ec34a9687f0b","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.36:2379]}","request-path":"/0/members/cb89ec34a9687f0b/attributes","cluster-id":"d8e0d5e222e856c9","publish-timeout":"7s"} {"level":"info","ts":"2026-10-19T01:54:15.723971Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-19T01:54:15.724423Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-19T01:54:15.727714Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-10-19T01:54:15.728423Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.36:2379"} {"level":"info","ts":"2026-10-19T01:54:15.728428Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-10-19T01:54:15.72856Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-10-19T01:54:15.738433Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"d8e0d5e222e856c9","local-member-id":"cb89ec34a9687f0b","cluster-version":"3.5"} {"level":"info","ts":"2026-10-19T01:54:15.738536Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-10-19T01:54:15.738569Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"warn","ts":"2026-10-19T01:54:16.093063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.779515ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-10-19T01:54:16.09322Z","caller":"traceutil/trace.go:171","msg":"trace[423425807] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:1; }","duration":"140.991391ms","start":"2026-10-19T01:54:15.952202Z","end":"2026-10-19T01:54:16.093194Z","steps":["trace[423425807] 'count revisions from in-memory index tree' (duration: 140.667283ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:54:16.094283Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.938875ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-10-19T01:54:16.094342Z","caller":"traceutil/trace.go:171","msg":"trace[439906935] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:1; }","duration":"209.022877ms","start":"2026-10-19T01:54:15.885292Z","end":"2026-10-19T01:54:16.094315Z","steps":["trace[439906935] 'range keys from in-memory index tree' (duration: 208.896944ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:54:16.09442Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.31959ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-10-19T01:54:16.094529Z","caller":"traceutil/trace.go:171","msg":"trace[1996687327] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:1; }","duration":"153.638626ms","start":"2026-10-19T01:54:15.940854Z","end":"2026-10-19T01:54:16.094493Z","steps":["trace[1996687327] 'range keys from in-memory index tree' (duration: 153.263088ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:54:16.094922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.671178ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-10-19T01:54:16.09497Z","caller":"traceutil/trace.go:171","msg":"trace[693431338] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:1; }","duration":"142.726709ms","start":"2026-10-19T01:54:15.952224Z","end":"2026-10-19T01:54:16.094951Z","steps":["trace[693431338] 'range keys from in-memory index tree' (duration: 142.606407ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:54:16.096554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.555293ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-10-19T01:54:16.096617Z","caller":"traceutil/trace.go:171","msg":"trace[1252277185] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:1; }","duration":"103.630634ms","start":"2026-10-19T01:54:15.992965Z","end":"2026-10-19T01:54:16.096596Z","steps":["trace[1252277185] 'count revisions from in-memory index tree' (duration: 103.509572ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:54:16.096535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.941948ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-10-19T01:54:16.09668Z","caller":"traceutil/trace.go:171","msg":"trace[2065447479] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:1; }","duration":"118.158423ms","start":"2026-10-19T01:54:15.978512Z","end":"2026-10-19T01:54:16.09667Z","steps":["trace[2065447479] 'range keys from in-memory index tree' (duration: 117.864445ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:54:16.096956Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.428822ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-10-19T01:54:16.097008Z","caller":"traceutil/trace.go:171","msg":"trace[543462417] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:1; }","duration":"169.502494ms","start":"2026-10-19T01:54:15.927486Z","end":"2026-10-19T01:54:16.096989Z","steps":["trace[543462417] 'count revisions from in-memory index tree' (duration: 169.352471ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:54:16.097252Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.024922ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-10-19T01:54:16.09718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.061025ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-10-19T01:54:16.097373Z","caller":"traceutil/trace.go:171","msg":"trace[650961492] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:1; }","duration":"132.28787ms","start":"2026-10-19T01:54:15.965059Z","end":"2026-10-19T01:54:16.097346Z","steps":["trace[650961492] 'count revisions from in-memory index tree' (duration: 132.015624ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:54:16.097298Z","caller":"traceutil/trace.go:171","msg":"trace[887409118] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:1; }","duration":"212.064333ms","start":"2026-10-19T01:54:15.885215Z","end":"2026-10-19T01:54:16.097279Z","steps":["trace[887409118] 'count revisions from in-memory index tree' (duration: 211.862219ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:54:16.097403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.397507ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-10-19T01:54:16.097488Z","caller":"traceutil/trace.go:171","msg":"trace[1842927359] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:1; }","duration":"156.498829ms","start":"2026-10-19T01:54:15.940969Z","end":"2026-10-19T01:54:16.097468Z","steps":["trace[1842927359] 'count revisions from in-memory index tree' (duration: 156.348806ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:54:16.099954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.934607ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-10-19T01:54:16.100021Z","caller":"traceutil/trace.go:171","msg":"trace[12318377] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:1; }","duration":"135.0422ms","start":"2026-10-19T01:54:15.964964Z","end":"2026-10-19T01:54:16.100007Z","steps":["trace[12318377] 'range keys from in-memory index tree' (duration: 134.806875ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:54:16.100312Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.638427ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-10-19T01:54:16.100337Z","caller":"traceutil/trace.go:171","msg":"trace[1694103810] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:1; }","duration":"121.690368ms","start":"2026-10-19T01:54:15.97864Z","end":"2026-10-19T01:54:16.100331Z","steps":["trace[1694103810] 'count revisions from in-memory index tree' (duration: 121.528774ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:54:17.553127Z","caller":"traceutil/trace.go:171","msg":"trace[1420153720] linearizableReadLoop","detail":"{readStateIndex:12; appliedIndex:6; }","duration":"159.162488ms","start":"2026-10-19T01:54:17.393942Z","end":"2026-10-19T01:54:17.553105Z","steps":["trace[1420153720] 'read index received' (duration: 73.19265ms)","trace[1420153720] 'applied index is now lower than readState.Index' (duration: 85.969138ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T01:54:17.553246Z","caller":"traceutil/trace.go:171","msg":"trace[1582980998] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"160.716832ms","start":"2026-10-19T01:54:17.392507Z","end":"2026-10-19T01:54:17.553224Z","steps":["trace[1582980998] 'process raft request' (duration: 160.472567ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:54:17.5532Z","caller":"traceutil/trace.go:171","msg":"trace[699026449] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"160.883195ms","start":"2026-10-19T01:54:17.392298Z","end":"2026-10-19T01:54:17.553181Z","steps":["trace[699026449] 'process raft request' (duration: 160.65601ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:54:17.553358Z","caller":"traceutil/trace.go:171","msg":"trace[926068503] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"160.720802ms","start":"2026-10-19T01:54:17.392627Z","end":"2026-10-19T01:54:17.553348Z","steps":["trace[926068503] 'process raft request' (duration: 160.378834ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:54:17.553396Z","caller":"traceutil/trace.go:171","msg":"trace[2008422053] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"161.181801ms","start":"2026-10-19T01:54:17.392201Z","end":"2026-10-19T01:54:17.553382Z","steps":["trace[2008422053] 'process raft request' (duration: 160.686221ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:54:17.553508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.924447ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-10-19T01:54:17.553823Z","caller":"traceutil/trace.go:171","msg":"trace[1239470608] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:9; }","duration":"161.257254ms","start":"2026-10-19T01:54:17.392547Z","end":"2026-10-19T01:54:17.553804Z","steps":["trace[1239470608] 'agreement among raft nodes before linearized reading' (duration: 160.885105ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:54:17.553553Z","caller":"traceutil/trace.go:171","msg":"trace[176706401] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"162.124461ms","start":"2026-10-19T01:54:17.391401Z","end":"2026-10-19T01:54:17.553525Z","steps":["trace[176706401] 'process raft request' (duration: 75.635562ms)","trace[176706401] 'compare' (duration: 85.701243ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T01:54:17.553588Z","caller":"traceutil/trace.go:171","msg":"trace[1330731415] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"161.365245ms","start":"2026-10-19T01:54:17.392207Z","end":"2026-10-19T01:54:17.553572Z","steps":["trace[1330731415] 'process raft request' (duration: 160.714992ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:54:17.553668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.619655ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-10-19T01:54:17.554216Z","caller":"traceutil/trace.go:171","msg":"trace[673556420] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:9; }","duration":"164.217508ms","start":"2026-10-19T01:54:17.389988Z","end":"2026-10-19T01:54:17.554206Z","steps":["trace[673556420] 'agreement among raft nodes before linearized reading' (duration: 163.635334ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:54:17.553717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.375599ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-10-19T01:54:17.5544Z","caller":"traceutil/trace.go:171","msg":"trace[1898552907] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:9; }","duration":"164.049065ms","start":"2026-10-19T01:54:17.390304Z","end":"2026-10-19T01:54:17.554353Z","steps":["trace[1898552907] 'agreement among raft nodes before linearized reading' (duration: 163.38048ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:54:17.553736Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.081555ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.36\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-10-19T01:54:17.554564Z","caller":"traceutil/trace.go:171","msg":"trace[419972013] range","detail":"{range_begin:/registry/masterleases/162.253.55.36; range_end:; response_count:0; response_revision:9; }","duration":"164.941154ms","start":"2026-10-19T01:54:17.3896Z","end":"2026-10-19T01:54:17.554541Z","steps":["trace[419972013] 'agreement among raft nodes before linearized reading' (duration: 164.081185ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:54:18.05407Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9154588040546916485,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-10-19T01:54:18.788263Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"657.181079ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-10-19T01:54:18.788397Z","caller":"traceutil/trace.go:171","msg":"trace[1686233316] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"1.382093818s","start":"2026-10-19T01:54:17.406262Z","end":"2026-10-19T01:54:18.788355Z","steps":["trace[1686233316] 'process raft request' (duration: 724.230014ms)","trace[1686233316] 'compare' (duration: 657.032666ms)"],"step_count":2} {"level":"warn","ts":"2026-10-19T01:54:18.788451Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:54:17.406249Z","time spent":"1.382181021s","remote":"127.0.0.1:55394","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3158,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-19T01:54:19.192009Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.061454503s","expected-duration":"1s"} {"level":"warn","ts":"2026-10-19T01:54:19.557084Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000312245s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-10-19T01:54:19.557165Z","caller":"traceutil/trace.go:171","msg":"trace[1392429750] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000438258s","start":"2026-10-19T01:54:17.556709Z","end":"2026-10-19T01:54:19.557147Z","steps":["trace[1392429750] 'agreement among raft nodes before linearized reading' (duration: 2.000332255s)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:54:19.557211Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:54:17.55664Z","time spent":"2.000562901s","remote":"127.0.0.1:55212","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/10/19 01:54:19 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-10-19T01:54:19.870248Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"678.011164ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-10-19T01:54:19.870597Z","caller":"traceutil/trace.go:171","msg":"trace[1148738666] linearizableReadLoop","detail":"{readStateIndex:21; appliedIndex:12; }","duration":"2.317379914s","start":"2026-10-19T01:54:17.553197Z","end":"2026-10-19T01:54:19.870577Z","steps":["trace[1148738666] 'read index received' (duration: 577.313904ms)","trace[1148738666] 'applied index is now lower than readState.Index' (duration: 1.74006467s)"],"step_count":2} {"level":"info","ts":"2026-10-19T01:54:19.870594Z","caller":"traceutil/trace.go:171","msg":"trace[1890721916] transaction","detail":"{read_only:false; number_of_response:0; response_revision:14; }","duration":"2.310096225s","start":"2026-10-19T01:54:17.560468Z","end":"2026-10-19T01:54:19.870564Z","steps":["trace[1890721916] 'process raft request' (duration: 2.309976522s)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:54:19.870626Z","caller":"traceutil/trace.go:171","msg":"trace[1272568570] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"2.313741334s","start":"2026-10-19T01:54:17.556847Z","end":"2026-10-19T01:54:19.870589Z","steps":["trace[1272568570] 'process raft request' (duration: 1.635327462s)","trace[1272568570] 'compare' (duration: 677.862721ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T01:54:19.870678Z","caller":"traceutil/trace.go:171","msg":"trace[679605639] transaction","detail":"{read_only:false; response_revision:15; number_of_response:1; }","duration":"2.309692725s","start":"2026-10-19T01:54:17.560975Z","end":"2026-10-19T01:54:19.870668Z","steps":["trace[679605639] 'process raft request' (duration: 2.309490271s)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:54:19.870763Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:54:17.560964Z","time spent":"2.309766007s","remote":"127.0.0.1:55712","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":923,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-19T01:54:19.870775Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:54:17.560405Z","time spent":"2.310304719s","remote":"127.0.0.1:55330","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-19T01:54:19.870787Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:54:17.556823Z","time spent":"2.313899467s","remote":"127.0.0.1:55330","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":338,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-19T01:54:19.870772Z","caller":"traceutil/trace.go:171","msg":"trace[931963782] transaction","detail":"{read_only:false; response_revision:12; number_of_response:1; }","duration":"2.310608846s","start":"2026-10-19T01:54:17.560072Z","end":"2026-10-19T01:54:19.87068Z","steps":["trace[931963782] 'process raft request' (duration: 2.310261119s)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:54:19.870798Z","caller":"traceutil/trace.go:171","msg":"trace[615444416] transaction","detail":"{read_only:false; response_revision:14; number_of_response:1; }","duration":"2.310464653s","start":"2026-10-19T01:54:17.560308Z","end":"2026-10-19T01:54:19.870773Z","steps":["trace[615444416] 'process raft request' (duration: 2.310111636s)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:54:19.870911Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:54:17.560247Z","time spent":"2.310606346s","remote":"127.0.0.1:55712","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":941,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-19T01:54:19.870926Z","caller":"traceutil/trace.go:171","msg":"trace[1738444128] transaction","detail":"{read_only:false; response_revision:17; number_of_response:1; }","duration":"2.309884529s","start":"2026-10-19T01:54:17.56103Z","end":"2026-10-19T01:54:19.870915Z","steps":["trace[1738444128] 'process raft request' (duration: 2.309507051s)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:54:19.870933Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:54:17.560057Z","time spent":"2.31079625s","remote":"127.0.0.1:55712","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-19T01:54:19.870973Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:54:17.561014Z","time spent":"2.309933131s","remote":"127.0.0.1:55712","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":965,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-19T01:54:19.871057Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.400837918s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/default\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-10-19T01:54:19.871065Z","caller":"traceutil/trace.go:171","msg":"trace[341604109] transaction","detail":"{read_only:false; response_revision:16; number_of_response:1; }","duration":"2.310056944s","start":"2026-10-19T01:54:17.560998Z","end":"2026-10-19T01:54:19.871055Z","steps":["trace[341604109] 'process raft request' (duration: 2.309508322s)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:54:19.871097Z","caller":"traceutil/trace.go:171","msg":"trace[1229024944] range","detail":"{range_begin:/registry/namespaces/default; range_end:; response_count:0; response_revision:17; }","duration":"2.400880559s","start":"2026-10-19T01:54:17.470205Z","end":"2026-10-19T01:54:19.871086Z","steps":["trace[1229024944] 'agreement among raft nodes before linearized reading' (duration: 2.400753065s)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:54:19.871115Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:54:17.56098Z","time spent":"2.310112145s","remote":"127.0.0.1:55712","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":941,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-19T01:54:19.871127Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.396756009s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"warn","ts":"2026-10-19T01:54:19.871135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.42837507s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"warn","ts":"2026-10-19T01:54:19.871108Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.400225255s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"info","ts":"2026-10-19T01:54:19.871167Z","caller":"traceutil/trace.go:171","msg":"trace[59109657] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:17; }","duration":"2.396824949s","start":"2026-10-19T01:54:17.474331Z","end":"2026-10-19T01:54:19.871156Z","steps":["trace[59109657] 'agreement among raft nodes before linearized reading' (duration: 2.396746388s)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:54:19.871196Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:54:17.474319Z","time spent":"2.396870761s","remote":"127.0.0.1:55330","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":374,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-10-19T01:54:19.871193Z","caller":"traceutil/trace.go:171","msg":"trace[1188741935] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:17; }","duration":"2.400338157s","start":"2026-10-19T01:54:17.470837Z","end":"2026-10-19T01:54:19.871175Z","steps":["trace[1188741935] 'agreement among raft nodes before linearized reading' (duration: 2.40007167s)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:54:19.871203Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.421457008s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-10-19T01:54:19.871233Z","caller":"traceutil/trace.go:171","msg":"trace[242349422] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:17; }","duration":"2.421485569s","start":"2026-10-19T01:54:17.44974Z","end":"2026-10-19T01:54:19.871226Z","steps":["trace[242349422] 'agreement among raft nodes before linearized reading' (duration: 2.421444578s)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:54:19.871239Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:54:17.470823Z","time spent":"2.400402909s","remote":"127.0.0.1:55330","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":374,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-10-19T01:54:19.871257Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:54:17.449707Z","time spent":"2.4215445s","remote":"127.0.0.1:55590","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":0,"response size":28,"request content":"key:\"/registry/csinodes/instance\" "} {"level":"warn","ts":"2026-10-19T01:54:19.871135Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:54:17.470138Z","time spent":"2.400981141s","remote":"127.0.0.1:55330","response type":"/etcdserverpb.KV/Range","request count":0,"request size":30,"response count":0,"response size":28,"request content":"key:\"/registry/namespaces/default\" "} {"level":"info","ts":"2026-10-19T01:54:19.871169Z","caller":"traceutil/trace.go:171","msg":"trace[508279139] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:17; }","duration":"2.428473602s","start":"2026-10-19T01:54:17.442685Z","end":"2026-10-19T01:54:19.871158Z","steps":["trace[508279139] 'agreement among raft nodes before linearized reading' (duration: 2.428394651s)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:54:19.871396Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:54:17.442669Z","time spent":"2.428714297s","remote":"127.0.0.1:55330","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":374,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-10-19T01:54:19.87167Z","caller":"traceutil/trace.go:171","msg":"trace[603846898] transaction","detail":"{read_only:false; response_revision:13; number_of_response:1; }","duration":"2.311474525s","start":"2026-10-19T01:54:17.56018Z","end":"2026-10-19T01:54:19.871655Z","steps":["trace[603846898] 'process raft request' (duration: 2.310195457s)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:54:19.871402Z","caller":"traceutil/trace.go:171","msg":"trace[857720190] transaction","detail":"{read_only:false; response_revision:18; number_of_response:1; }","duration":"1.071938592s","start":"2026-10-19T01:54:18.799438Z","end":"2026-10-19T01:54:19.871377Z","steps":["trace[857720190] 'process raft request' (duration: 1.071815369s)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:54:19.871768Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:54:17.560172Z","time spent":"2.311553576s","remote":"127.0.0.1:55656","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":704,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-19T01:54:19.872087Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:54:18.799411Z","time spent":"1.072380202s","remote":"127.0.0.1:55394","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3478,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-19T01:54:19.881129Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.589963051s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/system-node-critical\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-10-19T01:54:19.881158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.546456811s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-10-19T01:54:19.881169Z","caller":"traceutil/trace.go:171","msg":"trace[758503624] transaction","detail":"{read_only:false; response_revision:19; number_of_response:1; }","duration":"400.87146ms","start":"2026-10-19T01:54:19.480278Z","end":"2026-10-19T01:54:19.88115Z","steps":["trace[758503624] 'process raft request' (duration: 400.577414ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:54:19.881177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.441287ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-10-19T01:54:19.88122Z","caller":"traceutil/trace.go:171","msg":"trace[1410599828] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:19; }","duration":"1.546535032s","start":"2026-10-19T01:54:18.334666Z","end":"2026-10-19T01:54:19.881201Z","steps":["trace[1410599828] 'agreement among raft nodes before linearized reading' (duration: 1.546361778s)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:54:19.881253Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.591106316s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-10-19T01:54:19.881266Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:54:19.480256Z","time spent":"400.959951ms","remote":"127.0.0.1:55464","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":849,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-19T01:54:19.881314Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.120974433s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-10-19T01:54:19.881353Z","caller":"traceutil/trace.go:171","msg":"trace[495691526] range","detail":"{range_begin:/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te; range_end:; response_count:0; response_revision:19; }","duration":"2.121043525s","start":"2026-10-19T01:54:17.760301Z","end":"2026-10-19T01:54:19.881345Z","steps":["trace[495691526] 'agreement among raft nodes before linearized reading' (duration: 2.120994514s)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:54:19.881381Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:54:17.760284Z","time spent":"2.121089795s","remote":"127.0.0.1:55474","response type":"/etcdserverpb.KV/Range","request count":0,"request size":67,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" "} {"level":"warn","ts":"2026-10-19T01:54:19.881414Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"845.180787ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"warn","ts":"2026-10-19T01:54:19.881282Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:54:18.334655Z","time spent":"1.546601953s","remote":"127.0.0.1:55210","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-10-19T01:54:19.881247Z","caller":"traceutil/trace.go:171","msg":"trace[2118357953] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:19; }","duration":"220.57951ms","start":"2026-10-19T01:54:19.660647Z","end":"2026-10-19T01:54:19.881227Z","steps":["trace[2118357953] 'agreement among raft nodes before linearized reading' (duration: 220.411187ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:54:19.881474Z","caller":"traceutil/trace.go:171","msg":"trace[363427040] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:19; }","duration":"845.29302ms","start":"2026-10-19T01:54:19.036152Z","end":"2026-10-19T01:54:19.881445Z","steps":["trace[363427040] 'agreement among raft nodes before linearized reading' (duration: 845.185048ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:54:19.881468Z","caller":"traceutil/trace.go:171","msg":"trace[391966054] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:19; }","duration":"1.591176587s","start":"2026-10-19T01:54:18.290102Z","end":"2026-10-19T01:54:19.881279Z","steps":["trace[391966054] 'agreement among raft nodes before linearized reading' (duration: 1.591122546s)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:54:19.881518Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:54:19.036131Z","time spent":"845.374941ms","remote":"127.0.0.1:55330","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":374,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-10-19T01:54:19.881529Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:54:18.290081Z","time spent":"1.591433212s","remote":"127.0.0.1:55558","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":28,"request content":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" "} {"level":"info","ts":"2026-10-19T01:54:19.881197Z","caller":"traceutil/trace.go:171","msg":"trace[797938985] range","detail":"{range_begin:/registry/priorityclasses/system-node-critical; range_end:; response_count:0; response_revision:19; }","duration":"1.590048962s","start":"2026-10-19T01:54:18.291131Z","end":"2026-10-19T01:54:19.88118Z","steps":["trace[797938985] 'agreement among raft nodes before linearized reading' (duration: 1.589885449s)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:54:19.881596Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:54:18.29112Z","time spent":"1.590454971s","remote":"127.0.0.1:55566","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":0,"response size":28,"request content":"key:\"/registry/priorityclasses/system-node-critical\" "} {"level":"info","ts":"2026-10-19T01:54:20.588972Z","caller":"traceutil/trace.go:171","msg":"trace[1233977756] transaction","detail":"{read_only:false; response_revision:90; number_of_response:1; }","duration":"137.475014ms","start":"2026-10-19T01:54:20.451443Z","end":"2026-10-19T01:54:20.588918Z","steps":["trace[1233977756] 'process raft request' (duration: 90.520928ms)","trace[1233977756] 'compare' (duration: 46.796082ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T01:54:20.589057Z","caller":"traceutil/trace.go:171","msg":"trace[1568358023] linearizableReadLoop","detail":"{readStateIndex:96; appliedIndex:94; }","duration":"135.429998ms","start":"2026-10-19T01:54:20.453612Z","end":"2026-10-19T01:54:20.589042Z","steps":["trace[1568358023] 'read index received' (duration: 88.36266ms)","trace[1568358023] 'applied index is now lower than readState.Index' (duration: 47.066568ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T01:54:20.589094Z","caller":"traceutil/trace.go:171","msg":"trace[39062423] transaction","detail":"{read_only:false; response_revision:91; number_of_response:1; }","duration":"135.697205ms","start":"2026-10-19T01:54:20.453375Z","end":"2026-10-19T01:54:20.589072Z","steps":["trace[39062423] 'process raft request' (duration: 135.48336ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:54:20.589146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.51824ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/default/instance.18dfcb6ecb900d2e\" ","response":"range_response_count:1 size:654"} {"level":"info","ts":"2026-10-19T01:54:20.58917Z","caller":"traceutil/trace.go:171","msg":"trace[38916038] range","detail":"{range_begin:/registry/events/default/instance.18dfcb6ecb900d2e; range_end:; response_count:1; response_revision:91; }","duration":"135.585972ms","start":"2026-10-19T01:54:20.453576Z","end":"2026-10-19T01:54:20.589162Z","steps":["trace[38916038] 'agreement among raft nodes before linearized reading' (duration: 135.524591ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:54:20.816881Z","caller":"traceutil/trace.go:171","msg":"trace[1365009331] transaction","detail":"{read_only:false; response_revision:102; number_of_response:1; }","duration":"139.268372ms","start":"2026-10-19T01:54:20.677597Z","end":"2026-10-19T01:54:20.816865Z","steps":["trace[1365009331] 'process raft request' (duration: 139.218731ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:54:20.816869Z","caller":"traceutil/trace.go:171","msg":"trace[1168898765] transaction","detail":"{read_only:false; response_revision:101; number_of_response:1; }","duration":"146.42368ms","start":"2026-10-19T01:54:20.670418Z","end":"2026-10-19T01:54:20.816842Z","steps":["trace[1168898765] 'process raft request' (duration: 63.517259ms)","trace[1168898765] 'compare' (duration: 82.740157ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T01:54:20.816956Z","caller":"traceutil/trace.go:171","msg":"trace[457959824] linearizableReadLoop","detail":"{readStateIndex:106; appliedIndex:104; }","duration":"146.447389ms","start":"2026-10-19T01:54:20.670486Z","end":"2026-10-19T01:54:20.816933Z","steps":["trace[457959824] 'read index received' (duration: 3.398653ms)","trace[457959824] 'applied index is now lower than readState.Index' (duration: 143.047026ms)"],"step_count":2} {"level":"warn","ts":"2026-10-19T01:54:20.817133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.627954ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/default/instance.18dfcb6ecb900d2e\" ","response":"range_response_count:1 size:654"} {"level":"info","ts":"2026-10-19T01:54:20.817198Z","caller":"traceutil/trace.go:171","msg":"trace[755076016] range","detail":"{range_begin:/registry/events/default/instance.18dfcb6ecb900d2e; range_end:; response_count:1; response_revision:102; }","duration":"146.715605ms","start":"2026-10-19T01:54:20.670463Z","end":"2026-10-19T01:54:20.817179Z","steps":["trace[755076016] 'agreement among raft nodes before linearized reading' (duration: 146.573462ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:54:21.479961Z","caller":"traceutil/trace.go:171","msg":"trace[993171585] linearizableReadLoop","detail":"{readStateIndex:127; appliedIndex:126; }","duration":"107.411827ms","start":"2026-10-19T01:54:21.372528Z","end":"2026-10-19T01:54:21.479939Z","steps":["trace[993171585] 'read index received' (duration: 85.572719ms)","trace[993171585] 'applied index is now lower than readState.Index' (duration: 21.831968ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T01:54:21.479996Z","caller":"traceutil/trace.go:171","msg":"trace[1734226184] transaction","detail":"{read_only:false; response_revision:122; number_of_response:1; }","duration":"107.526469ms","start":"2026-10-19T01:54:21.372442Z","end":"2026-10-19T01:54:21.479969Z","steps":["trace[1734226184] 'process raft request' (duration: 85.700632ms)","trace[1734226184] 'compare' (duration: 21.710005ms)"],"step_count":2} {"level":"warn","ts":"2026-10-19T01:54:21.480118Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.57441ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/default/instance.18dfcb6ecb905338\" ","response":"range_response_count:1 size:650"} {"level":"info","ts":"2026-10-19T01:54:21.480495Z","caller":"traceutil/trace.go:171","msg":"trace[345008536] range","detail":"{range_begin:/registry/events/default/instance.18dfcb6ecb905338; range_end:; response_count:1; response_revision:122; }","duration":"107.903297ms","start":"2026-10-19T01:54:21.372522Z","end":"2026-10-19T01:54:21.480425Z","steps":["trace[345008536] 'agreement among raft nodes before linearized reading' (duration: 107.511469ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:54:21.978581Z","caller":"traceutil/trace.go:171","msg":"trace[969594883] transaction","detail":"{read_only:false; response_revision:144; number_of_response:1; }","duration":"114.979632ms","start":"2026-10-19T01:54:21.863581Z","end":"2026-10-19T01:54:21.978561Z","steps":["trace[969594883] 'process raft request' (duration: 114.911301ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:54:21.978756Z","caller":"traceutil/trace.go:171","msg":"trace[1429238526] transaction","detail":"{read_only:false; response_revision:143; number_of_response:1; }","duration":"115.77461ms","start":"2026-10-19T01:54:21.862949Z","end":"2026-10-19T01:54:21.978724Z","steps":["trace[1429238526] 'process raft request' (duration: 62.581217ms)","trace[1429238526] 'compare' (duration: 52.883916ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T01:54:22.190239Z","caller":"traceutil/trace.go:171","msg":"trace[242193326] transaction","detail":"{read_only:false; response_revision:149; number_of_response:1; }","duration":"191.861252ms","start":"2026-10-19T01:54:21.998354Z","end":"2026-10-19T01:54:22.190215Z","steps":["trace[242193326] 'process raft request' (duration: 191.809301ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:54:22.19029Z","caller":"traceutil/trace.go:171","msg":"trace[1930535076] transaction","detail":"{read_only:false; response_revision:148; number_of_response:1; }","duration":"193.821245ms","start":"2026-10-19T01:54:21.996433Z","end":"2026-10-19T01:54:22.190254Z","steps":["trace[1930535076] 'process raft request' (duration: 112.15204ms)","trace[1930535076] 'compare' (duration: 81.420539ms)"],"step_count":2} {"level":"warn","ts":"2026-10-19T01:54:50.846345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.060645ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-19T01:54:50.84645Z","caller":"traceutil/trace.go:171","msg":"trace[280903522] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:483; }","duration":"102.210768ms","start":"2026-10-19T01:54:50.744214Z","end":"2026-10-19T01:54:50.846425Z","steps":["trace[280903522] 'range keys from in-memory index tree' (duration: 101.994733ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:55:01.720252Z","caller":"traceutil/trace.go:171","msg":"trace[1657264623] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"104.378995ms","start":"2026-10-19T01:55:01.61585Z","end":"2026-10-19T01:55:01.720229Z","steps":["trace[1657264623] 'process raft request' (duration: 104.259733ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:55:02.179202Z","caller":"traceutil/trace.go:171","msg":"trace[2020012119] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"145.24347ms","start":"2026-10-19T01:55:02.033934Z","end":"2026-10-19T01:55:02.179177Z","steps":["trace[2020012119] 'process raft request' (duration: 145.202339ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:55:02.179262Z","caller":"traceutil/trace.go:171","msg":"trace[852110743] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"145.333202ms","start":"2026-10-19T01:55:02.033907Z","end":"2026-10-19T01:55:02.17924Z","steps":["trace[852110743] 'process raft request' (duration: 126.861387ms)","trace[852110743] 'compare' (duration: 18.217349ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T01:55:02.50872Z","caller":"traceutil/trace.go:171","msg":"trace[1319564074] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"102.953494ms","start":"2026-10-19T01:55:02.405714Z","end":"2026-10-19T01:55:02.508667Z","steps":["trace[1319564074] 'process raft request' (duration: 77.131349ms)","trace[1319564074] 'compare' (duration: 25.717383ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T01:55:02.516075Z","caller":"traceutil/trace.go:171","msg":"trace[939026136] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"109.253682ms","start":"2026-10-19T01:55:02.406801Z","end":"2026-10-19T01:55:02.516054Z","steps":["trace[939026136] 'process raft request' (duration: 109.15581ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:55:04.540814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"335.695598ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-10-19T01:55:04.540862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.104571ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-10-19T01:55:04.540903Z","caller":"traceutil/trace.go:171","msg":"trace[2083400385] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:547; }","duration":"335.820881ms","start":"2026-10-19T01:55:04.20506Z","end":"2026-10-19T01:55:04.540881Z","steps":["trace[2083400385] 'range keys from in-memory index tree' (duration: 335.605816ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:55:04.540923Z","caller":"traceutil/trace.go:171","msg":"trace[510950660] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:547; }","duration":"327.192292ms","start":"2026-10-19T01:55:04.213712Z","end":"2026-10-19T01:55:04.540904Z","steps":["trace[510950660] 'range keys from in-memory index tree' (duration: 326.995858ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:55:04.540944Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:55:04.205045Z","time spent":"335.889872ms","remote":"127.0.0.1:55474","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-10-19T01:55:04.540961Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:55:04.213671Z","time spent":"327.282365ms","remote":"127.0.0.1:55474","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":"warn","ts":"2026-10-19T01:55:04.54075Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"562.851592ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-19T01:55:04.541111Z","caller":"traceutil/trace.go:171","msg":"trace[314794143] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:0; response_revision:547; }","duration":"563.251951ms","start":"2026-10-19T01:55:03.977847Z","end":"2026-10-19T01:55:04.541099Z","steps":["trace[314794143] 'range keys from in-memory index tree' (duration: 562.789731ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:55:04.541143Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:55:03.97783Z","time spent":"563.301673ms","remote":"127.0.0.1:55304","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":29,"request content":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" "} {"level":"info","ts":"2026-10-19T01:55:04.669619Z","caller":"traceutil/trace.go:171","msg":"trace[1719442178] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"124.224819ms","start":"2026-10-19T01:55:04.545368Z","end":"2026-10-19T01:55:04.669593Z","steps":["trace[1719442178] 'process raft request' (duration: 114.107878ms)","trace[1719442178] 'compare' (duration: 10.018579ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T01:55:08.139679Z","caller":"traceutil/trace.go:171","msg":"trace[2054534178] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"122.238826ms","start":"2026-10-19T01:55:08.017417Z","end":"2026-10-19T01:55:08.139656Z","steps":["trace[2054534178] 'process raft request' (duration: 121.270345ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:55:08.99934Z","caller":"traceutil/trace.go:171","msg":"trace[17660010] transaction","detail":"{read_only:false; response_revision:638; number_of_response:1; }","duration":"295.778595ms","start":"2026-10-19T01:55:08.703534Z","end":"2026-10-19T01:55:08.999313Z","steps":["trace[17660010] 'process raft request' (duration: 210.813795ms)","trace[17660010] 'compare' (duration: 84.627872ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T01:55:09.187862Z","caller":"traceutil/trace.go:171","msg":"trace[495843706] transaction","detail":"{read_only:false; response_revision:639; number_of_response:1; }","duration":"117.206135ms","start":"2026-10-19T01:55:09.070596Z","end":"2026-10-19T01:55:09.187802Z","steps":["trace[495843706] 'process raft request' (duration: 100.092681ms)","trace[495843706] 'compare' (duration: 16.834938ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T01:55:12.000058Z","caller":"traceutil/trace.go:171","msg":"trace[1320641331] linearizableReadLoop","detail":"{readStateIndex:685; appliedIndex:684; }","duration":"183.300863ms","start":"2026-10-19T01:55:11.816733Z","end":"2026-10-19T01:55:12.000034Z","steps":["trace[1320641331] 'read index received' (duration: 182.505495ms)","trace[1320641331] 'applied index is now lower than readState.Index' (duration: 794.368µs)"],"step_count":2} {"level":"info","ts":"2026-10-19T01:55:12.000111Z","caller":"traceutil/trace.go:171","msg":"trace[1539644399] transaction","detail":"{read_only:false; response_revision:656; number_of_response:1; }","duration":"338.406178ms","start":"2026-10-19T01:55:11.661673Z","end":"2026-10-19T01:55:12.000079Z","steps":["trace[1539644399] 'process raft request' (duration: 337.848486ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:55:12.000267Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:55:11.661641Z","time spent":"338.537791ms","remote":"127.0.0.1:55304","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036285,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-19T01:55:12.000623Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.891575ms","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-10-19T01:55:12.000778Z","caller":"traceutil/trace.go:171","msg":"trace[1874736981] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:656; }","duration":"184.114181ms","start":"2026-10-19T01:55:11.816647Z","end":"2026-10-19T01:55:12.000761Z","steps":["trace[1874736981] 'agreement among raft nodes before linearized reading' (duration: 183.524088ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:55:12.118779Z","caller":"traceutil/trace.go:171","msg":"trace[2084359468] transaction","detail":"{read_only:false; response_revision:657; number_of_response:1; }","duration":"113.204798ms","start":"2026-10-19T01:55:12.00554Z","end":"2026-10-19T01:55:12.118745Z","steps":["trace[2084359468] 'process raft request' (duration: 30.334523ms)","trace[2084359468] 'compare' (duration: 82.584158ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T01:55:12.119309Z","caller":"traceutil/trace.go:171","msg":"trace[388236153] transaction","detail":"{read_only:false; response_revision:658; number_of_response:1; }","duration":"112.706848ms","start":"2026-10-19T01:55:12.006103Z","end":"2026-10-19T01:55:12.118809Z","steps":["trace[388236153] 'process raft request' (duration: 112.504583ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:55:12.649666Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9154588040546917751,"retry-timeout":"500ms"} {"level":"info","ts":"2026-10-19T01:55:12.959585Z","caller":"traceutil/trace.go:171","msg":"trace[627501848] linearizableReadLoop","detail":"{readStateIndex:689; appliedIndex:688; }","duration":"810.324559ms","start":"2026-10-19T01:55:12.14923Z","end":"2026-10-19T01:55:12.959555Z","steps":["trace[627501848] 'read index received' (duration: 762.280768ms)","trace[627501848] 'applied index is now lower than readState.Index' (duration: 48.042501ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T01:55:12.959607Z","caller":"traceutil/trace.go:171","msg":"trace[1367807819] transaction","detail":"{read_only:false; response_revision:660; number_of_response:1; }","duration":"811.107547ms","start":"2026-10-19T01:55:12.148467Z","end":"2026-10-19T01:55:12.959574Z","steps":["trace[1367807819] 'process raft request' (duration: 763.075526ms)","trace[1367807819] 'compare' (duration: 47.729754ms)"],"step_count":2} {"level":"warn","ts":"2026-10-19T01:55:12.959781Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:55:12.148432Z","time spent":"811.244549ms","remote":"127.0.0.1:55400","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-19T01:55:12.959758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"810.511284ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-19T01:55:12.959842Z","caller":"traceutil/trace.go:171","msg":"trace[42886134] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:660; }","duration":"810.661547ms","start":"2026-10-19T01:55:12.149157Z","end":"2026-10-19T01:55:12.959819Z","steps":["trace[42886134] 'agreement among raft nodes before linearized reading' (duration: 810.493183ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:55:12.959888Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:55:12.149135Z","time spent":"810.745198ms","remote":"127.0.0.1:55444","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":29,"request content":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" "} {"level":"warn","ts":"2026-10-19T01:55:12.959899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.362838ms","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-10-19T01:55:12.959953Z","caller":"traceutil/trace.go:171","msg":"trace[2050848110] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:660; }","duration":"169.46311ms","start":"2026-10-19T01:55:12.790475Z","end":"2026-10-19T01:55:12.959938Z","steps":["trace[2050848110] 'agreement among raft nodes before linearized reading' (duration: 169.265755ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:55:12.959977Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.54681ms","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-10-19T01:55:12.960025Z","caller":"traceutil/trace.go:171","msg":"trace[1409614583] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:660; }","duration":"163.614402ms","start":"2026-10-19T01:55:12.796394Z","end":"2026-10-19T01:55:12.960008Z","steps":["trace[1409614583] 'agreement among raft nodes before linearized reading' (duration: 163.484438ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:55:14.33818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.233106005s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-19T01:55:14.338368Z","caller":"traceutil/trace.go:171","msg":"trace[1755748316] linearizableReadLoop","detail":"{readStateIndex:693; appliedIndex:692; }","duration":"977.613291ms","start":"2026-10-19T01:55:13.360718Z","end":"2026-10-19T01:55:14.338331Z","steps":["trace[1755748316] 'read index received' (duration: 34.291µs)","trace[1755748316] 'applied index is now lower than readState.Index' (duration: 977.57679ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T01:55:14.338457Z","caller":"traceutil/trace.go:171","msg":"trace[1933935125] transaction","detail":"{read_only:false; response_revision:663; number_of_response:1; }","duration":"1.353877918s","start":"2026-10-19T01:55:12.984554Z","end":"2026-10-19T01:55:14.338431Z","steps":["trace[1933935125] 'process raft request' (duration: 120.398075ms)","trace[1933935125] 'compare' (duration: 1.232996343s)"],"step_count":2} {"level":"warn","ts":"2026-10-19T01:55:14.338565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"977.843476ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-19T01:55:14.338572Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:55:12.984531Z","time spent":"1.353982921s","remote":"127.0.0.1:55234","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":118,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-19T01:55:14.338609Z","caller":"traceutil/trace.go:171","msg":"trace[333205397] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:663; }","duration":"977.930778ms","start":"2026-10-19T01:55:13.360666Z","end":"2026-10-19T01:55:14.338597Z","steps":["trace[333205397] 'agreement among raft nodes before linearized reading' (duration: 977.776095ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:55:14.338646Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:55:13.360649Z","time spent":"977.98829ms","remote":"127.0.0.1:55210","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-10-19T01:55:14.465685Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.090644816s","expected-duration":"1s"} {"level":"warn","ts":"2026-10-19T01:55:14.610057Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.536563ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-19T01:55:14.610202Z","caller":"traceutil/trace.go:171","msg":"trace[1276493173] linearizableReadLoop","detail":"{readStateIndex:694; appliedIndex:693; }","duration":"271.749039ms","start":"2026-10-19T01:55:14.33841Z","end":"2026-10-19T01:55:14.610159Z","steps":["trace[1276493173] 'read index received' (duration: 127.45192ms)","trace[1276493173] 'applied index is now lower than readState.Index' (duration: 144.296069ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T01:55:14.610199Z","caller":"traceutil/trace.go:171","msg":"trace[2010428071] transaction","detail":"{read_only:false; response_revision:664; number_of_response:1; }","duration":"1.237243945s","start":"2026-10-19T01:55:13.372929Z","end":"2026-10-19T01:55:14.610173Z","steps":["trace[2010428071] 'process raft request' (duration: 1.093509958s)","trace[2010428071] 'compare' (duration: 143.155345ms)"],"step_count":2} {"level":"warn","ts":"2026-10-19T01:55:14.610291Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:55:13.37289Z","time spent":"1.237353228s","remote":"127.0.0.1:55304","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036309,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-19T01:55:14.610365Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"486.416768ms","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-10-19T01:55:14.610391Z","caller":"traceutil/trace.go:171","msg":"trace[1351220580] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:664; }","duration":"486.459989ms","start":"2026-10-19T01:55:14.123921Z","end":"2026-10-19T01:55:14.610381Z","steps":["trace[1351220580] 'agreement among raft nodes before linearized reading' (duration: 486.343536ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:55:14.610423Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:55:14.123912Z","time spent":"486.50412ms","remote":"127.0.0.1:55474","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-10-19T01:55:14.610621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.103825ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-19T01:55:14.610665Z","caller":"traceutil/trace.go:171","msg":"trace[625183538] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:664; }","duration":"271.176576ms","start":"2026-10-19T01:55:14.339474Z","end":"2026-10-19T01:55:14.610651Z","steps":["trace[625183538] 'agreement among raft nodes before linearized reading' (duration: 271.106865ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:55:14.610778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"487.571165ms","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-10-19T01:55:14.610814Z","caller":"traceutil/trace.go:171","msg":"trace[95138347] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:664; }","duration":"487.660677ms","start":"2026-10-19T01:55:14.123144Z","end":"2026-10-19T01:55:14.610805Z","steps":["trace[95138347] 'agreement among raft nodes before linearized reading' (duration: 487.567504ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:55:14.610838Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:55:14.123125Z","time spent":"487.707157ms","remote":"127.0.0.1:55474","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-10-19T01:55:14.610897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.96656ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:421"} {"level":"info","ts":"2026-10-19T01:55:14.610951Z","caller":"traceutil/trace.go:171","msg":"trace[949023699] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:664; }","duration":"270.075522ms","start":"2026-10-19T01:55:14.340859Z","end":"2026-10-19T01:55:14.610934Z","steps":["trace[949023699] 'agreement among raft nodes before linearized reading' (duration: 269.93967ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:55:16.125236Z","caller":"traceutil/trace.go:171","msg":"trace[171353893] transaction","detail":"{read_only:false; response_revision:682; number_of_response:1; }","duration":"135.982397ms","start":"2026-10-19T01:55:15.989226Z","end":"2026-10-19T01:55:16.125208Z","steps":["trace[171353893] 'process raft request' (duration: 135.825943ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:55:17.035508Z","caller":"traceutil/trace.go:171","msg":"trace[875874124] transaction","detail":"{read_only:false; response_revision:695; number_of_response:1; }","duration":"409.993685ms","start":"2026-10-19T01:55:16.62549Z","end":"2026-10-19T01:55:17.035484Z","steps":["trace[875874124] 'process raft request' (duration: 409.884493ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:55:17.035879Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:55:16.625472Z","time spent":"410.317814ms","remote":"127.0.0.1:55474","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-19T01:55:17.106558Z","caller":"traceutil/trace.go:171","msg":"trace[2078033791] transaction","detail":"{read_only:false; response_revision:696; number_of_response:1; }","duration":"478.607428ms","start":"2026-10-19T01:55:16.62793Z","end":"2026-10-19T01:55:17.106537Z","steps":["trace[2078033791] 'process raft request' (duration: 478.384633ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:55:17.106662Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:55:16.627911Z","time spent":"478.700049ms","remote":"127.0.0.1:55474","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-19T01:55:17.106832Z","caller":"traceutil/trace.go:171","msg":"trace[70102641] transaction","detail":"{read_only:false; response_revision:697; number_of_response:1; }","duration":"348.54536ms","start":"2026-10-19T01:55:16.758257Z","end":"2026-10-19T01:55:17.106802Z","steps":["trace[70102641] 'process raft request' (duration: 348.213163ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:55:17.106992Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:55:16.758234Z","time spent":"348.693063ms","remote":"127.0.0.1:55246","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3353,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-19T01:55:17.107155Z","caller":"traceutil/trace.go:171","msg":"trace[1027689517] transaction","detail":"{read_only:false; response_revision:698; number_of_response:1; }","duration":"146.346893ms","start":"2026-10-19T01:55:16.960771Z","end":"2026-10-19T01:55:17.107118Z","steps":["trace[1027689517] 'process raft request' (duration: 145.966325ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:55:27.286795Z","caller":"traceutil/trace.go:171","msg":"trace[1635695638] transaction","detail":"{read_only:false; response_revision:802; number_of_response:1; }","duration":"133.42831ms","start":"2026-10-19T01:55:27.153342Z","end":"2026-10-19T01:55:27.28677Z","steps":["trace[1635695638] 'process raft request' (duration: 133.273517ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:55:27.310171Z","caller":"traceutil/trace.go:171","msg":"trace[413694743] transaction","detail":"{read_only:false; response_revision:803; number_of_response:1; }","duration":"153.811308ms","start":"2026-10-19T01:55:27.156335Z","end":"2026-10-19T01:55:27.310147Z","steps":["trace[413694743] 'process raft request' (duration: 153.604192ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:55:27.471199Z","caller":"traceutil/trace.go:171","msg":"trace[195683026] transaction","detail":"{read_only:false; response_revision:805; number_of_response:1; }","duration":"155.890074ms","start":"2026-10-19T01:55:27.315287Z","end":"2026-10-19T01:55:27.471177Z","steps":["trace[195683026] 'process raft request' (duration: 155.73759ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:55:27.471443Z","caller":"traceutil/trace.go:171","msg":"trace[135838054] transaction","detail":"{read_only:false; response_revision:806; number_of_response:1; }","duration":"154.81397ms","start":"2026-10-19T01:55:27.316604Z","end":"2026-10-19T01:55:27.471418Z","steps":["trace[135838054] 'process raft request' (duration: 154.536664ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:55:27.471982Z","caller":"traceutil/trace.go:171","msg":"trace[40656030] transaction","detail":"{read_only:false; response_revision:807; number_of_response:1; }","duration":"152.835055ms","start":"2026-10-19T01:55:27.319129Z","end":"2026-10-19T01:55:27.471964Z","steps":["trace[40656030] 'process raft request' (duration: 152.238483ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:55:28.650464Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.468007ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-10-19T01:55:28.650552Z","caller":"traceutil/trace.go:171","msg":"trace[1803033208] linearizableReadLoop","detail":"{readStateIndex:851; appliedIndex:850; }","duration":"198.643068ms","start":"2026-10-19T01:55:28.451893Z","end":"2026-10-19T01:55:28.650536Z","steps":["trace[1803033208] 'read index received' (duration: 73.055179ms)","trace[1803033208] 'applied index is now lower than readState.Index' (duration: 125.586279ms)"],"step_count":2} {"level":"warn","ts":"2026-10-19T01:55:28.65078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.881514ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-19T01:55:28.65081Z","caller":"traceutil/trace.go:171","msg":"trace[727882474] range","detail":"{range_begin:/registry/roles/; range_end:/registry/roles0; response_count:0; response_revision:815; }","duration":"198.949575ms","start":"2026-10-19T01:55:28.451851Z","end":"2026-10-19T01:55:28.650801Z","steps":["trace[727882474] 'agreement among raft nodes before linearized reading' (duration: 198.880584ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:55:28.651177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.432764ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-19T01:55:28.651203Z","caller":"traceutil/trace.go:171","msg":"trace[2113662582] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:815; }","duration":"198.514245ms","start":"2026-10-19T01:55:28.45268Z","end":"2026-10-19T01:55:28.651194Z","steps":["trace[2113662582] 'agreement among raft nodes before linearized reading' (duration: 198.469644ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:55:28.651354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.437759ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-19T01:55:28.651387Z","caller":"traceutil/trace.go:171","msg":"trace[1427924634] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:815; }","duration":"121.49336ms","start":"2026-10-19T01:55:28.529885Z","end":"2026-10-19T01:55:28.651378Z","steps":["trace[1427924634] 'agreement among raft nodes before linearized reading' (duration: 121.444399ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:55:28.651517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.233427ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-19T01:55:28.651549Z","caller":"traceutil/trace.go:171","msg":"trace[2089121063] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:815; }","duration":"122.269308ms","start":"2026-10-19T01:55:28.529272Z","end":"2026-10-19T01:55:28.651541Z","steps":["trace[2089121063] 'agreement among raft nodes before linearized reading' (duration: 122.220067ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:55:28.651659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.476632ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-19T01:55:28.651712Z","caller":"traceutil/trace.go:171","msg":"trace[2036337779] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:815; }","duration":"122.523323ms","start":"2026-10-19T01:55:28.529161Z","end":"2026-10-19T01:55:28.651685Z","steps":["trace[2036337779] 'agreement among raft nodes before linearized reading' (duration: 122.475252ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:55:28.651831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.172724ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-19T01:55:28.651879Z","caller":"traceutil/trace.go:171","msg":"trace[1726114058] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:815; }","duration":"148.216914ms","start":"2026-10-19T01:55:28.503638Z","end":"2026-10-19T01:55:28.651855Z","steps":["trace[1726114058] 'agreement among raft nodes before linearized reading' (duration: 148.169443ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:55:28.652017Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.879349ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-19T01:55:28.652047Z","caller":"traceutil/trace.go:171","msg":"trace[552313097] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:815; }","duration":"148.93095ms","start":"2026-10-19T01:55:28.503109Z","end":"2026-10-19T01:55:28.65204Z","steps":["trace[552313097] 'agreement among raft nodes before linearized reading' (duration: 148.886529ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:55:28.652215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.379004ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-19T01:55:28.652284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.177105ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-19T01:55:28.652338Z","caller":"traceutil/trace.go:171","msg":"trace[706049480] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:815; }","duration":"149.266787ms","start":"2026-10-19T01:55:28.503059Z","end":"2026-10-19T01:55:28.652326Z","steps":["trace[706049480] 'agreement among raft nodes before linearized reading' (duration: 149.192446ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:55:28.652448Z","caller":"traceutil/trace.go:171","msg":"trace[2144144357] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:815; }","duration":"199.511517ms","start":"2026-10-19T01:55:28.452788Z","end":"2026-10-19T01:55:28.6523Z","steps":["trace[2144144357] 'agreement among raft nodes before linearized reading' (duration: 199.373274ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:55:28.652623Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.928044ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-19T01:55:28.652662Z","caller":"traceutil/trace.go:171","msg":"trace[1346773201] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:815; }","duration":"199.006986ms","start":"2026-10-19T01:55:28.453645Z","end":"2026-10-19T01:55:28.652652Z","steps":["trace[1346773201] 'agreement among raft nodes before linearized reading' (duration: 198.952185ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:55:28.652818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.519129ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-19T01:55:28.652851Z","caller":"traceutil/trace.go:171","msg":"trace[1501141708] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:815; }","duration":"178.5853ms","start":"2026-10-19T01:55:28.474257Z","end":"2026-10-19T01:55:28.652843Z","steps":["trace[1501141708] 'agreement among raft nodes before linearized reading' (duration: 178.536679ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:55:28.652249Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.628988ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-19T01:55:28.653384Z","caller":"traceutil/trace.go:171","msg":"trace[1880409445] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:815; }","duration":"178.791534ms","start":"2026-10-19T01:55:28.474573Z","end":"2026-10-19T01:55:28.653364Z","steps":["trace[1880409445] 'agreement among raft nodes before linearized reading' (duration: 177.618129ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:55:31.826975Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9154588040546918145,"retry-timeout":"500ms"} {"level":"info","ts":"2026-10-19T01:55:31.93178Z","caller":"traceutil/trace.go:171","msg":"trace[1352987863] transaction","detail":"{read_only:false; response_revision:829; number_of_response:1; }","duration":"677.704847ms","start":"2026-10-19T01:55:31.254054Z","end":"2026-10-19T01:55:31.931759Z","steps":["trace[1352987863] 'process raft request' (duration: 677.556003ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:55:31.931925Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:55:31.254033Z","time spent":"677.808549ms","remote":"127.0.0.1:55400","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4027,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-19T01:55:31.94056Z","caller":"traceutil/trace.go:171","msg":"trace[1628686019] linearizableReadLoop","detail":"{readStateIndex:866; appliedIndex:864; }","duration":"614.492422ms","start":"2026-10-19T01:55:31.326049Z","end":"2026-10-19T01:55:31.940541Z","steps":["trace[1628686019] 'read index received' (duration: 605.577447ms)","trace[1628686019] 'applied index is now lower than readState.Index' (duration: 8.914045ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T01:55:31.940633Z","caller":"traceutil/trace.go:171","msg":"trace[291271514] transaction","detail":"{read_only:false; response_revision:830; number_of_response:1; }","duration":"323.39659ms","start":"2026-10-19T01:55:31.617217Z","end":"2026-10-19T01:55:31.940614Z","steps":["trace[291271514] 'process raft request' (duration: 323.201826ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:55:31.940776Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:55:31.617186Z","time spent":"323.501342ms","remote":"127.0.0.1:55474","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-19T01:55:31.940797Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"441.491265ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-19T01:55:31.94084Z","caller":"traceutil/trace.go:171","msg":"trace[566246410] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:830; }","duration":"441.558587ms","start":"2026-10-19T01:55:31.49927Z","end":"2026-10-19T01:55:31.940829Z","steps":["trace[566246410] 'agreement among raft nodes before linearized reading' (duration: 441.488755ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:55:31.940869Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:55:31.49926Z","time spent":"441.600877ms","remote":"127.0.0.1:55344","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":0,"response size":29,"request content":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true "} {"level":"warn","ts":"2026-10-19T01:55:31.94087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"584.751111ms","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-10-19T01:55:31.940917Z","caller":"traceutil/trace.go:171","msg":"trace[1842179040] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:830; }","duration":"584.824223ms","start":"2026-10-19T01:55:31.356079Z","end":"2026-10-19T01:55:31.940903Z","steps":["trace[1842179040] 'agreement among raft nodes before linearized reading' (duration: 584.583608ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:55:31.940926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"454.889518ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-10-19T01:55:31.940955Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:55:31.356067Z","time spent":"584.877414ms","remote":"127.0.0.1:55474","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-10-19T01:55:31.940979Z","caller":"traceutil/trace.go:171","msg":"trace[688816681] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:830; }","duration":"454.96621ms","start":"2026-10-19T01:55:31.485998Z","end":"2026-10-19T01:55:31.940965Z","steps":["trace[688816681] 'agreement among raft nodes before linearized reading' (duration: 454.828448ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:55:31.940974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"456.707648ms","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-10-19T01:55:31.94102Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:55:31.485986Z","time spent":"455.021371ms","remote":"127.0.0.1:55474","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-10-19T01:55:31.941035Z","caller":"traceutil/trace.go:171","msg":"trace[869943056] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:830; }","duration":"456.798081ms","start":"2026-10-19T01:55:31.48422Z","end":"2026-10-19T01:55:31.941018Z","steps":["trace[869943056] 'agreement among raft nodes before linearized reading' (duration: 456.632037ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:55:31.941073Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:55:31.484207Z","time spent":"456.854601ms","remote":"127.0.0.1:55474","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-10-19T01:55:31.943012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"616.939165ms","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-10-19T01:55:31.943168Z","caller":"traceutil/trace.go:171","msg":"trace[2058952479] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:830; }","duration":"617.132991ms","start":"2026-10-19T01:55:31.326016Z","end":"2026-10-19T01:55:31.943149Z","steps":["trace[2058952479] 'agreement among raft nodes before linearized reading' (duration: 614.630976ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:55:31.943216Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:55:31.326003Z","time spent":"617.200332ms","remote":"127.0.0.1:55474","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-10-19T01:55:43.120387Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.790879ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/\" range_end:\"/registry/masterleases0\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-10-19T01:55:43.120463Z","caller":"traceutil/trace.go:171","msg":"trace[2024433915] range","detail":"{range_begin:/registry/masterleases/; range_end:/registry/masterleases0; response_count:1; response_revision:953; }","duration":"113.903892ms","start":"2026-10-19T01:55:43.006543Z","end":"2026-10-19T01:55:43.120446Z","steps":["trace[2024433915] 'range keys from in-memory index tree' (duration: 113.732499ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:56:08.865773Z","caller":"traceutil/trace.go:171","msg":"trace[681258240] transaction","detail":"{read_only:false; response_revision:1054; number_of_response:1; }","duration":"108.493413ms","start":"2026-10-19T01:56:08.757265Z","end":"2026-10-19T01:56:08.865758Z","steps":["trace[681258240] 'process raft request' (duration: 108.37549ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:56:10.349856Z","caller":"traceutil/trace.go:171","msg":"trace[2081033799] linearizableReadLoop","detail":"{readStateIndex:1151; appliedIndex:1150; }","duration":"134.420753ms","start":"2026-10-19T01:56:10.215406Z","end":"2026-10-19T01:56:10.349827Z","steps":["trace[2081033799] 'read index received' (duration: 134.25747ms)","trace[2081033799] 'applied index is now lower than readState.Index' (duration: 161.943µs)"],"step_count":2} {"level":"info","ts":"2026-10-19T01:56:10.349952Z","caller":"traceutil/trace.go:171","msg":"trace[1452739158] transaction","detail":"{read_only:false; response_revision:1105; number_of_response:1; }","duration":"203.822377ms","start":"2026-10-19T01:56:10.146099Z","end":"2026-10-19T01:56:10.349921Z","steps":["trace[1452739158] 'process raft request' (duration: 203.552721ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:56:10.350124Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.862997ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-10-19T01:56:10.350159Z","caller":"traceutil/trace.go:171","msg":"trace[1659486865] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1105; }","duration":"131.943608ms","start":"2026-10-19T01:56:10.2182Z","end":"2026-10-19T01:56:10.350144Z","steps":["trace[1659486865] 'agreement among raft nodes before linearized reading' (duration: 131.786855ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:56:10.350212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.003207ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-10-19T01:56:10.350191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.77354ms","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-10-19T01:56:10.350244Z","caller":"traceutil/trace.go:171","msg":"trace[169822831] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1105; }","duration":"131.106851ms","start":"2026-10-19T01:56:10.219128Z","end":"2026-10-19T01:56:10.350235Z","steps":["trace[169822831] 'agreement among raft nodes before linearized reading' (duration: 130.982647ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:56:10.350272Z","caller":"traceutil/trace.go:171","msg":"trace[1185314701] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1105; }","duration":"134.907784ms","start":"2026-10-19T01:56:10.215343Z","end":"2026-10-19T01:56:10.350251Z","steps":["trace[1185314701] 'agreement among raft nodes before linearized reading' (duration: 134.648228ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:56:12.682107Z","caller":"traceutil/trace.go:171","msg":"trace[320659020] linearizableReadLoop","detail":"{readStateIndex:1157; appliedIndex:1156; }","duration":"321.184905ms","start":"2026-10-19T01:56:12.360899Z","end":"2026-10-19T01:56:12.682084Z","steps":["trace[320659020] 'read index received' (duration: 321.041622ms)","trace[320659020] 'applied index is now lower than readState.Index' (duration: 142.383µs)"],"step_count":2} {"level":"info","ts":"2026-10-19T01:56:12.682174Z","caller":"traceutil/trace.go:171","msg":"trace[1837421912] transaction","detail":"{read_only:false; response_revision:1111; number_of_response:1; }","duration":"323.269651ms","start":"2026-10-19T01:56:12.358871Z","end":"2026-10-19T01:56:12.682141Z","steps":["trace[1837421912] 'process raft request' (duration: 323.073077ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:56:12.682269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"321.360669ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-19T01:56:12.682313Z","caller":"traceutil/trace.go:171","msg":"trace[1652207618] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1111; }","duration":"321.443531ms","start":"2026-10-19T01:56:12.360853Z","end":"2026-10-19T01:56:12.682296Z","steps":["trace[1652207618] 'agreement among raft nodes before linearized reading' (duration: 321.363859ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:56:12.68237Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:56:12.360822Z","time spent":"321.537223ms","remote":"127.0.0.1:55210","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-10-19T01:56:12.682322Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:56:12.358854Z","time spent":"323.386994ms","remote":"127.0.0.1:55474","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-19T01:56:13.222853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.887806ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-19T01:56:13.222927Z","caller":"traceutil/trace.go:171","msg":"trace[1036523633] linearizableReadLoop","detail":"{readStateIndex:1158; appliedIndex:1157; }","duration":"540.721108ms","start":"2026-10-19T01:56:12.682192Z","end":"2026-10-19T01:56:13.222914Z","steps":["trace[1036523633] 'read index received' (duration: 307.651278ms)","trace[1036523633] 'applied index is now lower than readState.Index' (duration: 233.06898ms)"],"step_count":2} {"level":"warn","ts":"2026-10-19T01:56:13.223076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"607.826782ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-10-19T01:56:13.223121Z","caller":"traceutil/trace.go:171","msg":"trace[638371063] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1112; }","duration":"607.926895ms","start":"2026-10-19T01:56:12.615186Z","end":"2026-10-19T01:56:13.223113Z","steps":["trace[638371063] 'agreement among raft nodes before linearized reading' (duration: 607.782572ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:56:13.223131Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"805.402452ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-10-19T01:56:13.22315Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:56:12.615134Z","time spent":"608.009546ms","remote":"127.0.0.1:55474","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-10-19T01:56:13.223199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"805.587626ms","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-10-19T01:56:13.22322Z","caller":"traceutil/trace.go:171","msg":"trace[2061563382] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1112; }","duration":"805.646218ms","start":"2026-10-19T01:56:12.417569Z","end":"2026-10-19T01:56:13.223215Z","steps":["trace[2061563382] 'agreement among raft nodes before linearized reading' (duration: 805.594287ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:56:13.223235Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"539.850898ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-19T01:56:13.223238Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:56:12.417546Z","time spent":"805.686318ms","remote":"127.0.0.1:55474","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-10-19T01:56:13.223257Z","caller":"traceutil/trace.go:171","msg":"trace[416381608] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1112; }","duration":"539.90212ms","start":"2026-10-19T01:56:12.683349Z","end":"2026-10-19T01:56:13.223252Z","steps":["trace[416381608] 'agreement among raft nodes before linearized reading' (duration: 539.869799ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:56:13.223276Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:56:12.68331Z","time spent":"539.960481ms","remote":"127.0.0.1:55212","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-10-19T01:56:13.223152Z","caller":"traceutil/trace.go:171","msg":"trace[1857541728] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1112; }","duration":"805.474473ms","start":"2026-10-19T01:56:12.41767Z","end":"2026-10-19T01:56:13.223145Z","steps":["trace[1857541728] 'agreement among raft nodes before linearized reading' (duration: 805.421952ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:56:13.223354Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:56:12.41764Z","time spent":"805.70658ms","remote":"127.0.0.1:55474","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-10-19T01:56:13.223368Z","caller":"traceutil/trace.go:171","msg":"trace[214399563] transaction","detail":"{read_only:false; response_revision:1112; number_of_response:1; }","duration":"727.90022ms","start":"2026-10-19T01:56:12.495444Z","end":"2026-10-19T01:56:13.223344Z","steps":["trace[214399563] 'process raft request' (duration: 494.449921ms)","trace[214399563] 'compare' (duration: 232.798404ms)"],"step_count":2} {"level":"warn","ts":"2026-10-19T01:56:13.223424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.76033ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.36\" ","response":"range_response_count:1 size:133"} {"level":"warn","ts":"2026-10-19T01:56:13.223077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"810.126786ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-10-19T01:56:13.223448Z","caller":"traceutil/trace.go:171","msg":"trace[1062305704] range","detail":"{range_begin:/registry/masterleases/162.253.55.36; range_end:; response_count:1; response_revision:1112; }","duration":"256.853993ms","start":"2026-10-19T01:56:12.966587Z","end":"2026-10-19T01:56:13.223441Z","steps":["trace[1062305704] 'agreement among raft nodes before linearized reading' (duration: 256.790531ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:56:13.223455Z","caller":"traceutil/trace.go:171","msg":"trace[1442846509] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1112; }","duration":"810.545086ms","start":"2026-10-19T01:56:12.412903Z","end":"2026-10-19T01:56:13.223449Z","steps":["trace[1442846509] 'agreement among raft nodes before linearized reading' (duration: 810.082945ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:56:13.223472Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:56:12.495409Z","time spent":"727.999212ms","remote":"127.0.0.1:55474","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-19T01:56:13.223512Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:56:12.41287Z","time spent":"810.599666ms","remote":"127.0.0.1:55474","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-10-19T01:56:13.22305Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"595.783418ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-19T01:56:13.223606Z","caller":"traceutil/trace.go:171","msg":"trace[895766106] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:1112; }","duration":"596.397801ms","start":"2026-10-19T01:56:12.627201Z","end":"2026-10-19T01:56:13.223599Z","steps":["trace[895766106] 'agreement among raft nodes before linearized reading' (duration: 595.745866ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:56:13.223636Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:56:12.627184Z","time spent":"596.443383ms","remote":"127.0.0.1:55426","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":29,"request content":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true "} {"level":"info","ts":"2026-10-19T01:56:15.385499Z","caller":"traceutil/trace.go:171","msg":"trace[2089950599] transaction","detail":"{read_only:false; response_revision:1123; number_of_response:1; }","duration":"112.86854ms","start":"2026-10-19T01:56:15.272613Z","end":"2026-10-19T01:56:15.385481Z","steps":["trace[2089950599] 'process raft request' (duration: 112.820569ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:56:15.385663Z","caller":"traceutil/trace.go:171","msg":"trace[747937917] transaction","detail":"{read_only:false; response_revision:1122; number_of_response:1; }","duration":"113.116715ms","start":"2026-10-19T01:56:15.272541Z","end":"2026-10-19T01:56:15.385658Z","steps":["trace[747937917] 'process raft request' (duration: 112.813888ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:56:15.385862Z","caller":"traceutil/trace.go:171","msg":"trace[1346292740] transaction","detail":"{read_only:false; response_revision:1124; number_of_response:1; }","duration":"111.50403ms","start":"2026-10-19T01:56:15.274353Z","end":"2026-10-19T01:56:15.385857Z","steps":["trace[1346292740] 'process raft request' (duration: 111.108082ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:56:26.880873Z","caller":"traceutil/trace.go:171","msg":"trace[1925125355] linearizableReadLoop","detail":"{readStateIndex:1207; appliedIndex:1206; }","duration":"100.961897ms","start":"2026-10-19T01:56:26.779889Z","end":"2026-10-19T01:56:26.880851Z","steps":["trace[1925125355] 'read index received' (duration: 100.773043ms)","trace[1925125355] 'applied index is now lower than readState.Index' (duration: 187.804µs)"],"step_count":2} {"level":"info","ts":"2026-10-19T01:56:26.880959Z","caller":"traceutil/trace.go:171","msg":"trace[1250515809] transaction","detail":"{read_only:false; response_revision:1158; number_of_response:1; }","duration":"224.794359ms","start":"2026-10-19T01:56:26.656133Z","end":"2026-10-19T01:56:26.880928Z","steps":["trace[1250515809] 'process raft request' (duration: 224.554804ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:56:26.881046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.143222ms","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-10-19T01:56:26.881091Z","caller":"traceutil/trace.go:171","msg":"trace[1025355000] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1158; }","duration":"101.243793ms","start":"2026-10-19T01:56:26.779837Z","end":"2026-10-19T01:56:26.881081Z","steps":["trace[1025355000] 'agreement among raft nodes before linearized reading' (duration: 101.09304ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:56:27.109773Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.262382ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-19T01:56:27.109835Z","caller":"traceutil/trace.go:171","msg":"trace[1342913671] transaction","detail":"{read_only:false; response_revision:1159; number_of_response:1; }","duration":"224.393279ms","start":"2026-10-19T01:56:26.885431Z","end":"2026-10-19T01:56:27.109824Z","steps":["trace[1342913671] 'process raft request' (duration: 99.026485ms)","trace[1342913671] 'compare' (duration: 125.17765ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T01:56:27.824292Z","caller":"traceutil/trace.go:171","msg":"trace[2074655944] linearizableReadLoop","detail":"{readStateIndex:1209; appliedIndex:1208; }","duration":"336.751488ms","start":"2026-10-19T01:56:27.487512Z","end":"2026-10-19T01:56:27.824264Z","steps":["trace[2074655944] 'read index received' (duration: 320.617553ms)","trace[2074655944] 'applied index is now lower than readState.Index' (duration: 16.132555ms)"],"step_count":2} {"level":"warn","ts":"2026-10-19T01:56:27.825285Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.369626ms","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-10-19T01:56:27.825339Z","caller":"traceutil/trace.go:171","msg":"trace[1323523550] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1160; }","duration":"294.457289ms","start":"2026-10-19T01:56:27.53087Z","end":"2026-10-19T01:56:27.825328Z","steps":["trace[1323523550] 'agreement among raft nodes before linearized reading' (duration: 294.298985ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:56:27.825345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.948291ms","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-10-19T01:56:27.825415Z","caller":"traceutil/trace.go:171","msg":"trace[375204029] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1160; }","duration":"266.045684ms","start":"2026-10-19T01:56:27.559355Z","end":"2026-10-19T01:56:27.825401Z","steps":["trace[375204029] 'agreement among raft nodes before linearized reading' (duration: 265.845179ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:56:27.825433Z","caller":"traceutil/trace.go:171","msg":"trace[836470207] transaction","detail":"{read_only:false; response_revision:1160; number_of_response:1; }","duration":"467.946921ms","start":"2026-10-19T01:56:27.357478Z","end":"2026-10-19T01:56:27.825425Z","steps":["trace[836470207] 'process raft request' (duration: 450.714191ms)","trace[836470207] 'compare' (duration: 15.957651ms)"],"step_count":2} {"level":"warn","ts":"2026-10-19T01:56:27.825482Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:56:27.357462Z","time spent":"467.983451ms","remote":"127.0.0.1:55474","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-19T01:56:27.825452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.541776ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-10-19T01:56:27.825567Z","caller":"traceutil/trace.go:171","msg":"trace[1950196781] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1160; }","duration":"266.690339ms","start":"2026-10-19T01:56:27.558853Z","end":"2026-10-19T01:56:27.825544Z","steps":["trace[1950196781] 'agreement among raft nodes before linearized reading' (duration: 266.388202ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:56:27.825828Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"337.824931ms","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-10-19T01:56:27.825938Z","caller":"traceutil/trace.go:171","msg":"trace[2048114804] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1160; }","duration":"338.462985ms","start":"2026-10-19T01:56:27.487454Z","end":"2026-10-19T01:56:27.825917Z","steps":["trace[2048114804] 'agreement among raft nodes before linearized reading' (duration: 337.670937ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:56:27.826286Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:56:27.487409Z","time spent":"338.857803ms","remote":"127.0.0.1:55474","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-10-19T01:56:29.605968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.533221ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-19T01:56:29.606044Z","caller":"traceutil/trace.go:171","msg":"trace[1242966319] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1165; }","duration":"244.645673ms","start":"2026-10-19T01:56:29.361378Z","end":"2026-10-19T01:56:29.606024Z","steps":["trace[1242966319] 'range keys from in-memory index tree' (duration: 244.46034ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:56:29.606087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.8016ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-19T01:56:29.60617Z","caller":"traceutil/trace.go:171","msg":"trace[1572096642] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:1165; }","duration":"276.925223ms","start":"2026-10-19T01:56:29.329223Z","end":"2026-10-19T01:56:29.606148Z","steps":["trace[1572096642] 'count revisions from in-memory index tree' (duration: 276.740308ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:56:29.606163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"342.191417ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-19T01:56:29.60632Z","caller":"traceutil/trace.go:171","msg":"trace[244508412] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1165; }","duration":"342.363591ms","start":"2026-10-19T01:56:29.263933Z","end":"2026-10-19T01:56:29.606297Z","steps":["trace[244508412] 'range keys from in-memory index tree' (duration: 342.157837ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:56:29.944599Z","caller":"traceutil/trace.go:171","msg":"trace[1331408246] transaction","detail":"{read_only:false; response_revision:1166; number_of_response:1; }","duration":"114.170657ms","start":"2026-10-19T01:56:29.830396Z","end":"2026-10-19T01:56:29.944567Z","steps":["trace[1331408246] 'process raft request' (duration: 113.958382ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:56:30.152858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.190565ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-19T01:56:30.15298Z","caller":"traceutil/trace.go:171","msg":"trace[1663869160] transaction","detail":"{read_only:false; response_revision:1167; number_of_response:1; }","duration":"202.878187ms","start":"2026-10-19T01:56:29.950081Z","end":"2026-10-19T01:56:30.152959Z","steps":["trace[1663869160] 'process raft request' (duration: 95.488098ms)","trace[1663869160] 'compare' (duration: 107.025601ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T01:56:30.199845Z","caller":"traceutil/trace.go:171","msg":"trace[732563163] transaction","detail":"{read_only:false; response_revision:1168; number_of_response:1; }","duration":"249.360538ms","start":"2026-10-19T01:56:29.950457Z","end":"2026-10-19T01:56:30.199818Z","steps":["trace[732563163] 'process raft request' (duration: 249.091112ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:56:30.199874Z","caller":"traceutil/trace.go:171","msg":"trace[1443333228] transaction","detail":"{read_only:false; response_revision:1169; number_of_response:1; }","duration":"248.849746ms","start":"2026-10-19T01:56:29.951003Z","end":"2026-10-19T01:56:30.199853Z","steps":["trace[1443333228] 'process raft request' (duration: 248.694893ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:56:30.200212Z","caller":"traceutil/trace.go:171","msg":"trace[1501968948] transaction","detail":"{read_only:false; response_revision:1170; number_of_response:1; }","duration":"248.278475ms","start":"2026-10-19T01:56:29.951913Z","end":"2026-10-19T01:56:30.200192Z","steps":["trace[1501968948] 'process raft request' (duration: 247.863265ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:56:31.682899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"544.024972ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-19T01:56:31.683592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"495.936675ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-10-19T01:56:31.68374Z","caller":"traceutil/trace.go:171","msg":"trace[606489039] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1170; }","duration":"496.092757ms","start":"2026-10-19T01:56:31.187603Z","end":"2026-10-19T01:56:31.683695Z","steps":["trace[606489039] 'range keys from in-memory index tree' (duration: 495.686859ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:56:31.683848Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:56:31.187581Z","time spent":"496.249941ms","remote":"127.0.0.1:55474","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":"info","ts":"2026-10-19T01:56:31.683612Z","caller":"traceutil/trace.go:171","msg":"trace[203270350] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:1170; }","duration":"544.797257ms","start":"2026-10-19T01:56:31.138792Z","end":"2026-10-19T01:56:31.683589Z","steps":["trace[203270350] 'count revisions from in-memory index tree' (duration: 543.945039ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:56:31.684166Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:56:31.13877Z","time spent":"545.365341ms","remote":"127.0.0.1:38480","response type":"/etcdserverpb.KV/Range","request count":0,"request size":112,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true "} {"level":"warn","ts":"2026-10-19T01:56:31.683427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"321.238936ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-19T01:56:31.684324Z","caller":"traceutil/trace.go:171","msg":"trace[984954229] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1170; }","duration":"322.204067ms","start":"2026-10-19T01:56:31.362108Z","end":"2026-10-19T01:56:31.684312Z","steps":["trace[984954229] 'range keys from in-memory index tree' (duration: 321.127884ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:56:31.684434Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:56:31.362085Z","time spent":"322.331161ms","remote":"127.0.0.1:55212","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-10-19T01:56:31.683384Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"941.683727ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-19T01:56:31.684698Z","caller":"traceutil/trace.go:171","msg":"trace[1925638681] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1170; }","duration":"943.098558ms","start":"2026-10-19T01:56:30.741585Z","end":"2026-10-19T01:56:31.684683Z","steps":["trace[1925638681] 'range keys from in-memory index tree' (duration: 941.536854ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:56:31.684814Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:56:30.741558Z","time spent":"943.239521ms","remote":"127.0.0.1:55210","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-10-19T01:56:32.493204Z","caller":"traceutil/trace.go:171","msg":"trace[1166881495] transaction","detail":"{read_only:false; response_revision:1173; number_of_response:1; }","duration":"270.598345ms","start":"2026-10-19T01:56:32.222576Z","end":"2026-10-19T01:56:32.493174Z","steps":["trace[1166881495] 'process raft request' (duration: 270.410691ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:56:32.870273Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.845936ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-19T01:56:32.870481Z","caller":"traceutil/trace.go:171","msg":"trace[940964453] transaction","detail":"{read_only:false; response_revision:1175; number_of_response:1; }","duration":"647.842302ms","start":"2026-10-19T01:56:32.222624Z","end":"2026-10-19T01:56:32.870467Z","steps":["trace[940964453] 'process raft request' (duration: 647.73387ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:56:32.870525Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:56:32.222598Z","time spent":"647.906823ms","remote":"127.0.0.1:55474","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-19T01:56:32.870587Z","caller":"traceutil/trace.go:171","msg":"trace[636887882] transaction","detail":"{read_only:false; response_revision:1174; number_of_response:1; }","duration":"647.899573ms","start":"2026-10-19T01:56:32.222646Z","end":"2026-10-19T01:56:32.870545Z","steps":["trace[636887882] 'process raft request' (duration: 510.693939ms)","trace[636887882] 'compare' (duration: 136.553999ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T01:56:32.870664Z","caller":"traceutil/trace.go:171","msg":"trace[989797611] linearizableReadLoop","detail":"{readStateIndex:1226; appliedIndex:1222; }","duration":"508.991672ms","start":"2026-10-19T01:56:32.36165Z","end":"2026-10-19T01:56:32.870642Z","steps":["trace[989797611] 'read index received' (duration: 131.354396ms)","trace[989797611] 'applied index is now lower than readState.Index' (duration: 377.635686ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T01:56:32.870717Z","caller":"traceutil/trace.go:171","msg":"trace[2011000041] transaction","detail":"{read_only:false; response_revision:1176; number_of_response:1; }","duration":"647.662598ms","start":"2026-10-19T01:56:32.223029Z","end":"2026-10-19T01:56:32.870692Z","steps":["trace[2011000041] 'process raft request' (duration: 647.412103ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:56:32.870757Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:56:32.22301Z","time spent":"647.726079ms","remote":"127.0.0.1:55474","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-19T01:56:32.870804Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:56:32.222593Z","time spent":"648.086117ms","remote":"127.0.0.1:55474","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-19T01:56:32.870917Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"509.262237ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-19T01:56:32.870966Z","caller":"traceutil/trace.go:171","msg":"trace[261913285] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1176; }","duration":"509.344639ms","start":"2026-10-19T01:56:32.361607Z","end":"2026-10-19T01:56:32.870952Z","steps":["trace[261913285] 'agreement among raft nodes before linearized reading' (duration: 509.128775ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:56:32.871002Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:56:32.361588Z","time spent":"509.40471ms","remote":"127.0.0.1:55210","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-10-19T01:56:33.221343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.889248ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:41"} {"level":"warn","ts":"2026-10-19T01:56:33.634259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.823716ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:42"} {"level":"info","ts":"2026-10-19T01:56:33.634395Z","caller":"traceutil/trace.go:171","msg":"trace[1011922352] linearizableReadLoop","detail":"{readStateIndex:1229; appliedIndex:1228; }","duration":"352.858922ms","start":"2026-10-19T01:56:33.281512Z","end":"2026-10-19T01:56:33.634371Z","steps":["trace[1011922352] 'read index received' (duration: 164.976165ms)","trace[1011922352] 'applied index is now lower than readState.Index' (duration: 187.880737ms)"],"step_count":2} {"level":"warn","ts":"2026-10-19T01:56:33.634488Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:56:33.272531Z","time spent":"361.947921ms","remote":"127.0.0.1:55292","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-10-19T01:56:33.634616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"353.096977ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:421"} {"level":"info","ts":"2026-10-19T01:56:33.634668Z","caller":"traceutil/trace.go:171","msg":"trace[1327523935] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:1177; }","duration":"353.20663ms","start":"2026-10-19T01:56:33.281447Z","end":"2026-10-19T01:56:33.634654Z","steps":["trace[1327523935] 'agreement among raft nodes before linearized reading' (duration: 353.068457ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:56:33.634733Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:56:33.2814Z","time spent":"353.298782ms","remote":"127.0.0.1:55380","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":445,"request content":"key:\"/registry/services/endpoints/default/kubernetes\" "} {"level":"warn","ts":"2026-10-19T01:56:33.635248Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.538295ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-19T01:56:33.635286Z","caller":"traceutil/trace.go:171","msg":"trace[1604989706] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1177; }","duration":"271.634517ms","start":"2026-10-19T01:56:33.363642Z","end":"2026-10-19T01:56:33.635276Z","steps":["trace[1604989706] 'agreement among raft nodes before linearized reading' (duration: 271.570155ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:56:34.205337Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"430.654849ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-10-19T01:56:34.205444Z","caller":"traceutil/trace.go:171","msg":"trace[1044856322] linearizableReadLoop","detail":"{readStateIndex:1230; appliedIndex:1229; }","duration":"568.944058ms","start":"2026-10-19T01:56:33.636484Z","end":"2026-10-19T01:56:34.205428Z","steps":["trace[1044856322] 'read index received' (duration: 138.041433ms)","trace[1044856322] 'applied index is now lower than readState.Index' (duration: 430.901575ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T01:56:34.20547Z","caller":"traceutil/trace.go:171","msg":"trace[339741021] transaction","detail":"{read_only:false; response_revision:1178; number_of_response:1; }","duration":"569.830758ms","start":"2026-10-19T01:56:33.635608Z","end":"2026-10-19T01:56:34.205439Z","steps":["trace[339741021] 'process raft request' (duration: 138.982744ms)","trace[339741021] 'compare' (duration: 430.530967ms)"],"step_count":2} {"level":"warn","ts":"2026-10-19T01:56:34.205619Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:56:33.635587Z","time spent":"569.950441ms","remote":"127.0.0.1:55292","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":839,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-19T01:56:34.205664Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"569.196613ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/\" range_end:\"/registry/masterleases0\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-10-19T01:56:34.205694Z","caller":"traceutil/trace.go:171","msg":"trace[1386247948] range","detail":"{range_begin:/registry/masterleases/; range_end:/registry/masterleases0; response_count:1; response_revision:1178; }","duration":"569.279455ms","start":"2026-10-19T01:56:33.636405Z","end":"2026-10-19T01:56:34.205685Z","steps":["trace[1386247948] 'agreement among raft nodes before linearized reading' (duration: 569.087151ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:56:34.205768Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:56:33.636342Z","time spent":"569.41768ms","remote":"127.0.0.1:55234","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/\" range_end:\"/registry/masterleases0\" "} {"level":"warn","ts":"2026-10-19T01:56:34.706545Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9154588040546918901,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-10-19T01:56:35.080746Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.095982996s","expected-duration":"1s"} {"level":"info","ts":"2026-10-19T01:56:35.081335Z","caller":"traceutil/trace.go:171","msg":"trace[238732487] transaction","detail":"{read_only:false; response_revision:1179; number_of_response:1; }","duration":"1.096703992s","start":"2026-10-19T01:56:33.984606Z","end":"2026-10-19T01:56:35.08131Z","steps":["trace[238732487] 'process raft request' (duration: 1.096306534s)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:56:35.081593Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:56:33.984577Z","time spent":"1.096826014s","remote":"127.0.0.1:55474","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-19T01:56:35.411399Z","caller":"traceutil/trace.go:171","msg":"trace[1658002018] linearizableReadLoop","detail":"{readStateIndex:1232; appliedIndex:1230; }","duration":"1.205905762s","start":"2026-10-19T01:56:34.205466Z","end":"2026-10-19T01:56:35.411372Z","steps":["trace[1658002018] 'read index received' (duration: 875.596906ms)","trace[1658002018] 'applied index is now lower than readState.Index' (duration: 330.307186ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T01:56:35.411543Z","caller":"traceutil/trace.go:171","msg":"trace[1923409858] transaction","detail":"{read_only:false; response_revision:1180; number_of_response:1; }","duration":"1.398629144s","start":"2026-10-19T01:56:34.012902Z","end":"2026-10-19T01:56:35.411531Z","steps":["trace[1923409858] 'process raft request' (duration: 1.354581836s)","trace[1923409858] 'compare' (duration: 43.70456ms)"],"step_count":2} {"level":"warn","ts":"2026-10-19T01:56:35.411621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.203949468s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:480"} {"level":"warn","ts":"2026-10-19T01:56:35.411655Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:56:34.012873Z","time spent":"1.398695116s","remote":"127.0.0.1:55474","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-19T01:56:35.411685Z","caller":"traceutil/trace.go:171","msg":"trace[670029177] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:1180; }","duration":"1.20405542s","start":"2026-10-19T01:56:34.207613Z","end":"2026-10-19T01:56:35.411668Z","steps":["trace[670029177] 'agreement among raft nodes before linearized reading' (duration: 1.203938148s)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:56:35.411746Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:56:34.207594Z","time spent":"1.204144002s","remote":"127.0.0.1:55478","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":504,"request content":"key:\"/registry/endpointslices/default/kubernetes\" "} {"level":"warn","ts":"2026-10-19T01:56:35.412025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"536.003225ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-10-19T01:56:35.41206Z","caller":"traceutil/trace.go:171","msg":"trace[1086791642] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1180; }","duration":"536.057526ms","start":"2026-10-19T01:56:34.875988Z","end":"2026-10-19T01:56:35.412046Z","steps":["trace[1086791642] 'agreement among raft nodes before linearized reading' (duration: 535.939184ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:56:35.412086Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:56:34.875973Z","time spent":"536.106797ms","remote":"127.0.0.1:55474","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":"warn","ts":"2026-10-19T01:56:35.412069Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.049520176s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-19T01:56:35.412163Z","caller":"traceutil/trace.go:171","msg":"trace[1826745211] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1180; }","duration":"1.049663409s","start":"2026-10-19T01:56:34.362474Z","end":"2026-10-19T01:56:35.412137Z","steps":["trace[1826745211] 'agreement among raft nodes before linearized reading' (duration: 1.049481495s)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:56:35.412217Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:56:34.362451Z","time spent":"1.049754921s","remote":"127.0.0.1:55212","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-10-19T01:56:35.412244Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.696224831s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-10-19T01:56:35.412215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"536.133548ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-10-19T01:56:35.412276Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"535.539984ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-10-19T01:56:35.412278Z","caller":"traceutil/trace.go:171","msg":"trace[312435592] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1180; }","duration":"1.696287563s","start":"2026-10-19T01:56:33.715979Z","end":"2026-10-19T01:56:35.412266Z","steps":["trace[312435592] 'agreement among raft nodes before linearized reading' (duration: 1.69614738s)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:56:35.412306Z","caller":"traceutil/trace.go:171","msg":"trace[1836488014] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1180; }","duration":"535.598846ms","start":"2026-10-19T01:56:34.876699Z","end":"2026-10-19T01:56:35.412297Z","steps":["trace[1836488014] 'agreement among raft nodes before linearized reading' (duration: 535.442352ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:56:35.412312Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:56:33.715959Z","time spent":"1.696346704s","remote":"127.0.0.1:55474","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-10-19T01:56:35.4121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.677903ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-19T01:56:35.412412Z","caller":"traceutil/trace.go:171","msg":"trace[1275762629] range","detail":"{range_begin:/registry/controllerrevisions/; range_end:/registry/controllerrevisions0; response_count:0; response_revision:1180; }","duration":"173.027391ms","start":"2026-10-19T01:56:35.239369Z","end":"2026-10-19T01:56:35.412397Z","steps":["trace[1275762629] 'agreement among raft nodes before linearized reading' (duration: 172.681493ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:56:35.412438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"914.484219ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-10-19T01:56:35.412472Z","caller":"traceutil/trace.go:171","msg":"trace[1951674601] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1180; }","duration":"914.562531ms","start":"2026-10-19T01:56:34.4979Z","end":"2026-10-19T01:56:35.412463Z","steps":["trace[1951674601] 'agreement among raft nodes before linearized reading' (duration: 914.413028ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:56:35.412515Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:56:34.497879Z","time spent":"914.629992ms","remote":"127.0.0.1:55474","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-10-19T01:56:35.412326Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:56:34.876695Z","time spent":"535.627066ms","remote":"127.0.0.1:55474","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-10-19T01:56:35.412309Z","caller":"traceutil/trace.go:171","msg":"trace[146219413] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1180; }","duration":"536.26037ms","start":"2026-10-19T01:56:34.876027Z","end":"2026-10-19T01:56:35.412287Z","steps":["trace[146219413] 'agreement among raft nodes before linearized reading' (duration: 535.886892ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:56:35.412657Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:56:34.876022Z","time spent":"536.621898ms","remote":"127.0.0.1:55474","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-10-19T01:56:35.555611Z","caller":"traceutil/trace.go:171","msg":"trace[189544363] transaction","detail":"{read_only:false; response_revision:1182; number_of_response:1; }","duration":"136.719904ms","start":"2026-10-19T01:56:35.41886Z","end":"2026-10-19T01:56:35.55558Z","steps":["trace[189544363] 'process raft request' (duration: 100.583479ms)","trace[189544363] 'compare' (duration: 35.864338ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T01:56:35.555743Z","caller":"traceutil/trace.go:171","msg":"trace[1420933808] transaction","detail":"{read_only:false; response_revision:1184; number_of_response:1; }","duration":"136.367637ms","start":"2026-10-19T01:56:35.419307Z","end":"2026-10-19T01:56:35.555674Z","steps":["trace[1420933808] 'process raft request' (duration: 136.180513ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:56:35.555773Z","caller":"traceutil/trace.go:171","msg":"trace[593897791] transaction","detail":"{read_only:false; response_revision:1183; number_of_response:1; }","duration":"136.644572ms","start":"2026-10-19T01:56:35.4191Z","end":"2026-10-19T01:56:35.555745Z","steps":["trace[593897791] 'process raft request' (duration: 136.347205ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:56:35.555602Z","caller":"traceutil/trace.go:171","msg":"trace[1280557440] linearizableReadLoop","detail":"{readStateIndex:1237; appliedIndex:1233; }","duration":"133.918783ms","start":"2026-10-19T01:56:35.421658Z","end":"2026-10-19T01:56:35.555577Z","steps":["trace[1280557440] 'read index received' (duration: 27.478754ms)","trace[1280557440] 'applied index is now lower than readState.Index' (duration: 106.438739ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T01:56:35.555841Z","caller":"traceutil/trace.go:171","msg":"trace[547539686] transaction","detail":"{read_only:false; response_revision:1185; number_of_response:1; }","duration":"136.300325ms","start":"2026-10-19T01:56:35.41953Z","end":"2026-10-19T01:56:35.55583Z","steps":["trace[547539686] 'process raft request' (duration: 135.994468ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:56:35.556084Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.037365ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-19T01:56:35.556157Z","caller":"traceutil/trace.go:171","msg":"trace[543913615] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1185; }","duration":"134.516856ms","start":"2026-10-19T01:56:35.421622Z","end":"2026-10-19T01:56:35.556139Z","steps":["trace[543913615] 'agreement among raft nodes before linearized reading' (duration: 134.033805ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:56:36.074895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.447345ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:5316"} {"level":"info","ts":"2026-10-19T01:56:36.074995Z","caller":"traceutil/trace.go:171","msg":"trace[678901294] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:1186; }","duration":"155.607069ms","start":"2026-10-19T01:56:35.919362Z","end":"2026-10-19T01:56:36.074969Z","steps":["trace[678901294] 'range keys from in-memory index tree' (duration: 155.156577ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:56:36.675272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"343.832053ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-10-19T01:56:36.675372Z","caller":"traceutil/trace.go:171","msg":"trace[1464388164] linearizableReadLoop","detail":"{readStateIndex:1240; appliedIndex:1239; }","duration":"140.944626ms","start":"2026-10-19T01:56:36.534413Z","end":"2026-10-19T01:56:36.675357Z","steps":["trace[1464388164] 'read index received' (duration: 44.291µs)","trace[1464388164] 'applied index is now lower than readState.Index' (duration: 140.898605ms)"],"step_count":2} {"level":"warn","ts":"2026-10-19T01:56:36.675457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.044457ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-19T01:56:36.675485Z","caller":"traceutil/trace.go:171","msg":"trace[1388178883] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:1188; }","duration":"141.115609ms","start":"2026-10-19T01:56:36.534359Z","end":"2026-10-19T01:56:36.675474Z","steps":["trace[1388178883] 'agreement among raft nodes before linearized reading' (duration: 141.037647ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:56:36.675725Z","caller":"traceutil/trace.go:171","msg":"trace[2034134055] transaction","detail":"{read_only:false; response_revision:1188; number_of_response:1; }","duration":"423.502444ms","start":"2026-10-19T01:56:36.252173Z","end":"2026-10-19T01:56:36.675675Z","steps":["trace[2034134055] 'process raft request' (duration: 79.17436ms)","trace[2034134055] 'compare' (duration: 343.528016ms)"],"step_count":2} {"level":"warn","ts":"2026-10-19T01:56:36.675799Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:56:36.252146Z","time spent":"423.616186ms","remote":"127.0.0.1:55292","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":822,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-19T01:56:37.454188Z","caller":"traceutil/trace.go:171","msg":"trace[1360572220] transaction","detail":"{read_only:false; response_revision:1189; number_of_response:1; }","duration":"456.747964ms","start":"2026-10-19T01:56:36.997416Z","end":"2026-10-19T01:56:37.454164Z","steps":["trace[1360572220] 'process raft request' (duration: 456.60178ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:56:37.454359Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:56:36.997391Z","time spent":"456.859676ms","remote":"127.0.0.1:55474","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-19T01:56:37.632937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.174606ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-19T01:56:37.633077Z","caller":"traceutil/trace.go:171","msg":"trace[1879587541] linearizableReadLoop","detail":"{readStateIndex:1242; appliedIndex:1241; }","duration":"271.355279ms","start":"2026-10-19T01:56:37.3617Z","end":"2026-10-19T01:56:37.633055Z","steps":["trace[1879587541] 'read index received' (duration: 92.44843ms)","trace[1879587541] 'applied index is now lower than readState.Index' (duration: 178.901399ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T01:56:37.633134Z","caller":"traceutil/trace.go:171","msg":"trace[267908841] transaction","detail":"{read_only:false; response_revision:1190; number_of_response:1; }","duration":"546.461073ms","start":"2026-10-19T01:56:37.086648Z","end":"2026-10-19T01:56:37.633109Z","steps":["trace[267908841] 'process raft request' (duration: 433.010911ms)","trace[267908841] 'compare' (duration: 113.025903ms)"],"step_count":2} {"level":"warn","ts":"2026-10-19T01:56:37.633168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.460082ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-19T01:56:37.633238Z","caller":"traceutil/trace.go:171","msg":"trace[1962338430] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1190; }","duration":"271.571905ms","start":"2026-10-19T01:56:37.361648Z","end":"2026-10-19T01:56:37.63322Z","steps":["trace[1962338430] 'agreement among raft nodes before linearized reading' (duration: 271.466483ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:56:37.633234Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:56:37.086619Z","time spent":"546.566206ms","remote":"127.0.0.1:55474","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-19T01:56:37.633324Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.790332ms","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-10-19T01:56:37.633372Z","caller":"traceutil/trace.go:171","msg":"trace[444772902] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1190; }","duration":"180.879124ms","start":"2026-10-19T01:56:37.452479Z","end":"2026-10-19T01:56:37.633359Z","steps":["trace[444772902] 'agreement among raft nodes before linearized reading' (duration: 180.688199ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:56:37.836291Z","caller":"traceutil/trace.go:171","msg":"trace[1102543956] transaction","detail":"{read_only:false; response_revision:1192; number_of_response:1; }","duration":"198.578921ms","start":"2026-10-19T01:56:37.637689Z","end":"2026-10-19T01:56:37.836268Z","steps":["trace[1102543956] 'process raft request' (duration: 198.367686ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:56:37.836571Z","caller":"traceutil/trace.go:171","msg":"trace[359310493] transaction","detail":"{read_only:false; response_revision:1195; number_of_response:1; }","duration":"198.702065ms","start":"2026-10-19T01:56:37.637848Z","end":"2026-10-19T01:56:37.836551Z","steps":["trace[359310493] 'process raft request' (duration: 198.667714ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:56:37.836573Z","caller":"traceutil/trace.go:171","msg":"trace[1546386343] transaction","detail":"{read_only:false; response_revision:1193; number_of_response:1; }","duration":"198.871808ms","start":"2026-10-19T01:56:37.637675Z","end":"2026-10-19T01:56:37.836546Z","steps":["trace[1546386343] 'process raft request' (duration: 198.55796ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:56:37.836615Z","caller":"traceutil/trace.go:171","msg":"trace[1604052277] transaction","detail":"{read_only:false; response_revision:1194; number_of_response:1; }","duration":"198.775396ms","start":"2026-10-19T01:56:37.637814Z","end":"2026-10-19T01:56:37.836589Z","steps":["trace[1604052277] 'process raft request' (duration: 198.628863ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:56:40.306862Z","caller":"traceutil/trace.go:171","msg":"trace[287536005] transaction","detail":"{read_only:false; response_revision:1212; number_of_response:1; }","duration":"107.143954ms","start":"2026-10-19T01:56:40.19969Z","end":"2026-10-19T01:56:40.306834Z","steps":["trace[287536005] 'process raft request' (duration: 106.975061ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:56:40.442976Z","caller":"traceutil/trace.go:171","msg":"trace[2105094277] transaction","detail":"{read_only:false; response_revision:1213; number_of_response:1; }","duration":"129.136476ms","start":"2026-10-19T01:56:40.313818Z","end":"2026-10-19T01:56:40.442955Z","steps":["trace[2105094277] 'process raft request' (duration: 128.970923ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:56:40.644626Z","caller":"traceutil/trace.go:171","msg":"trace[1521785862] transaction","detail":"{read_only:false; response_revision:1214; number_of_response:1; }","duration":"115.173079ms","start":"2026-10-19T01:56:40.529426Z","end":"2026-10-19T01:56:40.644599Z","steps":["trace[1521785862] 'process raft request' (duration: 114.933264ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:56:45.028483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"879.565008ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-19T01:56:45.028555Z","caller":"traceutil/trace.go:171","msg":"trace[2058105895] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:0; response_revision:1239; }","duration":"879.68494ms","start":"2026-10-19T01:56:44.148854Z","end":"2026-10-19T01:56:45.028539Z","steps":["trace[2058105895] 'range keys from in-memory index tree' (duration: 879.461536ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:56:45.028591Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:56:44.148834Z","time spent":"879.748362ms","remote":"127.0.0.1:55474","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":0,"response size":29,"request content":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-10-19T01:56:45.02862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"665.777983ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-19T01:56:45.028673Z","caller":"traceutil/trace.go:171","msg":"trace[1579331682] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1239; }","duration":"665.873645ms","start":"2026-10-19T01:56:44.362784Z","end":"2026-10-19T01:56:45.028658Z","steps":["trace[1579331682] 'range keys from in-memory index tree' (duration: 665.67863ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:56:45.028734Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:56:44.362761Z","time spent":"665.939526ms","remote":"127.0.0.1:55210","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-10-19T01:56:45.771818Z","caller":"traceutil/trace.go:171","msg":"trace[1768615106] linearizableReadLoop","detail":"{readStateIndex:1294; appliedIndex:1293; }","duration":"409.159897ms","start":"2026-10-19T01:56:45.362637Z","end":"2026-10-19T01:56:45.771797Z","steps":["trace[1768615106] 'read index received' (duration: 409.018814ms)","trace[1768615106] 'applied index is now lower than readState.Index' (duration: 140.333µs)"],"step_count":2} {"level":"info","ts":"2026-10-19T01:56:45.771984Z","caller":"traceutil/trace.go:171","msg":"trace[1062958133] transaction","detail":"{read_only:false; response_revision:1240; number_of_response:1; }","duration":"738.166673ms","start":"2026-10-19T01:56:45.033684Z","end":"2026-10-19T01:56:45.771851Z","steps":["trace[1062958133] 'process raft request' (duration: 737.966828ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:56:45.77205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"409.383651ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-19T01:56:45.772274Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:56:45.033666Z","time spent":"738.51119ms","remote":"127.0.0.1:55474","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":492,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-19T01:56:45.77232Z","caller":"traceutil/trace.go:171","msg":"trace[278752182] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1240; }","duration":"409.702819ms","start":"2026-10-19T01:56:45.362596Z","end":"2026-10-19T01:56:45.772299Z","steps":["trace[278752182] 'agreement among raft nodes before linearized reading' (duration: 409.31344ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:56:45.772387Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:56:45.362578Z","time spent":"409.780721ms","remote":"127.0.0.1:55210","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-10-19T01:56:45.776829Z","caller":"traceutil/trace.go:171","msg":"trace[1835220292] transaction","detail":"{read_only:false; response_revision:1241; number_of_response:1; }","duration":"115.280722ms","start":"2026-10-19T01:56:45.661532Z","end":"2026-10-19T01:56:45.776813Z","steps":["trace[1835220292] 'process raft request' (duration: 114.808071ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:56:45.776941Z","caller":"traceutil/trace.go:171","msg":"trace[1932313224] transaction","detail":"{read_only:false; response_revision:1242; number_of_response:1; }","duration":"104.948395ms","start":"2026-10-19T01:56:45.671971Z","end":"2026-10-19T01:56:45.776919Z","steps":["trace[1932313224] 'process raft request' (duration: 104.511705ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:56:45.911068Z","caller":"traceutil/trace.go:171","msg":"trace[1173939503] transaction","detail":"{read_only:false; response_revision:1243; number_of_response:1; }","duration":"129.383203ms","start":"2026-10-19T01:56:45.781661Z","end":"2026-10-19T01:56:45.911044Z","steps":["trace[1173939503] 'process raft request' (duration: 129.217858ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:56:45.920185Z","caller":"traceutil/trace.go:171","msg":"trace[1630521490] transaction","detail":"{read_only:false; response_revision:1244; number_of_response:1; }","duration":"137.891838ms","start":"2026-10-19T01:56:45.782274Z","end":"2026-10-19T01:56:45.920166Z","steps":["trace[1630521490] 'process raft request' (duration: 137.725805ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:56:45.92026Z","caller":"traceutil/trace.go:171","msg":"trace[1485594926] transaction","detail":"{read_only:false; response_revision:1245; number_of_response:1; }","duration":"135.953376ms","start":"2026-10-19T01:56:45.784285Z","end":"2026-10-19T01:56:45.920239Z","steps":["trace[1485594926] 'process raft request' (duration: 135.818333ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:56:53.301101Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:56:52.968854Z","time spent":"332.242749ms","remote":"127.0.0.1:55234","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-10-19T01:58:52.811751Z","caller":"traceutil/trace.go:171","msg":"trace[846874870] transaction","detail":"{read_only:false; response_revision:1850; number_of_response:1; }","duration":"116.781995ms","start":"2026-10-19T01:58:52.694925Z","end":"2026-10-19T01:58:52.811707Z","steps":["trace[846874870] 'process raft request' (duration: 57.854021ms)","trace[846874870] 'compare' (duration: 58.780261ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T01:58:53.095951Z","caller":"traceutil/trace.go:171","msg":"trace[1137171914] linearizableReadLoop","detail":"{readStateIndex:1932; appliedIndex:1929; }","duration":"190.982976ms","start":"2026-10-19T01:58:52.904942Z","end":"2026-10-19T01:58:53.095925Z","steps":["trace[1137171914] 'read index received' (duration: 1.221876ms)","trace[1137171914] 'applied index is now lower than readState.Index' (duration: 189.7599ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T01:58:53.09598Z","caller":"traceutil/trace.go:171","msg":"trace[898190532] transaction","detail":"{read_only:false; response_revision:1853; number_of_response:1; }","duration":"278.697154ms","start":"2026-10-19T01:58:52.817256Z","end":"2026-10-19T01:58:53.095953Z","steps":["trace[898190532] 'process raft request' (duration: 278.578561ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:58:53.096024Z","caller":"traceutil/trace.go:171","msg":"trace[458269713] transaction","detail":"{read_only:false; response_revision:1852; number_of_response:1; }","duration":"279.483492ms","start":"2026-10-19T01:58:52.816518Z","end":"2026-10-19T01:58:53.096002Z","steps":["trace[458269713] 'process raft request' (duration: 184.370632ms)","trace[458269713] 'compare' (duration: 94.689681ms)"],"step_count":2} {"level":"warn","ts":"2026-10-19T01:58:53.096179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.223572ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:535"} {"level":"info","ts":"2026-10-19T01:58:53.096225Z","caller":"traceutil/trace.go:171","msg":"trace[52497485] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1853; }","duration":"191.325913ms","start":"2026-10-19T01:58:52.904886Z","end":"2026-10-19T01:58:53.096212Z","steps":["trace[52497485] 'agreement among raft nodes before linearized reading' (duration: 191.16683ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:58:53.096344Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.089481ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.36\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-10-19T01:58:53.096439Z","caller":"traceutil/trace.go:171","msg":"trace[127184653] range","detail":"{range_begin:/registry/masterleases/162.253.55.36; range_end:; response_count:1; response_revision:1853; }","duration":"121.185563ms","start":"2026-10-19T01:58:52.975236Z","end":"2026-10-19T01:58:53.096422Z","steps":["trace[127184653] 'agreement among raft nodes before linearized reading' (duration: 120.998299ms)"],"step_count":1}