{"level":"warn","ts":"2026-08-14T23:12:32.081205Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-14T23:12:32.081343Z","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-08-14T23:12:32.081429Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-14T23:12:32.08146Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.22:2380"]} {"level":"info","ts":"2026-08-14T23:12:32.08155Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-08-14T23:12:32.086468Z","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-08-14T23:12:32.086865Z","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-08-14T23:12:32.090763Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.474724ms"} {"level":"info","ts":"2026-08-14T23:12:32.104366Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"fed19d9291630e09","cluster-id":"6ebf1e01320cc017"} {"level":"info","ts":"2026-08-14T23:12:32.104482Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 switched to configuration voters=()"} {"level":"info","ts":"2026-08-14T23:12:32.104518Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 became follower at term 0"} {"level":"info","ts":"2026-08-14T23:12:32.104538Z","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-08-14T23:12:32.104556Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 became follower at term 1"} {"level":"info","ts":"2026-08-14T23:12:32.104642Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 switched to configuration voters=(18361630408596196873)"} {"level":"warn","ts":"2026-08-14T23:12:32.116246Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-14T23:12:32.120614Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-14T23:12:32.121824Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-08-14T23:12:32.126195Z","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-08-14T23:12:32.12668Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-08-14T23:12:32.126768Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-08-14T23:12:32.126784Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-08-14T23:12:32.126853Z","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-08-14T23:12:32.127728Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 switched to configuration voters=(18361630408596196873)"} {"level":"info","ts":"2026-08-14T23:12:32.129734Z","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-08-14T23:12:32.132057Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-08-14T23:12:32.132313Z","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-08-14T23:12:32.132354Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-14T23:12:32.132412Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.22:2380"} {"level":"info","ts":"2026-08-14T23:12:32.132439Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.22:2380"} {"level":"info","ts":"2026-08-14T23:12:32.20531Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 is starting a new election at term 1"} {"level":"info","ts":"2026-08-14T23:12:32.205392Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 became pre-candidate at term 1"} {"level":"info","ts":"2026-08-14T23:12:32.205432Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 received MsgPreVoteResp from fed19d9291630e09 at term 1"} {"level":"info","ts":"2026-08-14T23:12:32.205472Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 became candidate at term 2"} {"level":"info","ts":"2026-08-14T23:12:32.2055Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 received MsgVoteResp from fed19d9291630e09 at term 2"} {"level":"info","ts":"2026-08-14T23:12:32.205527Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 became leader at term 2"} {"level":"info","ts":"2026-08-14T23:12:32.20555Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: fed19d9291630e09 elected leader fed19d9291630e09 at term 2"} {"level":"info","ts":"2026-08-14T23:12:32.206572Z","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-08-14T23:12:32.206634Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-14T23:12:32.206932Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-14T23:12:32.206968Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-14T23:12:32.206714Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-14T23:12:32.206675Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-14T23:12:32.20937Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-08-14T23:12:32.210577Z","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-08-14T23:12:32.210693Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-14T23:12:32.210757Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-08-14T23:12:32.213323Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.22:2379"} {"level":"warn","ts":"2026-08-14T23:12:34.52243Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1011515524127615094,"retry-timeout":"500ms"} {"level":"info","ts":"2026-08-14T23:12:34.581836Z","caller":"traceutil/trace.go:171","msg":"trace[32457831] transaction","detail":"{read_only:false; response_revision:2; number_of_response:1; }","duration":"560.131219ms","start":"2026-08-14T23:12:34.021677Z","end":"2026-08-14T23:12:34.581809Z","steps":["trace[32457831] 'process raft request' (duration: 559.923334ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:12:34.582397Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:12:34.021664Z","time spent":"560.255592ms","remote":"127.0.0.1:40950","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":105,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-14T23:12:35.491606Z","caller":"traceutil/trace.go:171","msg":"trace[1815290955] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"1.392605881s","start":"2026-08-14T23:12:34.098957Z","end":"2026-08-14T23:12:35.491562Z","steps":["trace[1815290955] 'process raft request' (duration: 1.392334374s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:12:35.491807Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:12:34.098927Z","time spent":"1.392788005s","remote":"127.0.0.1:41422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":920,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-14T23:12:35.491927Z","caller":"traceutil/trace.go:171","msg":"trace[1219231238] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"1.392789236s","start":"2026-08-14T23:12:34.099113Z","end":"2026-08-14T23:12:35.491902Z","steps":["trace[1219231238] 'process raft request' (duration: 1.392342745s)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:12:35.492006Z","caller":"traceutil/trace.go:171","msg":"trace[526594382] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"1.392283743s","start":"2026-08-14T23:12:34.099714Z","end":"2026-08-14T23:12:35.491998Z","steps":["trace[526594382] 'process raft request' (duration: 1.391900394s)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:12:35.491999Z","caller":"traceutil/trace.go:171","msg":"trace[678817732] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"1.392285474s","start":"2026-08-14T23:12:34.09966Z","end":"2026-08-14T23:12:35.491946Z","steps":["trace[678817732] 'process raft request' (duration: 1.391912505s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:12:35.49207Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:12:34.099085Z","time spent":"1.392924488s","remote":"127.0.0.1:41422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":971,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-14T23:12:35.492119Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:12:34.099663Z","time spent":"1.392383056s","remote":"127.0.0.1:41310","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":698,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-14T23:12:35.491942Z","caller":"traceutil/trace.go:171","msg":"trace[1524443487] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"1.383129343s","start":"2026-08-14T23:12:34.108765Z","end":"2026-08-14T23:12:35.491894Z","steps":["trace[1524443487] 'process raft request' (duration: 1.382881898s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:12:35.492162Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:12:34.099589Z","time spent":"1.392482178s","remote":"127.0.0.1:41422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":992,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-14T23:12:35.492165Z","caller":"traceutil/trace.go:171","msg":"trace[267680848] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"1.392666413s","start":"2026-08-14T23:12:34.099485Z","end":"2026-08-14T23:12:35.492151Z","steps":["trace[267680848] 'process raft request' (duration: 1.392015607s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:12:35.49223Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:12:34.108755Z","time spent":"1.383453931s","remote":"127.0.0.1:41048","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3158,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-14T23:12:35.492255Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:12:34.099473Z","time spent":"1.392756644s","remote":"127.0.0.1:41422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":883,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-14T23:12:35.492312Z","caller":"traceutil/trace.go:171","msg":"trace[787186999] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"1.378803659s","start":"2026-08-14T23:12:34.113496Z","end":"2026-08-14T23:12:35.4923Z","steps":["trace[787186999] 'process raft request' (duration: 1.378230375s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:12:35.492367Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:12:34.113486Z","time spent":"1.378851411s","remote":"127.0.0.1:41104","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":845,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-14T23:12:35.492413Z","caller":"traceutil/trace.go:171","msg":"trace[1991905838] linearizableReadLoop","detail":"{readStateIndex:13; appliedIndex:4; }","duration":"1.470570825s","start":"2026-08-14T23:12:34.02181Z","end":"2026-08-14T23:12:35.492381Z","steps":["trace[1991905838] 'read index received' (duration: 559.892994ms)","trace[1991905838] 'applied index is now lower than readState.Index' (duration: 910.676441ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T23:12:35.492623Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"494.986394ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/system-node-critical\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-08-14T23:12:35.492662Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.470750149s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-08-14T23:12:35.492629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.47078885s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3170"} {"level":"info","ts":"2026-08-14T23:12:35.492691Z","caller":"traceutil/trace.go:171","msg":"trace[887137406] range","detail":"{range_begin:/registry/priorityclasses/system-node-critical; range_end:; response_count:0; response_revision:10; }","duration":"495.081046ms","start":"2026-08-14T23:12:34.997599Z","end":"2026-08-14T23:12:35.49268Z","steps":["trace[887137406] 'agreement among raft nodes before linearized reading' (duration: 494.994594ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:12:35.492724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.393934923s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-14T23:12:35.492727Z","caller":"traceutil/trace.go:171","msg":"trace[1814035897] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:0; response_revision:10; }","duration":"1.470855631s","start":"2026-08-14T23:12:34.021836Z","end":"2026-08-14T23:12:35.492692Z","steps":["trace[1814035897] 'agreement among raft nodes before linearized reading' (duration: 1.470723738s)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:12:35.492735Z","caller":"traceutil/trace.go:171","msg":"trace[356060114] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:10; }","duration":"1.470920683s","start":"2026-08-14T23:12:34.02179Z","end":"2026-08-14T23:12:35.492711Z","steps":["trace[356060114] 'agreement among raft nodes before linearized reading' (duration: 1.470662407s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:12:35.492763Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:12:34.0216Z","time spent":"1.471154299s","remote":"127.0.0.1:40946","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":0,"response size":27,"request content":"key:\"/registry/ranges/serviceips\" "} {"level":"info","ts":"2026-08-14T23:12:35.492754Z","caller":"traceutil/trace.go:171","msg":"trace[1069846340] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"1.393976625s","start":"2026-08-14T23:12:34.098767Z","end":"2026-08-14T23:12:35.492743Z","steps":["trace[1069846340] 'agreement among raft nodes before linearized reading' (duration: 1.393943964s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:12:35.492772Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"495.023854ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-08-14T23:12:35.492783Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:12:34.021777Z","time spent":"1.470997744s","remote":"127.0.0.1:41048","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":3193,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-08-14T23:12:35.492792Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:12:34.09876Z","time spent":"1.394025476s","remote":"127.0.0.1:40986","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-08-14T23:12:35.492811Z","caller":"traceutil/trace.go:171","msg":"trace[628096508] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:10; }","duration":"495.112427ms","start":"2026-08-14T23:12:34.997686Z","end":"2026-08-14T23:12:35.492799Z","steps":["trace[628096508] 'agreement among raft nodes before linearized reading' (duration: 495.065336ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:12:35.492838Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:12:34.997661Z","time spent":"495.170328ms","remote":"127.0.0.1:41212","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":27,"request content":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" "} {"level":"warn","ts":"2026-08-14T23:12:35.492694Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.342486517s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-08-14T23:12:35.492938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.395825238s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.22\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-08-14T23:12:35.492634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.393928533s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-14T23:12:35.49297Z","caller":"traceutil/trace.go:171","msg":"trace[1028869711] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:10; }","duration":"1.394302653s","start":"2026-08-14T23:12:34.098656Z","end":"2026-08-14T23:12:35.492959Z","steps":["trace[1028869711] 'agreement among raft nodes before linearized reading' (duration: 1.393929544s)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:12:35.492963Z","caller":"traceutil/trace.go:171","msg":"trace[2084952969] range","detail":"{range_begin:/registry/masterleases/199.204.45.22; range_end:; response_count:0; response_revision:10; }","duration":"1.39588395s","start":"2026-08-14T23:12:34.097071Z","end":"2026-08-14T23:12:35.492955Z","steps":["trace[2084952969] 'agreement among raft nodes before linearized reading' (duration: 1.395840169s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:12:35.492999Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:12:34.097053Z","time spent":"1.395941222s","remote":"127.0.0.1:40938","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":0,"response size":27,"request content":"key:\"/registry/masterleases/199.204.45.22\" "} {"level":"warn","ts":"2026-08-14T23:12:35.493001Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:12:34.098641Z","time spent":"1.394351044s","remote":"127.0.0.1:40966","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":27,"request content":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" "} {"level":"warn","ts":"2026-08-14T23:12:35.493059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.421804242s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-14T23:12:35.493086Z","caller":"traceutil/trace.go:171","msg":"trace[1653384018] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"1.421853114s","start":"2026-08-14T23:12:34.071225Z","end":"2026-08-14T23:12:35.493078Z","steps":["trace[1653384018] 'agreement among raft nodes before linearized reading' (duration: 1.421811013s)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:12:35.492934Z","caller":"traceutil/trace.go:171","msg":"trace[1689237764] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"1.342764124s","start":"2026-08-14T23:12:34.150159Z","end":"2026-08-14T23:12:35.492923Z","steps":["trace[1689237764] 'agreement among raft nodes before linearized reading' (duration: 1.342517388s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:12:35.492724Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:12:34.997579Z","time spent":"495.138547ms","remote":"127.0.0.1:41236","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":0,"response size":27,"request content":"key:\"/registry/priorityclasses/system-node-critical\" "} {"level":"warn","ts":"2026-08-14T23:12:35.493121Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:12:34.150134Z","time spent":"1.342979458s","remote":"127.0.0.1:40986","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-08-14T23:12:35.493125Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:12:34.071211Z","time spent":"1.421898394s","remote":"127.0.0.1:40986","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-08-14T23:12:35.493153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.471270501s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3170"} {"level":"info","ts":"2026-08-14T23:12:35.493179Z","caller":"traceutil/trace.go:171","msg":"trace[1753205521] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:10; }","duration":"1.471323973s","start":"2026-08-14T23:12:34.021848Z","end":"2026-08-14T23:12:35.493172Z","steps":["trace[1753205521] 'agreement among raft nodes before linearized reading' (duration: 1.471258551s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:12:35.493195Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:12:34.021826Z","time spent":"1.471365293s","remote":"127.0.0.1:41048","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":3193,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-08-14T23:12:35.493206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.419546998s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-14T23:12:35.493232Z","caller":"traceutil/trace.go:171","msg":"trace[923163899] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"1.41960583s","start":"2026-08-14T23:12:34.073618Z","end":"2026-08-14T23:12:35.493224Z","steps":["trace[923163899] 'agreement among raft nodes before linearized reading' (duration: 1.419571369s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:12:35.493255Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:12:34.0736Z","time spent":"1.419650501s","remote":"127.0.0.1:40986","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-08-14T23:12:35.493432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.419912348s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-14T23:12:35.493467Z","caller":"traceutil/trace.go:171","msg":"trace[707725915] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"1.392312204s","start":"2026-08-14T23:12:34.099533Z","end":"2026-08-14T23:12:35.491845Z","steps":["trace[707725915] 'process raft request' (duration: 1.392010837s)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:12:35.493495Z","caller":"traceutil/trace.go:171","msg":"trace[2057851845] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"1.419983639s","start":"2026-08-14T23:12:34.0735Z","end":"2026-08-14T23:12:35.493484Z","steps":["trace[2057851845] 'agreement among raft nodes before linearized reading' (duration: 1.419904607s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:12:35.493524Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:12:34.073494Z","time spent":"1.42002402s","remote":"127.0.0.1:40986","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-08-14T23:12:35.493537Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:12:34.099518Z","time spent":"1.393984684s","remote":"127.0.0.1:41422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-14T23:12:37.166826Z","caller":"traceutil/trace.go:171","msg":"trace[1516873464] linearizableReadLoop","detail":"{readStateIndex:223; appliedIndex:222; }","duration":"116.167832ms","start":"2026-08-14T23:12:37.050626Z","end":"2026-08-14T23:12:37.166794Z","steps":["trace[1516873464] 'read index received' (duration: 30.873962ms)","trace[1516873464] 'applied index is now lower than readState.Index' (duration: 85.29232ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T23:12:37.166939Z","caller":"traceutil/trace.go:171","msg":"trace[63146910] transaction","detail":"{read_only:false; response_revision:217; number_of_response:1; }","duration":"124.141263ms","start":"2026-08-14T23:12:37.042763Z","end":"2026-08-14T23:12:37.166905Z","steps":["trace[63146910] 'process raft request' (duration: 38.799852ms)","trace[63146910] 'compare' (duration: 85.072985ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T23:12:37.167233Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.414678ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-08-14T23:12:37.167354Z","caller":"traceutil/trace.go:171","msg":"trace[1098290734] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:217; }","duration":"116.754596ms","start":"2026-08-14T23:12:37.050582Z","end":"2026-08-14T23:12:37.167337Z","steps":["trace[1098290734] 'agreement among raft nodes before linearized reading' (duration: 116.343966ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:12:37.533245Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.887332ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-08-14T23:12:37.533517Z","caller":"traceutil/trace.go:171","msg":"trace[413501649] transaction","detail":"{read_only:false; response_revision:222; number_of_response:1; }","duration":"281.824172ms","start":"2026-08-14T23:12:37.251673Z","end":"2026-08-14T23:12:37.533497Z","steps":["trace[413501649] 'process raft request' (duration: 281.713198ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:12:37.53354Z","caller":"traceutil/trace.go:171","msg":"trace[1886817478] transaction","detail":"{read_only:false; response_revision:221; number_of_response:1; }","duration":"291.634689ms","start":"2026-08-14T23:12:37.241868Z","end":"2026-08-14T23:12:37.533503Z","steps":["trace[1886817478] 'process raft request' (duration: 158.235193ms)","trace[1886817478] 'compare' (duration: 132.735029ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T23:12:41.975833Z","caller":"traceutil/trace.go:171","msg":"trace[2128599037] linearizableReadLoop","detail":"{readStateIndex:321; appliedIndex:320; }","duration":"273.718006ms","start":"2026-08-14T23:12:41.702091Z","end":"2026-08-14T23:12:41.975809Z","steps":["trace[2128599037] 'read index received' (duration: 273.590223ms)","trace[2128599037] 'applied index is now lower than readState.Index' (duration: 126.813µs)"],"step_count":2} {"level":"info","ts":"2026-08-14T23:12:41.975893Z","caller":"traceutil/trace.go:171","msg":"trace[976996147] transaction","detail":"{read_only:false; response_revision:310; number_of_response:1; }","duration":"314.203559ms","start":"2026-08-14T23:12:41.661646Z","end":"2026-08-14T23:12:41.97585Z","steps":["trace[976996147] 'process raft request' (duration: 314.035095ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:12:41.976029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.931891ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" ","response":"range_response_count:1 size:218"} {"level":"info","ts":"2026-08-14T23:12:41.976109Z","caller":"traceutil/trace.go:171","msg":"trace[1343599891] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/service-account-controller; range_end:; response_count:1; response_revision:310; }","duration":"274.060404ms","start":"2026-08-14T23:12:41.702026Z","end":"2026-08-14T23:12:41.976087Z","steps":["trace[1343599891] 'agreement among raft nodes before linearized reading' (duration: 273.920671ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:12:41.976365Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.146316ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" ","response":"range_response_count:1 size:193"} {"level":"warn","ts":"2026-08-14T23:12:41.976522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.32507ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-08-14T23:12:41.976609Z","caller":"traceutil/trace.go:171","msg":"trace[1889135404] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:1; response_revision:310; }","duration":"174.438182ms","start":"2026-08-14T23:12:41.802151Z","end":"2026-08-14T23:12:41.976589Z","steps":["trace[1889135404] 'agreement among raft nodes before linearized reading' (duration: 174.302389ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:12:41.976603Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:12:41.661629Z","time spent":"314.350483ms","remote":"127.0.0.1:40952","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":649,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-14T23:12:41.976706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.399193ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" ","response":"range_response_count:1 size:197"} {"level":"info","ts":"2026-08-14T23:12:41.976851Z","caller":"traceutil/trace.go:171","msg":"trace[223394961] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/bootstrap-signer; range_end:; response_count:1; response_revision:310; }","duration":"125.642619ms","start":"2026-08-14T23:12:41.851177Z","end":"2026-08-14T23:12:41.97682Z","steps":["trace[223394961] 'agreement among raft nodes before linearized reading' (duration: 125.25835ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:12:41.97679Z","caller":"traceutil/trace.go:171","msg":"trace[678881733] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-controller; range_end:; response_count:1; response_revision:310; }","duration":"224.2789ms","start":"2026-08-14T23:12:41.75214Z","end":"2026-08-14T23:12:41.976419Z","steps":["trace[678881733] 'agreement among raft nodes before linearized reading' (duration: 224.117155ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:12:42.205397Z","caller":"traceutil/trace.go:171","msg":"trace[2082037563] transaction","detail":"{read_only:false; response_revision:311; number_of_response:1; }","duration":"220.499928ms","start":"2026-08-14T23:12:41.984842Z","end":"2026-08-14T23:12:42.205342Z","steps":["trace[2082037563] 'process raft request' (duration: 157.168907ms)","trace[2082037563] 'compare' (duration: 63.168227ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T23:12:42.232061Z","caller":"traceutil/trace.go:171","msg":"trace[1690497135] transaction","detail":"{read_only:false; response_revision:312; number_of_response:1; }","duration":"246.919042ms","start":"2026-08-14T23:12:41.985116Z","end":"2026-08-14T23:12:42.232035Z","steps":["trace[1690497135] 'process raft request' (duration: 246.726358ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:12:42.232484Z","caller":"traceutil/trace.go:171","msg":"trace[1885860798] transaction","detail":"{read_only:false; response_revision:313; number_of_response:1; }","duration":"246.647876ms","start":"2026-08-14T23:12:41.985823Z","end":"2026-08-14T23:12:42.232471Z","steps":["trace[1885860798] 'process raft request' (duration: 246.159634ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:12:42.232781Z","caller":"traceutil/trace.go:171","msg":"trace[1149087011] transaction","detail":"{read_only:false; response_revision:314; number_of_response:1; }","duration":"246.38425ms","start":"2026-08-14T23:12:41.986357Z","end":"2026-08-14T23:12:42.232741Z","steps":["trace[1149087011] 'process raft request' (duration: 245.96842ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:12:42.233486Z","caller":"traceutil/trace.go:171","msg":"trace[907483872] transaction","detail":"{read_only:false; response_revision:315; number_of_response:1; }","duration":"247.419164ms","start":"2026-08-14T23:12:41.986042Z","end":"2026-08-14T23:12:42.233462Z","steps":["trace[907483872] 'process raft request' (duration: 246.535583ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:12:42.233515Z","caller":"traceutil/trace.go:171","msg":"trace[646556844] transaction","detail":"{read_only:false; response_revision:317; number_of_response:1; }","duration":"246.303508ms","start":"2026-08-14T23:12:41.987191Z","end":"2026-08-14T23:12:42.233494Z","steps":["trace[646556844] 'process raft request' (duration: 246.227916ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:12:42.234033Z","caller":"traceutil/trace.go:171","msg":"trace[1085238319] transaction","detail":"{read_only:false; response_revision:316; number_of_response:1; }","duration":"246.961243ms","start":"2026-08-14T23:12:41.987058Z","end":"2026-08-14T23:12:42.234019Z","steps":["trace[1085238319] 'process raft request' (duration: 246.286877ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:12:42.234334Z","caller":"traceutil/trace.go:171","msg":"trace[1239385799] transaction","detail":"{read_only:false; response_revision:318; number_of_response:1; }","duration":"246.083513ms","start":"2026-08-14T23:12:41.988234Z","end":"2026-08-14T23:12:42.234318Z","steps":["trace[1239385799] 'process raft request' (duration: 245.229281ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:12:42.348131Z","caller":"traceutil/trace.go:171","msg":"trace[725850033] transaction","detail":"{read_only:false; response_revision:322; number_of_response:1; }","duration":"106.259204ms","start":"2026-08-14T23:12:42.241798Z","end":"2026-08-14T23:12:42.348058Z","steps":["trace[725850033] 'process raft request' (duration: 106.148221ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:12:42.348326Z","caller":"traceutil/trace.go:171","msg":"trace[1451751650] transaction","detail":"{read_only:false; response_revision:323; number_of_response:1; }","duration":"105.417922ms","start":"2026-08-14T23:12:42.242878Z","end":"2026-08-14T23:12:42.348296Z","steps":["trace[1451751650] 'process raft request' (duration: 105.103715ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:12:42.348355Z","caller":"traceutil/trace.go:171","msg":"trace[214307312] transaction","detail":"{read_only:false; response_revision:324; number_of_response:1; }","duration":"105.358981ms","start":"2026-08-14T23:12:42.24297Z","end":"2026-08-14T23:12:42.348329Z","steps":["trace[214307312] 'process raft request' (duration: 105.051764ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:12:42.348401Z","caller":"traceutil/trace.go:171","msg":"trace[1978098180] transaction","detail":"{read_only:false; response_revision:325; number_of_response:1; }","duration":"104.822468ms","start":"2026-08-14T23:12:42.243562Z","end":"2026-08-14T23:12:42.348385Z","steps":["trace[1978098180] 'process raft request' (duration: 104.500911ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:12:42.348522Z","caller":"traceutil/trace.go:171","msg":"trace[1845731883] transaction","detail":"{read_only:false; response_revision:326; number_of_response:1; }","duration":"104.270405ms","start":"2026-08-14T23:12:42.24424Z","end":"2026-08-14T23:12:42.34851Z","steps":["trace[1845731883] 'process raft request' (duration: 103.868276ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:12:42.348875Z","caller":"traceutil/trace.go:171","msg":"trace[1751495518] transaction","detail":"{read_only:false; response_revision:321; number_of_response:1; }","duration":"107.113524ms","start":"2026-08-14T23:12:42.241746Z","end":"2026-08-14T23:12:42.348859Z","steps":["trace[1751495518] 'process raft request' (duration: 105.480345ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:12:46.521888Z","caller":"traceutil/trace.go:171","msg":"trace[15983132] transaction","detail":"{read_only:false; response_revision:357; number_of_response:1; }","duration":"140.708551ms","start":"2026-08-14T23:12:46.381157Z","end":"2026-08-14T23:12:46.521865Z","steps":["trace[15983132] 'process raft request' (duration: 49.49266ms)","trace[15983132] 'compare' (duration: 90.981245ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T23:12:46.521887Z","caller":"traceutil/trace.go:171","msg":"trace[1309990028] transaction","detail":"{read_only:false; response_revision:358; number_of_response:1; }","duration":"137.879953ms","start":"2026-08-14T23:12:46.383987Z","end":"2026-08-14T23:12:46.521867Z","steps":["trace[1309990028] 'process raft request' (duration: 137.821552ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:12:46.730852Z","caller":"traceutil/trace.go:171","msg":"trace[1187580653] transaction","detail":"{read_only:false; response_revision:359; number_of_response:1; }","duration":"137.304779ms","start":"2026-08-14T23:12:46.59352Z","end":"2026-08-14T23:12:46.730825Z","steps":["trace[1187580653] 'process raft request' (duration: 96.849387ms)","trace[1187580653] 'compare' (duration: 40.225857ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T23:12:46.858769Z","caller":"traceutil/trace.go:171","msg":"trace[1555780556] transaction","detail":"{read_only:false; response_revision:361; number_of_response:1; }","duration":"121.891758ms","start":"2026-08-14T23:12:46.736855Z","end":"2026-08-14T23:12:46.858747Z","steps":["trace[1555780556] 'process raft request' (duration: 111.796976ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:12:49.017887Z","caller":"traceutil/trace.go:171","msg":"trace[1880215175] transaction","detail":"{read_only:false; response_revision:366; number_of_response:1; }","duration":"152.018862ms","start":"2026-08-14T23:12:48.865843Z","end":"2026-08-14T23:12:49.017862Z","steps":["trace[1880215175] 'process raft request' (duration: 85.063073ms)","trace[1880215175] 'compare' (duration: 66.857547ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T23:12:49.024617Z","caller":"traceutil/trace.go:171","msg":"trace[1309519029] transaction","detail":"{read_only:false; response_revision:367; number_of_response:1; }","duration":"157.978745ms","start":"2026-08-14T23:12:48.866614Z","end":"2026-08-14T23:12:49.024593Z","steps":["trace[1309519029] 'process raft request' (duration: 157.810421ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:12:49.024811Z","caller":"traceutil/trace.go:171","msg":"trace[547984193] transaction","detail":"{read_only:false; response_revision:368; number_of_response:1; }","duration":"140.680951ms","start":"2026-08-14T23:12:48.884103Z","end":"2026-08-14T23:12:49.024784Z","steps":["trace[547984193] 'process raft request' (duration: 140.447894ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:13:09.121157Z","caller":"traceutil/trace.go:171","msg":"trace[863082675] transaction","detail":"{read_only:false; response_revision:448; number_of_response:1; }","duration":"134.294937ms","start":"2026-08-14T23:13:08.986828Z","end":"2026-08-14T23:13:09.121123Z","steps":["trace[863082675] 'process raft request' (duration: 78.809303ms)","trace[863082675] 'compare' (duration: 55.386291ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T23:13:12.519833Z","caller":"traceutil/trace.go:171","msg":"trace[929956407] transaction","detail":"{read_only:false; response_revision:458; number_of_response:1; }","duration":"142.591966ms","start":"2026-08-14T23:13:12.377216Z","end":"2026-08-14T23:13:12.519808Z","steps":["trace[929956407] 'process raft request' (duration: 135.430323ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:13:14.914666Z","caller":"traceutil/trace.go:171","msg":"trace[1857646567] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"587.445214ms","start":"2026-08-14T23:13:14.327194Z","end":"2026-08-14T23:13:14.914639Z","steps":["trace[1857646567] 'process raft request' (duration: 587.26145ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:13:14.914833Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:13:14.327169Z","time spent":"587.600017ms","remote":"127.0.0.1:40942","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-14T23:13:14.928232Z","caller":"traceutil/trace.go:171","msg":"trace[1187361394] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"600.477958ms","start":"2026-08-14T23:13:14.327737Z","end":"2026-08-14T23:13:14.928215Z","steps":["trace[1187361394] 'process raft request' (duration: 600.265973ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:13:14.928282Z","caller":"traceutil/trace.go:171","msg":"trace[365361498] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"593.250204ms","start":"2026-08-14T23:13:14.334994Z","end":"2026-08-14T23:13:14.928244Z","steps":["trace[365361498] 'process raft request' (duration: 593.124061ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:13:14.928343Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:13:14.327716Z","time spent":"600.57494ms","remote":"127.0.0.1:40942","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-14T23:13:14.92834Z","caller":"traceutil/trace.go:171","msg":"trace[1637548386] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"593.261345ms","start":"2026-08-14T23:13:14.33503Z","end":"2026-08-14T23:13:14.928291Z","steps":["trace[1637548386] 'process raft request' (duration: 593.126611ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:13:14.928436Z","caller":"traceutil/trace.go:171","msg":"trace[1309692748] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"589.414633ms","start":"2026-08-14T23:13:14.339Z","end":"2026-08-14T23:13:14.928415Z","steps":["trace[1309692748] 'process raft request' (duration: 589.184587ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:13:14.928517Z","caller":"traceutil/trace.go:171","msg":"trace[799842343] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"589.456593ms","start":"2026-08-14T23:13:14.339049Z","end":"2026-08-14T23:13:14.928506Z","steps":["trace[799842343] 'process raft request' (duration: 589.262318ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:13:14.928532Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:13:14.33899Z","time spent":"589.497614ms","remote":"127.0.0.1:40942","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-14T23:13:14.928564Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:13:14.339046Z","time spent":"589.499234ms","remote":"127.0.0.1:40942","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-14T23:13:14.928677Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:13:14.335027Z","time spent":"593.433509ms","remote":"127.0.0.1:40942","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-14T23:13:14.928406Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:13:14.334985Z","time spent":"593.356317ms","remote":"127.0.0.1:40942","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-14T23:13:14.928863Z","caller":"traceutil/trace.go:171","msg":"trace[577152889] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"586.311848ms","start":"2026-08-14T23:13:14.342542Z","end":"2026-08-14T23:13:14.928854Z","steps":["trace[577152889] 'process raft request' (duration: 586.179315ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:13:14.928904Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:13:14.342535Z","time spent":"586.351609ms","remote":"127.0.0.1:40942","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-14T23:13:14.928962Z","caller":"traceutil/trace.go:171","msg":"trace[304633844] transaction","detail":"{read_only:false; response_revision:500; number_of_response:1; }","duration":"586.359479ms","start":"2026-08-14T23:13:14.342581Z","end":"2026-08-14T23:13:14.92894Z","steps":["trace[304633844] 'process raft request' (duration: 586.217096ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:13:14.929033Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:13:14.342577Z","time spent":"586.425991ms","remote":"127.0.0.1:40942","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-14T23:13:14.929125Z","caller":"traceutil/trace.go:171","msg":"trace[481124156] transaction","detail":"{read_only:false; response_revision:501; number_of_response:1; }","duration":"578.319776ms","start":"2026-08-14T23:13:14.350795Z","end":"2026-08-14T23:13:14.929114Z","steps":["trace[481124156] 'process raft request' (duration: 578.063719ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:13:14.929172Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:13:14.350775Z","time spent":"578.378558ms","remote":"127.0.0.1:40942","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-14T23:13:14.929231Z","caller":"traceutil/trace.go:171","msg":"trace[2037453194] transaction","detail":"{read_only:false; response_revision:502; number_of_response:1; }","duration":"575.55586ms","start":"2026-08-14T23:13:14.353665Z","end":"2026-08-14T23:13:14.929221Z","steps":["trace[2037453194] 'process raft request' (duration: 575.265332ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:13:14.929277Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:13:14.353648Z","time spent":"575.607681ms","remote":"127.0.0.1:40942","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-14T23:13:14.929575Z","caller":"traceutil/trace.go:171","msg":"trace[1567307997] transaction","detail":"{read_only:false; response_revision:503; number_of_response:1; }","duration":"539.235388ms","start":"2026-08-14T23:13:14.390321Z","end":"2026-08-14T23:13:14.929557Z","steps":["trace[1567307997] 'process raft request' (duration: 539.056063ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:13:14.929641Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:13:14.390302Z","time spent":"539.305069ms","remote":"127.0.0.1:40942","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-14T23:13:14.929977Z","caller":"traceutil/trace.go:171","msg":"trace[1884460520] linearizableReadLoop","detail":"{readStateIndex:524; appliedIndex:512; }","duration":"279.494226ms","start":"2026-08-14T23:13:14.650471Z","end":"2026-08-14T23:13:14.929966Z","steps":["trace[1884460520] 'read index received' (duration: 264.099716ms)","trace[1884460520] 'applied index is now lower than readState.Index' (duration: 15.39387ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T23:13:14.93008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.611709ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-08-14T23:13:14.930086Z","caller":"traceutil/trace.go:171","msg":"trace[326880993] transaction","detail":"{read_only:false; response_revision:504; number_of_response:1; }","duration":"436.404296ms","start":"2026-08-14T23:13:14.49367Z","end":"2026-08-14T23:13:14.930074Z","steps":["trace[326880993] 'process raft request' (duration: 436.135499ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:13:14.930105Z","caller":"traceutil/trace.go:171","msg":"trace[1668510875] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:504; }","duration":"279.67515ms","start":"2026-08-14T23:13:14.650423Z","end":"2026-08-14T23:13:14.930099Z","steps":["trace[1668510875] 'agreement among raft nodes before linearized reading' (duration: 279.583688ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:13:14.930136Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:13:14.493652Z","time spent":"436.461678ms","remote":"127.0.0.1:40942","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-14T23:13:18.008109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.905169ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T23:13:18.008201Z","caller":"traceutil/trace.go:171","msg":"trace[1658969559] range","detail":"{range_begin:/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:581; }","duration":"102.042053ms","start":"2026-08-14T23:13:17.90614Z","end":"2026-08-14T23:13:18.008182Z","steps":["trace[1658969559] 'range keys from in-memory index tree' (duration: 101.844828ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:13:19.631836Z","caller":"traceutil/trace.go:171","msg":"trace[16595681] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"329.966678ms","start":"2026-08-14T23:13:19.301848Z","end":"2026-08-14T23:13:19.631814Z","steps":["trace[16595681] 'process raft request' (duration: 329.828485ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:13:19.631985Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:13:19.301827Z","time spent":"330.084752ms","remote":"127.0.0.1:41108","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-14T23:13:19.639217Z","caller":"traceutil/trace.go:171","msg":"trace[1120385087] linearizableReadLoop","detail":"{readStateIndex:615; appliedIndex:613; }","duration":"135.819194ms","start":"2026-08-14T23:13:19.503376Z","end":"2026-08-14T23:13:19.639195Z","steps":["trace[1120385087] 'read index received' (duration: 129.042321ms)","trace[1120385087] 'applied index is now lower than readState.Index' (duration: 6.776113ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T23:13:19.639409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.025569ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-08-14T23:13:19.63944Z","caller":"traceutil/trace.go:171","msg":"trace[1088598231] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:590; }","duration":"136.103961ms","start":"2026-08-14T23:13:19.503326Z","end":"2026-08-14T23:13:19.63943Z","steps":["trace[1088598231] 'agreement among raft nodes before linearized reading' (duration: 135.946077ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:13:19.63968Z","caller":"traceutil/trace.go:171","msg":"trace[1053037003] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"298.702907ms","start":"2026-08-14T23:13:19.340967Z","end":"2026-08-14T23:13:19.639669Z","steps":["trace[1053037003] 'process raft request' (duration: 297.466038ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:13:19.63989Z","caller":"traceutil/trace.go:171","msg":"trace[1537439112] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"227.213809ms","start":"2026-08-14T23:13:19.412662Z","end":"2026-08-14T23:13:19.639876Z","steps":["trace[1537439112] 'process raft request' (duration: 226.088703ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:13:21.184697Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.879959ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-08-14T23:13:21.184802Z","caller":"traceutil/trace.go:171","msg":"trace[621217124] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:600; }","duration":"127.046193ms","start":"2026-08-14T23:13:21.057733Z","end":"2026-08-14T23:13:21.184779Z","steps":["trace[621217124] 'range keys from in-memory index tree' (duration: 126.747216ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:13:21.214477Z","caller":"traceutil/trace.go:171","msg":"trace[59428484] transaction","detail":"{read_only:false; response_revision:601; number_of_response:1; }","duration":"156.007647ms","start":"2026-08-14T23:13:21.058432Z","end":"2026-08-14T23:13:21.21444Z","steps":["trace[59428484] 'process raft request' (duration: 155.223899ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:13:21.654076Z","caller":"traceutil/trace.go:171","msg":"trace[1811756059] linearizableReadLoop","detail":"{readStateIndex:627; appliedIndex:626; }","duration":"413.594878ms","start":"2026-08-14T23:13:21.24045Z","end":"2026-08-14T23:13:21.654045Z","steps":["trace[1811756059] 'read index received' (duration: 361.052855ms)","trace[1811756059] 'applied index is now lower than readState.Index' (duration: 52.540803ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T23:13:21.654203Z","caller":"traceutil/trace.go:171","msg":"trace[699089758] transaction","detail":"{read_only:false; response_revision:602; number_of_response:1; }","duration":"464.405889ms","start":"2026-08-14T23:13:21.189762Z","end":"2026-08-14T23:13:21.654168Z","steps":["trace[699089758] 'process raft request' (duration: 411.712933ms)","trace[699089758] 'compare' (duration: 52.43878ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T23:13:21.654262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"413.788302ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T23:13:21.654305Z","caller":"traceutil/trace.go:171","msg":"trace[35928751] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:602; }","duration":"413.880155ms","start":"2026-08-14T23:13:21.240414Z","end":"2026-08-14T23:13:21.654294Z","steps":["trace[35928751] 'agreement among raft nodes before linearized reading' (duration: 413.774552ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:13:21.654352Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:13:21.240385Z","time spent":"413.957717ms","remote":"127.0.0.1:40920","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-14T23:13:21.654365Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:13:21.189735Z","time spent":"464.551693ms","remote":"127.0.0.1:41108","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-08-14T23:13:21.668789Z","caller":"traceutil/trace.go:171","msg":"trace[1040383995] transaction","detail":"{read_only:false; response_revision:603; number_of_response:1; }","duration":"396.905726ms","start":"2026-08-14T23:13:21.271824Z","end":"2026-08-14T23:13:21.66873Z","steps":["trace[1040383995] 'process raft request' (duration: 396.68327ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:13:21.669068Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:13:21.271802Z","time spent":"397.104901ms","remote":"127.0.0.1:41398","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-14T23:13:22.085736Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.508948ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-14T23:13:22.086053Z","caller":"traceutil/trace.go:171","msg":"trace[1857582237] transaction","detail":"{read_only:false; response_revision:604; number_of_response:1; }","duration":"410.222346ms","start":"2026-08-14T23:13:21.675765Z","end":"2026-08-14T23:13:22.085987Z","steps":["trace[1857582237] 'process raft request' (duration: 85.357681ms)","trace[1857582237] 'compare' (duration: 324.358213ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T23:13:22.086319Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:13:21.675733Z","time spent":"410.451212ms","remote":"127.0.0.1:41108","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-14T23:13:23.167134Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.081267131s","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-08-14T23:13:23.168109Z","caller":"traceutil/trace.go:171","msg":"trace[1677806746] linearizableReadLoop","detail":"{readStateIndex:631; appliedIndex:628; }","duration":"1.489963291s","start":"2026-08-14T23:13:21.678124Z","end":"2026-08-14T23:13:23.168087Z","steps":["trace[1677806746] 'read index received' (duration: 83.001004ms)","trace[1677806746] 'applied index is now lower than readState.Index' (duration: 1.406960567s)"],"step_count":2} {"level":"info","ts":"2026-08-14T23:13:23.168158Z","caller":"traceutil/trace.go:171","msg":"trace[394199935] transaction","detail":"{read_only:false; response_revision:605; number_of_response:1; }","duration":"1.491948889s","start":"2026-08-14T23:13:21.676151Z","end":"2026-08-14T23:13:23.1681Z","steps":["trace[394199935] 'process raft request' (duration: 1.491088058s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:13:23.168316Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:13:21.676121Z","time spent":"1.492111612s","remote":"127.0.0.1:41108","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-14T23:13:23.18905Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"948.273834ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-14T23:13:23.189103Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.505962964s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T23:13:23.189173Z","caller":"traceutil/trace.go:171","msg":"trace[1292480241] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:605; }","duration":"948.451939ms","start":"2026-08-14T23:13:22.240688Z","end":"2026-08-14T23:13:23.18914Z","steps":["trace[1292480241] 'agreement among raft nodes before linearized reading' (duration: 927.535407ms)","trace[1292480241] 'range keys from in-memory index tree' (duration: 20.740588ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T23:13:23.189212Z","caller":"traceutil/trace.go:171","msg":"trace[205502071] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:605; }","duration":"1.506118759s","start":"2026-08-14T23:13:21.683062Z","end":"2026-08-14T23:13:23.189181Z","steps":["trace[205502071] 'agreement among raft nodes before linearized reading' (duration: 1.485145456s)","trace[205502071] 'range keys from in-memory index tree' (duration: 20.816659ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T23:13:23.189233Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:13:22.240666Z","time spent":"948.553791ms","remote":"127.0.0.1:40918","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-14T23:13:23.189201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.511016446s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-rvs6s\" ","response":"range_response_count:1 size:16961"} {"level":"warn","ts":"2026-08-14T23:13:23.18927Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:13:21.683043Z","time spent":"1.506215552s","remote":"127.0.0.1:41084","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" "} {"level":"info","ts":"2026-08-14T23:13:23.189328Z","caller":"traceutil/trace.go:171","msg":"trace[1466099273] range","detail":"{range_begin:/registry/pods/kube-system/cilium-rvs6s; range_end:; response_count:1; response_revision:605; }","duration":"1.51122405s","start":"2026-08-14T23:13:21.678071Z","end":"2026-08-14T23:13:23.189295Z","steps":["trace[1466099273] 'agreement among raft nodes before linearized reading' (duration: 1.490119294s)","trace[1466099273] 'range keys from in-memory index tree' (duration: 20.83232ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T23:13:23.189311Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.632028ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-08-14T23:13:23.189392Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:13:21.678049Z","time spent":"1.511329853s","remote":"127.0.0.1:41052","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16984,"request content":"key:\"/registry/pods/kube-system/cilium-rvs6s\" "} {"level":"info","ts":"2026-08-14T23:13:23.189419Z","caller":"traceutil/trace.go:171","msg":"trace[1123499216] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:605; }","duration":"182.798642ms","start":"2026-08-14T23:13:23.006584Z","end":"2026-08-14T23:13:23.189382Z","steps":["trace[1123499216] 'agreement among raft nodes before linearized reading' (duration: 161.637844ms)","trace[1123499216] 'range keys from in-memory index tree' (duration: 20.889211ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T23:13:23.866049Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.737086ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-08-14T23:13:23.866192Z","caller":"traceutil/trace.go:171","msg":"trace[1232520528] transaction","detail":"{read_only:false; response_revision:610; number_of_response:1; }","duration":"182.054685ms","start":"2026-08-14T23:13:23.684114Z","end":"2026-08-14T23:13:23.866169Z","steps":["trace[1232520528] 'process raft request' (duration: 30.114274ms)","trace[1232520528] 'compare' (duration: 151.528001ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T23:13:23.89571Z","caller":"traceutil/trace.go:171","msg":"trace[1562231946] transaction","detail":"{read_only:false; response_revision:612; number_of_response:1; }","duration":"193.417847ms","start":"2026-08-14T23:13:23.70225Z","end":"2026-08-14T23:13:23.895668Z","steps":["trace[1562231946] 'process raft request' (duration: 193.310464ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:13:23.896073Z","caller":"traceutil/trace.go:171","msg":"trace[22650377] transaction","detail":"{read_only:false; response_revision:611; number_of_response:1; }","duration":"196.348528ms","start":"2026-08-14T23:13:23.699664Z","end":"2026-08-14T23:13:23.896012Z","steps":["trace[22650377] 'process raft request' (duration: 195.700523ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:13:24.263507Z","caller":"traceutil/trace.go:171","msg":"trace[1376005082] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"168.289893ms","start":"2026-08-14T23:13:24.095134Z","end":"2026-08-14T23:13:24.263424Z","steps":["trace[1376005082] 'process raft request' (duration: 165.426294ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:13:28.001196Z","caller":"traceutil/trace.go:171","msg":"trace[2025356281] transaction","detail":"{read_only:false; response_revision:684; number_of_response:1; }","duration":"125.872514ms","start":"2026-08-14T23:13:27.875302Z","end":"2026-08-14T23:13:28.001174Z","steps":["trace[2025356281] 'process raft request' (duration: 125.657909ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:13:33.741773Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1011515524127616507,"retry-timeout":"500ms"} {"level":"info","ts":"2026-08-14T23:13:34.073627Z","caller":"traceutil/trace.go:171","msg":"trace[378100489] linearizableReadLoop","detail":"{readStateIndex:758; appliedIndex:757; }","duration":"831.875398ms","start":"2026-08-14T23:13:33.241727Z","end":"2026-08-14T23:13:34.073603Z","steps":["trace[378100489] 'read index received' (duration: 831.680223ms)","trace[378100489] 'applied index is now lower than readState.Index' (duration: 194.295µs)"],"step_count":2} {"level":"info","ts":"2026-08-14T23:13:34.074441Z","caller":"traceutil/trace.go:171","msg":"trace[903383135] transaction","detail":"{read_only:false; response_revision:728; number_of_response:1; }","duration":"958.341497ms","start":"2026-08-14T23:13:33.116081Z","end":"2026-08-14T23:13:34.074422Z","steps":["trace[903383135] 'process raft request' (duration: 957.403564ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:13:34.074585Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:13:33.116061Z","time spent":"958.437429ms","remote":"127.0.0.1:41052","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":18506,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-14T23:13:34.074723Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"806.16503ms","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-08-14T23:13:34.074779Z","caller":"traceutil/trace.go:171","msg":"trace[920945844] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:728; }","duration":"806.266723ms","start":"2026-08-14T23:13:33.2685Z","end":"2026-08-14T23:13:34.074766Z","steps":["trace[920945844] 'agreement among raft nodes before linearized reading' (duration: 805.939775ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:13:34.074822Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:13:33.268485Z","time spent":"806.329434ms","remote":"127.0.0.1:41108","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-08-14T23:13:34.074908Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"833.183889ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T23:13:34.07497Z","caller":"traceutil/trace.go:171","msg":"trace[879419900] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:728; }","duration":"833.279081ms","start":"2026-08-14T23:13:33.241665Z","end":"2026-08-14T23:13:34.074944Z","steps":["trace[879419900] 'agreement among raft nodes before linearized reading' (duration: 833.22213ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:13:34.075009Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:13:33.241637Z","time spent":"833.365444ms","remote":"127.0.0.1:40920","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-14T23:13:34.075209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"367.587112ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-08-14T23:13:34.075316Z","caller":"traceutil/trace.go:171","msg":"trace[721336329] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:728; }","duration":"367.743385ms","start":"2026-08-14T23:13:33.707546Z","end":"2026-08-14T23:13:34.075289Z","steps":["trace[721336329] 'agreement among raft nodes before linearized reading' (duration: 367.395977ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:13:34.075365Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:13:33.70753Z","time spent":"367.826138ms","remote":"127.0.0.1:41108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-08-14T23:13:36.567984Z","caller":"traceutil/trace.go:171","msg":"trace[277367378] transaction","detail":"{read_only:false; response_revision:748; number_of_response:1; }","duration":"116.645874ms","start":"2026-08-14T23:13:36.45131Z","end":"2026-08-14T23:13:36.567955Z","steps":["trace[277367378] 'process raft request' (duration: 73.032525ms)","trace[277367378] 'compare' (duration: 43.482356ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T23:13:39.518689Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.403425ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T23:13:39.518809Z","caller":"traceutil/trace.go:171","msg":"trace[1812875949] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:768; }","duration":"277.58825ms","start":"2026-08-14T23:13:39.2412Z","end":"2026-08-14T23:13:39.518789Z","steps":["trace[1812875949] 'range keys from in-memory index tree' (duration: 277.316714ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:13:39.518965Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"737.312405ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-4v2cn\" ","response":"range_response_count:1 size:3964"} {"level":"info","ts":"2026-08-14T23:13:39.519042Z","caller":"traceutil/trace.go:171","msg":"trace[3421520] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-4v2cn; range_end:; response_count:1; response_revision:768; }","duration":"737.436418ms","start":"2026-08-14T23:13:38.781581Z","end":"2026-08-14T23:13:39.519018Z","steps":["trace[3421520] 'range keys from in-memory index tree' (duration: 737.05223ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:13:39.519082Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:13:38.78156Z","time spent":"737.513881ms","remote":"127.0.0.1:41052","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3987,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-4v2cn\" "} {"level":"info","ts":"2026-08-14T23:13:39.630612Z","caller":"traceutil/trace.go:171","msg":"trace[1608650270] transaction","detail":"{read_only:false; response_revision:769; number_of_response:1; }","duration":"102.00889ms","start":"2026-08-14T23:13:39.528578Z","end":"2026-08-14T23:13:39.630587Z","steps":["trace[1608650270] 'process raft request' (duration: 101.841266ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:13:53.525891Z","caller":"traceutil/trace.go:171","msg":"trace[1222756116] transaction","detail":"{read_only:false; response_revision:900; number_of_response:1; }","duration":"283.087522ms","start":"2026-08-14T23:13:53.242786Z","end":"2026-08-14T23:13:53.525874Z","steps":["trace[1222756116] 'process raft request' (duration: 282.931668ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:13:53.898765Z","caller":"traceutil/trace.go:171","msg":"trace[2011566645] transaction","detail":"{read_only:false; response_revision:901; number_of_response:1; }","duration":"367.044519ms","start":"2026-08-14T23:13:53.531691Z","end":"2026-08-14T23:13:53.898736Z","steps":["trace[2011566645] 'process raft request' (duration: 366.870165ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:13:53.898929Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:13:53.531669Z","time spent":"367.173332ms","remote":"127.0.0.1:41356","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5192,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-14T23:13:53.908696Z","caller":"traceutil/trace.go:171","msg":"trace[1390678667] transaction","detail":"{read_only:false; response_revision:902; number_of_response:1; }","duration":"375.615605ms","start":"2026-08-14T23:13:53.533065Z","end":"2026-08-14T23:13:53.908681Z","steps":["trace[1390678667] 'process raft request' (duration: 375.477052ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:13:53.908836Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:13:53.533044Z","time spent":"375.713357ms","remote":"127.0.0.1:41044","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1105,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-14T23:13:53.908833Z","caller":"traceutil/trace.go:171","msg":"trace[1598939288] transaction","detail":"{read_only:false; response_revision:903; number_of_response:1; }","duration":"375.357809ms","start":"2026-08-14T23:13:53.533464Z","end":"2026-08-14T23:13:53.908822Z","steps":["trace[1598939288] 'process raft request' (duration: 375.179574ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:13:53.909051Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:13:53.533456Z","time spent":"375.559564ms","remote":"127.0.0.1:41120","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1628,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-14T23:14:00.613781Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.168342ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-14T23:14:00.61388Z","caller":"traceutil/trace.go:171","msg":"trace[1313153239] linearizableReadLoop","detail":"{readStateIndex:969; appliedIndex:968; }","duration":"200.089498ms","start":"2026-08-14T23:14:00.413773Z","end":"2026-08-14T23:14:00.613863Z","steps":["trace[1313153239] 'read index received' (duration: 23.767571ms)","trace[1313153239] 'applied index is now lower than readState.Index' (duration: 176.320767ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T23:14:00.614004Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.236702ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-08-14T23:14:00.614238Z","caller":"traceutil/trace.go:171","msg":"trace[1113217666] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:933; }","duration":"200.295953ms","start":"2026-08-14T23:14:00.413732Z","end":"2026-08-14T23:14:00.614028Z","steps":["trace[1113217666] 'agreement among raft nodes before linearized reading' (duration: 200.17557ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:14:00.614102Z","caller":"traceutil/trace.go:171","msg":"trace[1911622616] transaction","detail":"{read_only:false; response_revision:933; number_of_response:1; }","duration":"236.518744ms","start":"2026-08-14T23:14:00.377412Z","end":"2026-08-14T23:14:00.613931Z","steps":["trace[1911622616] 'process raft request' (duration: 60.126675ms)","trace[1911622616] 'compare' (duration: 176.050029ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T23:14:01.120845Z","caller":"traceutil/trace.go:171","msg":"trace[1065996312] linearizableReadLoop","detail":"{readStateIndex:970; appliedIndex:969; }","duration":"280.062358ms","start":"2026-08-14T23:14:00.840761Z","end":"2026-08-14T23:14:01.120823Z","steps":["trace[1065996312] 'read index received' (duration: 263.974162ms)","trace[1065996312] 'applied index is now lower than readState.Index' (duration: 16.087356ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T23:14:01.121072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.288485ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-08-14T23:14:01.121111Z","caller":"traceutil/trace.go:171","msg":"trace[1092346637] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:934; }","duration":"280.395488ms","start":"2026-08-14T23:14:00.840703Z","end":"2026-08-14T23:14:01.121098Z","steps":["trace[1092346637] 'agreement among raft nodes before linearized reading' (duration: 280.208904ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:14:01.121301Z","caller":"traceutil/trace.go:171","msg":"trace[48184314] transaction","detail":"{read_only:false; response_revision:934; number_of_response:1; }","duration":"502.751061ms","start":"2026-08-14T23:14:00.618525Z","end":"2026-08-14T23:14:01.121276Z","steps":["trace[48184314] 'process raft request' (duration: 486.096981ms)","trace[48184314] 'compare' (duration: 16.116316ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T23:14:01.121429Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:14:00.618507Z","time spent":"502.859693ms","remote":"127.0.0.1:41108","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-14T23:14:01.175055Z","caller":"traceutil/trace.go:171","msg":"trace[1710139085] transaction","detail":"{read_only:false; response_revision:935; number_of_response:1; }","duration":"150.429415ms","start":"2026-08-14T23:14:01.024601Z","end":"2026-08-14T23:14:01.17503Z","steps":["trace[1710139085] 'process raft request' (duration: 150.291852ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:14:01.300529Z","caller":"traceutil/trace.go:171","msg":"trace[943874680] transaction","detail":"{read_only:false; response_revision:936; number_of_response:1; }","duration":"175.595479ms","start":"2026-08-14T23:14:01.124908Z","end":"2026-08-14T23:14:01.300504Z","steps":["trace[943874680] 'process raft request' (duration: 175.389264ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:14:26.626445Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"959.921525ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-14T23:14:26.626562Z","caller":"traceutil/trace.go:171","msg":"trace[1480125501] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/; range_end:/registry/mutatingwebhookconfigurations0; response_count:0; response_revision:1017; }","duration":"960.093999ms","start":"2026-08-14T23:14:25.666446Z","end":"2026-08-14T23:14:26.62654Z","steps":["trace[1480125501] 'count revisions from in-memory index tree' (duration: 959.77423ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:14:26.626604Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:14:25.666418Z","time spent":"960.173531ms","remote":"127.0.0.1:41398","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":1,"response size":30,"request content":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true "} {"level":"warn","ts":"2026-08-14T23:14:26.6266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.179294506s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-08-14T23:14:26.626645Z","caller":"traceutil/trace.go:171","msg":"trace[999052742] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1017; }","duration":"1.179389538s","start":"2026-08-14T23:14:25.447244Z","end":"2026-08-14T23:14:26.626634Z","steps":["trace[999052742] 'range keys from in-memory index tree' (duration: 1.179142782s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:14:26.626667Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:14:25.447223Z","time spent":"1.17943909s","remote":"127.0.0.1:41108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-08-14T23:14:26.626835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"372.448709ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-14T23:14:26.626911Z","caller":"traceutil/trace.go:171","msg":"trace[324259639] linearizableReadLoop","detail":"{readStateIndex:1060; appliedIndex:1059; }","duration":"386.258061ms","start":"2026-08-14T23:14:26.240641Z","end":"2026-08-14T23:14:26.626899Z","steps":["trace[324259639] 'read index received' (duration: 13.636898ms)","trace[324259639] 'applied index is now lower than readState.Index' (duration: 372.620243ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T23:14:26.626928Z","caller":"traceutil/trace.go:171","msg":"trace[1254182284] transaction","detail":"{read_only:false; response_revision:1018; number_of_response:1; }","duration":"543.412856ms","start":"2026-08-14T23:14:26.083494Z","end":"2026-08-14T23:14:26.626907Z","steps":["trace[1254182284] 'process raft request' (duration: 170.835434ms)","trace[1254182284] 'compare' (duration: 372.352517ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T23:14:26.626979Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"386.349923ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T23:14:26.627002Z","caller":"traceutil/trace.go:171","msg":"trace[601841086] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1018; }","duration":"386.409365ms","start":"2026-08-14T23:14:26.240587Z","end":"2026-08-14T23:14:26.626997Z","steps":["trace[601841086] 'agreement among raft nodes before linearized reading' (duration: 386.371704ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:14:26.627023Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:14:26.240565Z","time spent":"386.452545ms","remote":"127.0.0.1:40918","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-14T23:14:26.627064Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:14:26.08347Z","time spent":"543.492169ms","remote":"127.0.0.1:41108","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-14T23:14:26.627136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.067406ms","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-08-14T23:14:26.627383Z","caller":"traceutil/trace.go:171","msg":"trace[236604975] range","detail":"{range_begin:/registry/masterleases/199.204.45.22; range_end:; response_count:1; response_revision:1018; }","duration":"257.354152ms","start":"2026-08-14T23:14:26.370012Z","end":"2026-08-14T23:14:26.627366Z","steps":["trace[236604975] 'agreement among raft nodes before linearized reading' (duration: 256.999314ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:14:26.627492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.558038ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-08-14T23:14:26.627525Z","caller":"traceutil/trace.go:171","msg":"trace[108127604] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1018; }","duration":"175.62734ms","start":"2026-08-14T23:14:26.451888Z","end":"2026-08-14T23:14:26.627515Z","steps":["trace[108127604] 'agreement among raft nodes before linearized reading' (duration: 175.527347ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:14:27.120089Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.159738ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:40"} {"level":"info","ts":"2026-08-14T23:14:27.120183Z","caller":"traceutil/trace.go:171","msg":"trace[567460718] linearizableReadLoop","detail":"{readStateIndex:1061; appliedIndex:1060; }","duration":"492.057482ms","start":"2026-08-14T23:14:26.62811Z","end":"2026-08-14T23:14:27.120167Z","steps":["trace[567460718] 'read index received' (duration: 388.810942ms)","trace[567460718] 'applied index is now lower than readState.Index' (duration: 103.24517ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T23:14:27.12025Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:14:26.628043Z","time spent":"492.201516ms","remote":"127.0.0.1:40938","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-08-14T23:14:27.120461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"492.34059ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T23:14:27.120503Z","caller":"traceutil/trace.go:171","msg":"trace[1437586311] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1018; }","duration":"492.399792ms","start":"2026-08-14T23:14:26.628091Z","end":"2026-08-14T23:14:27.120491Z","steps":["trace[1437586311] 'agreement among raft nodes before linearized reading' (duration: 492.330749ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:14:27.120533Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:14:26.62808Z","time spent":"492.446613ms","remote":"127.0.0.1:40920","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-08-14T23:14:27.41783Z","caller":"traceutil/trace.go:171","msg":"trace[1272424655] linearizableReadLoop","detail":"{readStateIndex:1064; appliedIndex:1063; }","duration":"297.600982ms","start":"2026-08-14T23:14:27.12021Z","end":"2026-08-14T23:14:27.417811Z","steps":["trace[1272424655] 'read index received' (duration: 297.559751ms)","trace[1272424655] 'applied index is now lower than readState.Index' (duration: 40.501µs)"],"step_count":2} {"level":"info","ts":"2026-08-14T23:14:27.417909Z","caller":"traceutil/trace.go:171","msg":"trace[377654802] transaction","detail":"{read_only:false; response_revision:1020; number_of_response:1; }","duration":"786.836066ms","start":"2026-08-14T23:14:26.631067Z","end":"2026-08-14T23:14:27.417903Z","steps":["trace[377654802] 'process raft request' (duration: 786.684112ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:14:27.417877Z","caller":"traceutil/trace.go:171","msg":"trace[439853350] transaction","detail":"{read_only:false; response_revision:1019; number_of_response:1; }","duration":"786.835946ms","start":"2026-08-14T23:14:26.631003Z","end":"2026-08-14T23:14:27.417838Z","steps":["trace[439853350] 'process raft request' (duration: 786.634692ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:14:27.417991Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:14:26.631061Z","time spent":"786.868057ms","remote":"127.0.0.1:41108","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-14T23:14:27.418047Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:14:26.630985Z","time spent":"786.969629ms","remote":"127.0.0.1:41108","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-08-14T23:14:27.418074Z","caller":"traceutil/trace.go:171","msg":"trace[847478427] transaction","detail":"{read_only:false; response_revision:1021; number_of_response:1; }","duration":"786.99493ms","start":"2026-08-14T23:14:26.631076Z","end":"2026-08-14T23:14:27.418071Z","steps":["trace[847478427] 'process raft request' (duration: 786.704753ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:14:27.4181Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:14:26.631055Z","time spent":"787.03026ms","remote":"127.0.0.1:41108","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-14T23:14:27.418201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"660.641034ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-08-14T23:14:27.418224Z","caller":"traceutil/trace.go:171","msg":"trace[214318830] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1021; }","duration":"660.699315ms","start":"2026-08-14T23:14:26.757519Z","end":"2026-08-14T23:14:27.418218Z","steps":["trace[214318830] 'agreement among raft nodes before linearized reading' (duration: 660.623094ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:14:27.418243Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:14:26.757499Z","time spent":"660.739946ms","remote":"127.0.0.1:41108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-08-14T23:14:27.418386Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"536.110472ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T23:14:27.418552Z","caller":"traceutil/trace.go:171","msg":"trace[802012384] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:1021; }","duration":"536.339248ms","start":"2026-08-14T23:14:26.882184Z","end":"2026-08-14T23:14:27.418523Z","steps":["trace[802012384] 'agreement among raft nodes before linearized reading' (duration: 535.992959ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:14:27.418662Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:14:26.882169Z","time spent":"536.47163ms","remote":"127.0.0.1:41072","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":"info","ts":"2026-08-14T23:14:27.587723Z","caller":"traceutil/trace.go:171","msg":"trace[1959437029] linearizableReadLoop","detail":"{readStateIndex:1065; appliedIndex:1064; }","duration":"169.805ms","start":"2026-08-14T23:14:27.417884Z","end":"2026-08-14T23:14:27.587689Z","steps":["trace[1959437029] 'read index received' (duration: 152.32228ms)","trace[1959437029] 'applied index is now lower than readState.Index' (duration: 17.48159ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T23:14:27.58801Z","caller":"traceutil/trace.go:171","msg":"trace[469292350] transaction","detail":"{read_only:false; response_revision:1022; number_of_response:1; }","duration":"465.530325ms","start":"2026-08-14T23:14:27.122419Z","end":"2026-08-14T23:14:27.587949Z","steps":["trace[469292350] 'process raft request' (duration: 447.859671ms)","trace[469292350] 'compare' (duration: 17.274955ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T23:14:27.588234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.26013ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-08-14T23:14:27.588346Z","caller":"traceutil/trace.go:171","msg":"trace[139866484] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1022; }","duration":"289.440735ms","start":"2026-08-14T23:14:27.298888Z","end":"2026-08-14T23:14:27.588329Z","steps":["trace[139866484] 'agreement among raft nodes before linearized reading' (duration: 289.055655ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:14:27.588261Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:14:27.122396Z","time spent":"465.71864ms","remote":"127.0.0.1:40938","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":118,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-14T23:14:27.588614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"347.196223ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T23:14:27.588714Z","caller":"traceutil/trace.go:171","msg":"trace[1092101540] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1022; }","duration":"347.365467ms","start":"2026-08-14T23:14:27.241325Z","end":"2026-08-14T23:14:27.58869Z","steps":["trace[1092101540] 'agreement among raft nodes before linearized reading' (duration: 346.586377ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:14:27.588775Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:14:27.241295Z","time spent":"347.471079ms","remote":"127.0.0.1:40918","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-08-14T23:14:27.624267Z","caller":"traceutil/trace.go:171","msg":"trace[147087698] transaction","detail":"{read_only:false; response_revision:1023; number_of_response:1; }","duration":"200.444215ms","start":"2026-08-14T23:14:27.423794Z","end":"2026-08-14T23:14:27.624239Z","steps":["trace[147087698] 'process raft request' (duration: 200.183449ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:14:28.850771Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1011515524127617223,"retry-timeout":"500ms"} {"level":"info","ts":"2026-08-14T23:14:28.921233Z","caller":"traceutil/trace.go:171","msg":"trace[895165645] transaction","detail":"{read_only:false; response_revision:1025; number_of_response:1; }","duration":"574.901083ms","start":"2026-08-14T23:14:28.346305Z","end":"2026-08-14T23:14:28.921206Z","steps":["trace[895165645] 'process raft request' (duration: 574.733589ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:14:28.921425Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:14:28.346285Z","time spent":"575.026817ms","remote":"127.0.0.1:41108","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-14T23:14:29.911068Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.166855ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-14T23:14:29.911148Z","caller":"traceutil/trace.go:171","msg":"trace[400151384] linearizableReadLoop","detail":"{readStateIndex:1069; appliedIndex:1067; }","duration":"1.560886385s","start":"2026-08-14T23:14:28.350249Z","end":"2026-08-14T23:14:29.911135Z","steps":["trace[400151384] 'read index received' (duration: 570.766044ms)","trace[400151384] 'applied index is now lower than readState.Index' (duration: 990.119691ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T23:14:29.911211Z","caller":"traceutil/trace.go:171","msg":"trace[1893345737] transaction","detail":"{read_only:false; response_revision:1026; number_of_response:1; }","duration":"1.278247414s","start":"2026-08-14T23:14:28.632956Z","end":"2026-08-14T23:14:29.911204Z","steps":["trace[1893345737] 'process raft request' (duration: 1.138883085s)","trace[1893345737] 'compare' (duration: 139.070792ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T23:14:29.911263Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:14:28.632928Z","time spent":"1.278301496s","remote":"127.0.0.1:41108","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-14T23:14:29.911447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.561206283s","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-08-14T23:14:29.911466Z","caller":"traceutil/trace.go:171","msg":"trace[1187152668] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:1026; }","duration":"1.561226933s","start":"2026-08-14T23:14:28.350232Z","end":"2026-08-14T23:14:29.911459Z","steps":["trace[1187152668] 'agreement among raft nodes before linearized reading' (duration: 1.561183622s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:14:29.911485Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:14:28.350174Z","time spent":"1.561305635s","remote":"127.0.0.1:41052","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":11,"response size":30,"request content":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true "} {"level":"warn","ts":"2026-08-14T23:14:29.911556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.456173689s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-14T23:14:29.911608Z","caller":"traceutil/trace.go:171","msg":"trace[929823683] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:1026; }","duration":"1.456276542s","start":"2026-08-14T23:14:28.455319Z","end":"2026-08-14T23:14:29.911595Z","steps":["trace[929823683] 'agreement among raft nodes before linearized reading' (duration: 1.456169959s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:14:29.911641Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:14:28.455292Z","time spent":"1.456342373s","remote":"127.0.0.1:41206","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":16,"response size":30,"request content":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true "} {"level":"warn","ts":"2026-08-14T23:14:29.911646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"669.502806ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-14T23:14:29.911649Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.023223675s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T23:14:29.91169Z","caller":"traceutil/trace.go:171","msg":"trace[1516180887] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1026; }","duration":"669.581949ms","start":"2026-08-14T23:14:29.242097Z","end":"2026-08-14T23:14:29.911679Z","steps":["trace[1516180887] 'agreement among raft nodes before linearized reading' (duration: 669.506237ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:14:29.911694Z","caller":"traceutil/trace.go:171","msg":"trace[657052454] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:1026; }","duration":"1.023318218s","start":"2026-08-14T23:14:28.888367Z","end":"2026-08-14T23:14:29.911685Z","steps":["trace[657052454] 'agreement among raft nodes before linearized reading' (duration: 1.023238336s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:14:29.911712Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.480722ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-08-14T23:14:29.911717Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:14:28.888344Z","time spent":"1.023366799s","remote":"127.0.0.1:41254","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":0,"response size":28,"request content":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true "} {"level":"info","ts":"2026-08-14T23:14:29.911732Z","caller":"traceutil/trace.go:171","msg":"trace[806872519] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1026; }","duration":"231.519564ms","start":"2026-08-14T23:14:29.680206Z","end":"2026-08-14T23:14:29.911726Z","steps":["trace[806872519] 'agreement among raft nodes before linearized reading' (duration: 231.473563ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:14:29.911792Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"489.453691ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-08-14T23:14:29.911806Z","caller":"traceutil/trace.go:171","msg":"trace[723757986] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1026; }","duration":"489.508902ms","start":"2026-08-14T23:14:29.422293Z","end":"2026-08-14T23:14:29.911802Z","steps":["trace[723757986] 'agreement among raft nodes before linearized reading' (duration: 489.430011ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:14:29.911871Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:14:29.422262Z","time spent":"489.596494ms","remote":"127.0.0.1:41108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-08-14T23:14:29.911665Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"488.791865ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-08-14T23:14:29.911909Z","caller":"traceutil/trace.go:171","msg":"trace[435257387] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1026; }","duration":"489.080142ms","start":"2026-08-14T23:14:29.422821Z","end":"2026-08-14T23:14:29.911901Z","steps":["trace[435257387] 'agreement among raft nodes before linearized reading' (duration: 488.773265ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:14:29.911915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.671761ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-08-14T23:14:29.911711Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:14:29.242077Z","time spent":"669.629949ms","remote":"127.0.0.1:40918","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-14T23:14:29.911935Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:14:29.422799Z","time spent":"489.128023ms","remote":"127.0.0.1:41108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-08-14T23:14:29.911939Z","caller":"traceutil/trace.go:171","msg":"trace[471983079] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1026; }","duration":"284.717862ms","start":"2026-08-14T23:14:29.627215Z","end":"2026-08-14T23:14:29.911933Z","steps":["trace[471983079] 'agreement among raft nodes before linearized reading' (duration: 284.65337ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:14:29.912022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"489.108103ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-08-14T23:14:29.912036Z","caller":"traceutil/trace.go:171","msg":"trace[1691025450] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1026; }","duration":"489.152984ms","start":"2026-08-14T23:14:29.422879Z","end":"2026-08-14T23:14:29.912032Z","steps":["trace[1691025450] 'agreement among raft nodes before linearized reading' (duration: 489.107773ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:14:29.912052Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:14:29.422859Z","time spent":"489.187394ms","remote":"127.0.0.1:41108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-08-14T23:14:30.351793Z","caller":"traceutil/trace.go:171","msg":"trace[1402275137] transaction","detail":"{read_only:false; response_revision:1030; number_of_response:1; }","duration":"435.383831ms","start":"2026-08-14T23:14:29.916385Z","end":"2026-08-14T23:14:30.351769Z","steps":["trace[1402275137] 'process raft request' (duration: 435.316759ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:14:30.351865Z","caller":"traceutil/trace.go:171","msg":"trace[600230193] transaction","detail":"{read_only:false; response_revision:1029; number_of_response:1; }","duration":"436.018297ms","start":"2026-08-14T23:14:29.915747Z","end":"2026-08-14T23:14:30.351765Z","steps":["trace[600230193] 'process raft request' (duration: 435.838572ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:14:30.351932Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:14:29.91636Z","time spent":"435.499964ms","remote":"127.0.0.1:41108","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-14T23:14:30.351876Z","caller":"traceutil/trace.go:171","msg":"trace[248959850] transaction","detail":"{read_only:false; response_revision:1028; number_of_response:1; }","duration":"436.746624ms","start":"2026-08-14T23:14:29.91511Z","end":"2026-08-14T23:14:30.351856Z","steps":["trace[248959850] 'process raft request' (duration: 366.174468ms)","trace[248959850] 'compare' (duration: 69.933741ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T23:14:30.35202Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:14:29.915736Z","time spent":"436.195932ms","remote":"127.0.0.1:41108","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-14T23:14:30.352157Z","caller":"traceutil/trace.go:171","msg":"trace[625496278] transaction","detail":"{read_only:false; response_revision:1031; number_of_response:1; }","duration":"434.999912ms","start":"2026-08-14T23:14:29.917146Z","end":"2026-08-14T23:14:30.352146Z","steps":["trace[625496278] 'process raft request' (duration: 434.587872ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:14:30.352135Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:14:29.915093Z","time spent":"436.958529ms","remote":"127.0.0.1:41108","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-14T23:14:30.35232Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:14:29.917137Z","time spent":"435.059033ms","remote":"127.0.0.1:41108","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-08-14T23:14:32.464339Z","caller":"traceutil/trace.go:171","msg":"trace[1384781146] transaction","detail":"{read_only:false; response_revision:1036; number_of_response:1; }","duration":"104.461311ms","start":"2026-08-14T23:14:32.35984Z","end":"2026-08-14T23:14:32.464302Z","steps":["trace[1384781146] 'process raft request' (duration: 104.109902ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:14:32.464374Z","caller":"traceutil/trace.go:171","msg":"trace[1285817570] transaction","detail":"{read_only:false; response_revision:1038; number_of_response:1; }","duration":"104.137152ms","start":"2026-08-14T23:14:32.360198Z","end":"2026-08-14T23:14:32.464335Z","steps":["trace[1285817570] 'process raft request' (duration: 104.001929ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:14:32.46441Z","caller":"traceutil/trace.go:171","msg":"trace[1455750860] transaction","detail":"{read_only:false; response_revision:1037; number_of_response:1; }","duration":"104.427989ms","start":"2026-08-14T23:14:32.359939Z","end":"2026-08-14T23:14:32.464367Z","steps":["trace[1455750860] 'process raft request' (duration: 104.183593ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:14:36.226671Z","caller":"traceutil/trace.go:171","msg":"trace[2001334914] linearizableReadLoop","detail":"{readStateIndex:1089; appliedIndex:1088; }","duration":"208.12365ms","start":"2026-08-14T23:14:36.01847Z","end":"2026-08-14T23:14:36.226594Z","steps":["trace[2001334914] 'read index received' (duration: 207.985747ms)","trace[2001334914] 'applied index is now lower than readState.Index' (duration: 136.713µs)"],"step_count":2} {"level":"info","ts":"2026-08-14T23:14:36.226806Z","caller":"traceutil/trace.go:171","msg":"trace[1873858468] transaction","detail":"{read_only:false; response_revision:1045; number_of_response:1; }","duration":"271.152865ms","start":"2026-08-14T23:14:35.955612Z","end":"2026-08-14T23:14:36.226765Z","steps":["trace[1873858468] 'process raft request' (duration: 270.829028ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:14:36.226995Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.49879ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-08-14T23:14:36.227069Z","caller":"traceutil/trace.go:171","msg":"trace[613173362] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1045; }","duration":"208.630322ms","start":"2026-08-14T23:14:36.01842Z","end":"2026-08-14T23:14:36.227051Z","steps":["trace[613173362] 'agreement among raft nodes before linearized reading' (duration: 208.351726ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:14:36.227079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.743125ms","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":"info","ts":"2026-08-14T23:14:36.227147Z","caller":"traceutil/trace.go:171","msg":"trace[498629106] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:1045; }","duration":"153.885938ms","start":"2026-08-14T23:14:36.073245Z","end":"2026-08-14T23:14:36.227131Z","steps":["trace[498629106] 'agreement among raft nodes before linearized reading' (duration: 153.717714ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:14:36.739273Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1011515524127617270,"retry-timeout":"500ms"} {"level":"info","ts":"2026-08-14T23:14:36.918017Z","caller":"traceutil/trace.go:171","msg":"trace[480071089] linearizableReadLoop","detail":"{readStateIndex:1090; appliedIndex:1089; }","duration":"678.763929ms","start":"2026-08-14T23:14:36.239218Z","end":"2026-08-14T23:14:36.917982Z","steps":["trace[480071089] 'read index received' (duration: 676.222998ms)","trace[480071089] 'applied index is now lower than readState.Index' (duration: 2.539711ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T23:14:36.918059Z","caller":"traceutil/trace.go:171","msg":"trace[494157792] transaction","detail":"{read_only:false; response_revision:1046; number_of_response:1; }","duration":"686.923715ms","start":"2026-08-14T23:14:36.231112Z","end":"2026-08-14T23:14:36.918036Z","steps":["trace[494157792] 'process raft request' (duration: 684.242351ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:14:36.918162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"678.925953ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T23:14:36.918207Z","caller":"traceutil/trace.go:171","msg":"trace[697962610] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1046; }","duration":"678.998765ms","start":"2026-08-14T23:14:36.239197Z","end":"2026-08-14T23:14:36.918195Z","steps":["trace[697962610] 'agreement among raft nodes before linearized reading' (duration: 678.906723ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:14:36.918249Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:14:36.239189Z","time spent":"679.047016ms","remote":"127.0.0.1:40918","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-14T23:14:36.91826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"547.69596ms","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-08-14T23:14:36.918296Z","caller":"traceutil/trace.go:171","msg":"trace[719937855] range","detail":"{range_begin:/registry/masterleases/199.204.45.22; range_end:; response_count:1; response_revision:1046; }","duration":"547.774332ms","start":"2026-08-14T23:14:36.370514Z","end":"2026-08-14T23:14:36.918288Z","steps":["trace[719937855] 'agreement among raft nodes before linearized reading' (duration: 547.634849ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:14:36.918167Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:14:36.231093Z","time spent":"687.012837ms","remote":"127.0.0.1:41108","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-14T23:14:36.918508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"357.585443ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-08-14T23:14:36.918798Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:14:36.370493Z","time spent":"548.298245ms","remote":"127.0.0.1:40938","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/199.204.45.22\" "} {"level":"info","ts":"2026-08-14T23:14:36.918573Z","caller":"traceutil/trace.go:171","msg":"trace[1036000097] range","detail":"{range_begin:/registry/endpointslices/; range_end:/registry/endpointslices0; response_count:0; response_revision:1046; }","duration":"357.841169ms","start":"2026-08-14T23:14:36.560724Z","end":"2026-08-14T23:14:36.918565Z","steps":["trace[1036000097] 'agreement among raft nodes before linearized reading' (duration: 357.609093ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:14:36.919126Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:14:36.5607Z","time spent":"358.416592ms","remote":"127.0.0.1:41120","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":3,"response size":30,"request content":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true "} {"level":"warn","ts":"2026-08-14T23:14:36.919194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"461.204651ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-08-14T23:14:36.919248Z","caller":"traceutil/trace.go:171","msg":"trace[1096428304] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1046; }","duration":"461.289502ms","start":"2026-08-14T23:14:36.457945Z","end":"2026-08-14T23:14:36.919234Z","steps":["trace[1096428304] 'agreement among raft nodes before linearized reading' (duration: 460.932364ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:14:36.91928Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:14:36.457934Z","time spent":"461.338974ms","remote":"127.0.0.1:41108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-08-14T23:14:51.532937Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1011515524127617484,"retry-timeout":"500ms"} {"level":"info","ts":"2026-08-14T23:14:51.595138Z","caller":"traceutil/trace.go:171","msg":"trace[1722057501] linearizableReadLoop","detail":"{readStateIndex:1194; appliedIndex:1193; }","duration":"562.266281ms","start":"2026-08-14T23:14:51.032854Z","end":"2026-08-14T23:14:51.59512Z","steps":["trace[1722057501] 'read index received' (duration: 562.146038ms)","trace[1722057501] 'applied index is now lower than readState.Index' (duration: 119.543µs)"],"step_count":2} {"level":"info","ts":"2026-08-14T23:14:51.595248Z","caller":"traceutil/trace.go:171","msg":"trace[1498726353] transaction","detail":"{read_only:false; response_revision:1145; number_of_response:1; }","duration":"604.108115ms","start":"2026-08-14T23:14:50.9911Z","end":"2026-08-14T23:14:51.595208Z","steps":["trace[1498726353] 'process raft request' (duration: 603.91738ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:14:51.595331Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"562.461455ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-08-14T23:14:51.595364Z","caller":"traceutil/trace.go:171","msg":"trace[921495706] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1145; }","duration":"562.533477ms","start":"2026-08-14T23:14:51.032821Z","end":"2026-08-14T23:14:51.595355Z","steps":["trace[921495706] 'agreement among raft nodes before linearized reading' (duration: 562.412584ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:14:51.595391Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:14:51.032806Z","time spent":"562.579378ms","remote":"127.0.0.1:41108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-08-14T23:14:51.595422Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:14:50.991085Z","time spent":"604.240877ms","remote":"127.0.0.1:41108","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-14T23:14:51.595431Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"549.899182ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-08-14T23:14:51.59548Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"553.516879ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-08-14T23:14:51.595575Z","caller":"traceutil/trace.go:171","msg":"trace[1519615812] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1145; }","duration":"553.650283ms","start":"2026-08-14T23:14:51.041903Z","end":"2026-08-14T23:14:51.595553Z","steps":["trace[1519615812] 'agreement among raft nodes before linearized reading' (duration: 553.373966ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:14:51.59551Z","caller":"traceutil/trace.go:171","msg":"trace[193327154] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1145; }","duration":"550.013375ms","start":"2026-08-14T23:14:51.045477Z","end":"2026-08-14T23:14:51.59549Z","steps":["trace[193327154] 'agreement among raft nodes before linearized reading' (duration: 549.829881ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:14:51.595598Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"550.072856ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-08-14T23:14:51.595627Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:14:51.041892Z","time spent":"553.726284ms","remote":"127.0.0.1:41108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-08-14T23:14:51.595652Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:14:51.045454Z","time spent":"550.179739ms","remote":"127.0.0.1:41108","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-08-14T23:14:51.595668Z","caller":"traceutil/trace.go:171","msg":"trace[183794076] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1145; }","duration":"550.157429ms","start":"2026-08-14T23:14:51.045491Z","end":"2026-08-14T23:14:51.595648Z","steps":["trace[183794076] 'agreement among raft nodes before linearized reading' (duration: 549.824861ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:14:51.595712Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:14:51.045484Z","time spent":"550.21622ms","remote":"127.0.0.1:41108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-08-14T23:14:52.339755Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1011515524127617487,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-14T23:14:52.839923Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1011515524127617487,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-14T23:14:53.340749Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1011515524127617487,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-14T23:14:53.841534Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1011515524127617487,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-14T23:14:54.347532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000304293s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-08-14T23:14:54.347606Z","caller":"traceutil/trace.go:171","msg":"trace[2128501885] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000455347s","start":"2026-08-14T23:14:52.347134Z","end":"2026-08-14T23:14:54.34759Z","steps":["trace[2128501885] 'agreement among raft nodes before linearized reading' (duration: 2.000321824s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:14:54.347659Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:14:52.347126Z","time spent":"2.000522179s","remote":"127.0.0.1:40918","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/08/14 23:14:54 WARNING: [core] [Server #6] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-08-14T23:14:55.36199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.191799607s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-14T23:14:55.362084Z","caller":"traceutil/trace.go:171","msg":"trace[1987323571] transaction","detail":"{read_only:false; response_revision:1146; number_of_response:1; }","duration":"3.761478451s","start":"2026-08-14T23:14:51.600591Z","end":"2026-08-14T23:14:55.362069Z","steps":["trace[1987323571] 'process raft request' (duration: 2.569535341s)","trace[1987323571] 'compare' (duration: 1.191461868s)"],"step_count":2} {"level":"warn","ts":"2026-08-14T23:14:55.362125Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:14:51.600569Z","time spent":"3.761536133s","remote":"127.0.0.1:41108","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-14T23:14:55.830118Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.660059808s","expected-duration":"1s"} {"level":"info","ts":"2026-08-14T23:14:55.855808Z","caller":"traceutil/trace.go:171","msg":"trace[1282880979] transaction","detail":"{read_only:false; response_revision:1147; number_of_response:1; }","duration":"4.255067761s","start":"2026-08-14T23:14:51.60069Z","end":"2026-08-14T23:14:55.855758Z","steps":["trace[1282880979] 'process raft request' (duration: 4.22962472s)","trace[1282880979] 'compare' (duration: 24.923209ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T23:14:55.855909Z","caller":"traceutil/trace.go:171","msg":"trace[17507213] transaction","detail":"{read_only:false; response_revision:1148; number_of_response:1; }","duration":"4.255115122s","start":"2026-08-14T23:14:51.600757Z","end":"2026-08-14T23:14:55.855872Z","steps":["trace[17507213] 'process raft request' (duration: 4.254587799s)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:14:55.855986Z","caller":"traceutil/trace.go:171","msg":"trace[1028420265] transaction","detail":"{read_only:false; response_revision:1149; number_of_response:1; }","duration":"4.255166183s","start":"2026-08-14T23:14:51.600799Z","end":"2026-08-14T23:14:55.855965Z","steps":["trace[1028420265] 'process raft request' (duration: 4.254585079s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:14:55.856013Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:14:51.600671Z","time spent":"4.255207134s","remote":"127.0.0.1:41108","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-14T23:14:55.856066Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:14:51.600749Z","time spent":"4.255232664s","remote":"127.0.0.1:41108","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-14T23:14:55.856079Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:14:51.600794Z","time spent":"4.255242415s","remote":"127.0.0.1:41108","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-08-14T23:14:55.857225Z","caller":"traceutil/trace.go:171","msg":"trace[945079587] transaction","detail":"{read_only:false; response_revision:1150; number_of_response:1; }","duration":"3.514099807s","start":"2026-08-14T23:14:52.343107Z","end":"2026-08-14T23:14:55.857207Z","steps":["trace[945079587] 'process raft request' (duration: 3.513771469s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:14:55.857305Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:14:52.343069Z","time spent":"3.51419904s","remote":"127.0.0.1:41108","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-14T23:14:55.857524Z","caller":"traceutil/trace.go:171","msg":"trace[1705718164] linearizableReadLoop","detail":"{readStateIndex:1201; appliedIndex:1194; }","duration":"4.111639075s","start":"2026-08-14T23:14:51.745873Z","end":"2026-08-14T23:14:55.857512Z","steps":["trace[1705718164] 'read index received' (duration: 2.424215719s)","trace[1705718164] 'applied index is now lower than readState.Index' (duration: 1.687422516s)"],"step_count":2} {"level":"warn","ts":"2026-08-14T23:14:55.857675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.111793238s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-14T23:14:55.857708Z","caller":"traceutil/trace.go:171","msg":"trace[555517829] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:1151; }","duration":"4.11186398s","start":"2026-08-14T23:14:51.745835Z","end":"2026-08-14T23:14:55.857699Z","steps":["trace[555517829] 'agreement among raft nodes before linearized reading' (duration: 4.111796658s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:14:55.857731Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:14:51.745819Z","time spent":"4.111906411s","remote":"127.0.0.1:43608","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":4,"response size":30,"request content":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true "} {"level":"warn","ts":"2026-08-14T23:14:55.857726Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.766492792s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-14T23:14:55.857758Z","caller":"traceutil/trace.go:171","msg":"trace[1147996378] range","detail":"{range_begin:/registry/roles/; range_end:/registry/roles0; response_count:0; response_revision:1151; }","duration":"3.766569524s","start":"2026-08-14T23:14:52.09118Z","end":"2026-08-14T23:14:55.857749Z","steps":["trace[1147996378] 'agreement among raft nodes before linearized reading' (duration: 3.766504693s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:14:55.857789Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:14:52.091159Z","time spent":"3.766620705s","remote":"127.0.0.1:41192","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":17,"response size":30,"request content":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true "} {"level":"info","ts":"2026-08-14T23:14:55.85784Z","caller":"traceutil/trace.go:171","msg":"trace[1228664443] transaction","detail":"{read_only:false; response_revision:1151; number_of_response:1; }","duration":"3.476044882s","start":"2026-08-14T23:14:52.381786Z","end":"2026-08-14T23:14:55.857831Z","steps":["trace[1228664443] 'process raft request' (duration: 3.475374746s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:14:55.857886Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:14:52.381767Z","time spent":"3.476092374s","remote":"127.0.0.1:41108","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-14T23:14:55.858002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.00625ms","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-08-14T23:14:55.858035Z","caller":"traceutil/trace.go:171","msg":"trace[1111174013] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:1151; }","duration":"330.087252ms","start":"2026-08-14T23:14:55.527937Z","end":"2026-08-14T23:14:55.858025Z","steps":["trace[1111174013] 'agreement among raft nodes before linearized reading' (duration: 330.03621ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:14:55.858064Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:14:55.52791Z","time spent":"330.146003ms","remote":"127.0.0.1:42808","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":"warn","ts":"2026-08-14T23:14:55.858099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"719.335174ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T23:14:55.858122Z","caller":"traceutil/trace.go:171","msg":"trace[1718564764] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:1151; }","duration":"719.420917ms","start":"2026-08-14T23:14:55.138694Z","end":"2026-08-14T23:14:55.858115Z","steps":["trace[1718564764] 'agreement among raft nodes before linearized reading' (duration: 719.388496ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:14:55.858143Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:14:55.138678Z","time spent":"719.458827ms","remote":"127.0.0.1:42902","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true "} {"level":"warn","ts":"2026-08-14T23:14:55.8582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.993615451s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-14T23:14:55.858236Z","caller":"traceutil/trace.go:171","msg":"trace[877282339] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:1151; }","duration":"2.993693882s","start":"2026-08-14T23:14:52.864531Z","end":"2026-08-14T23:14:55.858225Z","steps":["trace[877282339] 'agreement among raft nodes before linearized reading' (duration: 2.993641851s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:14:55.858281Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:14:52.864507Z","time spent":"2.993748794s","remote":"127.0.0.1:41298","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":8,"response size":30,"request content":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true "} {"level":"warn","ts":"2026-08-14T23:14:55.858433Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.15337118s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T23:14:55.85846Z","caller":"traceutil/trace.go:171","msg":"trace[1294932199] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:1151; }","duration":"3.153438621s","start":"2026-08-14T23:14:52.705014Z","end":"2026-08-14T23:14:55.858452Z","steps":["trace[1294932199] 'agreement among raft nodes before linearized reading' (duration: 3.15339534s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:14:55.858488Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:14:52.704993Z","time spent":"3.153486973s","remote":"127.0.0.1:42896","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"warn","ts":"2026-08-14T23:14:55.858538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.72440381s","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-08-14T23:14:55.858568Z","caller":"traceutil/trace.go:171","msg":"trace[1427094359] 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:1151; }","duration":"3.724481261s","start":"2026-08-14T23:14:52.134078Z","end":"2026-08-14T23:14:55.858559Z","steps":["trace[1427094359] 'agreement among raft nodes before linearized reading' (duration: 3.72443095s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:14:55.85859Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:14:52.134044Z","time spent":"3.724540213s","remote":"127.0.0.1:42878","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-08-14T23:14:55.858068Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.483069834s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T23:14:55.858685Z","caller":"traceutil/trace.go:171","msg":"trace[1565181831] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:1151; }","duration":"2.483724078s","start":"2026-08-14T23:14:53.37495Z","end":"2026-08-14T23:14:55.858674Z","steps":["trace[1565181831] 'agreement among raft nodes before linearized reading' (duration: 2.483093953s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:14:55.858773Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:14:53.374921Z","time spent":"2.483838652s","remote":"127.0.0.1:42964","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true "} {"level":"warn","ts":"2026-08-14T23:14:55.858886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.233254772s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T23:14:55.858948Z","caller":"traceutil/trace.go:171","msg":"trace[14275420] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1151; }","duration":"1.233359945s","start":"2026-08-14T23:14:54.625574Z","end":"2026-08-14T23:14:55.858934Z","steps":["trace[14275420] 'agreement among raft nodes before linearized reading' (duration: 1.232651508s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:14:55.858988Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:14:54.62556Z","time spent":"1.233421316s","remote":"127.0.0.1:40918","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-14T23:14:55.859058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.511515938s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T23:14:55.859083Z","caller":"traceutil/trace.go:171","msg":"trace[654540851] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1151; }","duration":"1.51156671s","start":"2026-08-14T23:14:54.347509Z","end":"2026-08-14T23:14:55.859076Z","steps":["trace[654540851] 'agreement among raft nodes before linearized reading' (duration: 1.511527099s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:14:55.8591Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:14:54.347496Z","time spent":"1.5116007s","remote":"127.0.0.1:40920","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-14T23:14:55.859154Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.258794155s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-08-14T23:14:55.859252Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.259403308s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-14T23:14:55.859255Z","caller":"traceutil/trace.go:171","msg":"trace[1660549454] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1151; }","duration":"2.258922058s","start":"2026-08-14T23:14:53.600282Z","end":"2026-08-14T23:14:55.859204Z","steps":["trace[1660549454] 'agreement among raft nodes before linearized reading' (duration: 2.258719333s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:14:55.859295Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:14:53.600238Z","time spent":"2.259048201s","remote":"127.0.0.1:41108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-08-14T23:14:55.859363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.126581688s","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-08-14T23:14:55.859388Z","caller":"traceutil/trace.go:171","msg":"trace[881050549] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:1151; }","duration":"2.12664856s","start":"2026-08-14T23:14:53.732733Z","end":"2026-08-14T23:14:55.859381Z","steps":["trace[881050549] 'agreement among raft nodes before linearized reading' (duration: 2.126606799s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:14:55.859407Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:14:53.732687Z","time spent":"2.126715221s","remote":"127.0.0.1:42870","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true "} {"level":"info","ts":"2026-08-14T23:14:55.859419Z","caller":"traceutil/trace.go:171","msg":"trace[161552491] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:1151; }","duration":"2.25947421s","start":"2026-08-14T23:14:53.599798Z","end":"2026-08-14T23:14:55.859272Z","steps":["trace[161552491] 'agreement among raft nodes before linearized reading' (duration: 2.259407949s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:14:55.859451Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:14:53.599778Z","time spent":"2.259663735s","remote":"127.0.0.1:40982","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":17,"response size":30,"request content":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true "} {"level":"info","ts":"2026-08-14T23:15:00.029599Z","caller":"traceutil/trace.go:171","msg":"trace[757025584] linearizableReadLoop","detail":"{readStateIndex:1214; appliedIndex:1213; }","duration":"117.38337ms","start":"2026-08-14T23:14:59.912192Z","end":"2026-08-14T23:15:00.029576Z","steps":["trace[757025584] 'read index received' (duration: 117.168545ms)","trace[757025584] 'applied index is now lower than readState.Index' (duration: 213.755µs)"],"step_count":2} {"level":"info","ts":"2026-08-14T23:15:00.029645Z","caller":"traceutil/trace.go:171","msg":"trace[683312731] transaction","detail":"{read_only:false; response_revision:1163; number_of_response:1; }","duration":"120.70881ms","start":"2026-08-14T23:14:59.908908Z","end":"2026-08-14T23:15:00.029617Z","steps":["trace[683312731] 'process raft request' (duration: 120.484715ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:15:00.029815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.608856ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-08-14T23:15:00.029843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.363324ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-08-14T23:15:00.029878Z","caller":"traceutil/trace.go:171","msg":"trace[875066451] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1163; }","duration":"113.438385ms","start":"2026-08-14T23:14:59.916433Z","end":"2026-08-14T23:15:00.029871Z","steps":["trace[875066451] 'agreement among raft nodes before linearized reading' (duration: 113.323562ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:15:00.029876Z","caller":"traceutil/trace.go:171","msg":"trace[1332253968] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1163; }","duration":"117.682748ms","start":"2026-08-14T23:14:59.91218Z","end":"2026-08-14T23:15:00.029862Z","steps":["trace[1332253968] 'agreement among raft nodes before linearized reading' (duration: 117.503654ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:15:00.029959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.596261ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-08-14T23:15:00.030039Z","caller":"traceutil/trace.go:171","msg":"trace[694210535] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1163; }","duration":"116.723825ms","start":"2026-08-14T23:14:59.913297Z","end":"2026-08-14T23:15:00.030021Z","steps":["trace[694210535] 'agreement among raft nodes before linearized reading' (duration: 116.469299ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:15:00.030369Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.072053ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-08-14T23:15:00.030412Z","caller":"traceutil/trace.go:171","msg":"trace[251176398] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1163; }","duration":"117.116334ms","start":"2026-08-14T23:14:59.913285Z","end":"2026-08-14T23:15:00.030401Z","steps":["trace[251176398] 'agreement among raft nodes before linearized reading' (duration: 116.425707ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:15:10.580522Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1011515524127617608,"retry-timeout":"500ms"} {"level":"info","ts":"2026-08-14T23:15:10.654564Z","caller":"traceutil/trace.go:171","msg":"trace[404283026] transaction","detail":"{read_only:false; response_revision:1195; number_of_response:1; }","duration":"946.942883ms","start":"2026-08-14T23:15:09.707592Z","end":"2026-08-14T23:15:10.654535Z","steps":["trace[404283026] 'process raft request' (duration: 946.444961ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:15:10.654809Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:15:09.70758Z","time spent":"947.078306ms","remote":"127.0.0.1:41108","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-14T23:15:10.960981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.803806ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-14T23:15:10.961077Z","caller":"traceutil/trace.go:171","msg":"trace[1155672186] linearizableReadLoop","detail":"{readStateIndex:1249; appliedIndex:1247; }","duration":"881.661564ms","start":"2026-08-14T23:15:10.079402Z","end":"2026-08-14T23:15:10.961064Z","steps":["trace[1155672186] 'read index received' (duration: 574.895864ms)","trace[1155672186] 'applied index is now lower than readState.Index' (duration: 306.7648ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T23:15:10.961108Z","caller":"traceutil/trace.go:171","msg":"trace[928700709] transaction","detail":"{read_only:false; response_revision:1196; number_of_response:1; }","duration":"902.001393ms","start":"2026-08-14T23:15:10.05908Z","end":"2026-08-14T23:15:10.961081Z","steps":["trace[928700709] 'process raft request' (duration: 688.018412ms)","trace[928700709] 'compare' (duration: 213.702374ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T23:15:10.961217Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:15:10.059051Z","time spent":"902.106976ms","remote":"127.0.0.1:41108","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-14T23:15:10.961271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"804.561891ms","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-08-14T23:15:10.961294Z","caller":"traceutil/trace.go:171","msg":"trace[1199970449] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1196; }","duration":"804.606123ms","start":"2026-08-14T23:15:10.156681Z","end":"2026-08-14T23:15:10.961287Z","steps":["trace[1199970449] 'agreement among raft nodes before linearized reading' (duration: 804.556092ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:15:10.961222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"819.143652ms","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":"warn","ts":"2026-08-14T23:15:10.961326Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:15:10.156651Z","time spent":"804.667874ms","remote":"127.0.0.1:41108","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-08-14T23:15:10.961342Z","caller":"traceutil/trace.go:171","msg":"trace[1361084113] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1196; }","duration":"819.302066ms","start":"2026-08-14T23:15:10.142032Z","end":"2026-08-14T23:15:10.961334Z","steps":["trace[1361084113] 'agreement among raft nodes before linearized reading' (duration: 819.107541ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:15:10.961373Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:15:10.141996Z","time spent":"819.368998ms","remote":"127.0.0.1:41108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-08-14T23:15:10.961526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"804.91246ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-08-14T23:15:10.961559Z","caller":"traceutil/trace.go:171","msg":"trace[2000850682] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1196; }","duration":"804.946921ms","start":"2026-08-14T23:15:10.156604Z","end":"2026-08-14T23:15:10.961551Z","steps":["trace[2000850682] 'agreement among raft nodes before linearized reading' (duration: 804.834618ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:15:10.961577Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:15:10.156471Z","time spent":"805.101034ms","remote":"127.0.0.1:41108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-08-14T23:15:10.961826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"718.76059ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T23:15:10.961927Z","caller":"traceutil/trace.go:171","msg":"trace[264213914] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1196; }","duration":"718.917243ms","start":"2026-08-14T23:15:10.242985Z","end":"2026-08-14T23:15:10.961902Z","steps":["trace[264213914] 'agreement among raft nodes before linearized reading' (duration: 718.173316ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:15:10.961973Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:15:10.242962Z","time spent":"719.002256ms","remote":"127.0.0.1:40918","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-14T23:15:10.964065Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"884.668496ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-08-14T23:15:10.964114Z","caller":"traceutil/trace.go:171","msg":"trace[290005351] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1196; }","duration":"884.708167ms","start":"2026-08-14T23:15:10.079387Z","end":"2026-08-14T23:15:10.964095Z","steps":["trace[290005351] 'agreement among raft nodes before linearized reading' (duration: 881.728856ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:15:10.964135Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:15:10.07933Z","time spent":"884.7995ms","remote":"127.0.0.1:41108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-08-14T23:15:11.283851Z","caller":"traceutil/trace.go:171","msg":"trace[581741150] transaction","detail":"{read_only:false; response_revision:1198; number_of_response:1; }","duration":"314.929696ms","start":"2026-08-14T23:15:10.968887Z","end":"2026-08-14T23:15:11.283817Z","steps":["trace[581741150] 'process raft request' (duration: 261.349029ms)","trace[581741150] 'compare' (duration: 53.26307ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T23:15:11.283993Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:15:10.968866Z","time spent":"315.0585ms","remote":"127.0.0.1:41108","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-14T23:15:11.283834Z","caller":"traceutil/trace.go:171","msg":"trace[1331458810] transaction","detail":"{read_only:false; response_revision:1199; number_of_response:1; }","duration":"314.411505ms","start":"2026-08-14T23:15:10.969387Z","end":"2026-08-14T23:15:11.283799Z","steps":["trace[1331458810] 'process raft request' (duration: 314.312462ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:15:11.284134Z","caller":"traceutil/trace.go:171","msg":"trace[819864266] transaction","detail":"{read_only:false; response_revision:1200; number_of_response:1; }","duration":"314.65329ms","start":"2026-08-14T23:15:10.969469Z","end":"2026-08-14T23:15:11.284122Z","steps":["trace[819864266] 'process raft request' (duration: 314.283552ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:15:11.284244Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:15:10.969381Z","time spent":"314.765754ms","remote":"127.0.0.1:41108","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-14T23:15:11.284279Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:15:10.969455Z","time spent":"314.722973ms","remote":"127.0.0.1:41108","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-08-14T23:15:13.307091Z","caller":"traceutil/trace.go:171","msg":"trace[1166005373] linearizableReadLoop","detail":"{readStateIndex:1256; appliedIndex:1255; }","duration":"260.188322ms","start":"2026-08-14T23:15:13.046884Z","end":"2026-08-14T23:15:13.307072Z","steps":["trace[1166005373] 'read index received' (duration: 259.991587ms)","trace[1166005373] 'applied index is now lower than readState.Index' (duration: 195.665µs)"],"step_count":2} {"level":"info","ts":"2026-08-14T23:15:13.307214Z","caller":"traceutil/trace.go:171","msg":"trace[1038176865] transaction","detail":"{read_only:false; response_revision:1202; number_of_response:1; }","duration":"340.681446ms","start":"2026-08-14T23:15:12.966518Z","end":"2026-08-14T23:15:13.3072Z","steps":["trace[1038176865] 'process raft request' (duration: 340.373689ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:15:13.307319Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:15:12.966494Z","time spent":"340.750818ms","remote":"127.0.0.1:41108","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-14T23:15:13.307581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.685823ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-08-14T23:15:13.307651Z","caller":"traceutil/trace.go:171","msg":"trace[1166832150] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1202; }","duration":"260.764315ms","start":"2026-08-14T23:15:13.046869Z","end":"2026-08-14T23:15:13.307634Z","steps":["trace[1166832150] 'agreement among raft nodes before linearized reading' (duration: 260.632782ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:15:13.484856Z","caller":"traceutil/trace.go:171","msg":"trace[1506563494] transaction","detail":"{read_only:false; response_revision:1203; number_of_response:1; }","duration":"173.383536ms","start":"2026-08-14T23:15:13.31145Z","end":"2026-08-14T23:15:13.484833Z","steps":["trace[1506563494] 'process raft request' (duration: 173.224972ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:15:13.502719Z","caller":"traceutil/trace.go:171","msg":"trace[1030001291] transaction","detail":"{read_only:false; response_revision:1204; number_of_response:1; }","duration":"191.020809ms","start":"2026-08-14T23:15:13.311666Z","end":"2026-08-14T23:15:13.502687Z","steps":["trace[1030001291] 'process raft request' (duration: 190.766313ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:15:13.503079Z","caller":"traceutil/trace.go:171","msg":"trace[533806721] transaction","detail":"{read_only:false; response_revision:1206; number_of_response:1; }","duration":"189.233277ms","start":"2026-08-14T23:15:13.313838Z","end":"2026-08-14T23:15:13.503072Z","steps":["trace[533806721] 'process raft request' (duration: 189.084384ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:15:13.503049Z","caller":"traceutil/trace.go:171","msg":"trace[418625467] transaction","detail":"{read_only:false; response_revision:1205; number_of_response:1; }","duration":"190.342384ms","start":"2026-08-14T23:15:13.312653Z","end":"2026-08-14T23:15:13.502996Z","steps":["trace[418625467] 'process raft request' (duration: 189.889062ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:15:15.529884Z","caller":"traceutil/trace.go:171","msg":"trace[1971956457] transaction","detail":"{read_only:false; response_revision:1208; number_of_response:1; }","duration":"218.883558ms","start":"2026-08-14T23:15:15.310977Z","end":"2026-08-14T23:15:15.52986Z","steps":["trace[1971956457] 'process raft request' (duration: 218.440968ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:15:15.66859Z","caller":"traceutil/trace.go:171","msg":"trace[425183118] transaction","detail":"{read_only:false; response_revision:1210; number_of_response:1; }","duration":"134.095422ms","start":"2026-08-14T23:15:15.534476Z","end":"2026-08-14T23:15:15.668572Z","steps":["trace[425183118] 'process raft request' (duration: 133.99524ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:15:15.66895Z","caller":"traceutil/trace.go:171","msg":"trace[1762507509] transaction","detail":"{read_only:false; response_revision:1211; number_of_response:1; }","duration":"132.174746ms","start":"2026-08-14T23:15:15.536766Z","end":"2026-08-14T23:15:15.668941Z","steps":["trace[1762507509] 'process raft request' (duration: 131.781537ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:15:15.668924Z","caller":"traceutil/trace.go:171","msg":"trace[1181885793] transaction","detail":"{read_only:false; response_revision:1212; number_of_response:1; }","duration":"132.148816ms","start":"2026-08-14T23:15:15.536759Z","end":"2026-08-14T23:15:15.668908Z","steps":["trace[1181885793] 'process raft request' (duration: 131.989952ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:15:16.460971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.048077ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-14T23:15:16.461136Z","caller":"traceutil/trace.go:171","msg":"trace[98468646] linearizableReadLoop","detail":"{readStateIndex:1268; appliedIndex:1266; }","duration":"297.336915ms","start":"2026-08-14T23:15:16.163784Z","end":"2026-08-14T23:15:16.461121Z","steps":["trace[98468646] 'read index received' (duration: 22.061072ms)","trace[98468646] 'applied index is now lower than readState.Index' (duration: 275.275003ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T23:15:16.461259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.535868ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T23:15:16.461296Z","caller":"traceutil/trace.go:171","msg":"trace[161205450] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1214; }","duration":"220.61369ms","start":"2026-08-14T23:15:16.240673Z","end":"2026-08-14T23:15:16.461287Z","steps":["trace[161205450] 'agreement among raft nodes before linearized reading' (duration: 220.559328ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:15:16.461279Z","caller":"traceutil/trace.go:171","msg":"trace[420228128] transaction","detail":"{read_only:false; response_revision:1213; number_of_response:1; }","duration":"787.902631ms","start":"2026-08-14T23:15:15.673344Z","end":"2026-08-14T23:15:16.461247Z","steps":["trace[420228128] 'process raft request' (duration: 512.488594ms)","trace[420228128] 'compare' (duration: 274.867563ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T23:15:16.461308Z","caller":"traceutil/trace.go:171","msg":"trace[1442102054] transaction","detail":"{read_only:false; response_revision:1214; number_of_response:1; }","duration":"400.502975ms","start":"2026-08-14T23:15:16.060789Z","end":"2026-08-14T23:15:16.461292Z","steps":["trace[1442102054] 'process raft request' (duration: 400.270728ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:15:16.461318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.5129ms","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-08-14T23:15:16.4614Z","caller":"traceutil/trace.go:171","msg":"trace[22856588] 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:1214; }","duration":"297.615052ms","start":"2026-08-14T23:15:16.163768Z","end":"2026-08-14T23:15:16.461383Z","steps":["trace[22856588] 'agreement among raft nodes before linearized reading' (duration: 297.459418ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:15:16.461401Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:15:16.060765Z","time spent":"400.593447ms","remote":"127.0.0.1:41108","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-14T23:15:16.461441Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:15:15.673318Z","time spent":"788.040063ms","remote":"127.0.0.1:41108","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-14T23:15:18.487063Z","caller":"traceutil/trace.go:171","msg":"trace[153093443] linearizableReadLoop","detail":"{readStateIndex:1290; appliedIndex:1289; }","duration":"253.347644ms","start":"2026-08-14T23:15:18.2337Z","end":"2026-08-14T23:15:18.487048Z","steps":["trace[153093443] 'read index received' (duration: 253.19021ms)","trace[153093443] 'applied index is now lower than readState.Index' (duration: 156.864µs)"],"step_count":2} {"level":"info","ts":"2026-08-14T23:15:18.487272Z","caller":"traceutil/trace.go:171","msg":"trace[1691011715] transaction","detail":"{read_only:false; response_revision:1235; number_of_response:1; }","duration":"285.34055ms","start":"2026-08-14T23:15:18.201914Z","end":"2026-08-14T23:15:18.487255Z","steps":["trace[1691011715] 'process raft request' (duration: 285.037043ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:15:18.487471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.766564ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/ceph-csi-rbd-nodeplugin-879xj\" ","response":"range_response_count:1 size:11057"} {"level":"info","ts":"2026-08-14T23:15:18.4875Z","caller":"traceutil/trace.go:171","msg":"trace[1406023199] range","detail":"{range_begin:/registry/pods/kube-system/ceph-csi-rbd-nodeplugin-879xj; range_end:; response_count:1; response_revision:1235; }","duration":"253.805415ms","start":"2026-08-14T23:15:18.233688Z","end":"2026-08-14T23:15:18.487493Z","steps":["trace[1406023199] 'agreement among raft nodes before linearized reading' (duration: 253.708473ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:15:18.487663Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.730584ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T23:15:18.487738Z","caller":"traceutil/trace.go:171","msg":"trace[1210921577] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1235; }","duration":"248.833716ms","start":"2026-08-14T23:15:18.238887Z","end":"2026-08-14T23:15:18.487721Z","steps":["trace[1210921577] 'agreement among raft nodes before linearized reading' (duration: 248.703693ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:15:19.866888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.466133ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-08-14T23:15:19.867106Z","caller":"traceutil/trace.go:171","msg":"trace[1879021813] linearizableReadLoop","detail":"{readStateIndex:1304; appliedIndex:1302; }","duration":"240.173451ms","start":"2026-08-14T23:15:19.626917Z","end":"2026-08-14T23:15:19.86709Z","steps":["trace[1879021813] 'read index received' (duration: 25.419422ms)","trace[1879021813] 'applied index is now lower than readState.Index' (duration: 214.753139ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T23:15:19.867198Z","caller":"traceutil/trace.go:171","msg":"trace[196261905] transaction","detail":"{read_only:false; response_revision:1249; number_of_response:1; }","duration":"289.54465ms","start":"2026-08-14T23:15:19.577644Z","end":"2026-08-14T23:15:19.867188Z","steps":["trace[196261905] 'process raft request' (duration: 289.347095ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:15:19.867296Z","caller":"traceutil/trace.go:171","msg":"trace[2015511127] transaction","detail":"{read_only:false; response_revision:1248; number_of_response:1; }","duration":"291.727022ms","start":"2026-08-14T23:15:19.575539Z","end":"2026-08-14T23:15:19.867266Z","steps":["trace[2015511127] 'process raft request' (duration: 76.812888ms)","trace[2015511127] 'compare' (duration: 214.024193ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T23:15:19.867492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.56492ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-08-14T23:15:19.867549Z","caller":"traceutil/trace.go:171","msg":"trace[213686040] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1249; }","duration":"240.647263ms","start":"2026-08-14T23:15:19.626875Z","end":"2026-08-14T23:15:19.867522Z","steps":["trace[213686040] 'agreement among raft nodes before linearized reading' (duration: 240.507909ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:15:19.867816Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.605842ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-08-14T23:15:19.867881Z","caller":"traceutil/trace.go:171","msg":"trace[1452028529] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1249; }","duration":"185.714105ms","start":"2026-08-14T23:15:19.682152Z","end":"2026-08-14T23:15:19.867866Z","steps":["trace[1452028529] 'agreement among raft nodes before linearized reading' (duration: 185.5378ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:15:19.86793Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.001317ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-08-14T23:15:19.867974Z","caller":"traceutil/trace.go:171","msg":"trace[1021588546] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1249; }","duration":"185.053978ms","start":"2026-08-14T23:15:19.68291Z","end":"2026-08-14T23:15:19.867964Z","steps":["trace[1021588546] 'agreement among raft nodes before linearized reading' (duration: 184.951255ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:15:19.868097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.856568ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-08-14T23:15:19.868134Z","caller":"traceutil/trace.go:171","msg":"trace[1722463589] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1249; }","duration":"185.923909ms","start":"2026-08-14T23:15:19.682201Z","end":"2026-08-14T23:15:19.868125Z","steps":["trace[1722463589] 'agreement among raft nodes before linearized reading' (duration: 185.830086ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:15:23.67367Z","caller":"traceutil/trace.go:171","msg":"trace[121658663] transaction","detail":"{read_only:false; response_revision:1276; number_of_response:1; }","duration":"120.855877ms","start":"2026-08-14T23:15:23.552793Z","end":"2026-08-14T23:15:23.673649Z","steps":["trace[121658663] 'process raft request' (duration: 120.754065ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:15:55.774382Z","caller":"traceutil/trace.go:171","msg":"trace[1203475429] transaction","detail":"{read_only:false; response_revision:1439; number_of_response:1; }","duration":"574.954423ms","start":"2026-08-14T23:15:55.199405Z","end":"2026-08-14T23:15:55.77436Z","steps":["trace[1203475429] 'process raft request' (duration: 574.83153ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:15:55.774519Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:15:55.199394Z","time spent":"575.052345ms","remote":"127.0.0.1:41108","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":458,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-14T23:15:56.62466Z","caller":"traceutil/trace.go:171","msg":"trace[850576666] transaction","detail":"{read_only:false; response_revision:1440; number_of_response:1; }","duration":"1.423182094s","start":"2026-08-14T23:15:55.201427Z","end":"2026-08-14T23:15:56.624609Z","steps":["trace[850576666] 'process raft request' (duration: 1.420569181s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:15:56.625098Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:15:55.20142Z","time spent":"1.423594234s","remote":"127.0.0.1:41108","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-14T23:15:56.624727Z","caller":"traceutil/trace.go:171","msg":"trace[880266261] linearizableReadLoop","detail":"{readStateIndex:1502; appliedIndex:1500; }","duration":"1.342534065s","start":"2026-08-14T23:15:55.282162Z","end":"2026-08-14T23:15:56.624696Z","steps":["trace[880266261] 'read index received' (duration: 492.079988ms)","trace[880266261] 'applied index is now lower than readState.Index' (duration: 850.451557ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T23:15:56.624819Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.342645177s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T23:15:56.625299Z","caller":"traceutil/trace.go:171","msg":"trace[1704506993] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:1441; }","duration":"1.34316894s","start":"2026-08-14T23:15:55.282111Z","end":"2026-08-14T23:15:56.62528Z","steps":["trace[1704506993] 'agreement among raft nodes before linearized reading' (duration: 1.342651717s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:15:56.625581Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:15:55.282094Z","time spent":"1.343248822s","remote":"127.0.0.1:41072","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-08-14T23:15:56.625889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"760.957162ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T23:15:56.625934Z","caller":"traceutil/trace.go:171","msg":"trace[1124867453] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1441; }","duration":"761.032674ms","start":"2026-08-14T23:15:55.864892Z","end":"2026-08-14T23:15:56.625925Z","steps":["trace[1124867453] 'agreement among raft nodes before linearized reading' (duration: 760.955922ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:15:56.625964Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:15:55.864875Z","time spent":"761.081495ms","remote":"127.0.0.1:40918","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-08-14T23:15:56.624763Z","caller":"traceutil/trace.go:171","msg":"trace[587669078] transaction","detail":"{read_only:false; response_revision:1441; number_of_response:1; }","duration":"832.978699ms","start":"2026-08-14T23:15:55.791748Z","end":"2026-08-14T23:15:56.624726Z","steps":["trace[587669078] 'process raft request' (duration: 832.849806ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:15:56.62616Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:15:55.791708Z","time spent":"834.360813ms","remote":"127.0.0.1:41108","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-14T23:15:56.626667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.059742ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-08-14T23:15:56.626746Z","caller":"traceutil/trace.go:171","msg":"trace[2133608674] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1441; }","duration":"330.130954ms","start":"2026-08-14T23:15:56.296599Z","end":"2026-08-14T23:15:56.62673Z","steps":["trace[2133608674] 'agreement among raft nodes before linearized reading' (duration: 330.004571ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:15:56.626781Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:15:56.296577Z","time spent":"330.196005ms","remote":"127.0.0.1:41108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":531,"request content":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-08-14T23:15:56.626539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.979851ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.22\" ","response":"range_response_count:1 size:133"} {"level":"warn","ts":"2026-08-14T23:15:56.626941Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"386.191329ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T23:15:56.626978Z","caller":"traceutil/trace.go:171","msg":"trace[341609020] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1441; }","duration":"386.271741ms","start":"2026-08-14T23:15:56.240697Z","end":"2026-08-14T23:15:56.626969Z","steps":["trace[341609020] 'agreement among raft nodes before linearized reading' (duration: 386.21902ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:15:56.627012Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:15:56.240672Z","time spent":"386.333323ms","remote":"127.0.0.1:40920","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-14T23:15:56.627224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"465.050284ms","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-08-14T23:15:56.627259Z","caller":"traceutil/trace.go:171","msg":"trace[285808504] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1441; }","duration":"465.150797ms","start":"2026-08-14T23:15:56.162098Z","end":"2026-08-14T23:15:56.627249Z","steps":["trace[285808504] 'agreement among raft nodes before linearized reading' (duration: 465.039843ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:15:56.627284Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:15:56.162052Z","time spent":"465.225589ms","remote":"127.0.0.1:41108","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-08-14T23:15:56.627432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"479.899077ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-08-14T23:15:56.627463Z","caller":"traceutil/trace.go:171","msg":"trace[17913600] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1441; }","duration":"479.952148ms","start":"2026-08-14T23:15:56.147502Z","end":"2026-08-14T23:15:56.627454Z","steps":["trace[17913600] 'agreement among raft nodes before linearized reading' (duration: 479.844295ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:15:56.627492Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:15:56.147487Z","time spent":"479.998779ms","remote":"127.0.0.1:41108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-08-14T23:15:56.627721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"487.41721ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-08-14T23:15:56.627811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"491.668603ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-08-14T23:15:56.627821Z","caller":"traceutil/trace.go:171","msg":"trace[956997194] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1441; }","duration":"487.565683ms","start":"2026-08-14T23:15:56.14024Z","end":"2026-08-14T23:15:56.627806Z","steps":["trace[956997194] 'agreement among raft nodes before linearized reading' (duration: 487.310317ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:15:56.627851Z","caller":"traceutil/trace.go:171","msg":"trace[24584961] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1441; }","duration":"491.760276ms","start":"2026-08-14T23:15:56.136081Z","end":"2026-08-14T23:15:56.627842Z","steps":["trace[24584961] 'agreement among raft nodes before linearized reading' (duration: 491.664634ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:15:56.627877Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:15:56.140219Z","time spent":"487.649855ms","remote":"127.0.0.1:41108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-08-14T23:15:56.627882Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:15:56.136051Z","time spent":"491.825407ms","remote":"127.0.0.1:41108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-08-14T23:15:56.626589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.202309ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T23:15:56.62807Z","caller":"traceutil/trace.go:171","msg":"trace[2074645122] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:1441; }","duration":"307.708166ms","start":"2026-08-14T23:15:56.320351Z","end":"2026-08-14T23:15:56.628059Z","steps":["trace[2074645122] 'agreement among raft nodes before linearized reading' (duration: 306.206879ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:15:56.628115Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:15:56.320336Z","time spent":"307.755797ms","remote":"127.0.0.1:43634","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true "} {"level":"info","ts":"2026-08-14T23:15:56.627021Z","caller":"traceutil/trace.go:171","msg":"trace[1744702444] range","detail":"{range_begin:/registry/masterleases/199.204.45.22; range_end:; response_count:1; response_revision:1441; }","duration":"253.436912ms","start":"2026-08-14T23:15:56.373524Z","end":"2026-08-14T23:15:56.626961Z","steps":["trace[1744702444] 'agreement among raft nodes before linearized reading' (duration: 252.94662ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:15:57.847451Z","caller":"traceutil/trace.go:171","msg":"trace[136225584] transaction","detail":"{read_only:false; response_revision:1450; number_of_response:1; }","duration":"167.6479ms","start":"2026-08-14T23:15:57.679779Z","end":"2026-08-14T23:15:57.847427Z","steps":["trace[136225584] 'process raft request' (duration: 167.503876ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:16:28.999467Z","caller":"traceutil/trace.go:171","msg":"trace[2072196417] transaction","detail":"{read_only:false; response_revision:1591; number_of_response:1; }","duration":"120.887249ms","start":"2026-08-14T23:16:28.878546Z","end":"2026-08-14T23:16:28.999434Z","steps":["trace[2072196417] 'process raft request' (duration: 120.815627ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:16:28.999528Z","caller":"traceutil/trace.go:171","msg":"trace[1905933504] transaction","detail":"{read_only:false; response_revision:1590; number_of_response:1; }","duration":"120.93514ms","start":"2026-08-14T23:16:28.87856Z","end":"2026-08-14T23:16:28.999496Z","steps":["trace[1905933504] 'process raft request' (duration: 120.632183ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:16:29.019665Z","caller":"traceutil/trace.go:171","msg":"trace[1958988558] linearizableReadLoop","detail":"{readStateIndex:1661; appliedIndex:1658; }","duration":"112.119625ms","start":"2026-08-14T23:16:28.907517Z","end":"2026-08-14T23:16:29.019636Z","steps":["trace[1958988558] 'read index received' (duration: 91.707457ms)","trace[1958988558] 'applied index is now lower than readState.Index' (duration: 20.410628ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T23:16:29.019815Z","caller":"traceutil/trace.go:171","msg":"trace[409826997] transaction","detail":"{read_only:false; response_revision:1592; number_of_response:1; }","duration":"141.220955ms","start":"2026-08-14T23:16:28.878575Z","end":"2026-08-14T23:16:29.019796Z","steps":["trace[409826997] 'process raft request' (duration: 140.942377ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:16:29.020056Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.442686ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-08-14T23:16:29.020124Z","caller":"traceutil/trace.go:171","msg":"trace[219302114] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1592; }","duration":"108.532088ms","start":"2026-08-14T23:16:28.911574Z","end":"2026-08-14T23:16:29.020106Z","steps":["trace[219302114] 'agreement among raft nodes before linearized reading' (duration: 108.338373ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:16:29.02041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.668521ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-08-14T23:16:29.020479Z","caller":"traceutil/trace.go:171","msg":"trace[1693605011] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1592; }","duration":"108.798654ms","start":"2026-08-14T23:16:28.911663Z","end":"2026-08-14T23:16:29.020461Z","steps":["trace[1693605011] 'agreement among raft nodes before linearized reading' (duration: 108.305122ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:16:29.020623Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.089608ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:532"} {"level":"info","ts":"2026-08-14T23:16:29.020764Z","caller":"traceutil/trace.go:171","msg":"trace[605121182] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1592; }","duration":"113.267194ms","start":"2026-08-14T23:16:28.90748Z","end":"2026-08-14T23:16:29.020748Z","steps":["trace[605121182] 'agreement among raft nodes before linearized reading' (duration: 112.436064ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:16:29.142076Z","caller":"traceutil/trace.go:171","msg":"trace[2110623115] transaction","detail":"{read_only:false; response_revision:1595; number_of_response:1; }","duration":"113.436727ms","start":"2026-08-14T23:16:29.028623Z","end":"2026-08-14T23:16:29.14206Z","steps":["trace[2110623115] 'process raft request' (duration: 113.359805ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:16:29.14207Z","caller":"traceutil/trace.go:171","msg":"trace[820902672] transaction","detail":"{read_only:false; response_revision:1594; number_of_response:1; }","duration":"113.446886ms","start":"2026-08-14T23:16:29.028597Z","end":"2026-08-14T23:16:29.142044Z","steps":["trace[820902672] 'process raft request' (duration: 71.876972ms)","trace[820902672] 'compare' (duration: 41.41597ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T23:17:21.880423Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1011515524127619082,"retry-timeout":"500ms"} {"level":"info","ts":"2026-08-14T23:17:21.944601Z","caller":"traceutil/trace.go:171","msg":"trace[296418376] linearizableReadLoop","detail":"{readStateIndex:1908; appliedIndex:1905; }","duration":"697.043382ms","start":"2026-08-14T23:17:21.24754Z","end":"2026-08-14T23:17:21.944584Z","steps":["trace[296418376] 'read index received' (duration: 695.632218ms)","trace[296418376] 'applied index is now lower than readState.Index' (duration: 1.410504ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T23:17:21.94487Z","caller":"traceutil/trace.go:171","msg":"trace[1863890513] transaction","detail":"{read_only:false; response_revision:1827; number_of_response:1; }","duration":"736.501105ms","start":"2026-08-14T23:17:21.208361Z","end":"2026-08-14T23:17:21.944862Z","steps":["trace[1863890513] 'process raft request' (duration: 734.867436ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:17:21.944947Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:17:21.20835Z","time spent":"736.543116ms","remote":"127.0.0.1:41108","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-14T23:17:21.945072Z","caller":"traceutil/trace.go:171","msg":"trace[219959790] transaction","detail":"{read_only:false; response_revision:1828; number_of_response:1; }","duration":"735.623113ms","start":"2026-08-14T23:17:21.209443Z","end":"2026-08-14T23:17:21.945066Z","steps":["trace[219959790] 'process raft request' (duration: 733.897392ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:17:21.945107Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:17:21.209425Z","time spent":"735.664023ms","remote":"127.0.0.1:41108","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":459,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-14T23:17:21.945268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"695.253428ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-08-14T23:17:21.94532Z","caller":"traceutil/trace.go:171","msg":"trace[1516006999] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1828; }","duration":"695.345201ms","start":"2026-08-14T23:17:21.249963Z","end":"2026-08-14T23:17:21.945308Z","steps":["trace[1516006999] 'agreement among raft nodes before linearized reading' (duration: 695.188197ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:17:21.945345Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:17:21.24995Z","time spent":"695.390041ms","remote":"127.0.0.1:41108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-08-14T23:17:21.945451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"697.916763ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-08-14T23:17:21.945473Z","caller":"traceutil/trace.go:171","msg":"trace[460348332] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1828; }","duration":"697.971095ms","start":"2026-08-14T23:17:21.247495Z","end":"2026-08-14T23:17:21.945467Z","steps":["trace[460348332] 'agreement among raft nodes before linearized reading' (duration: 697.921833ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:17:21.945488Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:17:21.247477Z","time spent":"698.005446ms","remote":"127.0.0.1:41108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-08-14T23:17:21.94549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"551.076471ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:532"} {"level":"info","ts":"2026-08-14T23:17:21.94551Z","caller":"traceutil/trace.go:171","msg":"trace[1721809153] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1828; }","duration":"551.120912ms","start":"2026-08-14T23:17:21.394384Z","end":"2026-08-14T23:17:21.945505Z","steps":["trace[1721809153] 'agreement among raft nodes before linearized reading' (duration: 551.068601ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:17:21.945529Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:17:21.394367Z","time spent":"551.158193ms","remote":"127.0.0.1:41108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":555,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "} {"level":"warn","ts":"2026-08-14T23:17:21.945603Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"552.344793ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-08-14T23:17:21.945619Z","caller":"traceutil/trace.go:171","msg":"trace[1653253526] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1828; }","duration":"552.401314ms","start":"2026-08-14T23:17:21.393213Z","end":"2026-08-14T23:17:21.945614Z","steps":["trace[1653253526] 'agreement among raft nodes before linearized reading' (duration: 552.359453ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:17:21.945631Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:17:21.393187Z","time spent":"552.441444ms","remote":"127.0.0.1:41108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-08-14T23:17:21.945696Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"670.475674ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-08-14T23:17:21.945707Z","caller":"traceutil/trace.go:171","msg":"trace[612864869] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1828; }","duration":"670.524065ms","start":"2026-08-14T23:17:21.275179Z","end":"2026-08-14T23:17:21.945703Z","steps":["trace[612864869] 'agreement among raft nodes before linearized reading' (duration: 670.486964ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:17:21.945723Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:17:21.275163Z","time spent":"670.553495ms","remote":"127.0.0.1:41108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-08-14T23:17:21.945781Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"673.705792ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-08-14T23:17:21.945804Z","caller":"traceutil/trace.go:171","msg":"trace[1638858150] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1828; }","duration":"673.761214ms","start":"2026-08-14T23:17:21.272039Z","end":"2026-08-14T23:17:21.9458Z","steps":["trace[1638858150] 'agreement among raft nodes before linearized reading' (duration: 673.715352ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:17:21.945816Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:17:21.272018Z","time spent":"673.795145ms","remote":"127.0.0.1:41108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-08-14T23:17:22.522679Z","caller":"traceutil/trace.go:171","msg":"trace[1362554474] transaction","detail":"{read_only:false; response_revision:1829; number_of_response:1; }","duration":"573.360374ms","start":"2026-08-14T23:17:21.949293Z","end":"2026-08-14T23:17:22.522654Z","steps":["trace[1362554474] 'process raft request' (duration: 573.213631ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:17:22.522836Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:17:21.949279Z","time spent":"573.489408ms","remote":"127.0.0.1:41108","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-14T23:17:22.52796Z","caller":"traceutil/trace.go:171","msg":"trace[1261135858] transaction","detail":"{read_only:false; response_revision:1830; number_of_response:1; }","duration":"564.350855ms","start":"2026-08-14T23:17:21.963589Z","end":"2026-08-14T23:17:22.52794Z","steps":["trace[1261135858] 'process raft request' (duration: 564.176671ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:17:22.528099Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:17:21.963571Z","time spent":"564.450617ms","remote":"127.0.0.1:41108","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":517,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-14T23:17:22.52824Z","caller":"traceutil/trace.go:171","msg":"trace[1874330301] transaction","detail":"{read_only:false; response_revision:1831; number_of_response:1; }","duration":"564.55263ms","start":"2026-08-14T23:17:21.963661Z","end":"2026-08-14T23:17:22.528214Z","steps":["trace[1874330301] 'process raft request' (duration: 564.242342ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:17:22.528354Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:17:21.963657Z","time spent":"564.647042ms","remote":"127.0.0.1:41108","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-14T23:17:22.528736Z","caller":"traceutil/trace.go:171","msg":"trace[1055352561] transaction","detail":"{read_only:false; response_revision:1832; number_of_response:1; }","duration":"564.995992ms","start":"2026-08-14T23:17:21.963728Z","end":"2026-08-14T23:17:22.528724Z","steps":["trace[1055352561] 'process raft request' (duration: 564.397877ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:17:22.528828Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:17:21.963723Z","time spent":"565.067314ms","remote":"127.0.0.1:41108","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-14T23:17:22.529154Z","caller":"traceutil/trace.go:171","msg":"trace[2069361902] transaction","detail":"{read_only:false; response_revision:1833; number_of_response:1; }","duration":"565.387661ms","start":"2026-08-14T23:17:21.963756Z","end":"2026-08-14T23:17:22.529144Z","steps":["trace[2069361902] 'process raft request' (duration: 564.92744ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:17:22.529208Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:17:21.963752Z","time spent":"565.430872ms","remote":"127.0.0.1:41108","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-08-14T23:17:22.529344Z","caller":"traceutil/trace.go:171","msg":"trace[87759611] transaction","detail":"{read_only:false; response_revision:1834; number_of_response:1; }","duration":"431.129796ms","start":"2026-08-14T23:17:22.098197Z","end":"2026-08-14T23:17:22.529327Z","steps":["trace[87759611] 'process raft request' (duration: 430.907981ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:17:22.529487Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:17:22.09818Z","time spent":"431.224448ms","remote":"127.0.0.1:41108","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-08-14T23:17:22.529693Z","caller":"traceutil/trace.go:171","msg":"trace[943885784] transaction","detail":"{read_only:false; response_revision:1835; number_of_response:1; }","duration":"428.108283ms","start":"2026-08-14T23:17:22.101562Z","end":"2026-08-14T23:17:22.529671Z","steps":["trace[943885784] 'process raft request' (duration: 427.702593ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:17:22.529871Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:17:22.101535Z","time spent":"428.228305ms","remote":"127.0.0.1:41108","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":493,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-14T23:17:22.530041Z","caller":"traceutil/trace.go:171","msg":"trace[629722960] linearizableReadLoop","detail":"{readStateIndex:1913; appliedIndex:1908; }","duration":"469.719117ms","start":"2026-08-14T23:17:22.060304Z","end":"2026-08-14T23:17:22.530023Z","steps":["trace[629722960] 'read index received' (duration: 462.232024ms)","trace[629722960] 'applied index is now lower than readState.Index' (duration: 7.485873ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T23:17:22.530198Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"469.888551ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T23:17:22.53024Z","caller":"traceutil/trace.go:171","msg":"trace[333936616] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:1836; }","duration":"469.975713ms","start":"2026-08-14T23:17:22.060254Z","end":"2026-08-14T23:17:22.53023Z","steps":["trace[333936616] 'agreement among raft nodes before linearized reading' (duration: 469.909592ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:17:22.53027Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:17:22.060234Z","time spent":"470.027515ms","remote":"127.0.0.1:41004","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":0,"response size":28,"request content":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true "} {"level":"warn","ts":"2026-08-14T23:17:22.53038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.93735ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T23:17:22.530414Z","caller":"traceutil/trace.go:171","msg":"trace[39172865] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1836; }","duration":"292.005732ms","start":"2026-08-14T23:17:22.2384Z","end":"2026-08-14T23:17:22.530406Z","steps":["trace[39172865] 'agreement among raft nodes before linearized reading' (duration: 291.849929ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:18:45.041507Z","caller":"traceutil/trace.go:171","msg":"trace[1879767220] linearizableReadLoop","detail":"{readStateIndex:2343; appliedIndex:2341; }","duration":"103.085255ms","start":"2026-08-14T23:18:44.938403Z","end":"2026-08-14T23:18:45.041488Z","steps":["trace[1879767220] 'read index received' (duration: 82.112216ms)","trace[1879767220] 'applied index is now lower than readState.Index' (duration: 20.971918ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T23:18:45.041593Z","caller":"traceutil/trace.go:171","msg":"trace[1070199944] transaction","detail":"{read_only:false; response_revision:2246; number_of_response:1; }","duration":"103.347591ms","start":"2026-08-14T23:18:44.938216Z","end":"2026-08-14T23:18:45.041564Z","steps":["trace[1070199944] 'process raft request' (duration: 103.174307ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:18:45.04177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.350611ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/envoy-gateway-system/\" range_end:\"/registry/events/envoy-gateway-system0\" limit:500 ","response":"range_response_count:15 size:12285"} {"level":"info","ts":"2026-08-14T23:18:45.041813Z","caller":"traceutil/trace.go:171","msg":"trace[881262494] range","detail":"{range_begin:/registry/events/envoy-gateway-system/; range_end:/registry/events/envoy-gateway-system0; response_count:15; response_revision:2246; }","duration":"103.424733ms","start":"2026-08-14T23:18:44.938377Z","end":"2026-08-14T23:18:45.041802Z","steps":["trace[881262494] 'agreement among raft nodes before linearized reading' (duration: 103.221988ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:18:45.164675Z","caller":"traceutil/trace.go:171","msg":"trace[644593216] transaction","detail":"{read_only:false; response_revision:2247; number_of_response:1; }","duration":"117.832888ms","start":"2026-08-14T23:18:45.046659Z","end":"2026-08-14T23:18:45.164492Z","steps":["trace[644593216] 'process raft request' (duration: 117.673484ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:18:45.16584Z","caller":"traceutil/trace.go:171","msg":"trace[1551990886] linearizableReadLoop","detail":"{readStateIndex:2345; appliedIndex:2343; }","duration":"118.652368ms","start":"2026-08-14T23:18:45.047155Z","end":"2026-08-14T23:18:45.165807Z","steps":["trace[1551990886] 'read index received' (duration: 117.237994ms)","trace[1551990886] 'applied index is now lower than readState.Index' (duration: 1.413514ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T23:18:45.165916Z","caller":"traceutil/trace.go:171","msg":"trace[653445484] transaction","detail":"{read_only:false; response_revision:2248; number_of_response:1; }","duration":"119.16588ms","start":"2026-08-14T23:18:45.046731Z","end":"2026-08-14T23:18:45.165897Z","steps":["trace[653445484] 'process raft request' (duration: 118.971846ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:18:45.166052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.878634ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/envoy-gateway-system/envoy-gateway\" ","response":"range_response_count:1 size:1120"} {"level":"info","ts":"2026-08-14T23:18:45.166094Z","caller":"traceutil/trace.go:171","msg":"trace[597005971] range","detail":"{range_begin:/registry/services/endpoints/envoy-gateway-system/envoy-gateway; range_end:; response_count:1; response_revision:2248; }","duration":"118.960225ms","start":"2026-08-14T23:18:45.047122Z","end":"2026-08-14T23:18:45.166082Z","steps":["trace[597005971] 'agreement among raft nodes before linearized reading' (duration: 118.814681ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:19:04.414387Z","caller":"traceutil/trace.go:171","msg":"trace[1101857713] transaction","detail":"{read_only:false; response_revision:2333; number_of_response:1; }","duration":"119.55204ms","start":"2026-08-14T23:19:04.294812Z","end":"2026-08-14T23:19:04.414364Z","steps":["trace[1101857713] 'process raft request' (duration: 119.169911ms)"],"step_count":1}