{"level":"warn","ts":"2026-08-10T22:25:08.604126Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-10T22:25:08.604275Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.151: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.19.213.151:2380","--initial-cluster=instance=https://199.19.213.151:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.151:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.151: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-08-10T22:25:08.60439Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-10T22:25:08.604449Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.151:2380"]} {"level":"info","ts":"2026-08-10T22:25:08.604537Z","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-08-10T22:25:08.605459Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.151:2379"]} {"level":"info","ts":"2026-08-10T22:25:08.605568Z","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.19.213.151:2380"],"listen-peer-urls":["https://199.19.213.151:2380"],"advertise-client-urls":["https://199.19.213.151:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.151:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.151: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-08-10T22:25:08.611284Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.35514ms"} {"level":"info","ts":"2026-08-10T22:25:08.620818Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"9abf795dae4ebc2c","cluster-id":"8a186cf11cef5bce"} {"level":"info","ts":"2026-08-10T22:25:08.621164Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9abf795dae4ebc2c switched to configuration voters=()"} {"level":"info","ts":"2026-08-10T22:25:08.621272Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9abf795dae4ebc2c became follower at term 0"} {"level":"info","ts":"2026-08-10T22:25:08.621443Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 9abf795dae4ebc2c [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-10T22:25:08.621499Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9abf795dae4ebc2c became follower at term 1"} {"level":"info","ts":"2026-08-10T22:25:08.621671Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9abf795dae4ebc2c switched to configuration voters=(11150764645655952428)"} {"level":"warn","ts":"2026-08-10T22:25:08.635024Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-10T22:25:08.636824Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-10T22:25:08.638449Z","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-08-10T22:25:08.641186Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"9abf795dae4ebc2c","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-10T22:25:08.641463Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"9abf795dae4ebc2c","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-10T22:25:08.641758Z","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-08-10T22:25:08.641891Z","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-08-10T22:25:08.641913Z","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-08-10T22:25:08.644683Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9abf795dae4ebc2c switched to configuration voters=(11150764645655952428)"} {"level":"info","ts":"2026-08-10T22:25:08.646405Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"8a186cf11cef5bce","local-member-id":"9abf795dae4ebc2c","added-peer-id":"9abf795dae4ebc2c","added-peer-peer-urls":["https://199.19.213.151:2380"]} {"level":"info","ts":"2026-08-10T22:25:08.648199Z","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-08-10T22:25:08.648422Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.151:2380"} {"level":"info","ts":"2026-08-10T22:25:08.649309Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.151:2380"} {"level":"info","ts":"2026-08-10T22:25:08.648625Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"9abf795dae4ebc2c","initial-advertise-peer-urls":["https://199.19.213.151:2380"],"listen-peer-urls":["https://199.19.213.151:2380"],"advertise-client-urls":["https://199.19.213.151:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.151:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-10T22:25:08.648726Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-10T22:25:08.922695Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9abf795dae4ebc2c is starting a new election at term 1"} {"level":"info","ts":"2026-08-10T22:25:08.922857Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9abf795dae4ebc2c became pre-candidate at term 1"} {"level":"info","ts":"2026-08-10T22:25:08.922915Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9abf795dae4ebc2c received MsgPreVoteResp from 9abf795dae4ebc2c at term 1"} {"level":"info","ts":"2026-08-10T22:25:08.922957Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9abf795dae4ebc2c became candidate at term 2"} {"level":"info","ts":"2026-08-10T22:25:08.922982Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9abf795dae4ebc2c received MsgVoteResp from 9abf795dae4ebc2c at term 2"} {"level":"info","ts":"2026-08-10T22:25:08.923012Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9abf795dae4ebc2c became leader at term 2"} {"level":"info","ts":"2026-08-10T22:25:08.923038Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 9abf795dae4ebc2c elected leader 9abf795dae4ebc2c at term 2"} {"level":"info","ts":"2026-08-10T22:25:08.924324Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"9abf795dae4ebc2c","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.151:2379]}","request-path":"/0/members/9abf795dae4ebc2c/attributes","cluster-id":"8a186cf11cef5bce","publish-timeout":"7s"} {"level":"info","ts":"2026-08-10T22:25:08.924389Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-10T22:25:08.924516Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-10T22:25:08.924675Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-10T22:25:08.925177Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-10T22:25:08.92522Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-10T22:25:08.926063Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"8a186cf11cef5bce","local-member-id":"9abf795dae4ebc2c","cluster-version":"3.5"} {"level":"info","ts":"2026-08-10T22:25:08.926188Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-10T22:25:08.926243Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-08-10T22:25:08.928468Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-08-10T22:25:08.9294Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.151:2379"} {"level":"warn","ts":"2026-08-10T22:25:47.252643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.388359ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-10T22:25:47.252815Z","caller":"traceutil/trace.go:171","msg":"trace[1958077966] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:0; response_revision:530; }","duration":"130.614594ms","start":"2026-08-10T22:25:47.122173Z","end":"2026-08-10T22:25:47.252788Z","steps":["trace[1958077966] 'range keys from in-memory index tree' (duration: 130.302807ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T22:25:54.118714Z","caller":"traceutil/trace.go:171","msg":"trace[840993259] transaction","detail":"{read_only:false; response_revision:639; number_of_response:1; }","duration":"129.156115ms","start":"2026-08-10T22:25:53.989523Z","end":"2026-08-10T22:25:54.118679Z","steps":["trace[840993259] 'process raft request' (duration: 128.215535ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T22:25:54.347742Z","caller":"traceutil/trace.go:171","msg":"trace[1253792880] linearizableReadLoop","detail":"{readStateIndex:667; appliedIndex:666; }","duration":"163.960914ms","start":"2026-08-10T22:25:54.183761Z","end":"2026-08-10T22:25:54.347722Z","steps":["trace[1253792880] 'read index received' (duration: 163.77075ms)","trace[1253792880] 'applied index is now lower than readState.Index' (duration: 189.534µs)"],"step_count":2} {"level":"warn","ts":"2026-08-10T22:25:54.347899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.117957ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-f4gc4\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-08-10T22:25:54.347922Z","caller":"traceutil/trace.go:171","msg":"trace[1066861912] range","detail":"{range_begin:/registry/pods/kube-system/cilium-f4gc4; range_end:; response_count:1; response_revision:640; }","duration":"164.251359ms","start":"2026-08-10T22:25:54.183663Z","end":"2026-08-10T22:25:54.347915Z","steps":["trace[1066861912] 'agreement among raft nodes before linearized reading' (duration: 164.140597ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T22:25:54.348091Z","caller":"traceutil/trace.go:171","msg":"trace[285250303] transaction","detail":"{read_only:false; response_revision:640; number_of_response:1; }","duration":"175.578331ms","start":"2026-08-10T22:25:54.172495Z","end":"2026-08-10T22:25:54.348074Z","steps":["trace[285250303] 'process raft request' (duration: 175.10208ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T22:25:55.133508Z","caller":"traceutil/trace.go:171","msg":"trace[437970482] transaction","detail":"{read_only:false; response_revision:641; number_of_response:1; }","duration":"768.453204ms","start":"2026-08-10T22:25:54.365018Z","end":"2026-08-10T22:25:55.133471Z","steps":["trace[437970482] 'process raft request' (duration: 736.550222ms)","trace[437970482] 'compare' (duration: 31.570015ms)"],"step_count":2} {"level":"warn","ts":"2026-08-10T22:25:55.135678Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-10T22:25:54.365Z","time spent":"769.503115ms","remote":"127.0.0.1:34830","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-10T22:25:55.135863Z","caller":"traceutil/trace.go:171","msg":"trace[724940473] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"357.137124ms","start":"2026-08-10T22:25:54.778704Z","end":"2026-08-10T22:25:55.135841Z","steps":["trace[724940473] 'process raft request' (duration: 356.560633ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T22:25:55.135903Z","caller":"traceutil/trace.go:171","msg":"trace[198233425] linearizableReadLoop","detail":"{readStateIndex:669; appliedIndex:667; }","duration":"297.77949ms","start":"2026-08-10T22:25:54.8381Z","end":"2026-08-10T22:25:55.135879Z","steps":["trace[198233425] 'read index received' (duration: 263.52859ms)","trace[198233425] 'applied index is now lower than readState.Index' (duration: 34.171879ms)"],"step_count":2} {"level":"warn","ts":"2026-08-10T22:25:55.135999Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-10T22:25:54.778677Z","time spent":"357.240786ms","remote":"127.0.0.1:34766","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036305,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-10T22:25:55.136343Z","caller":"traceutil/trace.go:171","msg":"trace[957479341] transaction","detail":"{read_only:false; response_revision:643; number_of_response:1; }","duration":"196.467989ms","start":"2026-08-10T22:25:54.939859Z","end":"2026-08-10T22:25:55.136327Z","steps":["trace[957479341] 'process raft request' (duration: 195.898927ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T22:25:55.136444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.017102ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-10T22:25:55.13648Z","caller":"traceutil/trace.go:171","msg":"trace[1468070536] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:643; }","duration":"113.136594ms","start":"2026-08-10T22:25:55.023333Z","end":"2026-08-10T22:25:55.13647Z","steps":["trace[1468070536] 'agreement among raft nodes before linearized reading' (duration: 113.020601ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T22:25:55.136575Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.469895ms","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-08-10T22:25:55.136616Z","caller":"traceutil/trace.go:171","msg":"trace[146693489] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:643; }","duration":"298.539515ms","start":"2026-08-10T22:25:54.838063Z","end":"2026-08-10T22:25:55.136602Z","steps":["trace[146693489] 'agreement among raft nodes before linearized reading' (duration: 298.411823ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T22:25:56.489Z","caller":"traceutil/trace.go:171","msg":"trace[229556509] transaction","detail":"{read_only:false; response_revision:665; number_of_response:1; }","duration":"137.573305ms","start":"2026-08-10T22:25:56.351397Z","end":"2026-08-10T22:25:56.48897Z","steps":["trace[229556509] 'process raft request' (duration: 134.89684ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T22:26:10.004937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.983258ms","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-08-10T22:26:10.005085Z","caller":"traceutil/trace.go:171","msg":"trace[737684241] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:803; }","duration":"286.207163ms","start":"2026-08-10T22:26:09.718843Z","end":"2026-08-10T22:26:10.00505Z","steps":["trace[737684241] 'range keys from in-memory index tree' (duration: 285.703723ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T22:26:10.00518Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.000247ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-08-10T22:26:10.005264Z","caller":"traceutil/trace.go:171","msg":"trace[713629619] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:803; }","duration":"258.142849ms","start":"2026-08-10T22:26:09.747101Z","end":"2026-08-10T22:26:10.005244Z","steps":["trace[713629619] 'range keys from in-memory index tree' (duration: 257.70979ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T22:26:22.75335Z","caller":"traceutil/trace.go:171","msg":"trace[1335620100] transaction","detail":"{read_only:false; response_revision:934; number_of_response:1; }","duration":"125.123778ms","start":"2026-08-10T22:26:22.628209Z","end":"2026-08-10T22:26:22.753332Z","steps":["trace[1335620100] 'process raft request' (duration: 124.982945ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T22:26:22.95854Z","caller":"traceutil/trace.go:171","msg":"trace[1756742198] transaction","detail":"{read_only:false; response_revision:935; number_of_response:1; }","duration":"197.53919ms","start":"2026-08-10T22:26:22.760973Z","end":"2026-08-10T22:26:22.958512Z","steps":["trace[1756742198] 'process raft request' (duration: 197.366865ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T22:26:32.458276Z","caller":"traceutil/trace.go:171","msg":"trace[448114822] linearizableReadLoop","detail":"{readStateIndex:1008; appliedIndex:1007; }","duration":"303.311123ms","start":"2026-08-10T22:26:32.154944Z","end":"2026-08-10T22:26:32.458255Z","steps":["trace[448114822] 'read index received' (duration: 303.18175ms)","trace[448114822] 'applied index is now lower than readState.Index' (duration: 128.453µs)"],"step_count":2} {"level":"info","ts":"2026-08-10T22:26:32.458372Z","caller":"traceutil/trace.go:171","msg":"trace[1479726913] transaction","detail":"{read_only:false; response_revision:972; number_of_response:1; }","duration":"340.379553ms","start":"2026-08-10T22:26:32.117979Z","end":"2026-08-10T22:26:32.458358Z","steps":["trace[1479726913] 'process raft request' (duration: 340.155067ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T22:26:32.458518Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.573679ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-08-10T22:26:32.458546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.137541ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.151\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-08-10T22:26:32.458616Z","caller":"traceutil/trace.go:171","msg":"trace[1533508995] range","detail":"{range_begin:/registry/masterleases/199.19.213.151; range_end:; response_count:1; response_revision:972; }","duration":"194.240713ms","start":"2026-08-10T22:26:32.264367Z","end":"2026-08-10T22:26:32.458607Z","steps":["trace[1533508995] 'agreement among raft nodes before linearized reading' (duration: 194.12428ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T22:26:32.458618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.404665ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-08-10T22:26:32.458714Z","caller":"traceutil/trace.go:171","msg":"trace[2021632483] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:972; }","duration":"301.569668ms","start":"2026-08-10T22:26:32.157126Z","end":"2026-08-10T22:26:32.458696Z","steps":["trace[2021632483] 'agreement among raft nodes before linearized reading' (duration: 301.325604ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T22:26:32.458768Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-10T22:26:32.157119Z","time spent":"301.63848ms","remote":"127.0.0.1:34902","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-08-10T22:26:32.45855Z","caller":"traceutil/trace.go:171","msg":"trace[644152973] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:972; }","duration":"303.64898ms","start":"2026-08-10T22:26:32.154893Z","end":"2026-08-10T22:26:32.458542Z","steps":["trace[644152973] 'agreement among raft nodes before linearized reading' (duration: 303.499737ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T22:26:32.458863Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-10T22:26:32.154874Z","time spent":"303.976736ms","remote":"127.0.0.1:34902","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-08-10T22:26:32.458532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.224092ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-10T22:26:32.458966Z","caller":"traceutil/trace.go:171","msg":"trace[624225427] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:972; }","duration":"125.709651ms","start":"2026-08-10T22:26:32.333248Z","end":"2026-08-10T22:26:32.458957Z","steps":["trace[624225427] 'agreement among raft nodes before linearized reading' (duration: 125.218112ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T22:26:32.459798Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-10T22:26:32.117956Z","time spent":"340.447944ms","remote":"127.0.0.1:34902","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-10T22:26:33.111589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.56774ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:41"} {"level":"warn","ts":"2026-08-10T22:26:33.111949Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-10T22:26:32.460661Z","time spent":"651.28298ms","remote":"127.0.0.1:34714","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-08-10T22:26:33.11203Z","caller":"traceutil/trace.go:171","msg":"trace[477045178] linearizableReadLoop","detail":"{readStateIndex:1012; appliedIndex:1008; }","duration":"471.978173ms","start":"2026-08-10T22:26:32.640036Z","end":"2026-08-10T22:26:33.112014Z","steps":["trace[477045178] 'read index received' (duration: 276.924934ms)","trace[477045178] 'applied index is now lower than readState.Index' (duration: 195.052509ms)"],"step_count":2} {"level":"info","ts":"2026-08-10T22:26:33.112066Z","caller":"traceutil/trace.go:171","msg":"trace[2121159813] transaction","detail":"{read_only:false; response_revision:973; number_of_response:1; }","duration":"649.41378ms","start":"2026-08-10T22:26:32.462622Z","end":"2026-08-10T22:26:33.112036Z","steps":["trace[2121159813] 'process raft request' (duration: 649.042823ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T22:26:33.112206Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-10T22:26:32.4626Z","time spent":"649.530813ms","remote":"127.0.0.1:34902","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-10T22:26:33.112213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"472.154557ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-10T22:26:33.112237Z","caller":"traceutil/trace.go:171","msg":"trace[829850803] transaction","detail":"{read_only:false; response_revision:975; number_of_response:1; }","duration":"648.80803ms","start":"2026-08-10T22:26:32.463416Z","end":"2026-08-10T22:26:33.112224Z","steps":["trace[829850803] 'process raft request' (duration: 648.560464ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T22:26:33.112252Z","caller":"traceutil/trace.go:171","msg":"trace[1942300017] range","detail":"{range_begin:/registry/endpointslices/; range_end:/registry/endpointslices0; response_count:0; response_revision:975; }","duration":"472.240558ms","start":"2026-08-10T22:26:32.640004Z","end":"2026-08-10T22:26:33.112245Z","steps":["trace[1942300017] 'agreement among raft nodes before linearized reading' (duration: 472.115025ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T22:26:33.112254Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.277391ms","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-08-10T22:26:33.112083Z","caller":"traceutil/trace.go:171","msg":"trace[781383163] transaction","detail":"{read_only:false; response_revision:974; number_of_response:1; }","duration":"648.928961ms","start":"2026-08-10T22:26:32.463135Z","end":"2026-08-10T22:26:33.112064Z","steps":["trace[781383163] 'process raft request' (duration: 648.811959ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T22:26:33.112276Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-10T22:26:32.639989Z","time spent":"472.27922ms","remote":"127.0.0.1:34904","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":3,"response size":31,"request content":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true "} {"level":"warn","ts":"2026-08-10T22:26:33.11231Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-10T22:26:32.463404Z","time spent":"648.856711ms","remote":"127.0.0.1:34902","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-10T22:26:33.112284Z","caller":"traceutil/trace.go:171","msg":"trace[1679525686] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:975; }","duration":"323.346253ms","start":"2026-08-10T22:26:32.78893Z","end":"2026-08-10T22:26:33.112276Z","steps":["trace[1679525686] 'agreement among raft nodes before linearized reading' (duration: 323.196159ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T22:26:33.112393Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-10T22:26:32.788913Z","time spent":"323.473055ms","remote":"127.0.0.1:34902","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-08-10T22:26:33.112408Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-10T22:26:32.4631Z","time spent":"649.214358ms","remote":"127.0.0.1:34902","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-10T22:26:57.441448Z","caller":"traceutil/trace.go:171","msg":"trace[1973522075] transaction","detail":"{read_only:false; response_revision:1060; number_of_response:1; }","duration":"174.475279ms","start":"2026-08-10T22:26:57.266946Z","end":"2026-08-10T22:26:57.441421Z","steps":["trace[1973522075] 'process raft request' (duration: 174.320116ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T22:27:12.55801Z","caller":"traceutil/trace.go:171","msg":"trace[323191771] transaction","detail":"{read_only:false; response_revision:1159; number_of_response:1; }","duration":"146.078928ms","start":"2026-08-10T22:27:12.411896Z","end":"2026-08-10T22:27:12.557975Z","steps":["trace[323191771] 'process raft request' (duration: 143.911663ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T22:27:13.84636Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13559388421710419674,"retry-timeout":"500ms"} {"level":"info","ts":"2026-08-10T22:27:14.000875Z","caller":"traceutil/trace.go:171","msg":"trace[1840418047] transaction","detail":"{read_only:false; response_revision:1161; number_of_response:1; }","duration":"676.101987ms","start":"2026-08-10T22:27:13.324726Z","end":"2026-08-10T22:27:14.000828Z","steps":["trace[1840418047] 'process raft request' (duration: 675.945304ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T22:27:14.001074Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-10T22:27:13.32471Z","time spent":"676.28804ms","remote":"127.0.0.1:34902","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-10T22:27:14.679912Z","caller":"traceutil/trace.go:171","msg":"trace[316151487] linearizableReadLoop","detail":"{readStateIndex:1209; appliedIndex:1207; }","duration":"1.334079308s","start":"2026-08-10T22:27:13.345812Z","end":"2026-08-10T22:27:14.679891Z","steps":["trace[316151487] 'read index received' (duration: 654.848577ms)","trace[316151487] 'applied index is now lower than readState.Index' (duration: 679.227831ms)"],"step_count":2} {"level":"info","ts":"2026-08-10T22:27:14.679955Z","caller":"traceutil/trace.go:171","msg":"trace[550952228] transaction","detail":"{read_only:false; response_revision:1162; number_of_response:1; }","duration":"932.559174ms","start":"2026-08-10T22:27:13.747356Z","end":"2026-08-10T22:27:14.679915Z","steps":["trace[550952228] 'process raft request' (duration: 932.409821ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T22:27:14.680108Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"653.58922ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-10T22:27:14.680106Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-10T22:27:13.747337Z","time spent":"932.685956ms","remote":"127.0.0.1:34902","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-10T22:27:14.680145Z","caller":"traceutil/trace.go:171","msg":"trace[2041477170] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1162; }","duration":"653.677962ms","start":"2026-08-10T22:27:14.026457Z","end":"2026-08-10T22:27:14.680135Z","steps":["trace[2041477170] 'agreement among raft nodes before linearized reading' (duration: 653.57931ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T22:27:14.680172Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-10T22:27:14.026439Z","time spent":"653.727813ms","remote":"127.0.0.1:34684","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-10T22:27:14.680205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.151688336s","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-08-10T22:27:14.680259Z","caller":"traceutil/trace.go:171","msg":"trace[1528987498] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1162; }","duration":"1.151771777s","start":"2026-08-10T22:27:13.528474Z","end":"2026-08-10T22:27:14.680246Z","steps":["trace[1528987498] 'agreement among raft nodes before linearized reading' (duration: 1.151554073s)"],"step_count":1} {"level":"warn","ts":"2026-08-10T22:27:14.680293Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-10T22:27:13.52846Z","time spent":"1.15182523s","remote":"127.0.0.1:34902","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-08-10T22:27:14.68039Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.726373ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-10T22:27:14.680416Z","caller":"traceutil/trace.go:171","msg":"trace[1684162399] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:1162; }","duration":"108.778675ms","start":"2026-08-10T22:27:14.571631Z","end":"2026-08-10T22:27:14.680409Z","steps":["trace[1684162399] 'agreement among raft nodes before linearized reading' (duration: 108.732404ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T22:27:14.680427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.119643512s","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-08-10T22:27:14.680462Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.128374464s","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-08-10T22:27:14.680484Z","caller":"traceutil/trace.go:171","msg":"trace[1582278790] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1162; }","duration":"1.128433664s","start":"2026-08-10T22:27:13.552044Z","end":"2026-08-10T22:27:14.680477Z","steps":["trace[1582278790] 'agreement among raft nodes before linearized reading' (duration: 1.128369193s)"],"step_count":1} {"level":"info","ts":"2026-08-10T22:27:14.680487Z","caller":"traceutil/trace.go:171","msg":"trace[430188259] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1162; }","duration":"1.119737403s","start":"2026-08-10T22:27:13.560738Z","end":"2026-08-10T22:27:14.680475Z","steps":["trace[430188259] 'agreement among raft nodes before linearized reading' (duration: 1.11960844s)"],"step_count":1} {"level":"warn","ts":"2026-08-10T22:27:14.680509Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-10T22:27:13.552025Z","time spent":"1.128479265s","remote":"127.0.0.1:34902","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-08-10T22:27:14.680518Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-10T22:27:13.560721Z","time spent":"1.119788405s","remote":"127.0.0.1:34902","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-08-10T22:27:14.680664Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.334852214s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-08-10T22:27:14.680694Z","caller":"traceutil/trace.go:171","msg":"trace[1750197491] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1162; }","duration":"1.334881194s","start":"2026-08-10T22:27:13.345805Z","end":"2026-08-10T22:27:14.680686Z","steps":["trace[1750197491] 'agreement among raft nodes before linearized reading' (duration: 1.334205351s)"],"step_count":1} {"level":"warn","ts":"2026-08-10T22:27:14.680711Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-10T22:27:13.34577Z","time spent":"1.334937256s","remote":"127.0.0.1:34902","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-08-10T22:27:32.227757Z","caller":"traceutil/trace.go:171","msg":"trace[1651818362] transaction","detail":"{read_only:false; response_revision:1247; number_of_response:1; }","duration":"140.244448ms","start":"2026-08-10T22:27:32.087493Z","end":"2026-08-10T22:27:32.227737Z","steps":["trace[1651818362] 'process raft request' (duration: 140.124105ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T22:27:32.894878Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-10T22:27:32.268782Z","time spent":"626.08946ms","remote":"127.0.0.1:34714","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-08-10T22:27:32.90965Z","caller":"traceutil/trace.go:171","msg":"trace[1239782848] linearizableReadLoop","detail":"{readStateIndex:1300; appliedIndex:1298; }","duration":"131.557108ms","start":"2026-08-10T22:27:32.778071Z","end":"2026-08-10T22:27:32.909628Z","steps":["trace[1239782848] 'read index received' (duration: 28.526901ms)","trace[1239782848] 'applied index is now lower than readState.Index' (duration: 103.028667ms)"],"step_count":2} {"level":"info","ts":"2026-08-10T22:27:32.909761Z","caller":"traceutil/trace.go:171","msg":"trace[1802103472] transaction","detail":"{read_only:false; response_revision:1248; number_of_response:1; }","duration":"146.374095ms","start":"2026-08-10T22:27:32.763372Z","end":"2026-08-10T22:27:32.909746Z","steps":["trace[1802103472] 'process raft request' (duration: 146.082909ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T22:27:32.910069Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.980306ms","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-08-10T22:27:32.910194Z","caller":"traceutil/trace.go:171","msg":"trace[1237012291] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1248; }","duration":"132.145689ms","start":"2026-08-10T22:27:32.778028Z","end":"2026-08-10T22:27:32.910174Z","steps":["trace[1237012291] 'agreement among raft nodes before linearized reading' (duration: 131.807343ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T22:27:32.92663Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.102512ms","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":"warn","ts":"2026-08-10T22:27:32.926656Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.11517ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-08-10T22:27:32.926692Z","caller":"traceutil/trace.go:171","msg":"trace[1117191848] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1249; }","duration":"135.230924ms","start":"2026-08-10T22:27:32.791445Z","end":"2026-08-10T22:27:32.926676Z","steps":["trace[1117191848] 'agreement among raft nodes before linearized reading' (duration: 135.04964ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T22:27:32.926693Z","caller":"traceutil/trace.go:171","msg":"trace[1669335714] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1249; }","duration":"133.175961ms","start":"2026-08-10T22:27:32.793506Z","end":"2026-08-10T22:27:32.926682Z","steps":["trace[1669335714] 'agreement among raft nodes before linearized reading' (duration: 133.081519ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T22:27:32.926848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.245732ms","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-08-10T22:27:32.926961Z","caller":"traceutil/trace.go:171","msg":"trace[2142035584] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1249; }","duration":"133.428036ms","start":"2026-08-10T22:27:32.793507Z","end":"2026-08-10T22:27:32.926935Z","steps":["trace[2142035584] 'agreement among raft nodes before linearized reading' (duration: 133.052919ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T22:27:41.40434Z","caller":"traceutil/trace.go:171","msg":"trace[368088101] linearizableReadLoop","detail":"{readStateIndex:1364; appliedIndex:1363; }","duration":"395.017249ms","start":"2026-08-10T22:27:41.0093Z","end":"2026-08-10T22:27:41.404317Z","steps":["trace[368088101] 'read index received' (duration: 394.830836ms)","trace[368088101] 'applied index is now lower than readState.Index' (duration: 185.493µs)"],"step_count":2} {"level":"warn","ts":"2026-08-10T22:27:41.404608Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"392.688571ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-08-10T22:27:41.404658Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"392.698121ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-08-10T22:27:41.404733Z","caller":"traceutil/trace.go:171","msg":"trace[1000593346] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1311; }","duration":"392.808403ms","start":"2026-08-10T22:27:41.011901Z","end":"2026-08-10T22:27:41.404709Z","steps":["trace[1000593346] 'agreement among raft nodes before linearized reading' (duration: 392.670011ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T22:27:41.404399Z","caller":"traceutil/trace.go:171","msg":"trace[672121225] transaction","detail":"{read_only:false; response_revision:1311; number_of_response:1; }","duration":"472.227889ms","start":"2026-08-10T22:27:40.932141Z","end":"2026-08-10T22:27:41.404369Z","steps":["trace[672121225] 'process raft request' (duration: 472.038206ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T22:27:41.404787Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-10T22:27:41.011865Z","time spent":"392.910085ms","remote":"127.0.0.1:34902","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-08-10T22:27:41.404891Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-10T22:27:40.932123Z","time spent":"472.664779ms","remote":"127.0.0.1:34902","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-10T22:27:41.404639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"388.362651ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-08-10T22:27:41.405082Z","caller":"traceutil/trace.go:171","msg":"trace[1479141598] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1311; }","duration":"388.82035ms","start":"2026-08-10T22:27:41.016244Z","end":"2026-08-10T22:27:41.405065Z","steps":["trace[1479141598] 'agreement among raft nodes before linearized reading' (duration: 388.238349ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T22:27:41.4052Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-10T22:27:41.016213Z","time spent":"388.908882ms","remote":"127.0.0.1:34902","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-08-10T22:27:41.404673Z","caller":"traceutil/trace.go:171","msg":"trace[1560600959] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1311; }","duration":"392.798642ms","start":"2026-08-10T22:27:41.011862Z","end":"2026-08-10T22:27:41.404661Z","steps":["trace[1560600959] 'agreement among raft nodes before linearized reading' (duration: 392.610589ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T22:27:41.405322Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-10T22:27:41.011828Z","time spent":"393.474367ms","remote":"127.0.0.1:34902","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-08-10T22:27:41.405554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"396.254125ms","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-08-10T22:27:41.405609Z","caller":"traceutil/trace.go:171","msg":"trace[568043559] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1311; }","duration":"396.344027ms","start":"2026-08-10T22:27:41.009253Z","end":"2026-08-10T22:27:41.405597Z","steps":["trace[568043559] 'agreement among raft nodes before linearized reading' (duration: 395.166452ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T22:27:41.405642Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-10T22:27:41.009235Z","time spent":"396.399398ms","remote":"127.0.0.1:34902","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-08-10T22:28:01.825994Z","caller":"traceutil/trace.go:171","msg":"trace[1889823482] transaction","detail":"{read_only:false; response_revision:1409; number_of_response:1; }","duration":"159.789503ms","start":"2026-08-10T22:28:01.666166Z","end":"2026-08-10T22:28:01.825955Z","steps":["trace[1889823482] 'process raft request' (duration: 76.241742ms)","trace[1889823482] 'compare' (duration: 83.415168ms)"],"step_count":2}