{"level":"warn","ts":"2026-08-14T23:16:10.518766Z","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-14T23:16:10.518857Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.222: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.222:2380","--initial-cluster=instance=https://199.204.45.222:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.222:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.222: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-14T23:16:10.518917Z","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-14T23:16:10.518926Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.222:2380"]} {"level":"info","ts":"2026-08-14T23:16:10.518946Z","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-14T23:16:10.519595Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.222:2379"]} {"level":"info","ts":"2026-08-14T23:16:10.519687Z","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.222:2380"],"listen-peer-urls":["https://199.204.45.222:2380"],"advertise-client-urls":["https://199.204.45.222:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.222:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.222: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-14T23:16:10.523106Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.21284ms"} {"level":"info","ts":"2026-08-14T23:16:10.530075Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"380f6760faea5f9e","cluster-id":"b87e8aca83a17eab"} {"level":"info","ts":"2026-08-14T23:16:10.53022Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e switched to configuration voters=()"} {"level":"info","ts":"2026-08-14T23:16:10.530279Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e became follower at term 0"} {"level":"info","ts":"2026-08-14T23:16:10.530296Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 380f6760faea5f9e [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-14T23:16:10.530316Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e became follower at term 1"} {"level":"info","ts":"2026-08-14T23:16:10.53037Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e switched to configuration voters=(4039561056998809502)"} {"level":"warn","ts":"2026-08-14T23:16:10.537217Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-14T23:16:10.541847Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-14T23:16:10.545107Z","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-14T23:16:10.550655Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"380f6760faea5f9e","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-14T23:16:10.550952Z","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-14T23:16:10.55102Z","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-14T23:16:10.551031Z","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-14T23:16:10.551064Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"380f6760faea5f9e","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-14T23:16:10.553525Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e switched to configuration voters=(4039561056998809502)"} {"level":"info","ts":"2026-08-14T23:16:10.55376Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"b87e8aca83a17eab","local-member-id":"380f6760faea5f9e","added-peer-id":"380f6760faea5f9e","added-peer-peer-urls":["https://199.204.45.222:2380"]} {"level":"info","ts":"2026-08-14T23:16:10.555686Z","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-14T23:16:10.555833Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.222:2380"} {"level":"info","ts":"2026-08-14T23:16:10.555899Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.222:2380"} {"level":"info","ts":"2026-08-14T23:16:10.555971Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"380f6760faea5f9e","initial-advertise-peer-urls":["https://199.204.45.222:2380"],"listen-peer-urls":["https://199.204.45.222:2380"],"advertise-client-urls":["https://199.204.45.222:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.222:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-14T23:16:10.556016Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-14T23:16:10.630565Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e is starting a new election at term 1"} {"level":"info","ts":"2026-08-14T23:16:10.630633Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e became pre-candidate at term 1"} {"level":"info","ts":"2026-08-14T23:16:10.630659Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e received MsgPreVoteResp from 380f6760faea5f9e at term 1"} {"level":"info","ts":"2026-08-14T23:16:10.630723Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e became candidate at term 2"} {"level":"info","ts":"2026-08-14T23:16:10.630753Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e received MsgVoteResp from 380f6760faea5f9e at term 2"} {"level":"info","ts":"2026-08-14T23:16:10.630834Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e became leader at term 2"} {"level":"info","ts":"2026-08-14T23:16:10.630858Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 380f6760faea5f9e elected leader 380f6760faea5f9e at term 2"} {"level":"info","ts":"2026-08-14T23:16:10.632389Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"380f6760faea5f9e","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.222:2379]}","request-path":"/0/members/380f6760faea5f9e/attributes","cluster-id":"b87e8aca83a17eab","publish-timeout":"7s"} {"level":"info","ts":"2026-08-14T23:16:10.63272Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-14T23:16:10.633597Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-14T23:16:10.634033Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-14T23:16:10.634241Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-14T23:16:10.63426Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-14T23:16:10.634316Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"b87e8aca83a17eab","local-member-id":"380f6760faea5f9e","cluster-version":"3.5"} {"level":"info","ts":"2026-08-14T23:16:10.634421Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-14T23:16:10.634447Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-08-14T23:16:10.636456Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.222:2379"} {"level":"info","ts":"2026-08-14T23:16:10.638111Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-08-14T23:16:38.754863Z","caller":"traceutil/trace.go:171","msg":"trace[35243287] transaction","detail":"{read_only:false; response_revision:426; number_of_response:1; }","duration":"226.708829ms","start":"2026-08-14T23:16:38.528126Z","end":"2026-08-14T23:16:38.754834Z","steps":["trace[35243287] 'process raft request' (duration: 226.539436ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:16:47.004989Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.569322ms","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-14T23:16:47.005132Z","caller":"traceutil/trace.go:171","msg":"trace[648948195] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:480; }","duration":"141.762956ms","start":"2026-08-14T23:16:46.863345Z","end":"2026-08-14T23:16:47.005108Z","steps":["trace[648948195] 'range keys from in-memory index tree' (duration: 141.469321ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:16:47.005451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.033304ms","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-14T23:16:47.005543Z","caller":"traceutil/trace.go:171","msg":"trace[1847967342] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:480; }","duration":"147.161336ms","start":"2026-08-14T23:16:46.858359Z","end":"2026-08-14T23:16:47.00552Z","steps":["trace[1847967342] 'range keys from in-memory index tree' (duration: 146.929642ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:16:47.335689Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.804605ms","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-14T23:16:47.335996Z","caller":"traceutil/trace.go:171","msg":"trace[1694213605] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:0; response_revision:482; }","duration":"218.179932ms","start":"2026-08-14T23:16:47.117785Z","end":"2026-08-14T23:16:47.335965Z","steps":["trace[1694213605] 'range keys from in-memory index tree' (duration: 217.691772ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:16:48.087318Z","caller":"traceutil/trace.go:171","msg":"trace[379998089] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"500.325938ms","start":"2026-08-14T23:16:47.586941Z","end":"2026-08-14T23:16:48.087267Z","steps":["trace[379998089] 'process raft request' (duration: 500.263337ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:16:48.087385Z","caller":"traceutil/trace.go:171","msg":"trace[1113236366] transaction","detail":"{read_only:false; response_revision:486; number_of_response:1; }","duration":"523.488327ms","start":"2026-08-14T23:16:47.563828Z","end":"2026-08-14T23:16:48.087316Z","steps":["trace[1113236366] 'process raft request' (duration: 523.13137ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:16:48.087447Z","caller":"traceutil/trace.go:171","msg":"trace[22269749] transaction","detail":"{read_only:false; response_revision:488; number_of_response:1; }","duration":"520.132974ms","start":"2026-08-14T23:16:47.567268Z","end":"2026-08-14T23:16:48.087401Z","steps":["trace[22269749] 'process raft request' (duration: 519.767808ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:16:48.087516Z","caller":"traceutil/trace.go:171","msg":"trace[326751779] transaction","detail":"{read_only:false; response_revision:487; number_of_response:1; }","duration":"522.939417ms","start":"2026-08-14T23:16:47.564559Z","end":"2026-08-14T23:16:48.087498Z","steps":["trace[326751779] 'process raft request' (duration: 522.447277ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:16:48.087519Z","caller":"traceutil/trace.go:171","msg":"trace[1124432077] transaction","detail":"{read_only:false; response_revision:484; number_of_response:1; }","duration":"534.919299ms","start":"2026-08-14T23:16:47.552517Z","end":"2026-08-14T23:16:48.087437Z","steps":["trace[1124432077] 'process raft request' (duration: 534.143615ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:16:48.087616Z","caller":"traceutil/trace.go:171","msg":"trace[1258895941] transaction","detail":"{read_only:false; response_revision:485; number_of_response:1; }","duration":"523.855765ms","start":"2026-08-14T23:16:47.563744Z","end":"2026-08-14T23:16:48.0876Z","steps":["trace[1258895941] 'process raft request' (duration: 523.151271ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:16:48.087695Z","caller":"traceutil/trace.go:171","msg":"trace[1233455979] transaction","detail":"{read_only:false; response_revision:489; number_of_response:1; }","duration":"520.193806ms","start":"2026-08-14T23:16:47.567489Z","end":"2026-08-14T23:16:48.087683Z","steps":["trace[1233455979] 'process raft request' (duration: 519.635225ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:16:48.087737Z","caller":"traceutil/trace.go:171","msg":"trace[2121692976] transaction","detail":"{read_only:false; response_revision:490; number_of_response:1; }","duration":"518.905833ms","start":"2026-08-14T23:16:47.568813Z","end":"2026-08-14T23:16:48.087719Z","steps":["trace[2121692976] 'process raft request' (duration: 518.355452ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:16:48.087935Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:16:47.586932Z","time spent":"500.48537ms","remote":"127.0.0.1:43356","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-14T23:16:48.088031Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:16:47.563803Z","time spent":"523.724852ms","remote":"127.0.0.1:43356","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-14T23:16:48.08814Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:16:47.567483Z","time spent":"520.248127ms","remote":"127.0.0.1:43356","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-14T23:16:48.08823Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:16:47.567259Z","time spent":"520.324498ms","remote":"127.0.0.1:43356","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-14T23:16:48.088264Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:16:47.568802Z","time spent":"518.969834ms","remote":"127.0.0.1:43356","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-14T23:16:48.08837Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:16:47.564548Z","time spent":"523.067959ms","remote":"127.0.0.1:43356","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-14T23:16:48.088478Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:16:47.563716Z","time spent":"523.936256ms","remote":"127.0.0.1:43356","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-14T23:16:48.088586Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:16:47.552492Z","time spent":"535.174134ms","remote":"127.0.0.1:43356","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-14T23:16:48.258233Z","caller":"traceutil/trace.go:171","msg":"trace[891892355] transaction","detail":"{read_only:false; response_revision:492; number_of_response:1; }","duration":"665.898453ms","start":"2026-08-14T23:16:47.592279Z","end":"2026-08-14T23:16:48.258177Z","steps":["trace[891892355] 'process raft request' (duration: 665.586218ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:16:48.258415Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:16:47.59227Z","time spent":"666.066078ms","remote":"127.0.0.1:43356","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-14T23:16:48.258456Z","caller":"traceutil/trace.go:171","msg":"trace[250220738] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"633.652148ms","start":"2026-08-14T23:16:47.624785Z","end":"2026-08-14T23:16:48.258437Z","steps":["trace[250220738] 'process raft request' (duration: 633.498754ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:16:48.258488Z","caller":"traceutil/trace.go:171","msg":"trace[2016278061] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"644.604961ms","start":"2026-08-14T23:16:47.613832Z","end":"2026-08-14T23:16:48.258437Z","steps":["trace[2016278061] 'process raft request' (duration: 644.327895ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:16:48.258591Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:16:47.624775Z","time spent":"633.75379ms","remote":"127.0.0.1:43356","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-14T23:16:48.2584Z","caller":"traceutil/trace.go:171","msg":"trace[2097921922] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"644.808584ms","start":"2026-08-14T23:16:47.613521Z","end":"2026-08-14T23:16:48.25833Z","steps":["trace[2097921922] 'process raft request' (duration: 644.572539ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:16:48.258811Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:16:47.613506Z","time spent":"645.273222ms","remote":"127.0.0.1:43842","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":995,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-14T23:16:48.25894Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:16:47.613811Z","time spent":"644.741523ms","remote":"127.0.0.1:43356","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6888,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-14T23:16:48.259151Z","caller":"traceutil/trace.go:171","msg":"trace[37157056] linearizableReadLoop","detail":"{readStateIndex:514; appliedIndex:509; }","duration":"600.90771ms","start":"2026-08-14T23:16:47.658224Z","end":"2026-08-14T23:16:48.259132Z","steps":["trace[37157056] 'read index received' (duration: 429.138168ms)","trace[37157056] 'applied index is now lower than readState.Index' (duration: 171.768442ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T23:16:48.259202Z","caller":"traceutil/trace.go:171","msg":"trace[2061274389] transaction","detail":"{read_only:false; number_of_response:1; response_revision:495; }","duration":"630.859735ms","start":"2026-08-14T23:16:47.62833Z","end":"2026-08-14T23:16:48.259189Z","steps":["trace[2061274389] 'process raft request' (duration: 630.037441ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:16:48.259278Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:16:47.628322Z","time spent":"630.919546ms","remote":"127.0.0.1:43356","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":102,"response count":0,"response size":6937,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-14T23:16:48.25929Z","caller":"traceutil/trace.go:171","msg":"trace[346569823] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"510.474465ms","start":"2026-08-14T23:16:47.748724Z","end":"2026-08-14T23:16:48.259199Z","steps":["trace[346569823] 'process raft request' (duration: 510.283891ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:16:48.259362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"601.137465ms","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-14T23:16:48.259434Z","caller":"traceutil/trace.go:171","msg":"trace[1265922914] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:496; }","duration":"601.250997ms","start":"2026-08-14T23:16:47.658167Z","end":"2026-08-14T23:16:48.259418Z","steps":["trace[1265922914] 'agreement among raft nodes before linearized reading' (duration: 601.070203ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:16:48.259493Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:16:47.658134Z","time spent":"601.346219ms","remote":"127.0.0.1:43578","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-08-14T23:16:48.259647Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:16:47.748688Z","time spent":"510.7487ms","remote":"127.0.0.1:43356","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-14T23:16:48.263971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"419.279277ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T23:16:48.264011Z","caller":"traceutil/trace.go:171","msg":"trace[1881416414] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:504; }","duration":"419.371438ms","start":"2026-08-14T23:16:47.844631Z","end":"2026-08-14T23:16:48.264003Z","steps":["trace[1881416414] 'agreement among raft nodes before linearized reading' (duration: 419.282297ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:16:48.264144Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:16:47.844603Z","time spent":"419.532471ms","remote":"127.0.0.1:43324","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-08-14T23:16:48.264388Z","caller":"traceutil/trace.go:171","msg":"trace[827721528] transaction","detail":"{read_only:false; response_revision:501; number_of_response:1; }","duration":"154.194176ms","start":"2026-08-14T23:16:48.110185Z","end":"2026-08-14T23:16:48.264379Z","steps":["trace[827721528] 'process raft request' (duration: 153.509713ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:16:48.264474Z","caller":"traceutil/trace.go:171","msg":"trace[879171490] transaction","detail":"{read_only:false; response_revision:502; number_of_response:1; }","duration":"153.737307ms","start":"2026-08-14T23:16:48.110729Z","end":"2026-08-14T23:16:48.264467Z","steps":["trace[879171490] 'process raft request' (duration: 153.020044ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:16:48.264548Z","caller":"traceutil/trace.go:171","msg":"trace[1620637488] transaction","detail":"{read_only:false; response_revision:503; number_of_response:1; }","duration":"151.757831ms","start":"2026-08-14T23:16:48.112784Z","end":"2026-08-14T23:16:48.264542Z","steps":["trace[1620637488] 'process raft request' (duration: 151.019057ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:16:48.264732Z","caller":"traceutil/trace.go:171","msg":"trace[1376746728] transaction","detail":"{read_only:false; response_revision:504; number_of_response:1; }","duration":"151.008437ms","start":"2026-08-14T23:16:48.113713Z","end":"2026-08-14T23:16:48.264721Z","steps":["trace[1376746728] 'process raft request' (duration: 150.163271ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:16:48.265455Z","caller":"traceutil/trace.go:171","msg":"trace[1073956645] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"159.875562ms","start":"2026-08-14T23:16:48.105568Z","end":"2026-08-14T23:16:48.265444Z","steps":["trace[1073956645] 'process raft request' (duration: 158.067828ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:16:48.265559Z","caller":"traceutil/trace.go:171","msg":"trace[1144659476] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"160.056806ms","start":"2026-08-14T23:16:48.105494Z","end":"2026-08-14T23:16:48.265551Z","steps":["trace[1144659476] 'process raft request' (duration: 158.112539ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:16:48.265741Z","caller":"traceutil/trace.go:171","msg":"trace[1971131755] transaction","detail":"{read_only:false; response_revision:500; number_of_response:1; }","duration":"155.691964ms","start":"2026-08-14T23:16:48.11004Z","end":"2026-08-14T23:16:48.265732Z","steps":["trace[1971131755] 'process raft request' (duration: 153.621935ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:16:48.268285Z","caller":"traceutil/trace.go:171","msg":"trace[1028102798] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"166.181769ms","start":"2026-08-14T23:16:48.09858Z","end":"2026-08-14T23:16:48.264762Z","steps":["trace[1028102798] 'process raft request' (duration: 164.949146ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:16:51.150098Z","caller":"traceutil/trace.go:171","msg":"trace[1263241974] transaction","detail":"{read_only:false; response_revision:565; number_of_response:1; }","duration":"102.286774ms","start":"2026-08-14T23:16:51.047778Z","end":"2026-08-14T23:16:51.150065Z","steps":["trace[1263241974] 'process raft request' (duration: 34.083231ms)","trace[1263241974] 'compare' (duration: 68.073581ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T23:16:53.105253Z","caller":"traceutil/trace.go:171","msg":"trace[138415916] transaction","detail":"{read_only:false; response_revision:568; number_of_response:1; }","duration":"157.08927ms","start":"2026-08-14T23:16:52.948123Z","end":"2026-08-14T23:16:53.105212Z","steps":["trace[138415916] 'process raft request' (duration: 148.381349ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:16:54.220032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"451.780028ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-08-14T23:16:54.220259Z","caller":"traceutil/trace.go:171","msg":"trace[702215358] linearizableReadLoop","detail":"{readStateIndex:593; appliedIndex:591; }","duration":"376.292321ms","start":"2026-08-14T23:16:53.843947Z","end":"2026-08-14T23:16:54.22024Z","steps":["trace[702215358] 'read index received' (duration: 351.850658ms)","trace[702215358] 'applied index is now lower than readState.Index' (duration: 24.440533ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T23:16:54.220329Z","caller":"traceutil/trace.go:171","msg":"trace[1431079864] transaction","detail":"{read_only:false; response_revision:572; number_of_response:1; }","duration":"626.645638ms","start":"2026-08-14T23:16:53.593606Z","end":"2026-08-14T23:16:54.220252Z","steps":["trace[1431079864] 'process raft request' (duration: 174.34707ms)","trace[1431079864] 'compare' (duration: 451.470432ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T23:16:54.220472Z","caller":"traceutil/trace.go:171","msg":"trace[1125987790] transaction","detail":"{read_only:false; response_revision:573; number_of_response:1; }","duration":"626.494636ms","start":"2026-08-14T23:16:53.593964Z","end":"2026-08-14T23:16:54.220459Z","steps":["trace[1125987790] 'process raft request' (duration: 626.19455ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:16:54.22054Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:16:53.593951Z","time spent":"626.558466ms","remote":"127.0.0.1:43514","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":182,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-14T23:16:54.220529Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:16:53.593583Z","time spent":"626.857831ms","remote":"127.0.0.1:43410","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1749,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-14T23:16:54.220607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"376.653357ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-14T23:16:54.219428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.329399ms","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-08-14T23:16:54.220677Z","caller":"traceutil/trace.go:171","msg":"trace[1343729943] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:573; }","duration":"376.759649ms","start":"2026-08-14T23:16:53.843897Z","end":"2026-08-14T23:16:54.220656Z","steps":["trace[1343729943] 'agreement among raft nodes before linearized reading' (duration: 376.549845ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:16:54.220727Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:16:53.843877Z","time spent":"376.84138ms","remote":"127.0.0.1:43324","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-08-14T23:16:54.220737Z","caller":"traceutil/trace.go:171","msg":"trace[289109352] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:571; }","duration":"256.670994ms","start":"2026-08-14T23:16:53.964038Z","end":"2026-08-14T23:16:54.220709Z","steps":["trace[289109352] 'range keys from in-memory index tree' (duration: 255.302299ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:16:54.38826Z","caller":"traceutil/trace.go:171","msg":"trace[2090727276] linearizableReadLoop","detail":"{readStateIndex:594; appliedIndex:593; }","duration":"167.92676ms","start":"2026-08-14T23:16:54.220289Z","end":"2026-08-14T23:16:54.388216Z","steps":["trace[2090727276] 'read index received' (duration: 167.021463ms)","trace[2090727276] 'applied index is now lower than readState.Index' (duration: 903.827µs)"],"step_count":2} {"level":"info","ts":"2026-08-14T23:16:54.388476Z","caller":"traceutil/trace.go:171","msg":"trace[2071333028] transaction","detail":"{read_only:false; response_revision:574; number_of_response:1; }","duration":"400.452578ms","start":"2026-08-14T23:16:53.987955Z","end":"2026-08-14T23:16:54.388408Z","steps":["trace[2071333028] 'process raft request' (duration: 399.628732ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:16:54.388607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.416042ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-14T23:16:54.38863Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"506.92786ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.222\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-08-14T23:16:54.388683Z","caller":"traceutil/trace.go:171","msg":"trace[2091023626] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:574; }","duration":"166.597216ms","start":"2026-08-14T23:16:54.222064Z","end":"2026-08-14T23:16:54.388662Z","steps":["trace[2091023626] 'agreement among raft nodes before linearized reading' (duration: 166.415163ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:16:54.3887Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:16:53.987933Z","time spent":"400.688233ms","remote":"127.0.0.1:43408","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036023,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-14T23:16:54.388733Z","caller":"traceutil/trace.go:171","msg":"trace[1514034642] range","detail":"{range_begin:/registry/masterleases/199.204.45.222; range_end:; response_count:1; response_revision:574; }","duration":"507.097203ms","start":"2026-08-14T23:16:53.881613Z","end":"2026-08-14T23:16:54.38871Z","steps":["trace[1514034642] 'agreement among raft nodes before linearized reading' (duration: 506.821468ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:16:54.388818Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:16:53.881595Z","time spent":"507.207065ms","remote":"127.0.0.1:43346","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.204.45.222\" "} {"level":"info","ts":"2026-08-14T23:16:54.54718Z","caller":"traceutil/trace.go:171","msg":"trace[1510289991] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"106.539434ms","start":"2026-08-14T23:16:54.440607Z","end":"2026-08-14T23:16:54.547146Z","steps":["trace[1510289991] 'process raft request' (duration: 83.825203ms)","trace[1510289991] 'compare' (duration: 22.465976ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T23:16:55.37982Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6890120412785583923,"retry-timeout":"500ms"} {"level":"info","ts":"2026-08-14T23:16:55.414095Z","caller":"traceutil/trace.go:171","msg":"trace[582421335] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"534.892439ms","start":"2026-08-14T23:16:54.879167Z","end":"2026-08-14T23:16:55.41406Z","steps":["trace[582421335] 'process raft request' (duration: 534.626724ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:16:55.414344Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:16:54.879135Z","time spent":"535.037891ms","remote":"127.0.0.1:43492","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-14T23:16:55.521647Z","caller":"traceutil/trace.go:171","msg":"trace[128536162] linearizableReadLoop","detail":"{readStateIndex:602; appliedIndex:600; }","duration":"642.215896ms","start":"2026-08-14T23:16:54.879409Z","end":"2026-08-14T23:16:55.521625Z","steps":["trace[128536162] 'read index received' (duration: 534.399489ms)","trace[128536162] 'applied index is now lower than readState.Index' (duration: 107.815697ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T23:16:55.521744Z","caller":"traceutil/trace.go:171","msg":"trace[2049790386] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"499.899759ms","start":"2026-08-14T23:16:55.021789Z","end":"2026-08-14T23:16:55.521689Z","steps":["trace[2049790386] 'process raft request' (duration: 488.555399ms)","trace[2049790386] 'compare' (duration: 10.812271ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T23:16:55.521867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"642.431451ms","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-14T23:16:55.521908Z","caller":"traceutil/trace.go:171","msg":"trace[2013043110] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:581; }","duration":"642.556923ms","start":"2026-08-14T23:16:54.87934Z","end":"2026-08-14T23:16:55.521896Z","steps":["trace[2013043110] 'agreement among raft nodes before linearized reading' (duration: 642.39546ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:16:55.521936Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:16:54.87932Z","time spent":"642.609414ms","remote":"127.0.0.1:43578","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-08-14T23:16:55.521965Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:16:55.021759Z","time spent":"500.087673ms","remote":"127.0.0.1:43408","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036109,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-14T23:16:55.522179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.544936ms","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-14T23:16:55.522319Z","caller":"traceutil/trace.go:171","msg":"trace[1584249284] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:581; }","duration":"253.747841ms","start":"2026-08-14T23:16:55.268542Z","end":"2026-08-14T23:16:55.52229Z","steps":["trace[1584249284] 'agreement among raft nodes before linearized reading' (duration: 253.358853ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:16:55.522266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.67525ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-08-14T23:16:55.522536Z","caller":"traceutil/trace.go:171","msg":"trace[1491436600] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:581; }","duration":"341.916334ms","start":"2026-08-14T23:16:55.180547Z","end":"2026-08-14T23:16:55.522463Z","steps":["trace[1491436600] 'agreement among raft nodes before linearized reading' (duration: 341.328733ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:16:55.522735Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:16:55.180474Z","time spent":"342.148688ms","remote":"127.0.0.1:43578","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-08-14T23:16:56.34548Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6890120412785583927,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-14T23:16:56.847093Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6890120412785583927,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-14T23:16:57.347695Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6890120412785583927,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-14T23:16:57.359045Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.772708507s","expected-duration":"1s"} {"level":"info","ts":"2026-08-14T23:16:57.386948Z","caller":"traceutil/trace.go:171","msg":"trace[206098618] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"1.800715725s","start":"2026-08-14T23:16:55.586181Z","end":"2026-08-14T23:16:57.386897Z","steps":["trace[206098618] 'process raft request' (duration: 1.773128415s)","trace[206098618] 'compare' (duration: 27.162862ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T23:16:57.387129Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.541989012s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T23:16:57.387174Z","caller":"traceutil/trace.go:171","msg":"trace[2086176749] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:586; }","duration":"1.542106105s","start":"2026-08-14T23:16:55.845059Z","end":"2026-08-14T23:16:57.387165Z","steps":["trace[2086176749] 'agreement among raft nodes before linearized reading' (duration: 1.541991973s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:16:57.387204Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:16:55.845034Z","time spent":"1.542163406s","remote":"127.0.0.1:43324","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-14T23:16:57.387299Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:16:55.586147Z","time spent":"1.80098498s","remote":"127.0.0.1:43514","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":818,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-14T23:16:57.387426Z","caller":"traceutil/trace.go:171","msg":"trace[640201271] transaction","detail":"{read_only:false; response_revision:586; number_of_response:1; }","duration":"949.168482ms","start":"2026-08-14T23:16:56.438248Z","end":"2026-08-14T23:16:57.387417Z","steps":["trace[640201271] 'process raft request' (duration: 948.596461ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:16:57.387508Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:16:56.438209Z","time spent":"949.243793ms","remote":"127.0.0.1:43578","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-14T23:16:57.386991Z","caller":"traceutil/trace.go:171","msg":"trace[1292056552] linearizableReadLoop","detail":"{readStateIndex:607; appliedIndex:605; }","duration":"1.54184201s","start":"2026-08-14T23:16:55.845121Z","end":"2026-08-14T23:16:57.386964Z","steps":["trace[1292056552] 'read index received' (duration: 1.514202989s)","trace[1292056552] 'applied index is now lower than readState.Index' (duration: 27.638241ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T23:16:57.38828Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"912.971922ms","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-14T23:16:57.38859Z","caller":"traceutil/trace.go:171","msg":"trace[622791746] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:586; }","duration":"913.359589ms","start":"2026-08-14T23:16:56.475203Z","end":"2026-08-14T23:16:57.388563Z","steps":["trace[622791746] 'agreement among raft nodes before linearized reading' (duration: 912.87492ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:16:57.388675Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:16:56.475177Z","time spent":"913.482061ms","remote":"127.0.0.1:43578","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-08-14T23:16:59.298234Z","caller":"traceutil/trace.go:171","msg":"trace[1622744250] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"156.188492ms","start":"2026-08-14T23:16:59.142022Z","end":"2026-08-14T23:16:59.298211Z","steps":["trace[1622744250] 'process raft request' (duration: 156.099881ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:17:12.573199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"729.34136ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T23:17:12.573297Z","caller":"traceutil/trace.go:171","msg":"trace[680841081] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:758; }","duration":"729.495412ms","start":"2026-08-14T23:17:11.843781Z","end":"2026-08-14T23:17:12.573276Z","steps":["trace[680841081] 'range keys from in-memory index tree' (duration: 729.273459ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:17:12.573338Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:17:11.843762Z","time spent":"729.567704ms","remote":"127.0.0.1:43324","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-08-14T23:17:12.574559Z","caller":"traceutil/trace.go:171","msg":"trace[1866705760] linearizableReadLoop","detail":"{readStateIndex:785; appliedIndex:784; }","duration":"256.873729ms","start":"2026-08-14T23:17:12.317672Z","end":"2026-08-14T23:17:12.574546Z","steps":["trace[1866705760] 'read index received' (duration: 256.41631ms)","trace[1866705760] 'applied index is now lower than readState.Index' (duration: 456.879µs)"],"step_count":2} {"level":"warn","ts":"2026-08-14T23:17:12.574678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.997781ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T23:17:12.574644Z","caller":"traceutil/trace.go:171","msg":"trace[326292939] transaction","detail":"{read_only:false; response_revision:759; number_of_response:1; }","duration":"592.693879ms","start":"2026-08-14T23:17:11.981902Z","end":"2026-08-14T23:17:12.574596Z","steps":["trace[326292939] 'process raft request' (duration: 592.27578ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:17:12.574701Z","caller":"traceutil/trace.go:171","msg":"trace[165512039] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:759; }","duration":"257.085023ms","start":"2026-08-14T23:17:12.317608Z","end":"2026-08-14T23:17:12.574693Z","steps":["trace[165512039] 'agreement among raft nodes before linearized reading' (duration: 257.001581ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:17:12.574838Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:17:11.981869Z","time spent":"592.854982ms","remote":"127.0.0.1:43558","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-14T23:17:26.570323Z","caller":"traceutil/trace.go:171","msg":"trace[1113465929] transaction","detail":"{read_only:false; response_revision:891; number_of_response:1; }","duration":"156.522388ms","start":"2026-08-14T23:17:26.413488Z","end":"2026-08-14T23:17:26.57001Z","steps":["trace[1113465929] 'process raft request' (duration: 156.373086ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:17:26.732759Z","caller":"traceutil/trace.go:171","msg":"trace[699987061] transaction","detail":"{read_only:false; response_revision:893; number_of_response:1; }","duration":"156.208105ms","start":"2026-08-14T23:17:26.576531Z","end":"2026-08-14T23:17:26.732739Z","steps":["trace[699987061] 'process raft request' (duration: 154.600814ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:17:26.73287Z","caller":"traceutil/trace.go:171","msg":"trace[1201233701] transaction","detail":"{read_only:false; response_revision:894; number_of_response:1; }","duration":"156.202174ms","start":"2026-08-14T23:17:26.576659Z","end":"2026-08-14T23:17:26.732861Z","steps":["trace[1201233701] 'process raft request' (duration: 156.01746ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:17:27.002431Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.366824ms","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-14T23:17:27.002508Z","caller":"traceutil/trace.go:171","msg":"trace[1839157883] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:895; }","duration":"124.492626ms","start":"2026-08-14T23:17:26.877999Z","end":"2026-08-14T23:17:27.002491Z","steps":["trace[1839157883] 'range keys from in-memory index tree' (duration: 124.197731ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:17:59.244057Z","caller":"traceutil/trace.go:171","msg":"trace[1284121392] transaction","detail":"{read_only:false; response_revision:1015; number_of_response:1; }","duration":"222.085854ms","start":"2026-08-14T23:17:59.021944Z","end":"2026-08-14T23:17:59.244029Z","steps":["trace[1284121392] 'process raft request' (duration: 221.87138ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:17:59.937562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.868839ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-08-14T23:17:59.937785Z","caller":"traceutil/trace.go:171","msg":"trace[1365117966] linearizableReadLoop","detail":"{readStateIndex:1054; appliedIndex:1053; }","duration":"691.639251ms","start":"2026-08-14T23:17:59.246129Z","end":"2026-08-14T23:17:59.937768Z","steps":["trace[1365117966] 'read index received' (duration: 401.624469ms)","trace[1365117966] 'applied index is now lower than readState.Index' (duration: 290.013572ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T23:17:59.938054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"691.904517ms","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-14T23:17:59.938248Z","caller":"traceutil/trace.go:171","msg":"trace[1707564394] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1015; }","duration":"692.117741ms","start":"2026-08-14T23:17:59.246079Z","end":"2026-08-14T23:17:59.938196Z","steps":["trace[1707564394] 'agreement among raft nodes before linearized reading' (duration: 691.776064ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:17:59.938332Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:17:59.246057Z","time spent":"692.238784ms","remote":"127.0.0.1:43578","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-08-14T23:17:59.938432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.981013ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T23:17:59.938525Z","caller":"traceutil/trace.go:171","msg":"trace[571398497] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:1016; }","duration":"249.121614ms","start":"2026-08-14T23:17:59.68938Z","end":"2026-08-14T23:17:59.938502Z","steps":["trace[571398497] 'agreement among raft nodes before linearized reading' (duration: 248.942781ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:17:59.938702Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.659556ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T23:17:59.938748Z","caller":"traceutil/trace.go:171","msg":"trace[1717392475] range","detail":"{range_begin:/registry/csidrivers/; range_end:/registry/csidrivers0; response_count:0; response_revision:1016; }","duration":"147.774378ms","start":"2026-08-14T23:17:59.790961Z","end":"2026-08-14T23:17:59.938736Z","steps":["trace[1717392475] 'agreement among raft nodes before linearized reading' (duration: 147.687536ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:17:59.938744Z","caller":"traceutil/trace.go:171","msg":"trace[1249476904] transaction","detail":"{read_only:false; response_revision:1016; number_of_response:1; }","duration":"553.096535ms","start":"2026-08-14T23:17:59.385613Z","end":"2026-08-14T23:17:59.93871Z","steps":["trace[1249476904] 'process raft request' (duration: 552.054356ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:17:59.938874Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:17:59.385578Z","time spent":"553.203667ms","remote":"127.0.0.1:43578","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-14T23:17:59.939745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.922239ms","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-14T23:17:59.939819Z","caller":"traceutil/trace.go:171","msg":"trace[1930877508] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1016; }","duration":"156.026101ms","start":"2026-08-14T23:17:59.783776Z","end":"2026-08-14T23:17:59.939802Z","steps":["trace[1930877508] 'agreement among raft nodes before linearized reading' (duration: 154.980671ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:18:00.272906Z","caller":"traceutil/trace.go:171","msg":"trace[1673632117] transaction","detail":"{read_only:false; response_revision:1017; number_of_response:1; }","duration":"329.671517ms","start":"2026-08-14T23:17:59.943185Z","end":"2026-08-14T23:18:00.272856Z","steps":["trace[1673632117] 'process raft request' (duration: 320.530837ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:18:00.273054Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:17:59.943158Z","time spent":"329.82044ms","remote":"127.0.0.1:43578","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-14T23:18:00.312013Z","caller":"traceutil/trace.go:171","msg":"trace[800193030] transaction","detail":"{read_only:false; response_revision:1019; number_of_response:1; }","duration":"367.448477ms","start":"2026-08-14T23:17:59.944556Z","end":"2026-08-14T23:18:00.312004Z","steps":["trace[800193030] 'process raft request' (duration: 367.222872ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:18:00.31207Z","caller":"traceutil/trace.go:171","msg":"trace[825609019] linearizableReadLoop","detail":"{readStateIndex:1060; appliedIndex:1055; }","duration":"116.357946ms","start":"2026-08-14T23:18:00.195691Z","end":"2026-08-14T23:18:00.312049Z","steps":["trace[825609019] 'read index received' (duration: 68.033ms)","trace[825609019] 'applied index is now lower than readState.Index' (duration: 48.323926ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T23:18:00.312096Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:17:59.944547Z","time spent":"367.500818ms","remote":"127.0.0.1:43578","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-14T23:18:00.312184Z","caller":"traceutil/trace.go:171","msg":"trace[2104926827] transaction","detail":"{read_only:false; response_revision:1021; number_of_response:1; }","duration":"367.043799ms","start":"2026-08-14T23:17:59.945116Z","end":"2026-08-14T23:18:00.312159Z","steps":["trace[2104926827] 'process raft request' (duration: 366.841115ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:18:00.312202Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.500798ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T23:18:00.312255Z","caller":"traceutil/trace.go:171","msg":"trace[254158585] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:1021; }","duration":"116.59817ms","start":"2026-08-14T23:18:00.19564Z","end":"2026-08-14T23:18:00.312239Z","steps":["trace[254158585] 'agreement among raft nodes before linearized reading' (duration: 116.481548ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:18:00.312288Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:17:59.945108Z","time spent":"367.12365ms","remote":"127.0.0.1:43578","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-14T23:18:00.31233Z","caller":"traceutil/trace.go:171","msg":"trace[389026870] transaction","detail":"{read_only:false; response_revision:1020; number_of_response:1; }","duration":"367.344705ms","start":"2026-08-14T23:17:59.944636Z","end":"2026-08-14T23:18:00.311981Z","steps":["trace[389026870] 'process raft request' (duration: 367.167531ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:18:00.31257Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:17:59.94462Z","time spent":"367.904654ms","remote":"127.0.0.1:43578","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-14T23:18:00.311907Z","caller":"traceutil/trace.go:171","msg":"trace[1449719763] transaction","detail":"{read_only:false; response_revision:1018; number_of_response:1; }","duration":"367.806422ms","start":"2026-08-14T23:17:59.944054Z","end":"2026-08-14T23:18:00.311861Z","steps":["trace[1449719763] 'process raft request' (duration: 367.624838ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:18:00.312851Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:17:59.944033Z","time spent":"368.635138ms","remote":"127.0.0.1:43578","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-14T23:18:02.167278Z","caller":"traceutil/trace.go:171","msg":"trace[1428152290] transaction","detail":"{read_only:false; response_revision:1022; number_of_response:1; }","duration":"222.323748ms","start":"2026-08-14T23:18:01.944918Z","end":"2026-08-14T23:18:02.167242Z","steps":["trace[1428152290] 'process raft request' (duration: 222.075173ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:18:02.387334Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.530957ms","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-14T23:18:02.387418Z","caller":"traceutil/trace.go:171","msg":"trace[1210684021] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1022; }","duration":"110.67061ms","start":"2026-08-14T23:18:02.276728Z","end":"2026-08-14T23:18:02.387399Z","steps":["trace[1210684021] 'range keys from in-memory index tree' (duration: 109.852734ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:18:02.599396Z","caller":"traceutil/trace.go:171","msg":"trace[938859383] transaction","detail":"{read_only:false; response_revision:1025; number_of_response:1; }","duration":"206.665387ms","start":"2026-08-14T23:18:02.392704Z","end":"2026-08-14T23:18:02.599369Z","steps":["trace[938859383] 'process raft request' (duration: 206.592156ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:18:02.599675Z","caller":"traceutil/trace.go:171","msg":"trace[1656346447] transaction","detail":"{read_only:false; response_revision:1027; number_of_response:1; }","duration":"205.431595ms","start":"2026-08-14T23:18:02.394222Z","end":"2026-08-14T23:18:02.599654Z","steps":["trace[1656346447] 'process raft request' (duration: 205.321533ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:18:02.599732Z","caller":"traceutil/trace.go:171","msg":"trace[761935346] transaction","detail":"{read_only:false; response_revision:1026; number_of_response:1; }","duration":"206.81424ms","start":"2026-08-14T23:18:02.392894Z","end":"2026-08-14T23:18:02.599709Z","steps":["trace[761935346] 'process raft request' (duration: 206.435983ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:18:02.600068Z","caller":"traceutil/trace.go:171","msg":"trace[862812596] transaction","detail":"{read_only:false; response_revision:1024; number_of_response:1; }","duration":"206.84415ms","start":"2026-08-14T23:18:02.392609Z","end":"2026-08-14T23:18:02.599454Z","steps":["trace[862812596] 'process raft request' (duration: 206.513224ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:18:04.746492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.517881ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"warn","ts":"2026-08-14T23:18:04.746782Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"782.690218ms","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-08-14T23:18:04.746927Z","caller":"traceutil/trace.go:171","msg":"trace[1846771157] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1027; }","duration":"782.846911ms","start":"2026-08-14T23:18:03.96406Z","end":"2026-08-14T23:18:04.746907Z","steps":["trace[1846771157] 'range keys from in-memory index tree' (duration: 781.984444ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:18:04.74697Z","caller":"traceutil/trace.go:171","msg":"trace[2057243327] transaction","detail":"{read_only:false; response_revision:1028; number_of_response:1; }","duration":"827.289394ms","start":"2026-08-14T23:18:03.91963Z","end":"2026-08-14T23:18:04.746919Z","steps":["trace[2057243327] 'process raft request' (duration: 678.281434ms)","trace[2057243327] 'compare' (duration: 148.239956ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T23:18:04.746867Z","caller":"traceutil/trace.go:171","msg":"trace[1628402094] linearizableReadLoop","detail":"{readStateIndex:1069; appliedIndex:1067; }","duration":"291.351947ms","start":"2026-08-14T23:18:04.455498Z","end":"2026-08-14T23:18:04.74685Z","steps":["trace[1628402094] 'read index received' (duration: 142.430898ms)","trace[1628402094] 'applied index is now lower than readState.Index' (duration: 148.919919ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T23:18:04.747187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.687112ms","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-08-14T23:18:04.747232Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:18:03.919614Z","time spent":"827.468608ms","remote":"127.0.0.1:43346","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-14T23:18:04.747259Z","caller":"traceutil/trace.go:171","msg":"trace[2078488372] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1029; }","duration":"291.820615ms","start":"2026-08-14T23:18:04.455426Z","end":"2026-08-14T23:18:04.747247Z","steps":["trace[2078488372] 'agreement among raft nodes before linearized reading' (duration: 291.470858ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:18:04.747348Z","caller":"traceutil/trace.go:171","msg":"trace[806721780] transaction","detail":"{read_only:false; response_revision:1029; number_of_response:1; }","duration":"573.621795ms","start":"2026-08-14T23:18:04.173573Z","end":"2026-08-14T23:18:04.747195Z","steps":["trace[806721780] 'process raft request' (duration: 573.026884ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:18:04.748317Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:18:04.173538Z","time spent":"574.133585ms","remote":"127.0.0.1:43578","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-14T23:18:04.981914Z","caller":"traceutil/trace.go:171","msg":"trace[1623681939] linearizableReadLoop","detail":"{readStateIndex:1070; appliedIndex:1069; }","duration":"234.738438ms","start":"2026-08-14T23:18:04.747153Z","end":"2026-08-14T23:18:04.981891Z","steps":["trace[1623681939] 'read index received' (duration: 165.495275ms)","trace[1623681939] 'applied index is now lower than readState.Index' (duration: 69.242033ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T23:18:04.98195Z","caller":"traceutil/trace.go:171","msg":"trace[1566861955] transaction","detail":"{read_only:false; response_revision:1030; number_of_response:1; }","duration":"357.285028ms","start":"2026-08-14T23:18:04.62463Z","end":"2026-08-14T23:18:04.981915Z","steps":["trace[1566861955] 'process raft request' (duration: 287.907522ms)","trace[1566861955] 'compare' (duration: 69.256654ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T23:18:04.982112Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:18:04.624608Z","time spent":"357.40439ms","remote":"127.0.0.1:43578","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-14T23:18:04.98218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"376.592556ms","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-14T23:18:04.982228Z","caller":"traceutil/trace.go:171","msg":"trace[1766703185] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1030; }","duration":"376.675547ms","start":"2026-08-14T23:18:04.605538Z","end":"2026-08-14T23:18:04.982214Z","steps":["trace[1766703185] 'agreement among raft nodes before linearized reading' (duration: 376.478154ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:18:04.98225Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"376.766039ms","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-14T23:18:04.982262Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:18:04.605527Z","time spent":"376.726558ms","remote":"127.0.0.1:43578","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-14T23:18:04.98229Z","caller":"traceutil/trace.go:171","msg":"trace[1510873030] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1030; }","duration":"376.820029ms","start":"2026-08-14T23:18:04.605459Z","end":"2026-08-14T23:18:04.982279Z","steps":["trace[1510873030] 'agreement among raft nodes before linearized reading' (duration: 376.744098ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:18:04.982327Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:18:04.605452Z","time spent":"376.86454ms","remote":"127.0.0.1:43578","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":"warn","ts":"2026-08-14T23:18:04.98218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"376.927811ms","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-14T23:18:04.982452Z","caller":"traceutil/trace.go:171","msg":"trace[1266208680] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1030; }","duration":"377.246977ms","start":"2026-08-14T23:18:04.605192Z","end":"2026-08-14T23:18:04.982439Z","steps":["trace[1266208680] 'agreement among raft nodes before linearized reading' (duration: 376.903881ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:18:04.982496Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:18:04.605168Z","time spent":"377.316799ms","remote":"127.0.0.1:43578","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-08-14T23:18:04.982522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"377.520142ms","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-14T23:18:04.982595Z","caller":"traceutil/trace.go:171","msg":"trace[265789655] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1030; }","duration":"377.641555ms","start":"2026-08-14T23:18:04.604938Z","end":"2026-08-14T23:18:04.982579Z","steps":["trace[265789655] 'agreement among raft nodes before linearized reading' (duration: 377.425221ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:18:04.982637Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:18:04.604908Z","time spent":"377.719746ms","remote":"127.0.0.1:43578","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-08-14T23:18:04.990346Z","caller":"traceutil/trace.go:171","msg":"trace[43150878] transaction","detail":"{read_only:false; response_revision:1031; number_of_response:1; }","duration":"237.52878ms","start":"2026-08-14T23:18:04.752803Z","end":"2026-08-14T23:18:04.990332Z","steps":["trace[43150878] 'process raft request' (duration: 237.121693ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:18:04.990512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.573269ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:422"} {"level":"info","ts":"2026-08-14T23:18:04.990607Z","caller":"traceutil/trace.go:171","msg":"trace[1430755186] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:1031; }","duration":"238.734181ms","start":"2026-08-14T23:18:04.751853Z","end":"2026-08-14T23:18:04.990587Z","steps":["trace[1430755186] 'agreement among raft nodes before linearized reading' (duration: 238.499767ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:18:21.079061Z","caller":"traceutil/trace.go:171","msg":"trace[1983742042] linearizableReadLoop","detail":"{readStateIndex:1184; appliedIndex:1183; }","duration":"234.706907ms","start":"2026-08-14T23:18:20.844335Z","end":"2026-08-14T23:18:21.079042Z","steps":["trace[1983742042] 'read index received' (duration: 234.588535ms)","trace[1983742042] 'applied index is now lower than readState.Index' (duration: 117.072µs)"],"step_count":2} {"level":"info","ts":"2026-08-14T23:18:21.079141Z","caller":"traceutil/trace.go:171","msg":"trace[1450652425] transaction","detail":"{read_only:false; response_revision:1139; number_of_response:1; }","duration":"281.916643ms","start":"2026-08-14T23:18:20.797192Z","end":"2026-08-14T23:18:21.079109Z","steps":["trace[1450652425] 'process raft request' (duration: 281.72984ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:18:21.079214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.86655ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T23:18:21.079239Z","caller":"traceutil/trace.go:171","msg":"trace[404560380] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1139; }","duration":"234.954371ms","start":"2026-08-14T23:18:20.844278Z","end":"2026-08-14T23:18:21.079232Z","steps":["trace[404560380] 'agreement among raft nodes before linearized reading' (duration: 234.89879ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:18:23.587615Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6890120412785585124,"retry-timeout":"500ms"} {"level":"info","ts":"2026-08-14T23:18:23.722234Z","caller":"traceutil/trace.go:171","msg":"trace[114801072] linearizableReadLoop","detail":"{readStateIndex:1190; appliedIndex:1189; }","duration":"635.166384ms","start":"2026-08-14T23:18:23.087035Z","end":"2026-08-14T23:18:23.722201Z","steps":["trace[114801072] 'read index received' (duration: 634.935599ms)","trace[114801072] 'applied index is now lower than readState.Index' (duration: 229.655µs)"],"step_count":2} {"level":"info","ts":"2026-08-14T23:18:23.722337Z","caller":"traceutil/trace.go:171","msg":"trace[232565113] transaction","detail":"{read_only:false; response_revision:1145; number_of_response:1; }","duration":"637.408306ms","start":"2026-08-14T23:18:23.084919Z","end":"2026-08-14T23:18:23.722327Z","steps":["trace[232565113] 'process raft request' (duration: 637.10449ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:18:23.72245Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:18:23.084893Z","time spent":"637.472888ms","remote":"127.0.0.1:43578","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-14T23:18:23.722675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"630.653529ms","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-14T23:18:23.722771Z","caller":"traceutil/trace.go:171","msg":"trace[76607225] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1145; }","duration":"630.766862ms","start":"2026-08-14T23:18:23.091973Z","end":"2026-08-14T23:18:23.722739Z","steps":["trace[76607225] 'agreement among raft nodes before linearized reading' (duration: 630.569348ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:18:23.722814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"624.628086ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-08-14T23:18:23.722819Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:18:23.091964Z","time spent":"630.847183ms","remote":"127.0.0.1:43578","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":"info","ts":"2026-08-14T23:18:23.722844Z","caller":"traceutil/trace.go:171","msg":"trace[1355119991] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1145; }","duration":"624.683626ms","start":"2026-08-14T23:18:23.098153Z","end":"2026-08-14T23:18:23.722837Z","steps":["trace[1355119991] 'agreement among raft nodes before linearized reading' (duration: 624.569294ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:18:23.722869Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:18:23.098139Z","time spent":"624.724397ms","remote":"127.0.0.1:43578","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-14T23:18:23.722973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"635.947038ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-08-14T23:18:23.723001Z","caller":"traceutil/trace.go:171","msg":"trace[350054723] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1145; }","duration":"636.013429ms","start":"2026-08-14T23:18:23.086982Z","end":"2026-08-14T23:18:23.722995Z","steps":["trace[350054723] 'agreement among raft nodes before linearized reading' (duration: 635.939018ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:18:23.723021Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:18:23.086957Z","time spent":"636.05929ms","remote":"127.0.0.1:43578","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-08-14T23:18:23.723083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"624.965602ms","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-14T23:18:23.723124Z","caller":"traceutil/trace.go:171","msg":"trace[22445096] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1145; }","duration":"625.019033ms","start":"2026-08-14T23:18:23.098095Z","end":"2026-08-14T23:18:23.723114Z","steps":["trace[22445096] 'agreement among raft nodes before linearized reading' (duration: 624.914211ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:18:23.723153Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:18:23.098086Z","time spent":"625.060613ms","remote":"127.0.0.1:43578","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-08-14T23:18:23.723241Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"629.767593ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-08-14T23:18:23.723269Z","caller":"traceutil/trace.go:171","msg":"trace[602806112] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1145; }","duration":"629.821703ms","start":"2026-08-14T23:18:23.093442Z","end":"2026-08-14T23:18:23.723263Z","steps":["trace[602806112] 'agreement among raft nodes before linearized reading' (duration: 629.750352ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:18:23.723288Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:18:23.093429Z","time spent":"629.854674ms","remote":"127.0.0.1:43578","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-08-14T23:18:36.007674Z","caller":"traceutil/trace.go:171","msg":"trace[921365506] linearizableReadLoop","detail":"{readStateIndex:1233; appliedIndex:1232; }","duration":"226.898669ms","start":"2026-08-14T23:18:35.780754Z","end":"2026-08-14T23:18:36.007652Z","steps":["trace[921365506] 'read index received' (duration: 226.740296ms)","trace[921365506] 'applied index is now lower than readState.Index' (duration: 157.403µs)"],"step_count":2} {"level":"info","ts":"2026-08-14T23:18:36.007788Z","caller":"traceutil/trace.go:171","msg":"trace[70690853] transaction","detail":"{read_only:false; response_revision:1185; number_of_response:1; }","duration":"242.079784ms","start":"2026-08-14T23:18:35.765686Z","end":"2026-08-14T23:18:36.007766Z","steps":["trace[70690853] 'process raft request' (duration: 241.82864ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:18:36.007989Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.206805ms","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-14T23:18:36.008072Z","caller":"traceutil/trace.go:171","msg":"trace[44341065] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1185; }","duration":"227.329897ms","start":"2026-08-14T23:18:35.780721Z","end":"2026-08-14T23:18:36.008051Z","steps":["trace[44341065] 'agreement among raft nodes before linearized reading' (duration: 227.045442ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:18:36.014007Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.8678ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T23:18:36.014021Z","caller":"traceutil/trace.go:171","msg":"trace[937823215] transaction","detail":"{read_only:false; response_revision:1186; number_of_response:1; }","duration":"230.979716ms","start":"2026-08-14T23:18:35.783024Z","end":"2026-08-14T23:18:36.014004Z","steps":["trace[937823215] 'process raft request' (duration: 230.73915ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:18:36.014051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.454688ms","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-14T23:18:36.014093Z","caller":"traceutil/trace.go:171","msg":"trace[1044948402] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1186; }","duration":"169.972871ms","start":"2026-08-14T23:18:35.844106Z","end":"2026-08-14T23:18:36.014079Z","steps":["trace[1044948402] 'agreement among raft nodes before linearized reading' (duration: 169.850959ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:18:36.014118Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.092631ms","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-14T23:18:36.01412Z","caller":"traceutil/trace.go:171","msg":"trace[945812844] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1186; }","duration":"212.54242ms","start":"2026-08-14T23:18:35.801559Z","end":"2026-08-14T23:18:36.014101Z","steps":["trace[945812844] 'agreement among raft nodes before linearized reading' (duration: 212.349715ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:18:36.014129Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.423128ms","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-14T23:18:36.01416Z","caller":"traceutil/trace.go:171","msg":"trace[272025731] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1186; }","duration":"212.150802ms","start":"2026-08-14T23:18:35.801999Z","end":"2026-08-14T23:18:36.014149Z","steps":["trace[272025731] 'agreement among raft nodes before linearized reading' (duration: 212.01563ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:18:36.014177Z","caller":"traceutil/trace.go:171","msg":"trace[1618257685] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1186; }","duration":"212.482649ms","start":"2026-08-14T23:18:35.801681Z","end":"2026-08-14T23:18:36.014163Z","steps":["trace[1618257685] 'agreement among raft nodes before linearized reading' (duration: 212.375277ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:18:36.014784Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.52962ms","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-14T23:18:36.014934Z","caller":"traceutil/trace.go:171","msg":"trace[1831874662] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1186; }","duration":"212.677783ms","start":"2026-08-14T23:18:35.802195Z","end":"2026-08-14T23:18:36.014873Z","steps":["trace[1831874662] 'agreement among raft nodes before linearized reading' (duration: 211.903148ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:18:37.459812Z","caller":"traceutil/trace.go:171","msg":"trace[148072347] transaction","detail":"{read_only:false; response_revision:1196; number_of_response:1; }","duration":"237.324915ms","start":"2026-08-14T23:18:37.222463Z","end":"2026-08-14T23:18:37.459788Z","steps":["trace[148072347] 'process raft request' (duration: 237.172232ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:18:38.216018Z","caller":"traceutil/trace.go:171","msg":"trace[1397465498] linearizableReadLoop","detail":"{readStateIndex:1245; appliedIndex:1244; }","duration":"190.222371ms","start":"2026-08-14T23:18:38.025768Z","end":"2026-08-14T23:18:38.21599Z","steps":["trace[1397465498] 'read index received' (duration: 190.011237ms)","trace[1397465498] 'applied index is now lower than readState.Index' (duration: 210.104µs)"],"step_count":2} {"level":"info","ts":"2026-08-14T23:18:38.216076Z","caller":"traceutil/trace.go:171","msg":"trace[697124764] transaction","detail":"{read_only:false; response_revision:1197; number_of_response:1; }","duration":"197.340514ms","start":"2026-08-14T23:18:38.018707Z","end":"2026-08-14T23:18:38.216048Z","steps":["trace[697124764] 'process raft request' (duration: 197.133191ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:18:38.216293Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.203929ms","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-14T23:18:38.216363Z","caller":"traceutil/trace.go:171","msg":"trace[1372947871] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1197; }","duration":"190.305503ms","start":"2026-08-14T23:18:38.026045Z","end":"2026-08-14T23:18:38.216351Z","steps":["trace[1372947871] 'agreement among raft nodes before linearized reading' (duration: 190.087098ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:18:38.216281Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.495936ms","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-14T23:18:38.216432Z","caller":"traceutil/trace.go:171","msg":"trace[1331418662] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1197; }","duration":"190.6868ms","start":"2026-08-14T23:18:38.025735Z","end":"2026-08-14T23:18:38.216422Z","steps":["trace[1331418662] 'agreement among raft nodes before linearized reading' (duration: 190.374433ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:18:38.216432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.317443ms","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-14T23:18:38.216513Z","caller":"traceutil/trace.go:171","msg":"trace[1836880816] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1197; }","duration":"190.415834ms","start":"2026-08-14T23:18:38.02608Z","end":"2026-08-14T23:18:38.216496Z","steps":["trace[1836880816] 'agreement among raft nodes before linearized reading' (duration: 190.201159ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:18:38.216555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.841215ms","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-14T23:18:38.216666Z","caller":"traceutil/trace.go:171","msg":"trace[1699617969] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1197; }","duration":"189.544008ms","start":"2026-08-14T23:18:38.027102Z","end":"2026-08-14T23:18:38.216646Z","steps":["trace[1699617969] 'agreement among raft nodes before linearized reading' (duration: 189.095179ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:18:38.32905Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.797694ms","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-14T23:18:38.329181Z","caller":"traceutil/trace.go:171","msg":"trace[1859972042] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1197; }","duration":"303.014818ms","start":"2026-08-14T23:18:38.026136Z","end":"2026-08-14T23:18:38.32915Z","steps":["trace[1859972042] 'agreement among raft nodes before linearized reading' (duration: 190.610098ms)","trace[1859972042] 'range keys from in-memory index tree' (duration: 112.047554ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T23:18:38.32945Z","caller":"traceutil/trace.go:171","msg":"trace[59422552] transaction","detail":"{read_only:false; response_revision:1198; number_of_response:1; }","duration":"107.490627ms","start":"2026-08-14T23:18:38.221931Z","end":"2026-08-14T23:18:38.329422Z","steps":["trace[59422552] 'process raft request' (duration: 16.823785ms)","trace[59422552] 'compare' (duration: 90.177693ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T23:18:38.329477Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:18:38.026112Z","time spent":"303.341923ms","remote":"127.0.0.1:43578","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-14T23:18:38.32951Z","caller":"traceutil/trace.go:171","msg":"trace[1636408751] transaction","detail":"{read_only:false; response_revision:1199; number_of_response:1; }","duration":"107.509737ms","start":"2026-08-14T23:18:38.22199Z","end":"2026-08-14T23:18:38.329499Z","steps":["trace[1636408751] 'process raft request' (duration: 107.09247ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:18:38.329992Z","caller":"traceutil/trace.go:171","msg":"trace[908383719] transaction","detail":"{read_only:false; response_revision:1201; number_of_response:1; }","duration":"107.185233ms","start":"2026-08-14T23:18:38.22279Z","end":"2026-08-14T23:18:38.329975Z","steps":["trace[908383719] 'process raft request' (duration: 107.141312ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:18:38.330212Z","caller":"traceutil/trace.go:171","msg":"trace[659780165] transaction","detail":"{read_only:false; response_revision:1200; number_of_response:1; }","duration":"108.013738ms","start":"2026-08-14T23:18:38.222185Z","end":"2026-08-14T23:18:38.330199Z","steps":["trace[659780165] 'process raft request' (duration: 106.938777ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:18:38.840658Z","caller":"traceutil/trace.go:171","msg":"trace[1620166832] transaction","detail":"{read_only:false; response_revision:1204; number_of_response:1; }","duration":"129.431979ms","start":"2026-08-14T23:18:38.711196Z","end":"2026-08-14T23:18:38.840628Z","steps":["trace[1620166832] 'process raft request' (duration: 53.682327ms)","trace[1620166832] 'compare' (duration: 75.602909ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T23:18:40.702968Z","caller":"traceutil/trace.go:171","msg":"trace[1186947834] transaction","detail":"{read_only:false; response_revision:1206; number_of_response:1; }","duration":"680.377162ms","start":"2026-08-14T23:18:40.022565Z","end":"2026-08-14T23:18:40.702942Z","steps":["trace[1186947834] 'process raft request' (duration: 680.156718ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:18:40.703127Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:18:40.022548Z","time spent":"680.502095ms","remote":"127.0.0.1:43578","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-14T23:18:40.805586Z","caller":"traceutil/trace.go:171","msg":"trace[903753123] linearizableReadLoop","detail":"{readStateIndex:1256; appliedIndex:1254; }","duration":"471.40665ms","start":"2026-08-14T23:18:40.334148Z","end":"2026-08-14T23:18:40.805555Z","steps":["trace[903753123] 'read index received' (duration: 368.706051ms)","trace[903753123] 'applied index is now lower than readState.Index' (duration: 102.699489ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T23:18:40.805714Z","caller":"traceutil/trace.go:171","msg":"trace[1132027611] transaction","detail":"{read_only:false; response_revision:1207; number_of_response:1; }","duration":"581.800962ms","start":"2026-08-14T23:18:40.223876Z","end":"2026-08-14T23:18:40.805677Z","steps":["trace[1132027611] 'process raft request' (duration: 504.755886ms)","trace[1132027611] 'compare' (duration: 76.774821ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T23:18:40.805868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"471.155705ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-08-14T23:18:40.805879Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:18:40.223858Z","time spent":"581.930274ms","remote":"127.0.0.1:43578","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-14T23:18:40.80591Z","caller":"traceutil/trace.go:171","msg":"trace[1772063105] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1207; }","duration":"471.262677ms","start":"2026-08-14T23:18:40.334637Z","end":"2026-08-14T23:18:40.8059Z","steps":["trace[1772063105] 'agreement among raft nodes before linearized reading' (duration: 471.077464ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:18:40.805948Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:18:40.334613Z","time spent":"471.326138ms","remote":"127.0.0.1:43578","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":"warn","ts":"2026-08-14T23:18:40.806103Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"470.983121ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-08-14T23:18:40.806133Z","caller":"traceutil/trace.go:171","msg":"trace[1026600576] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1207; }","duration":"471.031232ms","start":"2026-08-14T23:18:40.335094Z","end":"2026-08-14T23:18:40.806126Z","steps":["trace[1026600576] 'agreement among raft nodes before linearized reading' (duration: 470.954821ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:18:40.806158Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:18:40.335086Z","time spent":"471.066423ms","remote":"127.0.0.1:43578","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-08-14T23:18:40.806432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"471.278866ms","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-08-14T23:18:40.80659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"472.442389ms","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-08-14T23:18:40.806643Z","caller":"traceutil/trace.go:171","msg":"trace[128726611] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1207; }","duration":"472.537891ms","start":"2026-08-14T23:18:40.334093Z","end":"2026-08-14T23:18:40.806631Z","steps":["trace[128726611] 'agreement among raft nodes before linearized reading' (duration: 471.584243ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:18:40.806679Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:18:40.33407Z","time spent":"472.602592ms","remote":"127.0.0.1:43578","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-14T23:18:40.806932Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"399.775585ms","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-14T23:18:40.807015Z","caller":"traceutil/trace.go:171","msg":"trace[552530131] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1207; }","duration":"399.904788ms","start":"2026-08-14T23:18:40.407093Z","end":"2026-08-14T23:18:40.806997Z","steps":["trace[552530131] 'agreement among raft nodes before linearized reading' (duration: 398.797487ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:18:40.807069Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:18:40.407076Z","time spent":"399.983989ms","remote":"127.0.0.1:43578","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":"info","ts":"2026-08-14T23:18:40.808039Z","caller":"traceutil/trace.go:171","msg":"trace[569447073] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1207; }","duration":"471.392749ms","start":"2026-08-14T23:18:40.335106Z","end":"2026-08-14T23:18:40.806499Z","steps":["trace[569447073] 'agreement among raft nodes before linearized reading' (duration: 470.859879ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:18:40.808123Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:18:40.335094Z","time spent":"473.01283ms","remote":"127.0.0.1:43578","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-08-14T23:18:43.190685Z","caller":"traceutil/trace.go:171","msg":"trace[1189020381] transaction","detail":"{read_only:false; response_revision:1218; number_of_response:1; }","duration":"282.728467ms","start":"2026-08-14T23:18:42.907932Z","end":"2026-08-14T23:18:43.190661Z","steps":["trace[1189020381] 'process raft request' (duration: 282.686567ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:18:43.190728Z","caller":"traceutil/trace.go:171","msg":"trace[1052388907] transaction","detail":"{read_only:false; response_revision:1216; number_of_response:1; }","duration":"283.199086ms","start":"2026-08-14T23:18:42.907489Z","end":"2026-08-14T23:18:43.190688Z","steps":["trace[1052388907] 'process raft request' (duration: 282.944971ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:18:43.190739Z","caller":"traceutil/trace.go:171","msg":"trace[561389701] transaction","detail":"{read_only:false; response_revision:1217; number_of_response:1; }","duration":"283.095564ms","start":"2026-08-14T23:18:42.90761Z","end":"2026-08-14T23:18:43.190706Z","steps":["trace[561389701] 'process raft request' (duration: 282.963582ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:18:49.276949Z","caller":"traceutil/trace.go:171","msg":"trace[826965512] linearizableReadLoop","detail":"{readStateIndex:1309; appliedIndex:1308; }","duration":"368.360975ms","start":"2026-08-14T23:18:48.908565Z","end":"2026-08-14T23:18:49.276926Z","steps":["trace[826965512] 'read index received' (duration: 368.309804ms)","trace[826965512] 'applied index is now lower than readState.Index' (duration: 50.141µs)"],"step_count":2} {"level":"info","ts":"2026-08-14T23:18:49.277086Z","caller":"traceutil/trace.go:171","msg":"trace[730597901] transaction","detail":"{read_only:false; response_revision:1259; number_of_response:1; }","duration":"404.917891ms","start":"2026-08-14T23:18:48.872148Z","end":"2026-08-14T23:18:49.277066Z","steps":["trace[730597901] 'process raft request' (duration: 404.640466ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:18:49.277182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"368.610979ms","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-08-14T23:18:49.277209Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:18:48.872124Z","time spent":"405.013423ms","remote":"127.0.0.1:43578","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-14T23:18:49.27724Z","caller":"traceutil/trace.go:171","msg":"trace[298802325] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1259; }","duration":"368.716852ms","start":"2026-08-14T23:18:48.908507Z","end":"2026-08-14T23:18:49.277224Z","steps":["trace[298802325] 'agreement among raft nodes before linearized reading' (duration: 368.535648ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:18:49.27731Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:18:48.90849Z","time spent":"368.807683ms","remote":"127.0.0.1:43578","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-14T23:18:49.31892Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"359.389877ms","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-14T23:18:49.31915Z","caller":"traceutil/trace.go:171","msg":"trace[1619759804] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1260; }","duration":"359.672031ms","start":"2026-08-14T23:18:48.959463Z","end":"2026-08-14T23:18:49.319135Z","steps":["trace[1619759804] 'agreement among raft nodes before linearized reading' (duration: 359.344965ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:18:49.319239Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:18:48.959439Z","time spent":"359.786904ms","remote":"127.0.0.1:43578","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-08-14T23:18:49.319133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.20073ms","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-14T23:18:49.320977Z","caller":"traceutil/trace.go:171","msg":"trace[334838911] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1260; }","duration":"103.096155ms","start":"2026-08-14T23:18:49.217866Z","end":"2026-08-14T23:18:49.320962Z","steps":["trace[334838911] 'agreement among raft nodes before linearized reading' (duration: 101.130698ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:18:49.319037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.322622ms","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-14T23:18:49.321206Z","caller":"traceutil/trace.go:171","msg":"trace[347428211] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1260; }","duration":"102.526794ms","start":"2026-08-14T23:18:49.218661Z","end":"2026-08-14T23:18:49.321188Z","steps":["trace[347428211] 'agreement among raft nodes before linearized reading' (duration: 100.317003ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:18:49.318935Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.750801ms","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-08-14T23:18:49.321283Z","caller":"traceutil/trace.go:171","msg":"trace[507893642] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1260; }","duration":"103.186047ms","start":"2026-08-14T23:18:49.218086Z","end":"2026-08-14T23:18:49.321272Z","steps":["trace[507893642] 'agreement among raft nodes before linearized reading' (duration: 100.729991ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:18:49.319422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.953814ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-14T23:18:49.321312Z","caller":"traceutil/trace.go:171","msg":"trace[1231685379] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; response_count:0; response_revision:1261; }","duration":"258.88774ms","start":"2026-08-14T23:18:49.062418Z","end":"2026-08-14T23:18:49.321306Z","steps":["trace[1231685379] 'agreement among raft nodes before linearized reading' (duration: 256.82898ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:21:45.634754Z","caller":"traceutil/trace.go:171","msg":"trace[882139560] transaction","detail":"{read_only:false; response_revision:2113; number_of_response:1; }","duration":"256.537386ms","start":"2026-08-14T23:21:45.378189Z","end":"2026-08-14T23:21:45.634727Z","steps":["trace[882139560] 'process raft request' (duration: 256.348042ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:21:50.991037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.315189ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T23:21:50.991135Z","caller":"traceutil/trace.go:171","msg":"trace[1963401701] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2145; }","duration":"147.504893ms","start":"2026-08-14T23:21:50.843606Z","end":"2026-08-14T23:21:50.991111Z","steps":["trace[1963401701] 'range keys from in-memory index tree' (duration: 147.068324ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:21:51.269352Z","caller":"traceutil/trace.go:171","msg":"trace[202045387] transaction","detail":"{read_only:false; response_revision:2146; number_of_response:1; }","duration":"116.038924ms","start":"2026-08-14T23:21:51.15329Z","end":"2026-08-14T23:21:51.269329Z","steps":["trace[202045387] 'process raft request' (duration: 115.897502ms)"],"step_count":1}