{"level":"warn","ts":"2026-05-14T00:46:25.889209Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-14T00:46:25.889341Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.129: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://199.204.45.129:2380","--initial-cluster=instance=https://199.204.45.129:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.129:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.129: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-05-14T00:46:25.889434Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-14T00:46:25.889448Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.129:2380"]} {"level":"info","ts":"2026-05-14T00:46:25.889484Z","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-05-14T00:46:25.890588Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.129:2379"]} {"level":"info","ts":"2026-05-14T00:46:25.890962Z","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://199.204.45.129:2380"],"listen-peer-urls":["https://199.204.45.129:2380"],"advertise-client-urls":["https://199.204.45.129:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.129:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.129: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-05-14T00:46:25.897524Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.213284ms"} {"level":"info","ts":"2026-05-14T00:46:25.908306Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"3cec112083e8d3ff","cluster-id":"3f68255a3b440659"} {"level":"info","ts":"2026-05-14T00:46:25.908417Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff switched to configuration voters=()"} {"level":"info","ts":"2026-05-14T00:46:25.908442Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff became follower at term 0"} {"level":"info","ts":"2026-05-14T00:46:25.908457Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 3cec112083e8d3ff [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-14T00:46:25.908469Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff became follower at term 1"} {"level":"info","ts":"2026-05-14T00:46:25.908527Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff switched to configuration voters=(4389902568129090559)"} {"level":"warn","ts":"2026-05-14T00:46:25.917686Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-14T00:46:25.921442Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-14T00:46:25.922553Z","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-05-14T00:46:25.925528Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"3cec112083e8d3ff","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-14T00:46:25.926341Z","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-05-14T00:46:25.92642Z","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-05-14T00:46:25.926435Z","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-05-14T00:46:25.926425Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"3cec112083e8d3ff","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-14T00:46:25.930074Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff switched to configuration voters=(4389902568129090559)"} {"level":"info","ts":"2026-05-14T00:46:25.931898Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"3f68255a3b440659","local-member-id":"3cec112083e8d3ff","added-peer-id":"3cec112083e8d3ff","added-peer-peer-urls":["https://199.204.45.129:2380"]} {"level":"info","ts":"2026-05-14T00:46:25.934283Z","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-05-14T00:46:25.934643Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.129:2380"} {"level":"info","ts":"2026-05-14T00:46:25.93468Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.129:2380"} {"level":"info","ts":"2026-05-14T00:46:25.934815Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"3cec112083e8d3ff","initial-advertise-peer-urls":["https://199.204.45.129:2380"],"listen-peer-urls":["https://199.204.45.129:2380"],"advertise-client-urls":["https://199.204.45.129:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.129:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-14T00:46:25.934865Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-14T00:46:26.908732Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff is starting a new election at term 1"} {"level":"info","ts":"2026-05-14T00:46:26.908784Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff became pre-candidate at term 1"} {"level":"info","ts":"2026-05-14T00:46:26.908802Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff received MsgPreVoteResp from 3cec112083e8d3ff at term 1"} {"level":"info","ts":"2026-05-14T00:46:26.908815Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff became candidate at term 2"} {"level":"info","ts":"2026-05-14T00:46:26.908821Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff received MsgVoteResp from 3cec112083e8d3ff at term 2"} {"level":"info","ts":"2026-05-14T00:46:26.90883Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff became leader at term 2"} {"level":"info","ts":"2026-05-14T00:46:26.908839Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 3cec112083e8d3ff elected leader 3cec112083e8d3ff at term 2"} {"level":"info","ts":"2026-05-14T00:46:27.092284Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-14T00:46:27.092426Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"3cec112083e8d3ff","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.129:2379]}","request-path":"/0/members/3cec112083e8d3ff/attributes","cluster-id":"3f68255a3b440659","publish-timeout":"7s"} {"level":"info","ts":"2026-05-14T00:46:27.092447Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-14T00:46:27.092488Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-14T00:46:27.092881Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-14T00:46:27.092962Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-14T00:46:27.095991Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.129:2379"} {"level":"info","ts":"2026-05-14T00:46:27.096868Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-14T00:46:27.100837Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"3f68255a3b440659","local-member-id":"3cec112083e8d3ff","cluster-version":"3.5"} {"level":"info","ts":"2026-05-14T00:46:27.101642Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-14T00:46:27.10172Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-14T00:46:32.054119Z","caller":"traceutil/trace.go:171","msg":"trace[1204038819] transaction","detail":"{read_only:false; response_revision:280; number_of_response:1; }","duration":"105.042465ms","start":"2026-05-14T00:46:31.948849Z","end":"2026-05-14T00:46:32.053892Z","steps":["trace[1204038819] 'process raft request' (duration: 104.871591ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T00:46:32.789606Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.266396ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/persistent-volume-binder\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-14T00:46:32.789819Z","caller":"traceutil/trace.go:171","msg":"trace[750556337] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/persistent-volume-binder; range_end:; response_count:0; response_revision:294; }","duration":"178.515236ms","start":"2026-05-14T00:46:32.611281Z","end":"2026-05-14T00:46:32.789796Z","steps":["trace[750556337] 'range keys from in-memory index tree' (duration: 178.203349ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T00:46:36.983663Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.360741ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-05-14T00:46:36.983738Z","caller":"traceutil/trace.go:171","msg":"trace[560946370] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/certificate-controller; range_end:; response_count:1; response_revision:344; }","duration":"104.479071ms","start":"2026-05-14T00:46:36.879242Z","end":"2026-05-14T00:46:36.983722Z","steps":["trace[560946370] 'range keys from in-memory index tree' (duration: 104.220539ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T00:46:36.983733Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.437215ms","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-05-14T00:46:36.983818Z","caller":"traceutil/trace.go:171","msg":"trace[1445872104] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:344; }","duration":"139.558536ms","start":"2026-05-14T00:46:36.844239Z","end":"2026-05-14T00:46:36.983798Z","steps":["trace[1445872104] 'range keys from in-memory index tree' (duration: 139.336827ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T00:46:37.386287Z","caller":"traceutil/trace.go:171","msg":"trace[1188312912] transaction","detail":"{read_only:false; response_revision:348; number_of_response:1; }","duration":"103.788997ms","start":"2026-05-14T00:46:37.282476Z","end":"2026-05-14T00:46:37.386265Z","steps":["trace[1188312912] 'process raft request' (duration: 103.654986ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T00:46:37.468662Z","caller":"traceutil/trace.go:171","msg":"trace[1949525402] linearizableReadLoop","detail":"{readStateIndex:362; appliedIndex:360; }","duration":"144.614774ms","start":"2026-05-14T00:46:37.324028Z","end":"2026-05-14T00:46:37.468643Z","steps":["trace[1949525402] 'read index received' (duration: 62.196975ms)","trace[1949525402] 'applied index is now lower than readState.Index' (duration: 82.416959ms)"],"step_count":2} {"level":"info","ts":"2026-05-14T00:46:37.468758Z","caller":"traceutil/trace.go:171","msg":"trace[2050955569] transaction","detail":"{read_only:false; response_revision:349; number_of_response:1; }","duration":"185.921822ms","start":"2026-05-14T00:46:37.282811Z","end":"2026-05-14T00:46:37.468733Z","steps":["trace[2050955569] 'process raft request' (duration: 185.759448ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T00:46:37.468843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.797768ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/root-ca-cert-publisher\" ","response":"range_response_count:1 size:209"} {"level":"warn","ts":"2026-05-14T00:46:37.468894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.891436ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/bootstrap-token-3l68hn\" ","response":"range_response_count:1 size:540"} {"level":"info","ts":"2026-05-14T00:46:37.468925Z","caller":"traceutil/trace.go:171","msg":"trace[894137644] range","detail":"{range_begin:/registry/secrets/kube-system/bootstrap-token-3l68hn; range_end:; response_count:1; response_revision:349; }","duration":"139.94626ms","start":"2026-05-14T00:46:37.328968Z","end":"2026-05-14T00:46:37.468914Z","steps":["trace[894137644] 'agreement among raft nodes before linearized reading' (duration: 139.897296ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T00:46:37.468975Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.801608ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/etcd-instance\" ","response":"range_response_count:1 size:5164"} {"level":"info","ts":"2026-05-14T00:46:37.468893Z","caller":"traceutil/trace.go:171","msg":"trace[1200529853] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/root-ca-cert-publisher; range_end:; response_count:1; response_revision:349; }","duration":"144.887516ms","start":"2026-05-14T00:46:37.323992Z","end":"2026-05-14T00:46:37.468879Z","steps":["trace[1200529853] 'agreement among raft nodes before linearized reading' (duration: 144.777887ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T00:46:37.46911Z","caller":"traceutil/trace.go:171","msg":"trace[1309541884] range","detail":"{range_begin:/registry/pods/kube-system/etcd-instance; range_end:; response_count:1; response_revision:349; }","duration":"139.986194ms","start":"2026-05-14T00:46:37.329103Z","end":"2026-05-14T00:46:37.469089Z","steps":["trace[1309541884] 'agreement among raft nodes before linearized reading' (duration: 139.734133ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T00:46:37.468843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.844871ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" ","response":"range_response_count:1 size:7303"} {"level":"info","ts":"2026-05-14T00:46:37.469238Z","caller":"traceutil/trace.go:171","msg":"trace[695279214] range","detail":"{range_begin:/registry/pods/kube-system/kube-apiserver-instance; range_end:; response_count:1; response_revision:349; }","duration":"140.273027ms","start":"2026-05-14T00:46:37.328955Z","end":"2026-05-14T00:46:37.469228Z","steps":["trace[695279214] 'agreement among raft nodes before linearized reading' (duration: 139.82737ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T00:46:37.562147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.908927ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" ","response":"range_response_count:1 size:6965"} {"level":"warn","ts":"2026-05-14T00:46:37.56224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.426596ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"range_response_count:1 size:4326"} {"level":"info","ts":"2026-05-14T00:46:37.56225Z","caller":"traceutil/trace.go:171","msg":"trace[1669949820] range","detail":"{range_begin:/registry/pods/kube-system/kube-controller-manager-instance; range_end:; response_count:1; response_revision:349; }","duration":"233.065049ms","start":"2026-05-14T00:46:37.32916Z","end":"2026-05-14T00:46:37.562225Z","steps":["trace[1669949820] 'agreement among raft nodes before linearized reading' (duration: 140.121875ms)","trace[1669949820] 'range keys from in-memory index tree' (duration: 92.77047ms)"],"step_count":2} {"level":"warn","ts":"2026-05-14T00:46:37.562275Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.73145ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" ","response":"range_response_count:1 size:234"} {"level":"info","ts":"2026-05-14T00:46:37.562657Z","caller":"traceutil/trace.go:171","msg":"trace[1008302865] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller; range_end:; response_count:1; response_revision:349; }","duration":"188.126082ms","start":"2026-05-14T00:46:37.374505Z","end":"2026-05-14T00:46:37.562631Z","steps":["trace[1008302865] 'agreement among raft nodes before linearized reading' (duration: 94.489161ms)","trace[1008302865] 'range keys from in-memory index tree' (duration: 93.115209ms)"],"step_count":2} {"level":"warn","ts":"2026-05-14T00:46:37.562163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.281703ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-05-14T00:46:37.562855Z","caller":"traceutil/trace.go:171","msg":"trace[1744904866] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-controller; range_end:; response_count:1; response_revision:349; }","duration":"139.008962ms","start":"2026-05-14T00:46:37.423824Z","end":"2026-05-14T00:46:37.562833Z","steps":["trace[1744904866] 'agreement among raft nodes before linearized reading' (duration: 45.155604ms)","trace[1744904866] 'range keys from in-memory index tree' (duration: 93.098237ms)"],"step_count":2} {"level":"warn","ts":"2026-05-14T00:46:37.562585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.684147ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-vip-instance\" ","response":"range_response_count:1 size:4663"} {"level":"info","ts":"2026-05-14T00:46:37.563Z","caller":"traceutil/trace.go:171","msg":"trace[141151254] range","detail":"{range_begin:/registry/pods/kube-system/kube-vip-instance; range_end:; response_count:1; response_revision:349; }","duration":"233.094762ms","start":"2026-05-14T00:46:37.329889Z","end":"2026-05-14T00:46:37.562984Z","steps":["trace[141151254] 'agreement among raft nodes before linearized reading' (duration: 139.221101ms)","trace[141151254] 'range keys from in-memory index tree' (duration: 93.431255ms)"],"step_count":2} {"level":"info","ts":"2026-05-14T00:46:37.562293Z","caller":"traceutil/trace.go:171","msg":"trace[1191917769] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:349; }","duration":"232.482291ms","start":"2026-05-14T00:46:37.329788Z","end":"2026-05-14T00:46:37.56227Z","steps":["trace[1191917769] 'agreement among raft nodes before linearized reading' (duration: 139.006563ms)","trace[1191917769] 'range keys from in-memory index tree' (duration: 93.25382ms)"],"step_count":2} {"level":"info","ts":"2026-05-14T00:46:37.701248Z","caller":"traceutil/trace.go:171","msg":"trace[980527230] transaction","detail":"{read_only:false; response_revision:353; number_of_response:1; }","duration":"132.150059ms","start":"2026-05-14T00:46:37.569071Z","end":"2026-05-14T00:46:37.701221Z","steps":["trace[980527230] 'process raft request' (duration: 93.351438ms)","trace[980527230] 'compare' (duration: 38.650959ms)"],"step_count":2} {"level":"info","ts":"2026-05-14T00:46:37.701512Z","caller":"traceutil/trace.go:171","msg":"trace[1107999870] transaction","detail":"{read_only:false; response_revision:354; number_of_response:1; }","duration":"132.26945ms","start":"2026-05-14T00:46:37.569214Z","end":"2026-05-14T00:46:37.701483Z","steps":["trace[1107999870] 'process raft request' (duration: 131.964035ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T00:46:37.701651Z","caller":"traceutil/trace.go:171","msg":"trace[1544216316] transaction","detail":"{read_only:false; response_revision:357; number_of_response:1; }","duration":"129.867111ms","start":"2026-05-14T00:46:37.571771Z","end":"2026-05-14T00:46:37.701638Z","steps":["trace[1544216316] 'process raft request' (duration: 129.72965ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T00:46:37.701776Z","caller":"traceutil/trace.go:171","msg":"trace[1184944346] transaction","detail":"{read_only:false; response_revision:355; number_of_response:1; }","duration":"131.861574ms","start":"2026-05-14T00:46:37.569904Z","end":"2026-05-14T00:46:37.701766Z","steps":["trace[1184944346] 'process raft request' (duration: 131.455451ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T00:46:37.701876Z","caller":"traceutil/trace.go:171","msg":"trace[846605617] linearizableReadLoop","detail":"{readStateIndex:367; appliedIndex:365; }","duration":"132.614747ms","start":"2026-05-14T00:46:37.569252Z","end":"2026-05-14T00:46:37.701866Z","steps":["trace[846605617] 'read index received' (duration: 77.112572ms)","trace[846605617] 'applied index is now lower than readState.Index' (duration: 55.500635ms)"],"step_count":2} {"level":"info","ts":"2026-05-14T00:46:37.701908Z","caller":"traceutil/trace.go:171","msg":"trace[446183398] transaction","detail":"{read_only:false; response_revision:358; number_of_response:1; }","duration":"128.564733ms","start":"2026-05-14T00:46:37.573333Z","end":"2026-05-14T00:46:37.701897Z","steps":["trace[446183398] 'process raft request' (duration: 128.211704ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T00:46:37.701906Z","caller":"traceutil/trace.go:171","msg":"trace[121778662] transaction","detail":"{read_only:false; response_revision:356; number_of_response:1; }","duration":"130.56621ms","start":"2026-05-14T00:46:37.571132Z","end":"2026-05-14T00:46:37.701698Z","steps":["trace[121778662] 'process raft request' (duration: 130.319929ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T00:46:37.702145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.751267ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4369"} {"level":"info","ts":"2026-05-14T00:46:37.702194Z","caller":"traceutil/trace.go:171","msg":"trace[1888647077] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:359; }","duration":"132.957425ms","start":"2026-05-14T00:46:37.569224Z","end":"2026-05-14T00:46:37.702182Z","steps":["trace[1888647077] 'agreement among raft nodes before linearized reading' (duration: 132.718885ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T00:46:37.702325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.926673ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4369"} {"level":"warn","ts":"2026-05-14T00:46:37.702356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.920784ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" ","response":"range_response_count:1 size:214"} {"level":"info","ts":"2026-05-14T00:46:37.702381Z","caller":"traceutil/trace.go:171","msg":"trace[847801889] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:359; }","duration":"132.975217ms","start":"2026-05-14T00:46:37.56939Z","end":"2026-05-14T00:46:37.702366Z","steps":["trace[847801889] 'agreement among raft nodes before linearized reading' (duration: 132.908231ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T00:46:37.702431Z","caller":"traceutil/trace.go:171","msg":"trace[1935865457] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslice-controller; range_end:; response_count:1; response_revision:359; }","duration":"129.020952ms","start":"2026-05-14T00:46:37.573392Z","end":"2026-05-14T00:46:37.702413Z","steps":["trace[1935865457] 'agreement among raft nodes before linearized reading' (duration: 128.847148ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T00:46:37.702131Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.793492ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4369"} {"level":"info","ts":"2026-05-14T00:46:37.702552Z","caller":"traceutil/trace.go:171","msg":"trace[2057915414] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:359; }","duration":"133.247159ms","start":"2026-05-14T00:46:37.569292Z","end":"2026-05-14T00:46:37.702539Z","steps":["trace[2057915414] 'agreement among raft nodes before linearized reading' (duration: 132.777901ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T00:46:37.990129Z","caller":"traceutil/trace.go:171","msg":"trace[1783974261] transaction","detail":"{read_only:false; response_revision:360; number_of_response:1; }","duration":"281.006472ms","start":"2026-05-14T00:46:37.709099Z","end":"2026-05-14T00:46:37.990105Z","steps":["trace[1783974261] 'process raft request' (duration: 212.576124ms)","trace[1783974261] 'compare' (duration: 68.183608ms)"],"step_count":2} {"level":"warn","ts":"2026-05-14T00:46:38.243467Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.308732ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-14T00:46:38.24365Z","caller":"traceutil/trace.go:171","msg":"trace[9922368] transaction","detail":"{read_only:false; response_revision:362; number_of_response:1; }","duration":"531.251795ms","start":"2026-05-14T00:46:37.712379Z","end":"2026-05-14T00:46:38.243631Z","steps":["trace[9922368] 'process raft request' (duration: 531.147056ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T00:46:38.243664Z","caller":"traceutil/trace.go:171","msg":"trace[196873163] transaction","detail":"{read_only:false; response_revision:361; number_of_response:1; }","duration":"531.285529ms","start":"2026-05-14T00:46:37.712348Z","end":"2026-05-14T00:46:38.243634Z","steps":["trace[196873163] 'process raft request' (duration: 390.52694ms)","trace[196873163] 'compare' (duration: 140.087974ms)"],"step_count":2} {"level":"info","ts":"2026-05-14T00:46:38.243739Z","caller":"traceutil/trace.go:171","msg":"trace[51823182] transaction","detail":"{read_only:false; response_revision:364; number_of_response:1; }","duration":"531.079191ms","start":"2026-05-14T00:46:37.712639Z","end":"2026-05-14T00:46:38.243718Z","steps":["trace[51823182] 'process raft request' (duration: 530.961861ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T00:46:38.243787Z","caller":"traceutil/trace.go:171","msg":"trace[266691882] transaction","detail":"{read_only:false; response_revision:363; number_of_response:1; }","duration":"531.170299ms","start":"2026-05-14T00:46:37.712611Z","end":"2026-05-14T00:46:38.243782Z","steps":["trace[266691882] 'process raft request' (duration: 530.970532ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T00:46:38.243815Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T00:46:37.712606Z","time spent":"531.197521ms","remote":"127.0.0.1:34296","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1731,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-14T00:46:38.243843Z","caller":"traceutil/trace.go:171","msg":"trace[1764155286] transaction","detail":"{read_only:false; response_revision:365; number_of_response:1; }","duration":"529.726ms","start":"2026-05-14T00:46:37.714108Z","end":"2026-05-14T00:46:38.243834Z","steps":["trace[1764155286] 'process raft request' (duration: 529.519342ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T00:46:38.243866Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T00:46:37.712621Z","time spent":"531.187881ms","remote":"127.0.0.1:34378","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3527,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-14T00:46:38.24389Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T00:46:37.712339Z","time spent":"531.469544ms","remote":"127.0.0.1:34456","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1050,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-14T00:46:38.243693Z","caller":"traceutil/trace.go:171","msg":"trace[669780164] linearizableReadLoop","detail":"{readStateIndex:379; appliedIndex:372; }","duration":"520.052735ms","start":"2026-05-14T00:46:37.723631Z","end":"2026-05-14T00:46:38.243684Z","steps":["trace[669780164] 'read index received' (duration: 198.028147ms)","trace[669780164] 'applied index is now lower than readState.Index' (duration: 322.023917ms)"],"step_count":2} {"level":"warn","ts":"2026-05-14T00:46:38.243759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"520.124781ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" ","response":"range_response_count:1 size:203"} {"level":"info","ts":"2026-05-14T00:46:38.243999Z","caller":"traceutil/trace.go:171","msg":"trace[1356939648] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpoint-controller; range_end:; response_count:1; response_revision:366; }","duration":"520.393643ms","start":"2026-05-14T00:46:37.723597Z","end":"2026-05-14T00:46:38.243991Z","steps":["trace[1356939648] 'agreement among raft nodes before linearized reading' (duration: 520.1176ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T00:46:38.244021Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T00:46:37.714082Z","time spent":"529.792816ms","remote":"127.0.0.1:34436","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2259,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-14T00:46:38.244029Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T00:46:37.723575Z","time spent":"520.443157ms","remote":"127.0.0.1:34392","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":225,"request content":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" "} {"level":"warn","ts":"2026-05-14T00:46:38.244057Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"469.989327ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" ","response":"range_response_count:1 size:234"} {"level":"warn","ts":"2026-05-14T00:46:38.244083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"372.066744ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/kube-proxy\" ","response":"range_response_count:1 size:185"} {"level":"info","ts":"2026-05-14T00:46:38.244089Z","caller":"traceutil/trace.go:171","msg":"trace[1096864637] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller; range_end:; response_count:1; response_revision:366; }","duration":"470.043143ms","start":"2026-05-14T00:46:37.774038Z","end":"2026-05-14T00:46:38.244081Z","steps":["trace[1096864637] 'agreement among raft nodes before linearized reading' (duration: 469.979927ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T00:46:38.244101Z","caller":"traceutil/trace.go:171","msg":"trace[307843652] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/kube-proxy; range_end:; response_count:1; response_revision:366; }","duration":"372.122938ms","start":"2026-05-14T00:46:37.871974Z","end":"2026-05-14T00:46:38.244097Z","steps":["trace[307843652] 'agreement among raft nodes before linearized reading' (duration: 372.076823ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T00:46:38.244114Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T00:46:37.871953Z","time spent":"372.158371ms","remote":"127.0.0.1:34392","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":1,"response size":207,"request content":"key:\"/registry/serviceaccounts/kube-system/kube-proxy\" "} {"level":"warn","ts":"2026-05-14T00:46:38.244111Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T00:46:37.774024Z","time spent":"470.081185ms","remote":"127.0.0.1:34392","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":256,"request content":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" "} {"level":"warn","ts":"2026-05-14T00:46:38.24374Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T00:46:37.712362Z","time spent":"531.333811ms","remote":"127.0.0.1:34392","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":156,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-14T00:46:38.244265Z","caller":"traceutil/trace.go:171","msg":"trace[584574813] transaction","detail":"{read_only:false; response_revision:366; number_of_response:1; }","duration":"528.105596ms","start":"2026-05-14T00:46:37.716146Z","end":"2026-05-14T00:46:38.244251Z","steps":["trace[584574813] 'process raft request' (duration: 527.507547ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T00:46:38.245055Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T00:46:37.71614Z","time spent":"528.854759ms","remote":"127.0.0.1:34378","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4451,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-14T00:46:38.43007Z","caller":"traceutil/trace.go:171","msg":"trace[452736220] transaction","detail":"{read_only:false; response_revision:368; number_of_response:1; }","duration":"180.148981ms","start":"2026-05-14T00:46:38.249887Z","end":"2026-05-14T00:46:38.430036Z","steps":["trace[452736220] 'process raft request' (duration: 152.585325ms)","trace[452736220] 'compare' (duration: 27.322236ms)"],"step_count":2} {"level":"info","ts":"2026-05-14T00:46:38.430338Z","caller":"traceutil/trace.go:171","msg":"trace[1946698647] transaction","detail":"{read_only:false; response_revision:370; number_of_response:1; }","duration":"176.987931ms","start":"2026-05-14T00:46:38.253334Z","end":"2026-05-14T00:46:38.430321Z","steps":["trace[1946698647] 'process raft request' (duration: 176.683235ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T00:46:38.430361Z","caller":"traceutil/trace.go:171","msg":"trace[977015011] transaction","detail":"{read_only:false; response_revision:369; number_of_response:1; }","duration":"178.92873ms","start":"2026-05-14T00:46:38.251417Z","end":"2026-05-14T00:46:38.430346Z","steps":["trace[977015011] 'process raft request' (duration: 178.535628ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T00:46:38.430385Z","caller":"traceutil/trace.go:171","msg":"trace[1969355792] transaction","detail":"{read_only:false; response_revision:372; number_of_response:1; }","duration":"176.237848ms","start":"2026-05-14T00:46:38.25413Z","end":"2026-05-14T00:46:38.430368Z","steps":["trace[1969355792] 'process raft request' (duration: 175.998499ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T00:46:38.430484Z","caller":"traceutil/trace.go:171","msg":"trace[727163388] transaction","detail":"{read_only:false; response_revision:371; number_of_response:1; }","duration":"177.039765ms","start":"2026-05-14T00:46:38.253431Z","end":"2026-05-14T00:46:38.430471Z","steps":["trace[727163388] 'process raft request' (duration: 176.639492ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T00:46:38.430485Z","caller":"traceutil/trace.go:171","msg":"trace[2080910495] transaction","detail":"{read_only:false; response_revision:373; number_of_response:1; }","duration":"175.604055ms","start":"2026-05-14T00:46:38.254866Z","end":"2026-05-14T00:46:38.43047Z","steps":["trace[2080910495] 'process raft request' (duration: 175.310772ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T00:46:38.430578Z","caller":"traceutil/trace.go:171","msg":"trace[1009737182] transaction","detail":"{read_only:false; response_revision:377; number_of_response:1; }","duration":"107.968263ms","start":"2026-05-14T00:46:38.322587Z","end":"2026-05-14T00:46:38.430555Z","steps":["trace[1009737182] 'process raft request' (duration: 107.921369ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T00:46:38.43074Z","caller":"traceutil/trace.go:171","msg":"trace[41220048] transaction","detail":"{read_only:false; response_revision:376; number_of_response:1; }","duration":"173.134541ms","start":"2026-05-14T00:46:38.257553Z","end":"2026-05-14T00:46:38.430687Z","steps":["trace[41220048] 'process raft request' (duration: 172.913793ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T00:46:38.43081Z","caller":"traceutil/trace.go:171","msg":"trace[1125506328] transaction","detail":"{read_only:false; response_revision:375; number_of_response:1; }","duration":"173.332298ms","start":"2026-05-14T00:46:38.257459Z","end":"2026-05-14T00:46:38.430792Z","steps":["trace[1125506328] 'process raft request' (duration: 172.931946ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T00:46:38.430871Z","caller":"traceutil/trace.go:171","msg":"trace[1790273357] transaction","detail":"{read_only:false; response_revision:374; number_of_response:1; }","duration":"173.660646ms","start":"2026-05-14T00:46:38.257195Z","end":"2026-05-14T00:46:38.430856Z","steps":["trace[1790273357] 'process raft request' (duration: 173.029404ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T00:46:38.430894Z","caller":"traceutil/trace.go:171","msg":"trace[873471774] linearizableReadLoop","detail":"{readStateIndex:389; appliedIndex:380; }","duration":"158.802969ms","start":"2026-05-14T00:46:38.272074Z","end":"2026-05-14T00:46:38.430877Z","steps":["trace[873471774] 'read index received' (duration: 45.870796ms)","trace[873471774] 'applied index is now lower than readState.Index' (duration: 112.930773ms)"],"step_count":2} {"level":"warn","ts":"2026-05-14T00:46:38.430982Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.898367ms","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-05-14T00:46:38.431022Z","caller":"traceutil/trace.go:171","msg":"trace[338873064] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:377; }","duration":"158.994145ms","start":"2026-05-14T00:46:38.272019Z","end":"2026-05-14T00:46:38.431013Z","steps":["trace[338873064] 'agreement among raft nodes before linearized reading' (duration: 158.908058ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T00:46:38.69483Z","caller":"traceutil/trace.go:171","msg":"trace[1127859684] transaction","detail":"{read_only:false; response_revision:387; number_of_response:1; }","duration":"205.137384ms","start":"2026-05-14T00:46:38.48967Z","end":"2026-05-14T00:46:38.694807Z","steps":["trace[1127859684] 'process raft request' (duration: 151.056259ms)","trace[1127859684] 'compare' (duration: 53.720044ms)"],"step_count":2} {"level":"info","ts":"2026-05-14T00:46:43.36508Z","caller":"traceutil/trace.go:171","msg":"trace[1478271860] linearizableReadLoop","detail":"{readStateIndex:426; appliedIndex:425; }","duration":"189.622424ms","start":"2026-05-14T00:46:43.175434Z","end":"2026-05-14T00:46:43.365057Z","steps":["trace[1478271860] 'read index received' (duration: 189.555428ms)","trace[1478271860] 'applied index is now lower than readState.Index' (duration: 65.786µs)"],"step_count":2} {"level":"warn","ts":"2026-05-14T00:46:43.365207Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.756724ms","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-05-14T00:46:43.365242Z","caller":"traceutil/trace.go:171","msg":"trace[1845955581] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:411; }","duration":"189.805629ms","start":"2026-05-14T00:46:43.175426Z","end":"2026-05-14T00:46:43.365232Z","steps":["trace[1845955581] 'agreement among raft nodes before linearized reading' (duration: 189.729253ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T00:46:43.365173Z","caller":"traceutil/trace.go:171","msg":"trace[1657122870] transaction","detail":"{read_only:false; response_revision:411; number_of_response:1; }","duration":"190.160889ms","start":"2026-05-14T00:46:43.174982Z","end":"2026-05-14T00:46:43.365142Z","steps":["trace[1657122870] 'process raft request' (duration: 189.926779ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T00:46:52.820282Z","caller":"traceutil/trace.go:171","msg":"trace[730394272] transaction","detail":"{read_only:false; response_revision:461; number_of_response:1; }","duration":"251.054498ms","start":"2026-05-14T00:46:52.569199Z","end":"2026-05-14T00:46:52.820254Z","steps":["trace[730394272] 'process raft request' (duration: 250.481249ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T00:46:53.30119Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.355843ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-14T00:46:53.301296Z","caller":"traceutil/trace.go:171","msg":"trace[1438407871] linearizableReadLoop","detail":"{readStateIndex:480; appliedIndex:479; }","duration":"134.908155ms","start":"2026-05-14T00:46:53.166372Z","end":"2026-05-14T00:46:53.30128Z","steps":["trace[1438407871] 'read index received' (duration: 39.964µs)","trace[1438407871] 'applied index is now lower than readState.Index' (duration: 134.864701ms)"],"step_count":2} {"level":"warn","ts":"2026-05-14T00:46:53.301357Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.977441ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-14T00:46:53.301382Z","caller":"traceutil/trace.go:171","msg":"trace[1753958169] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:462; }","duration":"135.037966ms","start":"2026-05-14T00:46:53.166334Z","end":"2026-05-14T00:46:53.301372Z","steps":["trace[1753958169] 'agreement among raft nodes before linearized reading' (duration: 134.989132ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T00:46:53.301516Z","caller":"traceutil/trace.go:171","msg":"trace[1239438176] transaction","detail":"{read_only:false; response_revision:462; number_of_response:1; }","duration":"478.241372ms","start":"2026-05-14T00:46:52.823222Z","end":"2026-05-14T00:46:53.301463Z","steps":["trace[1239438176] 'process raft request' (duration: 324.504896ms)","trace[1239438176] 'compare' (duration: 153.119582ms)"],"step_count":2} {"level":"warn","ts":"2026-05-14T00:46:53.30168Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T00:46:52.823193Z","time spent":"478.396745ms","remote":"127.0.0.1:34440","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-14T00:46:59.134833Z","caller":"traceutil/trace.go:171","msg":"trace[494188347] transaction","detail":"{read_only:false; response_revision:473; number_of_response:1; }","duration":"215.379097ms","start":"2026-05-14T00:46:58.919431Z","end":"2026-05-14T00:46:59.13481Z","steps":["trace[494188347] 'process raft request' (duration: 215.234645ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T00:46:59.714484Z","caller":"traceutil/trace.go:171","msg":"trace[668537159] transaction","detail":"{read_only:false; response_revision:476; number_of_response:1; }","duration":"187.336307ms","start":"2026-05-14T00:46:59.5271Z","end":"2026-05-14T00:46:59.714436Z","steps":["trace[668537159] 'process raft request' (duration: 158.675471ms)","trace[668537159] 'compare' (duration: 28.367701ms)"],"step_count":2} {"level":"info","ts":"2026-05-14T00:47:03.168943Z","caller":"traceutil/trace.go:171","msg":"trace[1122077460] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"790.652218ms","start":"2026-05-14T00:47:02.378265Z","end":"2026-05-14T00:47:03.168917Z","steps":["trace[1122077460] 'process raft request' (duration: 790.540588ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T00:47:03.169194Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T00:47:02.378246Z","time spent":"790.866968ms","remote":"127.0.0.1:34246","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-14T00:47:03.176564Z","caller":"traceutil/trace.go:171","msg":"trace[782086591] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"794.675561ms","start":"2026-05-14T00:47:02.381857Z","end":"2026-05-14T00:47:03.176533Z","steps":["trace[782086591] 'process raft request' (duration: 794.509947ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T00:47:03.177088Z","caller":"traceutil/trace.go:171","msg":"trace[629399871] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"746.178396ms","start":"2026-05-14T00:47:02.430877Z","end":"2026-05-14T00:47:03.177055Z","steps":["trace[629399871] 'process raft request' (duration: 746.056905ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T00:47:03.177153Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T00:47:02.430843Z","time spent":"746.280555ms","remote":"127.0.0.1:34246","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-14T00:47:03.17746Z","caller":"traceutil/trace.go:171","msg":"trace[1822910817] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"764.791235ms","start":"2026-05-14T00:47:02.412452Z","end":"2026-05-14T00:47:03.177243Z","steps":["trace[1822910817] 'process raft request' (duration: 764.034609ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T00:47:03.177623Z","caller":"traceutil/trace.go:171","msg":"trace[376453492] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"756.864772ms","start":"2026-05-14T00:47:02.420655Z","end":"2026-05-14T00:47:03.17752Z","steps":["trace[376453492] 'process raft request' (duration: 755.916159ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T00:47:03.177629Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T00:47:02.412443Z","time spent":"765.104683ms","remote":"127.0.0.1:34246","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-14T00:47:03.177669Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T00:47:02.420645Z","time spent":"757.003724ms","remote":"127.0.0.1:34246","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-14T00:47:03.1775Z","caller":"traceutil/trace.go:171","msg":"trace[689161066] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"764.95396ms","start":"2026-05-14T00:47:02.412503Z","end":"2026-05-14T00:47:03.177456Z","steps":["trace[689161066] 'process raft request' (duration: 764.033779ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T00:47:03.177787Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T00:47:02.412448Z","time spent":"765.314221ms","remote":"127.0.0.1:34246","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-14T00:47:03.177929Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T00:47:02.381835Z","time spent":"794.771199ms","remote":"127.0.0.1:34246","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-14T00:47:03.178108Z","caller":"traceutil/trace.go:171","msg":"trace[1428186924] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"775.445508ms","start":"2026-05-14T00:47:02.40255Z","end":"2026-05-14T00:47:03.177995Z","steps":["trace[1428186924] 'process raft request' (duration: 773.893273ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T00:47:03.178152Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T00:47:02.402541Z","time spent":"775.596631ms","remote":"127.0.0.1:34246","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-14T00:47:03.180376Z","caller":"traceutil/trace.go:171","msg":"trace[1944921062] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"741.005285ms","start":"2026-05-14T00:47:02.439319Z","end":"2026-05-14T00:47:03.180325Z","steps":["trace[1944921062] 'process raft request' (duration: 737.721166ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T00:47:03.180349Z","caller":"traceutil/trace.go:171","msg":"trace[1942393324] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"735.270712ms","start":"2026-05-14T00:47:02.444987Z","end":"2026-05-14T00:47:03.180258Z","steps":["trace[1942393324] 'process raft request' (duration: 734.192357ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T00:47:03.180871Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T00:47:02.444963Z","time spent":"735.869474ms","remote":"127.0.0.1:34246","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-14T00:47:03.180575Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T00:47:02.439311Z","time spent":"741.115774ms","remote":"127.0.0.1:34246","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-14T00:47:03.188117Z","caller":"traceutil/trace.go:171","msg":"trace[214986852] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"721.491066ms","start":"2026-05-14T00:47:02.466596Z","end":"2026-05-14T00:47:03.188087Z","steps":["trace[214986852] 'process raft request' (duration: 721.097111ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T00:47:03.188301Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T00:47:02.466584Z","time spent":"721.663991ms","remote":"127.0.0.1:34246","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-14T00:47:03.188596Z","caller":"traceutil/trace.go:171","msg":"trace[341057375] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"621.287943ms","start":"2026-05-14T00:47:02.567298Z","end":"2026-05-14T00:47:03.188586Z","steps":["trace[341057375] 'process raft request' (duration: 620.532147ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T00:47:03.188658Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T00:47:02.567277Z","time spent":"621.347199ms","remote":"127.0.0.1:34440","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-14T00:47:03.188767Z","caller":"traceutil/trace.go:171","msg":"trace[862537990] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"621.260782ms","start":"2026-05-14T00:47:02.567498Z","end":"2026-05-14T00:47:03.188759Z","steps":["trace[862537990] 'process raft request' (duration: 620.417108ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T00:47:03.188806Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T00:47:02.567468Z","time spent":"621.322688ms","remote":"127.0.0.1:34246","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-14T00:47:03.189719Z","caller":"traceutil/trace.go:171","msg":"trace[1719277889] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"715.427384ms","start":"2026-05-14T00:47:02.465391Z","end":"2026-05-14T00:47:03.180818Z","steps":["trace[1719277889] 'process raft request' (duration: 714.871275ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T00:47:03.189774Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T00:47:02.46537Z","time spent":"724.38307ms","remote":"127.0.0.1:34246","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-14T00:47:09.502918Z","caller":"traceutil/trace.go:171","msg":"trace[264745734] linearizableReadLoop","detail":"{readStateIndex:649; appliedIndex:648; }","duration":"336.854411ms","start":"2026-05-14T00:47:09.166039Z","end":"2026-05-14T00:47:09.502893Z","steps":["trace[264745734] 'read index received' (duration: 336.060851ms)","trace[264745734] 'applied index is now lower than readState.Index' (duration: 792.49µs)"],"step_count":2} {"level":"info","ts":"2026-05-14T00:47:09.50375Z","caller":"traceutil/trace.go:171","msg":"trace[996461227] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"418.4869ms","start":"2026-05-14T00:47:09.08525Z","end":"2026-05-14T00:47:09.503737Z","steps":["trace[996461227] 'process raft request' (duration: 417.113868ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T00:47:09.50386Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T00:47:09.085219Z","time spent":"418.561586ms","remote":"127.0.0.1:34284","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036285,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-14T00:47:09.504004Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"337.971611ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-14T00:47:09.504034Z","caller":"traceutil/trace.go:171","msg":"trace[369306980] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:623; }","duration":"338.025507ms","start":"2026-05-14T00:47:09.166Z","end":"2026-05-14T00:47:09.504025Z","steps":["trace[369306980] 'agreement among raft nodes before linearized reading' (duration: 337.975072ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T00:47:09.504061Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T00:47:09.165982Z","time spent":"338.07411ms","remote":"127.0.0.1:34174","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-14T00:47:09.504288Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.272997ms","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-05-14T00:47:09.504317Z","caller":"traceutil/trace.go:171","msg":"trace[1315901836] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:623; }","duration":"244.344932ms","start":"2026-05-14T00:47:09.259963Z","end":"2026-05-14T00:47:09.504308Z","steps":["trace[1315901836] 'agreement among raft nodes before linearized reading' (duration: 244.235662ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T00:47:09.505476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.641607ms","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-05-14T00:47:09.505552Z","caller":"traceutil/trace.go:171","msg":"trace[1304173416] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:623; }","duration":"101.759277ms","start":"2026-05-14T00:47:09.403774Z","end":"2026-05-14T00:47:09.505534Z","steps":["trace[1304173416] 'agreement among raft nodes before linearized reading' (duration: 101.543628ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T00:47:09.874697Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.511382ms","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-05-14T00:47:09.874836Z","caller":"traceutil/trace.go:171","msg":"trace[628842019] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:623; }","duration":"292.666926ms","start":"2026-05-14T00:47:09.58215Z","end":"2026-05-14T00:47:09.874817Z","steps":["trace[628842019] 'range keys from in-memory index tree' (duration: 292.48704ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T00:47:09.875006Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.287477ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-14T00:47:09.875215Z","caller":"traceutil/trace.go:171","msg":"trace[2048754454] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"366.518374ms","start":"2026-05-14T00:47:09.508677Z","end":"2026-05-14T00:47:09.875196Z","steps":["trace[2048754454] 'process raft request' (duration: 70.953903ms)","trace[2048754454] 'compare' (duration: 295.176456ms)"],"step_count":2} {"level":"warn","ts":"2026-05-14T00:47:09.875292Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T00:47:09.508651Z","time spent":"366.607362ms","remote":"127.0.0.1:34440","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-14T00:47:09.875603Z","caller":"traceutil/trace.go:171","msg":"trace[277557979] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"366.103869ms","start":"2026-05-14T00:47:09.509479Z","end":"2026-05-14T00:47:09.875583Z","steps":["trace[277557979] 'process raft request' (duration: 365.624706ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T00:47:09.875638Z","caller":"traceutil/trace.go:171","msg":"trace[1932613852] linearizableReadLoop","detail":"{readStateIndex:652; appliedIndex:649; }","duration":"186.000015ms","start":"2026-05-14T00:47:09.689627Z","end":"2026-05-14T00:47:09.875627Z","steps":["trace[1932613852] 'read index received' (duration: 127.942472ms)","trace[1932613852] 'applied index is now lower than readState.Index' (duration: 58.056473ms)"],"step_count":2} {"level":"warn","ts":"2026-05-14T00:47:09.87569Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T00:47:09.509459Z","time spent":"366.190235ms","remote":"127.0.0.1:34440","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-14T00:47:09.875714Z","caller":"traceutil/trace.go:171","msg":"trace[1110049612] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"298.393333ms","start":"2026-05-14T00:47:09.577313Z","end":"2026-05-14T00:47:09.875707Z","steps":["trace[1110049612] 'process raft request' (duration: 298.040102ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T00:47:09.875952Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.333424ms","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-05-14T00:47:09.875993Z","caller":"traceutil/trace.go:171","msg":"trace[1266899232] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:626; }","duration":"186.438163ms","start":"2026-05-14T00:47:09.689545Z","end":"2026-05-14T00:47:09.875983Z","steps":["trace[1266899232] 'agreement among raft nodes before linearized reading' (duration: 186.272439ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T00:47:09.876Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.171046ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-05-14T00:47:09.876066Z","caller":"traceutil/trace.go:171","msg":"trace[1812719108] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:626; }","duration":"106.307809ms","start":"2026-05-14T00:47:09.76974Z","end":"2026-05-14T00:47:09.876048Z","steps":["trace[1812719108] 'agreement among raft nodes before linearized reading' (duration: 106.120642ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T00:47:10.293537Z","caller":"traceutil/trace.go:171","msg":"trace[1992806243] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"413.180681ms","start":"2026-05-14T00:47:09.880334Z","end":"2026-05-14T00:47:10.293515Z","steps":["trace[1992806243] 'process raft request' (duration: 413.036779ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T00:47:10.293686Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T00:47:09.880315Z","time spent":"413.299402ms","remote":"127.0.0.1:34440","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-14T00:47:12.16633Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000491926s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-05-14T00:47:12.166404Z","caller":"traceutil/trace.go:171","msg":"trace[1654498647] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000615947s","start":"2026-05-14T00:47:10.165767Z","end":"2026-05-14T00:47:12.166383Z","steps":["trace[1654498647] 'agreement among raft nodes before linearized reading' (duration: 2.000527149s)"],"step_count":1} {"level":"warn","ts":"2026-05-14T00:47:12.16644Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T00:47:10.165743Z","time spent":"2.000690573s","remote":"127.0.0.1:34166","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/05/14 00:47:12 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-05-14T00:47:12.279078Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T00:47:11.766342Z","time spent":"512.72793ms","remote":"127.0.0.1:55998","response type":"/etcdserverpb.Maintenance/Status","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-05-14T00:47:12.279773Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.055181466s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-14T00:47:12.280095Z","caller":"traceutil/trace.go:171","msg":"trace[908922243] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"2.399660031s","start":"2026-05-14T00:47:09.880402Z","end":"2026-05-14T00:47:12.280062Z","steps":["trace[908922243] 'process raft request' (duration: 1.34374875s)","trace[908922243] 'compare' (duration: 1.054837056s)"],"step_count":2} {"level":"warn","ts":"2026-05-14T00:47:12.280378Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T00:47:09.880384Z","time spent":"2.399794912s","remote":"127.0.0.1:34440","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-14T00:47:12.280369Z","caller":"traceutil/trace.go:171","msg":"trace[157901089] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"2.386186679s","start":"2026-05-14T00:47:09.89399Z","end":"2026-05-14T00:47:12.280177Z","steps":["trace[157901089] 'process raft request' (duration: 2.386028256s)"],"step_count":1} {"level":"info","ts":"2026-05-14T00:47:12.280406Z","caller":"traceutil/trace.go:171","msg":"trace[1661701681] linearizableReadLoop","detail":"{readStateIndex:654; appliedIndex:652; }","duration":"2.39229127s","start":"2026-05-14T00:47:09.888066Z","end":"2026-05-14T00:47:12.280358Z","steps":["trace[1661701681] 'read index received' (duration: 405.299135ms)","trace[1661701681] 'applied index is now lower than readState.Index' (duration: 1.986988684s)"],"step_count":2} {"level":"warn","ts":"2026-05-14T00:47:12.280614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.392547012s","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-05-14T00:47:12.280662Z","caller":"traceutil/trace.go:171","msg":"trace[1633667168] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:630; }","duration":"2.39262409s","start":"2026-05-14T00:47:09.888023Z","end":"2026-05-14T00:47:12.280647Z","steps":["trace[1633667168] 'agreement among raft nodes before linearized reading' (duration: 2.392538662s)"],"step_count":1} {"level":"warn","ts":"2026-05-14T00:47:12.280698Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T00:47:09.887984Z","time spent":"2.392706296s","remote":"127.0.0.1:34424","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":27,"request content":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" "} {"level":"warn","ts":"2026-05-14T00:47:12.280673Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T00:47:09.893955Z","time spent":"2.386645421s","remote":"127.0.0.1:34378","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-14T00:47:12.280737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.161045102s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.129\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-05-14T00:47:12.280788Z","caller":"traceutil/trace.go:171","msg":"trace[379936086] range","detail":"{range_begin:/registry/masterleases/199.204.45.129; range_end:; response_count:1; response_revision:630; }","duration":"2.161145081s","start":"2026-05-14T00:47:10.119629Z","end":"2026-05-14T00:47:12.280774Z","steps":["trace[379936086] 'agreement among raft nodes before linearized reading' (duration: 2.161048242s)"],"step_count":1} {"level":"info","ts":"2026-05-14T00:47:12.28078Z","caller":"traceutil/trace.go:171","msg":"trace[839021325] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"2.172484185s","start":"2026-05-14T00:47:10.108264Z","end":"2026-05-14T00:47:12.280748Z","steps":["trace[839021325] 'process raft request' (duration: 2.17186512s)"],"step_count":1} {"level":"warn","ts":"2026-05-14T00:47:12.280829Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T00:47:10.119607Z","time spent":"2.161212897s","remote":"127.0.0.1:34218","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.204.45.129\" "} {"level":"warn","ts":"2026-05-14T00:47:12.280944Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T00:47:10.108239Z","time spent":"2.172612996s","remote":"127.0.0.1:34440","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-14T00:47:12.281181Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"400.12576ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-05-14T00:47:12.281212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"401.215608ms","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-05-14T00:47:12.281231Z","caller":"traceutil/trace.go:171","msg":"trace[236159472] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:630; }","duration":"400.221159ms","start":"2026-05-14T00:47:11.880998Z","end":"2026-05-14T00:47:12.281219Z","steps":["trace[236159472] 'agreement among raft nodes before linearized reading' (duration: 400.065775ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T00:47:12.281253Z","caller":"traceutil/trace.go:171","msg":"trace[1496972907] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:630; }","duration":"401.294364ms","start":"2026-05-14T00:47:11.879947Z","end":"2026-05-14T00:47:12.281242Z","steps":["trace[1496972907] 'agreement among raft nodes before linearized reading' (duration: 401.149291ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T00:47:12.281295Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T00:47:11.879928Z","time spent":"401.35986ms","remote":"127.0.0.1:34440","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-14T00:47:12.281314Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.485228ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-14T00:47:12.281341Z","caller":"traceutil/trace.go:171","msg":"trace[1814028412] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:630; }","duration":"114.549574ms","start":"2026-05-14T00:47:12.166783Z","end":"2026-05-14T00:47:12.281333Z","steps":["trace[1814028412] 'agreement among raft nodes before linearized reading' (duration: 114.512071ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T00:47:12.281263Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T00:47:11.880986Z","time spent":"400.269923ms","remote":"127.0.0.1:34440","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-05-14T00:47:12.592028Z","caller":"traceutil/trace.go:171","msg":"trace[913769408] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"306.288297ms","start":"2026-05-14T00:47:12.285701Z","end":"2026-05-14T00:47:12.59199Z","steps":["trace[913769408] 'process raft request' (duration: 306.106612ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T00:47:12.592079Z","caller":"traceutil/trace.go:171","msg":"trace[1170983892] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"306.277327ms","start":"2026-05-14T00:47:12.285781Z","end":"2026-05-14T00:47:12.592058Z","steps":["trace[1170983892] 'process raft request' (duration: 306.147345ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T00:47:12.592106Z","caller":"traceutil/trace.go:171","msg":"trace[1389982341] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"305.501477ms","start":"2026-05-14T00:47:12.286582Z","end":"2026-05-14T00:47:12.592084Z","steps":["trace[1389982341] 'process raft request' (duration: 305.399028ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T00:47:12.592174Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T00:47:12.285669Z","time spent":"306.42972ms","remote":"127.0.0.1:34268","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":759,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-14T00:47:12.592207Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.510009ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-gd96v\" ","response":"range_response_count:1 size:17149"} {"level":"warn","ts":"2026-05-14T00:47:12.592219Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T00:47:12.285757Z","time spent":"306.390636ms","remote":"127.0.0.1:34440","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-14T00:47:12.592235Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T00:47:12.286547Z","time spent":"305.624559ms","remote":"127.0.0.1:34440","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-14T00:47:12.592254Z","caller":"traceutil/trace.go:171","msg":"trace[386821234] range","detail":"{range_begin:/registry/pods/kube-system/cilium-gd96v; range_end:; response_count:1; response_revision:633; }","duration":"304.583356ms","start":"2026-05-14T00:47:12.287661Z","end":"2026-05-14T00:47:12.592245Z","steps":["trace[386821234] 'agreement among raft nodes before linearized reading' (duration: 304.421861ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T00:47:12.592285Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T00:47:12.287652Z","time spent":"304.626309ms","remote":"127.0.0.1:34378","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":17171,"request content":"key:\"/registry/pods/kube-system/cilium-gd96v\" "} {"level":"info","ts":"2026-05-14T00:47:12.592037Z","caller":"traceutil/trace.go:171","msg":"trace[352982174] linearizableReadLoop","detail":"{readStateIndex:660; appliedIndex:656; }","duration":"304.333293ms","start":"2026-05-14T00:47:12.287683Z","end":"2026-05-14T00:47:12.592016Z","steps":["trace[352982174] 'read index received' (duration: 272.366467ms)","trace[352982174] 'applied index is now lower than readState.Index' (duration: 31.965876ms)"],"step_count":2} {"level":"warn","ts":"2026-05-14T00:47:12.594809Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.966568ms","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-05-14T00:47:12.594878Z","caller":"traceutil/trace.go:171","msg":"trace[592418849] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:634; }","duration":"298.066278ms","start":"2026-05-14T00:47:12.296799Z","end":"2026-05-14T00:47:12.594865Z","steps":["trace[592418849] 'agreement among raft nodes before linearized reading' (duration: 297.860109ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T00:47:12.59488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.793153ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-14T00:47:12.594954Z","caller":"traceutil/trace.go:171","msg":"trace[1864488157] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:634; }","duration":"297.940967ms","start":"2026-05-14T00:47:12.296995Z","end":"2026-05-14T00:47:12.594936Z","steps":["trace[1864488157] 'agreement among raft nodes before linearized reading' (duration: 297.803694ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T00:47:14.448197Z","caller":"traceutil/trace.go:171","msg":"trace[196092716] linearizableReadLoop","detail":"{readStateIndex:696; appliedIndex:695; }","duration":"281.265509ms","start":"2026-05-14T00:47:14.166906Z","end":"2026-05-14T00:47:14.448171Z","steps":["trace[196092716] 'read index received' (duration: 281.148505ms)","trace[196092716] 'applied index is now lower than readState.Index' (duration: 115.324µs)"],"step_count":2} {"level":"info","ts":"2026-05-14T00:47:14.448461Z","caller":"traceutil/trace.go:171","msg":"trace[2068476456] transaction","detail":"{read_only:false; response_revision:668; number_of_response:1; }","duration":"408.549012ms","start":"2026-05-14T00:47:14.039874Z","end":"2026-05-14T00:47:14.448423Z","steps":["trace[2068476456] 'process raft request' (duration: 408.124485ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T00:47:14.448533Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.616389ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-14T00:47:14.448767Z","caller":"traceutil/trace.go:171","msg":"trace[2043141546] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:668; }","duration":"281.899304ms","start":"2026-05-14T00:47:14.166843Z","end":"2026-05-14T00:47:14.448743Z","steps":["trace[2043141546] 'agreement among raft nodes before linearized reading' (duration: 281.581511ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T00:47:14.448768Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T00:47:14.039848Z","time spent":"408.776879ms","remote":"127.0.0.1:34246","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4234,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-14T00:47:14.464818Z","caller":"traceutil/trace.go:171","msg":"trace[1189791907] transaction","detail":"{read_only:false; response_revision:669; number_of_response:1; }","duration":"225.851254ms","start":"2026-05-14T00:47:14.238951Z","end":"2026-05-14T00:47:14.464802Z","steps":["trace[1189791907] 'process raft request' (duration: 225.504963ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T00:47:14.464944Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.503792ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-05-14T00:47:14.465094Z","caller":"traceutil/trace.go:171","msg":"trace[1561863724] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:670; }","duration":"179.7308ms","start":"2026-05-14T00:47:14.285335Z","end":"2026-05-14T00:47:14.465066Z","steps":["trace[1561863724] 'agreement among raft nodes before linearized reading' (duration: 179.372749ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T00:47:17.168173Z","caller":"traceutil/trace.go:171","msg":"trace[2101279149] transaction","detail":"{read_only:false; response_revision:708; number_of_response:1; }","duration":"125.750764ms","start":"2026-05-14T00:47:17.042388Z","end":"2026-05-14T00:47:17.168139Z","steps":["trace[2101279149] 'process raft request' (duration: 125.621271ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T00:47:29.036461Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.037716871s","expected-duration":"1s"} {"level":"warn","ts":"2026-05-14T00:47:29.301896Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.402922203s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-05-14T00:47:29.301985Z","caller":"traceutil/trace.go:171","msg":"trace[1914353603] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:794; }","duration":"1.403070138s","start":"2026-05-14T00:47:27.898895Z","end":"2026-05-14T00:47:29.301965Z","steps":["trace[1914353603] 'range keys from in-memory index tree' (duration: 1.40267276s)"],"step_count":1} {"level":"warn","ts":"2026-05-14T00:47:29.302025Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T00:47:27.898865Z","time spent":"1.403149106s","remote":"127.0.0.1:34440","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-05-14T00:47:29.302102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.341964303s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-9rr6z\" ","response":"range_response_count:1 size:3965"} {"level":"info","ts":"2026-05-14T00:47:29.302208Z","caller":"traceutil/trace.go:171","msg":"trace[1210854727] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-9rr6z; range_end:; response_count:1; response_revision:794; }","duration":"1.342114439s","start":"2026-05-14T00:47:27.960068Z","end":"2026-05-14T00:47:29.302182Z","steps":["trace[1210854727] 'range keys from in-memory index tree' (duration: 1.341769779s)"],"step_count":1} {"level":"warn","ts":"2026-05-14T00:47:29.302252Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T00:47:27.95986Z","time spent":"1.342382251s","remote":"127.0.0.1:34378","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3987,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-9rr6z\" "} {"level":"warn","ts":"2026-05-14T00:47:29.30805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.240138ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-05-14T00:47:29.308139Z","caller":"traceutil/trace.go:171","msg":"trace[391959195] linearizableReadLoop","detail":"{readStateIndex:826; appliedIndex:825; }","duration":"729.546815ms","start":"2026-05-14T00:47:28.578579Z","end":"2026-05-14T00:47:29.308126Z","steps":["trace[391959195] 'read index received' (duration: 458.124902ms)","trace[391959195] 'applied index is now lower than readState.Index' (duration: 271.420673ms)"],"step_count":2} {"level":"warn","ts":"2026-05-14T00:47:29.308438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"642.286773ms","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-05-14T00:47:29.308474Z","caller":"traceutil/trace.go:171","msg":"trace[1280603961] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:794; }","duration":"642.349802ms","start":"2026-05-14T00:47:28.66611Z","end":"2026-05-14T00:47:29.30846Z","steps":["trace[1280603961] 'agreement among raft nodes before linearized reading' (duration: 642.209936ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T00:47:29.308502Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T00:47:28.666091Z","time spent":"642.40566ms","remote":"127.0.0.1:34440","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-14T00:47:29.308606Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"729.995013ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-05-14T00:47:29.308625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"634.225849ms","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-05-14T00:47:29.308711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.311483ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-14T00:47:29.308765Z","caller":"traceutil/trace.go:171","msg":"trace[466661744] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:794; }","duration":"143.40235ms","start":"2026-05-14T00:47:29.165346Z","end":"2026-05-14T00:47:29.308748Z","steps":["trace[466661744] 'agreement among raft nodes before linearized reading' (duration: 143.341171ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T00:47:29.308768Z","caller":"traceutil/trace.go:171","msg":"trace[1876792439] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:794; }","duration":"634.389584ms","start":"2026-05-14T00:47:28.67435Z","end":"2026-05-14T00:47:29.30874Z","steps":["trace[1876792439] 'agreement among raft nodes before linearized reading' (duration: 634.044254ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T00:47:29.308626Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"642.061371ms","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-05-14T00:47:29.308824Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T00:47:28.674345Z","time spent":"634.466753ms","remote":"127.0.0.1:34440","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-05-14T00:47:29.308843Z","caller":"traceutil/trace.go:171","msg":"trace[807756393] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:794; }","duration":"642.337133ms","start":"2026-05-14T00:47:28.666496Z","end":"2026-05-14T00:47:29.308834Z","steps":["trace[807756393] 'agreement among raft nodes before linearized reading' (duration: 641.901935ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T00:47:29.308886Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T00:47:28.666482Z","time spent":"642.386601ms","remote":"127.0.0.1:34440","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-05-14T00:47:29.308774Z","caller":"traceutil/trace.go:171","msg":"trace[60419896] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:794; }","duration":"730.221127ms","start":"2026-05-14T00:47:28.57849Z","end":"2026-05-14T00:47:29.308712Z","steps":["trace[60419896] 'agreement among raft nodes before linearized reading' (duration: 729.73343ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T00:47:29.309326Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T00:47:28.578471Z","time spent":"730.842259ms","remote":"127.0.0.1:34440","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-05-14T00:47:31.955782Z","caller":"traceutil/trace.go:171","msg":"trace[1019074175] transaction","detail":"{read_only:false; response_revision:809; number_of_response:1; }","duration":"201.063482ms","start":"2026-05-14T00:47:31.754693Z","end":"2026-05-14T00:47:31.955756Z","steps":["trace[1019074175] 'process raft request' (duration: 200.906657ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T00:47:55.715709Z","caller":"traceutil/trace.go:171","msg":"trace[234470897] transaction","detail":"{read_only:false; response_revision:1015; number_of_response:1; }","duration":"124.002093ms","start":"2026-05-14T00:47:55.591685Z","end":"2026-05-14T00:47:55.715687Z","steps":["trace[234470897] 'process raft request' (duration: 121.737227ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T00:47:55.715946Z","caller":"traceutil/trace.go:171","msg":"trace[1757635969] transaction","detail":"{read_only:false; response_revision:1017; number_of_response:1; }","duration":"124.013153ms","start":"2026-05-14T00:47:55.591916Z","end":"2026-05-14T00:47:55.715929Z","steps":["trace[1757635969] 'process raft request' (duration: 123.942242ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T00:47:55.716182Z","caller":"traceutil/trace.go:171","msg":"trace[1806618021] transaction","detail":"{read_only:false; response_revision:1016; number_of_response:1; }","duration":"124.193854ms","start":"2026-05-14T00:47:55.591901Z","end":"2026-05-14T00:47:55.716094Z","steps":["trace[1806618021] 'process raft request' (duration: 123.757361ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T00:48:41.846147Z","caller":"traceutil/trace.go:171","msg":"trace[1706948097] transaction","detail":"{read_only:false; response_revision:1169; number_of_response:1; }","duration":"119.349162ms","start":"2026-05-14T00:48:41.726772Z","end":"2026-05-14T00:48:41.846121Z","steps":["trace[1706948097] 'process raft request' (duration: 119.200875ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T00:49:08.347691Z","caller":"traceutil/trace.go:171","msg":"trace[373667748] transaction","detail":"{read_only:false; response_revision:1271; number_of_response:1; }","duration":"138.358133ms","start":"2026-05-14T00:49:08.209303Z","end":"2026-05-14T00:49:08.347662Z","steps":["trace[373667748] 'process raft request' (duration: 138.1285ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T00:49:08.355219Z","caller":"traceutil/trace.go:171","msg":"trace[14692543] transaction","detail":"{read_only:false; response_revision:1272; number_of_response:1; }","duration":"145.855326ms","start":"2026-05-14T00:49:08.209346Z","end":"2026-05-14T00:49:08.355201Z","steps":["trace[14692543] 'process raft request' (duration: 145.541189ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T00:49:08.355205Z","caller":"traceutil/trace.go:171","msg":"trace[35060925] transaction","detail":"{read_only:false; response_revision:1273; number_of_response:1; }","duration":"145.224191ms","start":"2026-05-14T00:49:08.209951Z","end":"2026-05-14T00:49:08.355176Z","steps":["trace[35060925] 'process raft request' (duration: 145.129195ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T00:49:09.687693Z","caller":"traceutil/trace.go:171","msg":"trace[1775111104] transaction","detail":"{read_only:false; response_revision:1277; number_of_response:1; }","duration":"106.438974ms","start":"2026-05-14T00:49:09.581231Z","end":"2026-05-14T00:49:09.68767Z","steps":["trace[1775111104] 'process raft request' (duration: 106.286345ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T00:49:22.745867Z","caller":"traceutil/trace.go:171","msg":"trace[1201233387] linearizableReadLoop","detail":"{readStateIndex:1400; appliedIndex:1399; }","duration":"280.262565ms","start":"2026-05-14T00:49:22.46558Z","end":"2026-05-14T00:49:22.745843Z","steps":["trace[1201233387] 'read index received' (duration: 280.195051ms)","trace[1201233387] 'applied index is now lower than readState.Index' (duration: 66.494µs)"],"step_count":2} {"level":"info","ts":"2026-05-14T00:49:22.745988Z","caller":"traceutil/trace.go:171","msg":"trace[1435679268] transaction","detail":"{read_only:false; response_revision:1342; number_of_response:1; }","duration":"281.309837ms","start":"2026-05-14T00:49:22.464645Z","end":"2026-05-14T00:49:22.745955Z","steps":["trace[1435679268] 'process raft request' (duration: 281.061963ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T00:49:22.746186Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.587455ms","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-05-14T00:49:22.746256Z","caller":"traceutil/trace.go:171","msg":"trace[620382455] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1342; }","duration":"280.688892ms","start":"2026-05-14T00:49:22.46555Z","end":"2026-05-14T00:49:22.746239Z","steps":["trace[620382455] 'agreement among raft nodes before linearized reading' (duration: 280.423496ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T00:49:22.796445Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.403654ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-14T00:49:22.796615Z","caller":"traceutil/trace.go:171","msg":"trace[1604837099] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:1343; }","duration":"190.635237ms","start":"2026-05-14T00:49:22.605965Z","end":"2026-05-14T00:49:22.7966Z","steps":["trace[1604837099] 'agreement among raft nodes before linearized reading' (duration: 190.402574ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T00:49:22.796451Z","caller":"traceutil/trace.go:171","msg":"trace[332011029] transaction","detail":"{read_only:false; response_revision:1343; number_of_response:1; }","duration":"286.956605ms","start":"2026-05-14T00:49:22.509468Z","end":"2026-05-14T00:49:22.796425Z","steps":["trace[332011029] 'process raft request' (duration: 286.750233ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T00:49:22.796482Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.979179ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-05-14T00:49:22.797174Z","caller":"traceutil/trace.go:171","msg":"trace[112698312] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1343; }","duration":"330.69459ms","start":"2026-05-14T00:49:22.466455Z","end":"2026-05-14T00:49:22.79715Z","steps":["trace[112698312] 'agreement among raft nodes before linearized reading' (duration: 329.903724ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T00:49:22.79728Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T00:49:22.466441Z","time spent":"330.800996ms","remote":"127.0.0.1:34440","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\" "}