{"level":"warn","ts":"2026-07-09T01:31:15.113611Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-09T01:31:15.11369Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.22: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.22:2380","--initial-cluster=instance=https://199.204.45.22:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.22:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.22: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-07-09T01:31:15.113758Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-09T01:31:15.113772Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.22:2380"]} {"level":"info","ts":"2026-07-09T01:31:15.113786Z","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-07-09T01:31:15.114358Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.22:2379"]} {"level":"info","ts":"2026-07-09T01:31:15.114424Z","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.22:2380"],"listen-peer-urls":["https://199.204.45.22:2380"],"advertise-client-urls":["https://199.204.45.22:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.22:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.22: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-07-09T01:31:15.119832Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.207042ms"} {"level":"info","ts":"2026-07-09T01:31:15.131084Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"fed19d9291630e09","cluster-id":"6ebf1e01320cc017"} {"level":"info","ts":"2026-07-09T01:31:15.13116Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 switched to configuration voters=()"} {"level":"info","ts":"2026-07-09T01:31:15.131214Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 became follower at term 0"} {"level":"info","ts":"2026-07-09T01:31:15.131231Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft fed19d9291630e09 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-09T01:31:15.131241Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 became follower at term 1"} {"level":"info","ts":"2026-07-09T01:31:15.13131Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 switched to configuration voters=(18361630408596196873)"} {"level":"warn","ts":"2026-07-09T01:31:15.137747Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-09T01:31:15.139114Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-09T01:31:15.140546Z","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-07-09T01:31:15.143148Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"fed19d9291630e09","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-09T01:31:15.145671Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"fed19d9291630e09","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-09T01:31:15.146261Z","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-07-09T01:31:15.146309Z","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-07-09T01:31:15.146325Z","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-07-09T01:31:15.147071Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 switched to configuration voters=(18361630408596196873)"} {"level":"info","ts":"2026-07-09T01:31:15.147818Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"6ebf1e01320cc017","local-member-id":"fed19d9291630e09","added-peer-id":"fed19d9291630e09","added-peer-peer-urls":["https://199.204.45.22:2380"]} {"level":"info","ts":"2026-07-09T01:31:15.148732Z","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-07-09T01:31:15.148918Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.22:2380"} {"level":"info","ts":"2026-07-09T01:31:15.148995Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.22:2380"} {"level":"info","ts":"2026-07-09T01:31:15.149251Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"fed19d9291630e09","initial-advertise-peer-urls":["https://199.204.45.22:2380"],"listen-peer-urls":["https://199.204.45.22:2380"],"advertise-client-urls":["https://199.204.45.22:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.22:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-09T01:31:15.149316Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-09T01:31:15.332492Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 is starting a new election at term 1"} {"level":"info","ts":"2026-07-09T01:31:15.332557Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 became pre-candidate at term 1"} {"level":"info","ts":"2026-07-09T01:31:15.332601Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 received MsgPreVoteResp from fed19d9291630e09 at term 1"} {"level":"info","ts":"2026-07-09T01:31:15.332621Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 became candidate at term 2"} {"level":"info","ts":"2026-07-09T01:31:15.332695Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 received MsgVoteResp from fed19d9291630e09 at term 2"} {"level":"info","ts":"2026-07-09T01:31:15.332712Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 became leader at term 2"} {"level":"info","ts":"2026-07-09T01:31:15.332726Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: fed19d9291630e09 elected leader fed19d9291630e09 at term 2"} {"level":"info","ts":"2026-07-09T01:31:15.333549Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-09T01:31:15.333705Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"fed19d9291630e09","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.22:2379]}","request-path":"/0/members/fed19d9291630e09/attributes","cluster-id":"6ebf1e01320cc017","publish-timeout":"7s"} {"level":"info","ts":"2026-07-09T01:31:15.33374Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-09T01:31:15.333817Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-09T01:31:15.334023Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-09T01:31:15.334094Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-09T01:31:15.334516Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"6ebf1e01320cc017","local-member-id":"fed19d9291630e09","cluster-version":"3.5"} {"level":"info","ts":"2026-07-09T01:31:15.334618Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-09T01:31:15.334648Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-09T01:31:15.337074Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-09T01:31:15.337376Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.22:2379"} {"level":"warn","ts":"2026-07-09T01:31:18.196101Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.825492ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-07-09T01:31:18.196488Z","caller":"traceutil/trace.go:171","msg":"trace[704032023] transaction","detail":"{read_only:false; response_revision:181; number_of_response:1; }","duration":"237.388429ms","start":"2026-07-09T01:31:17.959068Z","end":"2026-07-09T01:31:18.196456Z","steps":["trace[704032023] 'process raft request' (duration: 19.688996ms)","trace[704032023] 'marshal mvccpb.KeyValue' {req_type:put; key:/registry/clusterrolebindings/cluster-admin; req_size:661; } (duration: 216.651045ms)"],"step_count":2} {"level":"warn","ts":"2026-07-09T01:31:19.46504Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"776.570976ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-07-09T01:31:19.465155Z","caller":"traceutil/trace.go:171","msg":"trace[1033890807] linearizableReadLoop","detail":"{readStateIndex:188; appliedIndex:187; }","duration":"861.014676ms","start":"2026-07-09T01:31:18.604123Z","end":"2026-07-09T01:31:19.465138Z","steps":["trace[1033890807] 'read index received' (duration: 84.201097ms)","trace[1033890807] 'applied index is now lower than readState.Index' (duration: 776.810568ms)"],"step_count":2} {"level":"info","ts":"2026-07-09T01:31:19.465236Z","caller":"traceutil/trace.go:171","msg":"trace[289269134] transaction","detail":"{read_only:false; response_revision:183; number_of_response:1; }","duration":"1.243212609s","start":"2026-07-09T01:31:18.221957Z","end":"2026-07-09T01:31:19.46517Z","steps":["trace[289269134] 'process raft request' (duration: 466.441244ms)","trace[289269134] 'compare' (duration: 776.455985ms)"],"step_count":2} {"level":"warn","ts":"2026-07-09T01:31:19.465348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"861.210855ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-09T01:31:19.465381Z","caller":"traceutil/trace.go:171","msg":"trace[1459084552] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:183; }","duration":"861.301823ms","start":"2026-07-09T01:31:18.604067Z","end":"2026-07-09T01:31:19.465369Z","steps":["trace[1459084552] 'agreement among raft nodes before linearized reading' (duration: 861.201314ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T01:31:19.465423Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T01:31:18.604021Z","time spent":"861.394212ms","remote":"127.0.0.1:60740","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-07-09T01:31:19.465428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"734.87232ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-07-09T01:31:19.465435Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T01:31:18.221945Z","time spent":"1.243400696s","remote":"127.0.0.1:32844","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":679,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-09T01:31:19.465525Z","caller":"traceutil/trace.go:171","msg":"trace[402810305] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:183; }","duration":"735.036266ms","start":"2026-07-09T01:31:18.730463Z","end":"2026-07-09T01:31:19.465499Z","steps":["trace[402810305] 'agreement among raft nodes before linearized reading' (duration: 734.847398ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T01:31:19.465581Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T01:31:18.730444Z","time spent":"735.126464ms","remote":"127.0.0.1:60992","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-09T01:31:19.465751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"730.013654ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"} {"level":"info","ts":"2026-07-09T01:31:19.46579Z","caller":"traceutil/trace.go:171","msg":"trace[817492315] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:183; }","duration":"730.096702ms","start":"2026-07-09T01:31:18.735684Z","end":"2026-07-09T01:31:19.465781Z","steps":["trace[817492315] 'agreement among raft nodes before linearized reading' (duration: 730.027475ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T01:31:19.465816Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T01:31:18.735664Z","time spent":"730.146397ms","remote":"127.0.0.1:60992","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-09T01:31:20.105819Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1011514707877510319,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-09T01:31:20.606905Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1011514707877510319,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-09T01:31:20.867952Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.398382958s","expected-duration":"1s"} {"level":"warn","ts":"2026-07-09T01:31:21.605455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000039192s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-07-09T01:31:21.605572Z","caller":"traceutil/trace.go:171","msg":"trace[2101119344] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.00023356s","start":"2026-07-09T01:31:19.605319Z","end":"2026-07-09T01:31:21.605553Z","steps":["trace[2101119344] 'agreement among raft nodes before linearized reading' (duration: 2.000068514s)"],"step_count":1} {"level":"warn","ts":"2026-07-09T01:31:21.605635Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T01:31:19.605303Z","time spent":"2.000321099s","remote":"127.0.0.1:60740","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-09T01:31:21.834135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"965.714021ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-09T01:31:21.834427Z","caller":"traceutil/trace.go:171","msg":"trace[771437108] linearizableReadLoop","detail":"{readStateIndex:191; appliedIndex:188; }","duration":"2.229036258s","start":"2026-07-09T01:31:19.605368Z","end":"2026-07-09T01:31:21.834405Z","steps":["trace[771437108] 'read index received' (duration: 1.262808339s)","trace[771437108] 'applied index is now lower than readState.Index' (duration: 966.226659ms)"],"step_count":2} {"level":"info","ts":"2026-07-09T01:31:21.834574Z","caller":"traceutil/trace.go:171","msg":"trace[675514290] transaction","detail":"{read_only:false; response_revision:185; number_of_response:1; }","duration":"2.364829169s","start":"2026-07-09T01:31:19.469643Z","end":"2026-07-09T01:31:21.834472Z","steps":["trace[675514290] 'process raft request' (duration: 2.364611548s)"],"step_count":1} {"level":"warn","ts":"2026-07-09T01:31:21.834787Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T01:31:19.46962Z","time spent":"2.365069371s","remote":"127.0.0.1:60992","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-09T01:31:21.834634Z","caller":"traceutil/trace.go:171","msg":"trace[1115411637] transaction","detail":"{read_only:false; response_revision:186; number_of_response:1; }","duration":"2.364325051s","start":"2026-07-09T01:31:19.470292Z","end":"2026-07-09T01:31:21.834617Z","steps":["trace[1115411637] 'process raft request' (duration: 2.364061236s)"],"step_count":1} {"level":"warn","ts":"2026-07-09T01:31:21.835252Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T01:31:19.470286Z","time spent":"2.364914867s","remote":"127.0.0.1:32844","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":682,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-09T01:31:21.835135Z","caller":"traceutil/trace.go:171","msg":"trace[362353031] transaction","detail":"{read_only:false; response_revision:184; number_of_response:1; }","duration":"2.365557089s","start":"2026-07-09T01:31:19.469519Z","end":"2026-07-09T01:31:21.835076Z","steps":["trace[362353031] 'process raft request' (duration: 1.398643874s)","trace[362353031] 'compare' (duration: 965.213853ms)"],"step_count":2} {"level":"warn","ts":"2026-07-09T01:31:21.835446Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T01:31:19.469508Z","time spent":"2.365896441s","remote":"127.0.0.1:60992","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-09T01:31:21.868677Z","caller":"traceutil/trace.go:171","msg":"trace[2132409372] transaction","detail":"{read_only:false; response_revision:187; number_of_response:1; }","duration":"994.092613ms","start":"2026-07-09T01:31:20.874565Z","end":"2026-07-09T01:31:21.868658Z","steps":["trace[2132409372] 'process raft request' (duration: 994.000774ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T01:31:21.868797Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T01:31:20.874541Z","time spent":"994.202824ms","remote":"127.0.0.1:60926","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2905,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-09T01:31:21.885079Z","caller":"traceutil/trace.go:171","msg":"trace[900550767] transaction","detail":"{read_only:false; response_revision:188; number_of_response:1; }","duration":"215.478495ms","start":"2026-07-09T01:31:21.669575Z","end":"2026-07-09T01:31:21.885053Z","steps":["trace[900550767] 'process raft request' (duration: 215.31378ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T01:31:21.885158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"847.372257ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-09T01:31:21.885269Z","caller":"traceutil/trace.go:171","msg":"trace[834566215] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:188; }","duration":"847.535272ms","start":"2026-07-09T01:31:21.037718Z","end":"2026-07-09T01:31:21.885253Z","steps":["trace[834566215] 'agreement among raft nodes before linearized reading' (duration: 847.374216ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T01:31:21.885305Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T01:31:21.037695Z","time spent":"847.602328ms","remote":"127.0.0.1:60740","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-07-09T01:31:21.885452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.010786ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-09T01:31:21.885599Z","caller":"traceutil/trace.go:171","msg":"trace[1393444066] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:188; }","duration":"279.208515ms","start":"2026-07-09T01:31:21.60637Z","end":"2026-07-09T01:31:21.885579Z","steps":["trace[1393444066] 'agreement among raft nodes before linearized reading' (duration: 278.693275ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T01:32:10.908681Z","caller":"traceutil/trace.go:171","msg":"trace[1904417853] transaction","detail":"{read_only:false; response_revision:564; number_of_response:1; }","duration":"134.375164ms","start":"2026-07-09T01:32:10.774271Z","end":"2026-07-09T01:32:10.908646Z","steps":["trace[1904417853] 'process raft request' (duration: 134.186113ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T01:32:11.305275Z","caller":"traceutil/trace.go:171","msg":"trace[138456242] transaction","detail":"{read_only:false; response_revision:565; number_of_response:1; }","duration":"100.758218ms","start":"2026-07-09T01:32:11.204498Z","end":"2026-07-09T01:32:11.305257Z","steps":["trace[138456242] 'process raft request' (duration: 100.653062ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T01:32:11.311441Z","caller":"traceutil/trace.go:171","msg":"trace[1935533765] transaction","detail":"{read_only:false; response_revision:566; number_of_response:1; }","duration":"101.924346ms","start":"2026-07-09T01:32:11.209494Z","end":"2026-07-09T01:32:11.311418Z","steps":["trace[1935533765] 'process raft request' (duration: 101.368582ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T01:32:11.311929Z","caller":"traceutil/trace.go:171","msg":"trace[1788422923] transaction","detail":"{read_only:false; response_revision:567; number_of_response:1; }","duration":"102.321977ms","start":"2026-07-09T01:32:11.209582Z","end":"2026-07-09T01:32:11.311904Z","steps":["trace[1788422923] 'process raft request' (duration: 101.331383ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T01:32:12.626447Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1011514707877511209,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-09T01:32:12.969531Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.027272545s","expected-duration":"1s"} {"level":"info","ts":"2026-07-09T01:32:12.976189Z","caller":"traceutil/trace.go:171","msg":"trace[29629077] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"1.034074972s","start":"2026-07-09T01:32:11.942088Z","end":"2026-07-09T01:32:12.976163Z","steps":["trace[29629077] 'process raft request' (duration: 1.02783327s)"],"step_count":1} {"level":"warn","ts":"2026-07-09T01:32:12.976338Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T01:32:11.942071Z","time spent":"1.034187917s","remote":"127.0.0.1:60788","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":98698,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-09T01:32:12.979943Z","caller":"traceutil/trace.go:171","msg":"trace[1881790852] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"881.887386ms","start":"2026-07-09T01:32:12.097984Z","end":"2026-07-09T01:32:12.979871Z","steps":["trace[1881790852] 'process raft request' (duration: 881.413447ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T01:32:12.980075Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T01:32:12.097962Z","time spent":"882.055798ms","remote":"127.0.0.1:60788","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":569094,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-09T01:32:12.980117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"854.015287ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-07-09T01:32:12.980197Z","caller":"traceutil/trace.go:171","msg":"trace[859345466] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:629; }","duration":"854.134641ms","start":"2026-07-09T01:32:12.126041Z","end":"2026-07-09T01:32:12.980176Z","steps":["trace[859345466] 'agreement among raft nodes before linearized reading' (duration: 853.93033ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T01:32:12.98024Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T01:32:12.126027Z","time spent":"854.205098ms","remote":"127.0.0.1:60992","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-07-09T01:32:12.979791Z","caller":"traceutil/trace.go:171","msg":"trace[822344868] linearizableReadLoop","detail":"{readStateIndex:657; appliedIndex:655; }","duration":"853.697651ms","start":"2026-07-09T01:32:12.126074Z","end":"2026-07-09T01:32:12.979771Z","steps":["trace[822344868] 'read index received' (duration: 843.668018ms)","trace[822344868] 'applied index is now lower than readState.Index' (duration: 10.028863ms)"],"step_count":2} {"level":"warn","ts":"2026-07-09T01:32:12.980617Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"854.353022ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"} {"level":"info","ts":"2026-07-09T01:32:12.980675Z","caller":"traceutil/trace.go:171","msg":"trace[559326152] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:629; }","duration":"854.433049ms","start":"2026-07-09T01:32:12.126221Z","end":"2026-07-09T01:32:12.980654Z","steps":["trace[559326152] 'agreement among raft nodes before linearized reading' (duration: 854.317634ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T01:32:12.980716Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T01:32:12.126215Z","time spent":"854.492166ms","remote":"127.0.0.1:60992","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-09T01:32:12.98072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.057401ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.22\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-07-09T01:32:12.980761Z","caller":"traceutil/trace.go:171","msg":"trace[678341062] range","detail":"{range_begin:/registry/masterleases/199.204.45.22; range_end:; response_count:1; response_revision:629; }","duration":"272.132967ms","start":"2026-07-09T01:32:12.708617Z","end":"2026-07-09T01:32:12.98075Z","steps":["trace[678341062] 'agreement among raft nodes before linearized reading' (duration: 272.06517ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T01:32:12.98088Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"475.919847ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-09T01:32:12.980934Z","caller":"traceutil/trace.go:171","msg":"trace[2069571828] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:629; }","duration":"476.007073ms","start":"2026-07-09T01:32:12.504915Z","end":"2026-07-09T01:32:12.980922Z","steps":["trace[2069571828] 'agreement among raft nodes before linearized reading' (duration: 475.932356ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T01:32:12.980967Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T01:32:12.504897Z","time spent":"476.063261ms","remote":"127.0.0.1:60740","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-07-09T01:32:16.87642Z","caller":"traceutil/trace.go:171","msg":"trace[1500931579] transaction","detail":"{read_only:false; response_revision:659; number_of_response:1; }","duration":"157.409392ms","start":"2026-07-09T01:32:16.718975Z","end":"2026-07-09T01:32:16.876384Z","steps":["trace[1500931579] 'process raft request' (duration: 156.892541ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T01:32:18.005562Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1011514707877511323,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-09T01:32:18.506553Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1011514707877511323,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-09T01:32:18.986033Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.51391311s","expected-duration":"1s"} {"level":"info","ts":"2026-07-09T01:32:18.987117Z","caller":"traceutil/trace.go:171","msg":"trace[1692577444] transaction","detail":"{read_only:false; response_revision:664; number_of_response:1; }","duration":"1.53329919s","start":"2026-07-09T01:32:17.453793Z","end":"2026-07-09T01:32:18.987093Z","steps":["trace[1692577444] 'process raft request' (duration: 1.53269599s)"],"step_count":1} {"level":"warn","ts":"2026-07-09T01:32:18.987233Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T01:32:17.453765Z","time spent":"1.533395767s","remote":"127.0.0.1:60832","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036225,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-09T01:32:19.03163Z","caller":"traceutil/trace.go:171","msg":"trace[2000933065] linearizableReadLoop","detail":"{readStateIndex:695; appliedIndex:692; }","duration":"1.526693814s","start":"2026-07-09T01:32:17.504916Z","end":"2026-07-09T01:32:19.03161Z","steps":["trace[2000933065] 'read index received' (duration: 1.481422741s)","trace[2000933065] 'applied index is now lower than readState.Index' (duration: 45.270423ms)"],"step_count":2} {"level":"info","ts":"2026-07-09T01:32:19.031712Z","caller":"traceutil/trace.go:171","msg":"trace[1769709364] transaction","detail":"{read_only:false; response_revision:665; number_of_response:1; }","duration":"733.959447ms","start":"2026-07-09T01:32:18.297745Z","end":"2026-07-09T01:32:19.031704Z","steps":["trace[1769709364] 'process raft request' (duration: 733.788252ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T01:32:19.031852Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T01:32:18.297718Z","time spent":"734.070803ms","remote":"127.0.0.1:60992","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-07-09T01:32:19.031858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.526935685s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-09T01:32:19.03187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.495200659s","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-07-09T01:32:19.031961Z","caller":"traceutil/trace.go:171","msg":"trace[558422656] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:665; }","duration":"1.495324305s","start":"2026-07-09T01:32:17.536627Z","end":"2026-07-09T01:32:19.031951Z","steps":["trace[558422656] 'agreement among raft nodes before linearized reading' (duration: 1.49515266s)"],"step_count":1} {"level":"warn","ts":"2026-07-09T01:32:19.032009Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T01:32:17.536602Z","time spent":"1.495398582s","remote":"127.0.0.1:60992","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-07-09T01:32:19.03192Z","caller":"traceutil/trace.go:171","msg":"trace[1760337381] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:665; }","duration":"1.527040582s","start":"2026-07-09T01:32:17.504859Z","end":"2026-07-09T01:32:19.0319Z","steps":["trace[1760337381] 'agreement among raft nodes before linearized reading' (duration: 1.526949895s)"],"step_count":1} {"level":"warn","ts":"2026-07-09T01:32:19.032048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.213169938s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-07-09T01:32:19.03211Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T01:32:17.504836Z","time spent":"1.527266825s","remote":"127.0.0.1:60740","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-07-09T01:32:19.032157Z","caller":"traceutil/trace.go:171","msg":"trace[1103646047] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:665; }","duration":"1.213367362s","start":"2026-07-09T01:32:17.81877Z","end":"2026-07-09T01:32:19.032138Z","steps":["trace[1103646047] 'agreement among raft nodes before linearized reading' (duration: 1.213056262s)"],"step_count":1} {"level":"warn","ts":"2026-07-09T01:32:19.032236Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T01:32:17.818747Z","time spent":"1.213477698s","remote":"127.0.0.1:60944","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":42,"response size":30,"request content":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true "} {"level":"info","ts":"2026-07-09T01:32:22.466695Z","caller":"traceutil/trace.go:171","msg":"trace[2057799876] transaction","detail":"{read_only:false; response_revision:689; number_of_response:1; }","duration":"700.753554ms","start":"2026-07-09T01:32:21.765922Z","end":"2026-07-09T01:32:22.466676Z","steps":["trace[2057799876] 'process raft request' (duration: 700.634597ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T01:32:22.466807Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T01:32:21.765897Z","time spent":"700.859011ms","remote":"127.0.0.1:60926","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-09T01:32:23.551737Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1011514707877511381,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-09T01:32:24.052516Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1011514707877511381,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-09T01:32:24.553656Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1011514707877511381,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-09T01:32:25.054661Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1011514707877511381,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-09T01:32:25.502376Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000147963s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-07-09T01:32:25.502491Z","caller":"traceutil/trace.go:171","msg":"trace[829736641] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000325899s","start":"2026-07-09T01:32:23.502143Z","end":"2026-07-09T01:32:25.502469Z","steps":["trace[829736641] 'agreement among raft nodes before linearized reading' (duration: 2.000182512s)"],"step_count":1} {"level":"warn","ts":"2026-07-09T01:32:25.502542Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T01:32:23.502119Z","time spent":"2.000411837s","remote":"127.0.0.1:60740","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/07/09 01:32:25 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-07-09T01:32:25.529045Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.818747864s","expected-duration":"1s"} {"level":"info","ts":"2026-07-09T01:32:25.529384Z","caller":"traceutil/trace.go:171","msg":"trace[2096501391] linearizableReadLoop","detail":"{readStateIndex:721; appliedIndex:720; }","duration":"2.478399635s","start":"2026-07-09T01:32:23.050968Z","end":"2026-07-09T01:32:25.529368Z","steps":["trace[2096501391] 'read index received' (duration: 2.478181829s)","trace[2096501391] 'applied index is now lower than readState.Index' (duration: 216.846µs)"],"step_count":2} {"level":"warn","ts":"2026-07-09T01:32:25.529412Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T01:32:22.710191Z","time spent":"2.819216634s","remote":"127.0.0.1:60762","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-07-09T01:32:25.529607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.829652536s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-09T01:32:25.529657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.478682169s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-07-09T01:32:25.529675Z","caller":"traceutil/trace.go:171","msg":"trace[1274247847] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:689; }","duration":"1.829775584s","start":"2026-07-09T01:32:23.699881Z","end":"2026-07-09T01:32:25.529656Z","steps":["trace[1274247847] 'agreement among raft nodes before linearized reading' (duration: 1.829663066s)"],"step_count":1} {"level":"info","ts":"2026-07-09T01:32:25.529713Z","caller":"traceutil/trace.go:171","msg":"trace[1744867058] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:689; }","duration":"2.478778457s","start":"2026-07-09T01:32:23.050918Z","end":"2026-07-09T01:32:25.529697Z","steps":["trace[1744867058] 'agreement among raft nodes before linearized reading' (duration: 2.478561061s)"],"step_count":1} {"level":"warn","ts":"2026-07-09T01:32:25.529721Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T01:32:23.699857Z","time spent":"1.829854382s","remote":"127.0.0.1:60958","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":28,"request content":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true "} {"level":"warn","ts":"2026-07-09T01:32:25.529728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.313389166s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-09T01:32:25.529766Z","caller":"traceutil/trace.go:171","msg":"trace[614499369] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:689; }","duration":"2.313456255s","start":"2026-07-09T01:32:23.216296Z","end":"2026-07-09T01:32:25.529752Z","steps":["trace[614499369] 'agreement among raft nodes before linearized reading' (duration: 2.313408906s)"],"step_count":1} {"level":"warn","ts":"2026-07-09T01:32:25.529764Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T01:32:23.050897Z","time spent":"2.478853256s","remote":"127.0.0.1:60992","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-09T01:32:25.529798Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T01:32:23.216268Z","time spent":"2.313521895s","remote":"127.0.0.1:60880","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":28,"request content":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true "} {"level":"warn","ts":"2026-07-09T01:32:25.529874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.432641946s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"} {"level":"info","ts":"2026-07-09T01:32:25.529921Z","caller":"traceutil/trace.go:171","msg":"trace[877237145] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:689; }","duration":"2.432749533s","start":"2026-07-09T01:32:23.097156Z","end":"2026-07-09T01:32:25.529906Z","steps":["trace[877237145] 'agreement among raft nodes before linearized reading' (duration: 2.432591836s)"],"step_count":1} {"level":"warn","ts":"2026-07-09T01:32:25.529956Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T01:32:23.097136Z","time spent":"2.432813173s","remote":"127.0.0.1:60992","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-09T01:32:25.529991Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.433297261s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-07-09T01:32:25.530019Z","caller":"traceutil/trace.go:171","msg":"trace[1914783802] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:689; }","duration":"2.433345649s","start":"2026-07-09T01:32:23.096665Z","end":"2026-07-09T01:32:25.530011Z","steps":["trace[1914783802] 'agreement among raft nodes before linearized reading' (duration: 2.433268351s)"],"step_count":1} {"level":"warn","ts":"2026-07-09T01:32:25.530045Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T01:32:23.096653Z","time spent":"2.433386489s","remote":"127.0.0.1:60992","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-09T01:32:25.530066Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.668232833s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-09T01:32:25.530096Z","caller":"traceutil/trace.go:171","msg":"trace[1800458647] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:689; }","duration":"1.668313902s","start":"2026-07-09T01:32:23.861773Z","end":"2026-07-09T01:32:25.530087Z","steps":["trace[1800458647] 'agreement among raft nodes before linearized reading' (duration: 1.668234543s)"],"step_count":1} {"level":"warn","ts":"2026-07-09T01:32:25.530123Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T01:32:23.861749Z","time spent":"1.66836727s","remote":"127.0.0.1:32840","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":67,"response size":30,"request content":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true "} {"level":"warn","ts":"2026-07-09T01:32:25.529674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.466420984s","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-07-09T01:32:25.530231Z","caller":"traceutil/trace.go:171","msg":"trace[879056574] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:689; }","duration":"2.467017712s","start":"2026-07-09T01:32:23.0632Z","end":"2026-07-09T01:32:25.530217Z","steps":["trace[879056574] 'agreement among raft nodes before linearized reading' (duration: 2.466335705s)"],"step_count":1} {"level":"warn","ts":"2026-07-09T01:32:25.530284Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T01:32:23.063175Z","time spent":"2.467096791s","remote":"127.0.0.1:60992","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-07-09T01:32:25.988224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.657082ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-09T01:32:25.988347Z","caller":"traceutil/trace.go:171","msg":"trace[531446991] transaction","detail":"{read_only:false; response_revision:690; number_of_response:1; }","duration":"456.907189ms","start":"2026-07-09T01:32:25.531419Z","end":"2026-07-09T01:32:25.988327Z","steps":["trace[531446991] 'process raft request' (duration: 152.023332ms)","trace[531446991] 'compare' (duration: 304.398018ms)"],"step_count":2} {"level":"warn","ts":"2026-07-09T01:32:25.988409Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T01:32:25.5314Z","time spent":"456.979158ms","remote":"127.0.0.1:60762","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":118,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-09T01:32:26.007045Z","caller":"traceutil/trace.go:171","msg":"trace[1031406526] transaction","detail":"{read_only:false; response_revision:691; number_of_response:1; }","duration":"472.613755ms","start":"2026-07-09T01:32:25.534413Z","end":"2026-07-09T01:32:26.007026Z","steps":["trace[1031406526] 'process raft request' (duration: 472.450209ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T01:32:26.00714Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T01:32:25.534397Z","time spent":"472.699194ms","remote":"127.0.0.1:60992","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-09T01:32:26.00734Z","caller":"traceutil/trace.go:171","msg":"trace[1732897275] transaction","detail":"{read_only:false; response_revision:692; number_of_response:1; }","duration":"472.222365ms","start":"2026-07-09T01:32:25.535097Z","end":"2026-07-09T01:32:26.007319Z","steps":["trace[1732897275] 'process raft request' (duration: 471.886411ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T01:32:26.007441Z","caller":"traceutil/trace.go:171","msg":"trace[1032637994] transaction","detail":"{read_only:false; response_revision:693; number_of_response:1; }","duration":"472.056039ms","start":"2026-07-09T01:32:25.535371Z","end":"2026-07-09T01:32:26.007428Z","steps":["trace[1032637994] 'process raft request' (duration: 471.884392ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T01:32:26.007486Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T01:32:25.535085Z","time spent":"472.331012ms","remote":"127.0.0.1:60992","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-09T01:32:26.007503Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T01:32:25.535353Z","time spent":"472.122927ms","remote":"127.0.0.1:60812","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":759,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-09T01:32:26.007612Z","caller":"traceutil/trace.go:171","msg":"trace[819699700] transaction","detail":"{read_only:false; response_revision:694; number_of_response:1; }","duration":"472.034058ms","start":"2026-07-09T01:32:25.535568Z","end":"2026-07-09T01:32:26.007602Z","steps":["trace[819699700] 'process raft request' (duration: 471.804533ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T01:32:26.007657Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T01:32:25.535532Z","time spent":"472.102887ms","remote":"127.0.0.1:60992","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-09T01:32:26.007779Z","caller":"traceutil/trace.go:171","msg":"trace[1918049555] transaction","detail":"{read_only:false; response_revision:695; number_of_response:1; }","duration":"472.093697ms","start":"2026-07-09T01:32:25.535677Z","end":"2026-07-09T01:32:26.007771Z","steps":["trace[1918049555] 'process raft request' (duration: 471.770223ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T01:32:26.007822Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T01:32:25.535668Z","time spent":"472.133716ms","remote":"127.0.0.1:60992","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-09T01:32:26.00803Z","caller":"traceutil/trace.go:171","msg":"trace[2006703508] linearizableReadLoop","detail":"{readStateIndex:727; appliedIndex:721; }","duration":"468.040221ms","start":"2026-07-09T01:32:25.539972Z","end":"2026-07-09T01:32:26.008012Z","steps":["trace[2006703508] 'read index received' (duration: 143.593606ms)","trace[2006703508] 'applied index is now lower than readState.Index' (duration: 324.445765ms)"],"step_count":2} {"level":"info","ts":"2026-07-09T01:32:26.008128Z","caller":"traceutil/trace.go:171","msg":"trace[2032187505] transaction","detail":"{read_only:false; response_revision:696; number_of_response:1; }","duration":"345.401422ms","start":"2026-07-09T01:32:25.662719Z","end":"2026-07-09T01:32:26.00812Z","steps":["trace[2032187505] 'process raft request' (duration: 345.234285ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T01:32:26.008148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"468.178949ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-09T01:32:26.008179Z","caller":"traceutil/trace.go:171","msg":"trace[1788662100] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:696; }","duration":"468.235917ms","start":"2026-07-09T01:32:25.539934Z","end":"2026-07-09T01:32:26.00817Z","steps":["trace[1788662100] 'agreement among raft nodes before linearized reading' (duration: 468.190088ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T01:32:26.0082Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T01:32:25.539917Z","time spent":"468.278857ms","remote":"127.0.0.1:60740","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-07-09T01:32:26.008573Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T01:32:25.662696Z","time spent":"345.456652ms","remote":"127.0.0.1:60992","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-07-09T01:32:26.901653Z","caller":"traceutil/trace.go:171","msg":"trace[1991924055] transaction","detail":"{read_only:false; response_revision:698; number_of_response:1; }","duration":"130.834114ms","start":"2026-07-09T01:32:26.770799Z","end":"2026-07-09T01:32:26.901633Z","steps":["trace[1991924055] 'process raft request' (duration: 130.720246ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T01:32:27.050722Z","caller":"traceutil/trace.go:171","msg":"trace[991798443] linearizableReadLoop","detail":"{readStateIndex:731; appliedIndex:729; }","duration":"233.454485ms","start":"2026-07-09T01:32:26.817246Z","end":"2026-07-09T01:32:27.050701Z","steps":["trace[991798443] 'read index received' (duration: 84.322468ms)","trace[991798443] 'applied index is now lower than readState.Index' (duration: 149.131117ms)"],"step_count":2} {"level":"info","ts":"2026-07-09T01:32:27.050769Z","caller":"traceutil/trace.go:171","msg":"trace[151740972] transaction","detail":"{read_only:false; response_revision:699; number_of_response:1; }","duration":"271.156809ms","start":"2026-07-09T01:32:26.779584Z","end":"2026-07-09T01:32:27.050741Z","steps":["trace[151740972] 'process raft request' (duration: 270.978362ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T01:32:27.050976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.677582ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-09T01:32:27.051037Z","caller":"traceutil/trace.go:171","msg":"trace[2034388531] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:699; }","duration":"233.79757ms","start":"2026-07-09T01:32:26.817228Z","end":"2026-07-09T01:32:27.051026Z","steps":["trace[2034388531] 'agreement among raft nodes before linearized reading' (duration: 233.570043ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T01:32:27.620859Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.107691ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-09T01:32:27.620956Z","caller":"traceutil/trace.go:171","msg":"trace[34508481] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:701; }","duration":"116.219479ms","start":"2026-07-09T01:32:27.504717Z","end":"2026-07-09T01:32:27.620937Z","steps":["trace[34508481] 'range keys from in-memory index tree' (duration: 116.036323ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T01:32:28.396508Z","caller":"traceutil/trace.go:171","msg":"trace[1861301868] transaction","detail":"{read_only:false; response_revision:707; number_of_response:1; }","duration":"380.208556ms","start":"2026-07-09T01:32:28.016285Z","end":"2026-07-09T01:32:28.396493Z","steps":["trace[1861301868] 'process raft request' (duration: 380.159167ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T01:32:28.399565Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T01:32:28.016278Z","time spent":"383.214579ms","remote":"127.0.0.1:60992","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-09T01:32:28.398804Z","caller":"traceutil/trace.go:171","msg":"trace[401450061] transaction","detail":"{read_only:false; response_revision:706; number_of_response:1; }","duration":"386.175132ms","start":"2026-07-09T01:32:28.012596Z","end":"2026-07-09T01:32:28.398771Z","steps":["trace[401450061] 'process raft request' (duration: 376.78888ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T01:32:28.399796Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T01:32:28.012574Z","time spent":"387.205036ms","remote":"127.0.0.1:60992","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-09T01:32:28.399071Z","caller":"traceutil/trace.go:171","msg":"trace[1820862296] linearizableReadLoop","detail":"{readStateIndex:738; appliedIndex:737; }","duration":"385.168729ms","start":"2026-07-09T01:32:28.013893Z","end":"2026-07-09T01:32:28.399062Z","steps":["trace[1820862296] 'read index received' (duration: 375.427032ms)","trace[1820862296] 'applied index is now lower than readState.Index' (duration: 9.740647ms)"],"step_count":2} {"level":"info","ts":"2026-07-09T01:32:28.399045Z","caller":"traceutil/trace.go:171","msg":"trace[1294211722] transaction","detail":"{read_only:false; response_revision:708; number_of_response:1; }","duration":"382.356632ms","start":"2026-07-09T01:32:28.01667Z","end":"2026-07-09T01:32:28.399027Z","steps":["trace[1294211722] 'process raft request' (duration: 379.800543ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T01:32:28.400017Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T01:32:28.016665Z","time spent":"383.333117ms","remote":"127.0.0.1:60992","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-09T01:32:28.416871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"402.966317ms","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-07-09T01:32:28.416924Z","caller":"traceutil/trace.go:171","msg":"trace[1222566535] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:708; }","duration":"403.052655ms","start":"2026-07-09T01:32:28.01386Z","end":"2026-07-09T01:32:28.416913Z","steps":["trace[1222566535] 'agreement among raft nodes before linearized reading' (duration: 385.229957ms)","trace[1222566535] 'range keys from in-memory index tree' (duration: 17.70957ms)"],"step_count":2} {"level":"warn","ts":"2026-07-09T01:32:28.416948Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T01:32:28.013848Z","time spent":"403.095695ms","remote":"127.0.0.1:60992","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-07-09T01:32:28.417131Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"398.515807ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-09T01:32:28.41715Z","caller":"traceutil/trace.go:171","msg":"trace[1212889968] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:708; }","duration":"398.566856ms","start":"2026-07-09T01:32:28.018579Z","end":"2026-07-09T01:32:28.417146Z","steps":["trace[1212889968] 'agreement among raft nodes before linearized reading' (duration: 398.036614ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T01:32:28.417164Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T01:32:28.018564Z","time spent":"398.596365ms","remote":"127.0.0.1:60270","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:10000 "} {"level":"warn","ts":"2026-07-09T01:32:28.41743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.251955ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-09T01:32:28.41745Z","caller":"traceutil/trace.go:171","msg":"trace[978386905] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:708; }","duration":"114.301434ms","start":"2026-07-09T01:32:28.303144Z","end":"2026-07-09T01:32:28.417446Z","steps":["trace[978386905] 'agreement among raft nodes before linearized reading' (duration: 114.274644ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T01:32:28.417517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.677459ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-09T01:32:28.417534Z","caller":"traceutil/trace.go:171","msg":"trace[2065069634] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:708; }","duration":"114.729088ms","start":"2026-07-09T01:32:28.302801Z","end":"2026-07-09T01:32:28.41753Z","steps":["trace[2065069634] 'agreement among raft nodes before linearized reading' (duration: 114.704229ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T01:32:28.41759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.856526ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-09T01:32:28.417606Z","caller":"traceutil/trace.go:171","msg":"trace[712326389] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:708; }","duration":"114.886465ms","start":"2026-07-09T01:32:28.302716Z","end":"2026-07-09T01:32:28.417602Z","steps":["trace[712326389] 'agreement among raft nodes before linearized reading' (duration: 114.862946ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T01:32:28.417664Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.900215ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-09T01:32:28.41768Z","caller":"traceutil/trace.go:171","msg":"trace[274442450] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:708; }","duration":"140.927224ms","start":"2026-07-09T01:32:28.276749Z","end":"2026-07-09T01:32:28.417676Z","steps":["trace[274442450] 'agreement among raft nodes before linearized reading' (duration: 140.904744ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T01:32:28.417764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"372.777324ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-09T01:32:28.417784Z","caller":"traceutil/trace.go:171","msg":"trace[813773328] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:708; }","duration":"372.826063ms","start":"2026-07-09T01:32:28.044953Z","end":"2026-07-09T01:32:28.417779Z","steps":["trace[813773328] 'agreement among raft nodes before linearized reading' (duration: 372.796974ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T01:32:28.417797Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T01:32:28.044937Z","time spent":"372.856522ms","remote":"127.0.0.1:60280","response type":"/etcdserverpb.KV/Range","request count":0,"request size":88,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true "} {"level":"warn","ts":"2026-07-09T01:32:28.41787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.946798ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-09T01:32:28.417886Z","caller":"traceutil/trace.go:171","msg":"trace[691145535] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:708; }","duration":"142.004237ms","start":"2026-07-09T01:32:28.275878Z","end":"2026-07-09T01:32:28.417883Z","steps":["trace[691145535] 'agreement among raft nodes before linearized reading' (duration: 141.977537ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T01:32:28.417949Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.126676ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-09T01:32:28.417964Z","caller":"traceutil/trace.go:171","msg":"trace[1642366834] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:708; }","duration":"142.155435ms","start":"2026-07-09T01:32:28.275805Z","end":"2026-07-09T01:32:28.417961Z","steps":["trace[1642366834] 'agreement among raft nodes before linearized reading' (duration: 142.134026ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T01:32:28.418033Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.276918ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-09T01:32:28.418048Z","caller":"traceutil/trace.go:171","msg":"trace[531266842] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:708; }","duration":"143.312338ms","start":"2026-07-09T01:32:28.274732Z","end":"2026-07-09T01:32:28.418045Z","steps":["trace[531266842] 'agreement among raft nodes before linearized reading' (duration: 143.280969ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T01:32:28.418127Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.885174ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-09T01:32:28.418146Z","caller":"traceutil/trace.go:171","msg":"trace[1109264038] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:708; }","duration":"263.926644ms","start":"2026-07-09T01:32:28.154213Z","end":"2026-07-09T01:32:28.41814Z","steps":["trace[1109264038] 'agreement among raft nodes before linearized reading' (duration: 263.895274ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T01:32:28.418217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.440605ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-09T01:32:28.418235Z","caller":"traceutil/trace.go:171","msg":"trace[418827545] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:708; }","duration":"264.469054ms","start":"2026-07-09T01:32:28.15376Z","end":"2026-07-09T01:32:28.418229Z","steps":["trace[418827545] 'agreement among raft nodes before linearized reading' (duration: 264.446434ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T01:32:28.418309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.607252ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-09T01:32:28.418325Z","caller":"traceutil/trace.go:171","msg":"trace[905958076] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:708; }","duration":"264.637502ms","start":"2026-07-09T01:32:28.153684Z","end":"2026-07-09T01:32:28.418321Z","steps":["trace[905958076] 'agreement among raft nodes before linearized reading' (duration: 264.614592ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T01:32:28.418387Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.244597ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-09T01:32:28.418406Z","caller":"traceutil/trace.go:171","msg":"trace[536632840] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:708; }","duration":"323.287885ms","start":"2026-07-09T01:32:28.095112Z","end":"2026-07-09T01:32:28.418399Z","steps":["trace[536632840] 'agreement among raft nodes before linearized reading' (duration: 323.265166ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T01:32:28.418419Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T01:32:28.095104Z","time spent":"323.311305ms","remote":"127.0.0.1:60288","response type":"/etcdserverpb.KV/Range","request count":0,"request size":131,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:500 "} {"level":"warn","ts":"2026-07-09T01:32:28.418484Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.077643ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-09T01:32:28.4185Z","caller":"traceutil/trace.go:171","msg":"trace[20935722] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:708; }","duration":"324.127612ms","start":"2026-07-09T01:32:28.094369Z","end":"2026-07-09T01:32:28.418497Z","steps":["trace[20935722] 'agreement among raft nodes before linearized reading' (duration: 324.103072ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T01:32:28.418513Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T01:32:28.094324Z","time spent":"324.184812ms","remote":"127.0.0.1:60288","response type":"/etcdserverpb.KV/Range","request count":0,"request size":131,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-07-09T01:32:28.418762Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"348.33366ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-09T01:32:28.418819Z","caller":"traceutil/trace.go:171","msg":"trace[277610946] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:708; }","duration":"348.445299ms","start":"2026-07-09T01:32:28.070361Z","end":"2026-07-09T01:32:28.418806Z","steps":["trace[277610946] 'agreement among raft nodes before linearized reading' (duration: 348.311051ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T01:32:28.418851Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T01:32:28.070354Z","time spent":"348.491097ms","remote":"127.0.0.1:60284","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 "} {"level":"warn","ts":"2026-07-09T01:32:28.41899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"349.430303ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-09T01:32:28.419008Z","caller":"traceutil/trace.go:171","msg":"trace[487051917] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:708; }","duration":"349.460032ms","start":"2026-07-09T01:32:28.069542Z","end":"2026-07-09T01:32:28.419002Z","steps":["trace[487051917] 'agreement among raft nodes before linearized reading' (duration: 349.433272ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T01:32:28.419023Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T01:32:28.069538Z","time spent":"349.480971ms","remote":"127.0.0.1:60284","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true "} {"level":"warn","ts":"2026-07-09T01:32:28.419089Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"349.631479ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-09T01:32:28.419105Z","caller":"traceutil/trace.go:171","msg":"trace[1670860268] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:708; }","duration":"349.671099ms","start":"2026-07-09T01:32:28.069429Z","end":"2026-07-09T01:32:28.419101Z","steps":["trace[1670860268] 'agreement among raft nodes before linearized reading' (duration: 349.645629ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T01:32:28.41912Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T01:32:28.069423Z","time spent":"349.692688ms","remote":"127.0.0.1:60284","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 "} {"level":"warn","ts":"2026-07-09T01:32:28.419188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"373.070629ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-09T01:32:28.419206Z","caller":"traceutil/trace.go:171","msg":"trace[199330863] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:708; }","duration":"373.105488ms","start":"2026-07-09T01:32:28.046094Z","end":"2026-07-09T01:32:28.419199Z","steps":["trace[199330863] 'agreement among raft nodes before linearized reading' (duration: 373.080279ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T01:32:28.419221Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T01:32:28.046087Z","time spent":"373.129608ms","remote":"127.0.0.1:60280","response type":"/etcdserverpb.KV/Range","request count":0,"request size":89,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:500 "} {"level":"warn","ts":"2026-07-09T01:32:28.419308Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"374.200512ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-09T01:32:28.419324Z","caller":"traceutil/trace.go:171","msg":"trace[571873246] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:708; }","duration":"374.255821ms","start":"2026-07-09T01:32:28.045064Z","end":"2026-07-09T01:32:28.41932Z","steps":["trace[571873246] 'agreement among raft nodes before linearized reading' (duration: 374.225781ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T01:32:28.419339Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T01:32:28.04504Z","time spent":"374.29589ms","remote":"127.0.0.1:60280","response type":"/etcdserverpb.KV/Range","request count":0,"request size":89,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:10000 "} {"level":"warn","ts":"2026-07-09T01:32:28.419372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.067487ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-09T01:32:28.419397Z","caller":"traceutil/trace.go:171","msg":"trace[436441250] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:708; }","duration":"325.137425ms","start":"2026-07-09T01:32:28.094254Z","end":"2026-07-09T01:32:28.419391Z","steps":["trace[436441250] 'agreement among raft nodes before linearized reading' (duration: 324.303489ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T01:32:28.419432Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T01:32:28.094243Z","time spent":"325.168455ms","remote":"127.0.0.1:60288","response type":"/etcdserverpb.KV/Range","request count":0,"request size":130,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true "} {"level":"warn","ts":"2026-07-09T01:32:28.419872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"401.036167ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-09T01:32:28.419897Z","caller":"traceutil/trace.go:171","msg":"trace[860124802] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:708; }","duration":"401.061916ms","start":"2026-07-09T01:32:28.018829Z","end":"2026-07-09T01:32:28.41989Z","steps":["trace[860124802] 'agreement among raft nodes before linearized reading' (duration: 401.025407ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T01:32:28.41997Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T01:32:28.018809Z","time spent":"401.099556ms","remote":"127.0.0.1:60270","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:500 "} {"level":"warn","ts":"2026-07-09T01:32:28.42006Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"401.401882ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-09T01:32:28.420084Z","caller":"traceutil/trace.go:171","msg":"trace[58930347] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:708; }","duration":"401.43686ms","start":"2026-07-09T01:32:28.018637Z","end":"2026-07-09T01:32:28.420074Z","steps":["trace[58930347] 'agreement among raft nodes before linearized reading' (duration: 401.409371ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T01:32:28.420145Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T01:32:28.018629Z","time spent":"401.508149ms","remote":"127.0.0.1:60270","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true "} {"level":"info","ts":"2026-07-09T01:32:29.108484Z","caller":"traceutil/trace.go:171","msg":"trace[1014647082] transaction","detail":"{read_only:false; response_revision:729; number_of_response:1; }","duration":"156.596005ms","start":"2026-07-09T01:32:28.951862Z","end":"2026-07-09T01:32:29.108458Z","steps":["trace[1014647082] 'process raft request' (duration: 156.346568ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T01:32:29.108727Z","caller":"traceutil/trace.go:171","msg":"trace[1649833062] transaction","detail":"{read_only:false; response_revision:730; number_of_response:1; }","duration":"153.74651ms","start":"2026-07-09T01:32:28.954949Z","end":"2026-07-09T01:32:29.108695Z","steps":["trace[1649833062] 'process raft request' (duration: 153.463844ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T01:32:31.17949Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.841515ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io\" ","response":"range_response_count:1 size:5586"} {"level":"info","ts":"2026-07-09T01:32:31.17958Z","caller":"traceutil/trace.go:171","msg":"trace[302370008] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io; range_end:; response_count:1; response_revision:760; }","duration":"107.995034ms","start":"2026-07-09T01:32:31.071564Z","end":"2026-07-09T01:32:31.179559Z","steps":["trace[302370008] 'range keys from in-memory index tree' (duration: 107.573399ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T01:32:42.770727Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1011514707877511741,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-09T01:32:42.921348Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.041807893s","expected-duration":"1s"} {"level":"info","ts":"2026-07-09T01:32:42.921642Z","caller":"traceutil/trace.go:171","msg":"trace[1140915103] linearizableReadLoop","detail":"{readStateIndex:886; appliedIndex:885; }","duration":"651.804843ms","start":"2026-07-09T01:32:42.269816Z","end":"2026-07-09T01:32:42.921621Z","steps":["trace[1140915103] 'read index received' (duration: 651.625112ms)","trace[1140915103] 'applied index is now lower than readState.Index' (duration: 178.851µs)"],"step_count":2} {"level":"info","ts":"2026-07-09T01:32:42.921725Z","caller":"traceutil/trace.go:171","msg":"trace[1149687843] transaction","detail":"{read_only:false; response_revision:850; number_of_response:1; }","duration":"1.042328294s","start":"2026-07-09T01:32:41.879384Z","end":"2026-07-09T01:32:42.921712Z","steps":["trace[1149687843] 'process raft request' (duration: 1.042116623s)"],"step_count":1} {"level":"warn","ts":"2026-07-09T01:32:42.921827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"651.991463ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-09T01:32:42.921898Z","caller":"traceutil/trace.go:171","msg":"trace[1927619582] range","detail":"{range_begin:/registry/ingress/; range_end:/registry/ingress0; response_count:0; response_revision:850; }","duration":"652.078664ms","start":"2026-07-09T01:32:42.269802Z","end":"2026-07-09T01:32:42.92188Z","steps":["trace[1927619582] 'agreement among raft nodes before linearized reading' (duration: 651.947073ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T01:32:42.921948Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T01:32:42.269732Z","time spent":"652.206065ms","remote":"127.0.0.1:32788","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":0,"response size":28,"request content":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true "} {"level":"warn","ts":"2026-07-09T01:32:42.92202Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"445.372849ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-07-09T01:32:42.922322Z","caller":"traceutil/trace.go:171","msg":"trace[827846767] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:850; }","duration":"445.7231ms","start":"2026-07-09T01:32:42.476583Z","end":"2026-07-09T01:32:42.922306Z","steps":["trace[827846767] 'agreement among raft nodes before linearized reading' (duration: 445.315479ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T01:32:42.922367Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T01:32:42.476559Z","time spent":"445.797531ms","remote":"127.0.0.1:60992","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-09T01:32:42.922066Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"418.240979ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-09T01:32:42.922495Z","caller":"traceutil/trace.go:171","msg":"trace[1306796644] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:850; }","duration":"418.690961ms","start":"2026-07-09T01:32:42.503788Z","end":"2026-07-09T01:32:42.922479Z","steps":["trace[1306796644] 'agreement among raft nodes before linearized reading' (duration: 418.217239ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T01:32:42.922554Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T01:32:42.50378Z","time spent":"418.762541ms","remote":"127.0.0.1:60740","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-07-09T01:32:42.922138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.87334ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.22\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-07-09T01:32:42.922676Z","caller":"traceutil/trace.go:171","msg":"trace[763975729] range","detail":"{range_begin:/registry/masterleases/199.204.45.22; range_end:; response_count:1; response_revision:850; }","duration":"213.435022ms","start":"2026-07-09T01:32:42.709227Z","end":"2026-07-09T01:32:42.922662Z","steps":["trace[763975729] 'agreement among raft nodes before linearized reading' (duration: 212.848179ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T01:32:42.922235Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"406.571932ms","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-07-09T01:32:42.922792Z","caller":"traceutil/trace.go:171","msg":"trace[1653864963] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:850; }","duration":"407.132254ms","start":"2026-07-09T01:32:42.515638Z","end":"2026-07-09T01:32:42.922771Z","steps":["trace[1653864963] 'agreement among raft nodes before linearized reading' (duration: 406.480482ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T01:32:42.92227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"445.57646ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-07-09T01:32:42.922889Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T01:32:42.515632Z","time spent":"407.242044ms","remote":"127.0.0.1:60992","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-07-09T01:32:42.922904Z","caller":"traceutil/trace.go:171","msg":"trace[529792690] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:850; }","duration":"446.234823ms","start":"2026-07-09T01:32:42.476659Z","end":"2026-07-09T01:32:42.922894Z","steps":["trace[529792690] 'agreement among raft nodes before linearized reading' (duration: 445.51808ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T01:32:42.922964Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T01:32:42.47664Z","time spent":"446.289583ms","remote":"127.0.0.1:60992","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-09T01:32:42.923135Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T01:32:41.879344Z","time spent":"1.04370149s","remote":"127.0.0.1:60926","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4027,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-09T01:32:42.922345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"445.58215ms","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-07-09T01:32:42.923357Z","caller":"traceutil/trace.go:171","msg":"trace[2001325620] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:850; }","duration":"446.623485ms","start":"2026-07-09T01:32:42.476704Z","end":"2026-07-09T01:32:42.923327Z","steps":["trace[2001325620] 'agreement among raft nodes before linearized reading' (duration: 445.38927ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T01:32:42.923479Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T01:32:42.476693Z","time spent":"446.767346ms","remote":"127.0.0.1:60992","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-07-09T01:32:57.304308Z","caller":"traceutil/trace.go:171","msg":"trace[1920143580] linearizableReadLoop","detail":"{readStateIndex:1053; appliedIndex:1052; }","duration":"218.032178ms","start":"2026-07-09T01:32:57.086256Z","end":"2026-07-09T01:32:57.304289Z","steps":["trace[1920143580] 'read index received' (duration: 217.853025ms)","trace[1920143580] 'applied index is now lower than readState.Index' (duration: 178.393µs)"],"step_count":2} {"level":"warn","ts":"2026-07-09T01:32:57.304514Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.238052ms","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-07-09T01:32:57.304546Z","caller":"traceutil/trace.go:171","msg":"trace[1585488360] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1014; }","duration":"218.310074ms","start":"2026-07-09T01:32:57.086227Z","end":"2026-07-09T01:32:57.304537Z","steps":["trace[1585488360] 'agreement among raft nodes before linearized reading' (duration: 218.161221ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T01:32:57.304685Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.288385ms","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-07-09T01:32:57.30474Z","caller":"traceutil/trace.go:171","msg":"trace[2029387564] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1014; }","duration":"199.369376ms","start":"2026-07-09T01:32:57.105357Z","end":"2026-07-09T01:32:57.304727Z","steps":["trace[2029387564] 'agreement among raft nodes before linearized reading' (duration: 199.251364ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T01:32:57.304735Z","caller":"traceutil/trace.go:171","msg":"trace[989447486] transaction","detail":"{read_only:false; response_revision:1014; number_of_response:1; }","duration":"228.920316ms","start":"2026-07-09T01:32:57.075773Z","end":"2026-07-09T01:32:57.304693Z","steps":["trace[989447486] 'process raft request' (duration: 228.406725ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T01:32:57.304839Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.800802ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"} {"level":"warn","ts":"2026-07-09T01:32:57.304768Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.615297ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-07-09T01:32:57.304903Z","caller":"traceutil/trace.go:171","msg":"trace[2122212909] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1014; }","duration":"216.043536ms","start":"2026-07-09T01:32:57.088822Z","end":"2026-07-09T01:32:57.304866Z","steps":["trace[2122212909] 'agreement among raft nodes before linearized reading' (duration: 215.706859ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T01:32:57.304919Z","caller":"traceutil/trace.go:171","msg":"trace[2086229771] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1014; }","duration":"204.75184ms","start":"2026-07-09T01:32:57.100142Z","end":"2026-07-09T01:32:57.304893Z","steps":["trace[2086229771] 'agreement among raft nodes before linearized reading' (duration: 204.552086ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T01:33:01.511782Z","caller":"traceutil/trace.go:171","msg":"trace[1968106415] transaction","detail":"{read_only:false; response_revision:1041; number_of_response:1; }","duration":"107.071218ms","start":"2026-07-09T01:33:01.404689Z","end":"2026-07-09T01:33:01.511761Z","steps":["trace[1968106415] 'process raft request' (duration: 104.283178ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T01:33:39.765251Z","caller":"traceutil/trace.go:171","msg":"trace[353285721] transaction","detail":"{read_only:false; response_revision:1169; number_of_response:1; }","duration":"103.401862ms","start":"2026-07-09T01:33:39.661819Z","end":"2026-07-09T01:33:39.765221Z","steps":["trace[353285721] 'process raft request' (duration: 102.251623ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T01:33:39.765522Z","caller":"traceutil/trace.go:171","msg":"trace[1437710135] transaction","detail":"{read_only:false; response_revision:1170; number_of_response:1; }","duration":"103.566931ms","start":"2026-07-09T01:33:39.661942Z","end":"2026-07-09T01:33:39.765509Z","steps":["trace[1437710135] 'process raft request' (duration: 102.748019ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T01:34:24.389542Z","caller":"traceutil/trace.go:171","msg":"trace[1625268216] transaction","detail":"{read_only:false; response_revision:1336; number_of_response:1; }","duration":"119.584168ms","start":"2026-07-09T01:34:24.269928Z","end":"2026-07-09T01:34:24.389512Z","steps":["trace[1625268216] 'process raft request' (duration: 99.045925ms)","trace[1625268216] 'compare' (duration: 20.401743ms)"],"step_count":2} {"level":"info","ts":"2026-07-09T01:34:28.484851Z","caller":"traceutil/trace.go:171","msg":"trace[2022541055] linearizableReadLoop","detail":"{readStateIndex:1416; appliedIndex:1415; }","duration":"574.025467ms","start":"2026-07-09T01:34:27.910778Z","end":"2026-07-09T01:34:28.484804Z","steps":["trace[2022541055] 'read index received' (duration: 489.812813ms)","trace[2022541055] 'applied index is now lower than readState.Index' (duration: 84.210303ms)"],"step_count":2} {"level":"warn","ts":"2026-07-09T01:34:28.485064Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"574.263224ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-07-09T01:34:28.48513Z","caller":"traceutil/trace.go:171","msg":"trace[912396482] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1355; }","duration":"574.374081ms","start":"2026-07-09T01:34:27.910742Z","end":"2026-07-09T01:34:28.485116Z","steps":["trace[912396482] 'agreement among raft nodes before linearized reading' (duration: 574.167647ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T01:34:28.485163Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T01:34:27.910724Z","time spent":"574.433015ms","remote":"127.0.0.1:60992","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-07-09T01:34:28.495188Z","caller":"traceutil/trace.go:171","msg":"trace[973491493] transaction","detail":"{read_only:false; response_revision:1356; number_of_response:1; }","duration":"285.789679ms","start":"2026-07-09T01:34:28.209379Z","end":"2026-07-09T01:34:28.495169Z","steps":["trace[973491493] 'process raft request' (duration: 285.577314ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T01:34:28.495366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"413.181956ms","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-07-09T01:34:28.495392Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"398.295045ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"} {"level":"warn","ts":"2026-07-09T01:34:28.495281Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"546.694483ms","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-07-09T01:34:28.495446Z","caller":"traceutil/trace.go:171","msg":"trace[601724024] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1357; }","duration":"546.882206ms","start":"2026-07-09T01:34:27.948558Z","end":"2026-07-09T01:34:28.495441Z","steps":["trace[601724024] 'agreement among raft nodes before linearized reading' (duration: 546.564583ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T01:34:28.495459Z","caller":"traceutil/trace.go:171","msg":"trace[30941949] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1357; }","duration":"398.387151ms","start":"2026-07-09T01:34:28.097054Z","end":"2026-07-09T01:34:28.495441Z","steps":["trace[30941949] 'agreement among raft nodes before linearized reading' (duration: 398.22079ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T01:34:28.495474Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T01:34:27.948527Z","time spent":"546.941541ms","remote":"127.0.0.1:60992","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-07-09T01:34:28.495499Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T01:34:28.097043Z","time spent":"398.448935ms","remote":"127.0.0.1:60992","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-07-09T01:34:28.495407Z","caller":"traceutil/trace.go:171","msg":"trace[1918783058] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1357; }","duration":"413.250801ms","start":"2026-07-09T01:34:28.082143Z","end":"2026-07-09T01:34:28.495394Z","steps":["trace[1918783058] 'agreement among raft nodes before linearized reading' (duration: 413.171825ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T01:34:28.4956Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T01:34:28.082124Z","time spent":"413.468695ms","remote":"127.0.0.1:60992","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-07-09T01:34:28.496015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"399.406192ms","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-07-09T01:34:28.496064Z","caller":"traceutil/trace.go:171","msg":"trace[1816075551] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1357; }","duration":"399.506548ms","start":"2026-07-09T01:34:28.096545Z","end":"2026-07-09T01:34:28.496052Z","steps":["trace[1816075551] 'agreement among raft nodes before linearized reading' (duration: 399.130442ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T01:34:28.4961Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T01:34:28.096528Z","time spent":"399.565383ms","remote":"127.0.0.1:60992","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-07-09T01:34:34.810392Z","caller":"traceutil/trace.go:171","msg":"trace[1001760319] transaction","detail":"{read_only:false; response_revision:1386; number_of_response:1; }","duration":"103.376443ms","start":"2026-07-09T01:34:34.706992Z","end":"2026-07-09T01:34:34.810369Z","steps":["trace[1001760319] 'process raft request' (duration: 64.581142ms)","trace[1001760319] 'compare' (duration: 38.680703ms)"],"step_count":2} {"level":"info","ts":"2026-07-09T01:34:36.953819Z","caller":"traceutil/trace.go:171","msg":"trace[1785004067] linearizableReadLoop","detail":"{readStateIndex:1452; appliedIndex:1451; }","duration":"273.635848ms","start":"2026-07-09T01:34:36.680161Z","end":"2026-07-09T01:34:36.953797Z","steps":["trace[1785004067] 'read index received' (duration: 273.539821ms)","trace[1785004067] 'applied index is now lower than readState.Index' (duration: 94.967µs)"],"step_count":2} {"level":"info","ts":"2026-07-09T01:34:36.95392Z","caller":"traceutil/trace.go:171","msg":"trace[1271447988] transaction","detail":"{read_only:false; response_revision:1390; number_of_response:1; }","duration":"381.406917ms","start":"2026-07-09T01:34:36.57248Z","end":"2026-07-09T01:34:36.953887Z","steps":["trace[1271447988] 'process raft request' (duration: 381.170261ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T01:34:36.954022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.850823ms","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-07-09T01:34:36.95405Z","caller":"traceutil/trace.go:171","msg":"trace[1371381537] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1390; }","duration":"273.934799ms","start":"2026-07-09T01:34:36.680107Z","end":"2026-07-09T01:34:36.954042Z","steps":["trace[1371381537] 'agreement among raft nodes before linearized reading' (duration: 273.80828ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T01:34:36.954061Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T01:34:36.572448Z","time spent":"381.538836ms","remote":"127.0.0.1:60992","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-09T01:34:37.092554Z","caller":"traceutil/trace.go:171","msg":"trace[610524545] linearizableReadLoop","detail":"{readStateIndex:1453; appliedIndex:1452; }","duration":"138.640731ms","start":"2026-07-09T01:34:36.953887Z","end":"2026-07-09T01:34:37.092528Z","steps":["trace[610524545] 'read index received' (duration: 98.452777ms)","trace[610524545] 'applied index is now lower than readState.Index' (duration: 40.186244ms)"],"step_count":2} {"level":"info","ts":"2026-07-09T01:34:37.092693Z","caller":"traceutil/trace.go:171","msg":"trace[743721166] transaction","detail":"{read_only:false; response_revision:1391; number_of_response:1; }","duration":"247.972511ms","start":"2026-07-09T01:34:36.844687Z","end":"2026-07-09T01:34:37.092659Z","steps":["trace[743721166] 'process raft request' (duration: 207.482076ms)","trace[743721166] 'compare' (duration: 40.242428ms)"],"step_count":2} {"level":"warn","ts":"2026-07-09T01:34:37.092813Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"401.047741ms","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-07-09T01:34:37.092847Z","caller":"traceutil/trace.go:171","msg":"trace[1737396443] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1391; }","duration":"401.119666ms","start":"2026-07-09T01:34:36.691718Z","end":"2026-07-09T01:34:37.092837Z","steps":["trace[1737396443] 'agreement among raft nodes before linearized reading' (duration: 400.917182ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T01:34:37.092839Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.996966ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-07-09T01:34:37.092881Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T01:34:36.691707Z","time spent":"401.166229ms","remote":"127.0.0.1:60992","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-07-09T01:34:37.092879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"370.905568ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-07-09T01:34:37.09316Z","caller":"traceutil/trace.go:171","msg":"trace[1255625699] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1391; }","duration":"371.215501ms","start":"2026-07-09T01:34:36.721925Z","end":"2026-07-09T01:34:37.09314Z","steps":["trace[1255625699] 'agreement among raft nodes before linearized reading' (duration: 370.761838ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T01:34:37.093268Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T01:34:36.721915Z","time spent":"371.33136ms","remote":"127.0.0.1:60992","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-07-09T01:34:37.092906Z","caller":"traceutil/trace.go:171","msg":"trace[1803077995] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1391; }","duration":"279.095113ms","start":"2026-07-09T01:34:36.813794Z","end":"2026-07-09T01:34:37.092889Z","steps":["trace[1803077995] 'agreement among raft nodes before linearized reading' (duration: 278.869117ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T01:34:37.137794Z","caller":"traceutil/trace.go:171","msg":"trace[2011498071] transaction","detail":"{read_only:false; response_revision:1392; number_of_response:1; }","duration":"179.617122ms","start":"2026-07-09T01:34:36.958149Z","end":"2026-07-09T01:34:37.137766Z","steps":["trace[2011498071] 'process raft request' (duration: 179.466802ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T01:34:39.07359Z","caller":"traceutil/trace.go:171","msg":"trace[1858845365] transaction","detail":"{read_only:false; response_revision:1399; number_of_response:1; }","duration":"111.155689ms","start":"2026-07-09T01:34:38.962409Z","end":"2026-07-09T01:34:39.073564Z","steps":["trace[1858845365] 'process raft request' (duration: 110.985457ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T01:34:39.323378Z","caller":"traceutil/trace.go:171","msg":"trace[1782338738] transaction","detail":"{read_only:false; response_revision:1404; number_of_response:1; }","duration":"166.393539ms","start":"2026-07-09T01:34:39.156962Z","end":"2026-07-09T01:34:39.323356Z","steps":["trace[1782338738] 'process raft request' (duration: 166.288761ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T01:34:39.323378Z","caller":"traceutil/trace.go:171","msg":"trace[828862044] transaction","detail":"{read_only:false; response_revision:1403; number_of_response:1; }","duration":"166.587213ms","start":"2026-07-09T01:34:39.15676Z","end":"2026-07-09T01:34:39.323347Z","steps":["trace[828862044] 'process raft request' (duration: 146.915333ms)","trace[828862044] 'compare' (duration: 19.191605ms)"],"step_count":2}