{"level":"warn","ts":"2026-06-28T19:57:41.882601Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-28T19:57:41.882745Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.177: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.177:2380","--initial-cluster=instance=https://199.204.45.177:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.177:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.177: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-06-28T19:57:41.88284Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-28T19:57:41.882859Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.177:2380"]} {"level":"info","ts":"2026-06-28T19:57:41.882887Z","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-06-28T19:57:41.883744Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.177:2379"]} {"level":"info","ts":"2026-06-28T19:57:41.883855Z","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.177:2380"],"listen-peer-urls":["https://199.204.45.177:2380"],"advertise-client-urls":["https://199.204.45.177:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.177:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.177: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-06-28T19:57:41.888205Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.067759ms"} {"level":"info","ts":"2026-06-28T19:57:41.894443Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"7c53a18098324dc9","cluster-id":"4717e8aa221973c8"} {"level":"info","ts":"2026-06-28T19:57:41.895358Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7c53a18098324dc9 switched to configuration voters=()"} {"level":"info","ts":"2026-06-28T19:57:41.895423Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7c53a18098324dc9 became follower at term 0"} {"level":"info","ts":"2026-06-28T19:57:41.895442Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 7c53a18098324dc9 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-28T19:57:41.895452Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7c53a18098324dc9 became follower at term 1"} {"level":"info","ts":"2026-06-28T19:57:41.895618Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7c53a18098324dc9 switched to configuration voters=(8958681657451367881)"} {"level":"warn","ts":"2026-06-28T19:57:41.901231Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-28T19:57:41.903373Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-28T19:57:41.90444Z","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-06-28T19:57:41.907266Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"7c53a18098324dc9","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-28T19:57:41.907422Z","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-06-28T19:57:41.907537Z","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-06-28T19:57:41.907552Z","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-06-28T19:57:41.907919Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"7c53a18098324dc9","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-28T19:57:41.912881Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7c53a18098324dc9 switched to configuration voters=(8958681657451367881)"} {"level":"info","ts":"2026-06-28T19:57:41.913287Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"4717e8aa221973c8","local-member-id":"7c53a18098324dc9","added-peer-id":"7c53a18098324dc9","added-peer-peer-urls":["https://199.204.45.177:2380"]} {"level":"info","ts":"2026-06-28T19:57:41.918763Z","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-06-28T19:57:41.919079Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"7c53a18098324dc9","initial-advertise-peer-urls":["https://199.204.45.177:2380"],"listen-peer-urls":["https://199.204.45.177:2380"],"advertise-client-urls":["https://199.204.45.177:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.177:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-28T19:57:41.919119Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-28T19:57:41.91925Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.177:2380"} {"level":"info","ts":"2026-06-28T19:57:41.919271Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.177:2380"} {"level":"info","ts":"2026-06-28T19:57:42.19617Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7c53a18098324dc9 is starting a new election at term 1"} {"level":"info","ts":"2026-06-28T19:57:42.196335Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7c53a18098324dc9 became pre-candidate at term 1"} {"level":"info","ts":"2026-06-28T19:57:42.196432Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7c53a18098324dc9 received MsgPreVoteResp from 7c53a18098324dc9 at term 1"} {"level":"info","ts":"2026-06-28T19:57:42.196515Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7c53a18098324dc9 became candidate at term 2"} {"level":"info","ts":"2026-06-28T19:57:42.196557Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7c53a18098324dc9 received MsgVoteResp from 7c53a18098324dc9 at term 2"} {"level":"info","ts":"2026-06-28T19:57:42.196634Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7c53a18098324dc9 became leader at term 2"} {"level":"info","ts":"2026-06-28T19:57:42.196752Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 7c53a18098324dc9 elected leader 7c53a18098324dc9 at term 2"} {"level":"info","ts":"2026-06-28T19:57:42.197728Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-28T19:57:42.198412Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"7c53a18098324dc9","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.177:2379]}","request-path":"/0/members/7c53a18098324dc9/attributes","cluster-id":"4717e8aa221973c8","publish-timeout":"7s"} {"level":"info","ts":"2026-06-28T19:57:42.198471Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-28T19:57:42.198583Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-28T19:57:42.198898Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"4717e8aa221973c8","local-member-id":"7c53a18098324dc9","cluster-version":"3.5"} {"level":"info","ts":"2026-06-28T19:57:42.198915Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-28T19:57:42.199017Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-28T19:57:42.199135Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-28T19:57:42.199237Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-28T19:57:42.200905Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.177:2379"} {"level":"info","ts":"2026-06-28T19:57:42.201336Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-28T19:57:47.548289Z","caller":"traceutil/trace.go:171","msg":"trace[784069546] linearizableReadLoop","detail":"{readStateIndex:241; appliedIndex:239; }","duration":"172.588243ms","start":"2026-06-28T19:57:47.375684Z","end":"2026-06-28T19:57:47.548272Z","steps":["trace[784069546] 'read index received' (duration: 1.760188ms)","trace[784069546] 'applied index is now lower than readState.Index' (duration: 170.827345ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:57:47.548385Z","caller":"traceutil/trace.go:171","msg":"trace[1440510543] transaction","detail":"{read_only:false; response_revision:235; number_of_response:1; }","duration":"171.850223ms","start":"2026-06-28T19:57:47.376526Z","end":"2026-06-28T19:57:47.548376Z","steps":["trace[1440510543] 'process raft request' (duration: 171.677178ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:57:47.548402Z","caller":"traceutil/trace.go:171","msg":"trace[1865038572] transaction","detail":"{read_only:false; response_revision:234; number_of_response:1; }","duration":"172.821689ms","start":"2026-06-28T19:57:47.375552Z","end":"2026-06-28T19:57:47.548373Z","steps":["trace[1865038572] 'process raft request' (duration: 84.818776ms)","trace[1865038572] 'compare' (duration: 87.729965ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:57:47.548508Z","caller":"traceutil/trace.go:171","msg":"trace[516117795] transaction","detail":"{read_only:false; number_of_response:0; response_revision:235; }","duration":"171.857383ms","start":"2026-06-28T19:57:47.376646Z","end":"2026-06-28T19:57:47.548503Z","steps":["trace[516117795] 'process raft request' (duration: 171.598136ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:57:47.548708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.929882ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4017"} {"level":"info","ts":"2026-06-28T19:57:47.548804Z","caller":"traceutil/trace.go:171","msg":"trace[937797309] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:235; }","duration":"173.136167ms","start":"2026-06-28T19:57:47.375657Z","end":"2026-06-28T19:57:47.548793Z","steps":["trace[937797309] 'agreement among raft nodes before linearized reading' (duration: 172.909351ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:57:47.563371Z","caller":"traceutil/trace.go:171","msg":"trace[80446431] transaction","detail":"{read_only:false; response_revision:237; number_of_response:1; }","duration":"185.952251ms","start":"2026-06-28T19:57:47.377397Z","end":"2026-06-28T19:57:47.563349Z","steps":["trace[80446431] 'process raft request' (duration: 185.845378ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:57:47.563397Z","caller":"traceutil/trace.go:171","msg":"trace[393752315] transaction","detail":"{read_only:false; response_revision:236; number_of_response:1; }","duration":"185.979902ms","start":"2026-06-28T19:57:47.377394Z","end":"2026-06-28T19:57:47.563374Z","steps":["trace[393752315] 'process raft request' (duration: 185.755796ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:57:47.563491Z","caller":"traceutil/trace.go:171","msg":"trace[980648275] transaction","detail":"{read_only:false; response_revision:238; number_of_response:1; }","duration":"185.334174ms","start":"2026-06-28T19:57:47.378133Z","end":"2026-06-28T19:57:47.563467Z","steps":["trace[980648275] 'process raft request' (duration: 185.141719ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:58:03.233367Z","caller":"traceutil/trace.go:171","msg":"trace[186241788] transaction","detail":"{read_only:false; response_revision:387; number_of_response:1; }","duration":"103.220502ms","start":"2026-06-28T19:58:03.130116Z","end":"2026-06-28T19:58:03.233336Z","steps":["trace[186241788] 'process raft request' (duration: 103.027547ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:58:07.296106Z","caller":"traceutil/trace.go:171","msg":"trace[2121418979] transaction","detail":"{read_only:false; response_revision:427; number_of_response:1; }","duration":"516.953052ms","start":"2026-06-28T19:58:06.779129Z","end":"2026-06-28T19:58:07.296082Z","steps":["trace[2121418979] 'process raft request' (duration: 516.782678ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:58:07.296866Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:58:06.779105Z","time spent":"517.079766ms","remote":"127.0.0.1:40928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-28T19:58:07.835833Z","caller":"traceutil/trace.go:171","msg":"trace[656477091] linearizableReadLoop","detail":"{readStateIndex:444; appliedIndex:443; }","duration":"102.485242ms","start":"2026-06-28T19:58:07.73332Z","end":"2026-06-28T19:58:07.835805Z","steps":["trace[656477091] 'read index received' (duration: 102.295027ms)","trace[656477091] 'applied index is now lower than readState.Index' (duration: 189.325µs)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:58:07.83588Z","caller":"traceutil/trace.go:171","msg":"trace[1802414243] transaction","detail":"{read_only:false; response_revision:428; number_of_response:1; }","duration":"405.749176ms","start":"2026-06-28T19:58:07.4301Z","end":"2026-06-28T19:58:07.835849Z","steps":["trace[1802414243] 'process raft request' (duration: 405.574822ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:58:07.835988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.657426ms","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-06-28T19:58:07.836024Z","caller":"traceutil/trace.go:171","msg":"trace[1604344279] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:428; }","duration":"102.748389ms","start":"2026-06-28T19:58:07.733264Z","end":"2026-06-28T19:58:07.836013Z","steps":["trace[1604344279] 'agreement among raft nodes before linearized reading' (duration: 102.663556ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:58:07.836036Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:58:07.430075Z","time spent":"405.887429ms","remote":"127.0.0.1:40928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-28T19:58:07.836085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.823088ms","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-06-28T19:58:07.836166Z","caller":"traceutil/trace.go:171","msg":"trace[2126530054] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:428; }","duration":"100.93863ms","start":"2026-06-28T19:58:07.735207Z","end":"2026-06-28T19:58:07.836146Z","steps":["trace[2126530054] 'agreement among raft nodes before linearized reading' (duration: 100.768256ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:58:07.976602Z","caller":"traceutil/trace.go:171","msg":"trace[723633414] transaction","detail":"{read_only:false; response_revision:429; number_of_response:1; }","duration":"137.251536ms","start":"2026-06-28T19:58:07.839324Z","end":"2026-06-28T19:58:07.976576Z","steps":["trace[723633414] 'process raft request' (duration: 137.114352ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:58:08.032671Z","caller":"traceutil/trace.go:171","msg":"trace[1074458841] transaction","detail":"{read_only:false; response_revision:430; number_of_response:1; }","duration":"192.52771ms","start":"2026-06-28T19:58:07.84012Z","end":"2026-06-28T19:58:08.032648Z","steps":["trace[1074458841] 'process raft request' (duration: 192.427368ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:58:12.86091Z","caller":"traceutil/trace.go:171","msg":"trace[312909975] transaction","detail":"{read_only:false; response_revision:439; number_of_response:1; }","duration":"204.155612ms","start":"2026-06-28T19:58:12.656738Z","end":"2026-06-28T19:58:12.860894Z","steps":["trace[312909975] 'process raft request' (duration: 204.041779ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:58:18.105367Z","caller":"traceutil/trace.go:171","msg":"trace[10193619] transaction","detail":"{read_only:false; response_revision:485; number_of_response:1; }","duration":"193.835205ms","start":"2026-06-28T19:58:17.911508Z","end":"2026-06-28T19:58:18.105343Z","steps":["trace[10193619] 'process raft request' (duration: 193.666891ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:58:18.116335Z","caller":"traceutil/trace.go:171","msg":"trace[343783715] transaction","detail":"{read_only:false; response_revision:486; number_of_response:1; }","duration":"204.209764ms","start":"2026-06-28T19:58:17.912082Z","end":"2026-06-28T19:58:18.116292Z","steps":["trace[343783715] 'process raft request' (duration: 201.4512ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:58:18.116495Z","caller":"traceutil/trace.go:171","msg":"trace[124071922] transaction","detail":"{read_only:false; response_revision:487; number_of_response:1; }","duration":"192.827458ms","start":"2026-06-28T19:58:17.923644Z","end":"2026-06-28T19:58:18.116472Z","steps":["trace[124071922] 'process raft request' (duration: 192.567721ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:58:18.116641Z","caller":"traceutil/trace.go:171","msg":"trace[1844362] transaction","detail":"{read_only:false; response_revision:489; number_of_response:1; }","duration":"171.717701ms","start":"2026-06-28T19:58:17.944915Z","end":"2026-06-28T19:58:18.116632Z","steps":["trace[1844362] 'process raft request' (duration: 171.390313ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:58:18.116521Z","caller":"traceutil/trace.go:171","msg":"trace[414885892] transaction","detail":"{read_only:false; response_revision:488; number_of_response:1; }","duration":"172.253435ms","start":"2026-06-28T19:58:17.94423Z","end":"2026-06-28T19:58:18.116483Z","steps":["trace[414885892] 'process raft request' (duration: 172.021819ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:58:18.116897Z","caller":"traceutil/trace.go:171","msg":"trace[405046839] transaction","detail":"{read_only:false; response_revision:490; number_of_response:1; }","duration":"171.887186ms","start":"2026-06-28T19:58:17.944976Z","end":"2026-06-28T19:58:18.116863Z","steps":["trace[405046839] 'process raft request' (duration: 171.390682ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:58:18.117046Z","caller":"traceutil/trace.go:171","msg":"trace[393578726] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"172.06242ms","start":"2026-06-28T19:58:17.944977Z","end":"2026-06-28T19:58:18.11704Z","steps":["trace[393578726] 'process raft request' (duration: 171.796723ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:58:18.117074Z","caller":"traceutil/trace.go:171","msg":"trace[1150548858] transaction","detail":"{read_only:false; response_revision:492; number_of_response:1; }","duration":"165.413492ms","start":"2026-06-28T19:58:17.951649Z","end":"2026-06-28T19:58:18.117062Z","steps":["trace[1150548858] 'process raft request' (duration: 165.214167ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:58:18.117102Z","caller":"traceutil/trace.go:171","msg":"trace[1544195855] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"158.379514ms","start":"2026-06-28T19:58:17.958706Z","end":"2026-06-28T19:58:18.117085Z","steps":["trace[1544195855] 'process raft request' (duration: 158.206629ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:58:18.117206Z","caller":"traceutil/trace.go:171","msg":"trace[187423507] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"144.629933ms","start":"2026-06-28T19:58:17.972561Z","end":"2026-06-28T19:58:18.117191Z","steps":["trace[187423507] 'process raft request' (duration: 144.452329ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:58:18.117328Z","caller":"traceutil/trace.go:171","msg":"trace[2004979594] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"133.67608ms","start":"2026-06-28T19:58:17.98364Z","end":"2026-06-28T19:58:18.117316Z","steps":["trace[2004979594] 'process raft request' (duration: 133.527366ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:58:18.406785Z","caller":"traceutil/trace.go:171","msg":"trace[2045210645] transaction","detail":"{read_only:false; response_revision:504; number_of_response:1; }","duration":"268.712387ms","start":"2026-06-28T19:58:18.138051Z","end":"2026-06-28T19:58:18.406763Z","steps":["trace[2045210645] 'process raft request' (duration: 267.770432ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:58:18.412076Z","caller":"traceutil/trace.go:171","msg":"trace[364252553] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"265.48962ms","start":"2026-06-28T19:58:18.146563Z","end":"2026-06-28T19:58:18.412052Z","steps":["trace[364252553] 'process raft request' (duration: 265.424178ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:58:18.412103Z","caller":"traceutil/trace.go:171","msg":"trace[1176091823] transaction","detail":"{read_only:false; response_revision:506; number_of_response:1; }","duration":"267.310888ms","start":"2026-06-28T19:58:18.144765Z","end":"2026-06-28T19:58:18.412076Z","steps":["trace[1176091823] 'process raft request' (duration: 267.159054ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:58:18.412248Z","caller":"traceutil/trace.go:171","msg":"trace[1544588873] transaction","detail":"{read_only:false; number_of_response:1; response_revision:507; }","duration":"255.170873ms","start":"2026-06-28T19:58:18.157045Z","end":"2026-06-28T19:58:18.412216Z","steps":["trace[1544588873] 'process raft request' (duration: 254.970028ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:58:18.412435Z","caller":"traceutil/trace.go:171","msg":"trace[1359604707] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"255.329607ms","start":"2026-06-28T19:58:18.157087Z","end":"2026-06-28T19:58:18.412416Z","steps":["trace[1359604707] 'process raft request' (duration: 255.054979ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:58:18.412536Z","caller":"traceutil/trace.go:171","msg":"trace[1327352612] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"247.292531ms","start":"2026-06-28T19:58:18.165229Z","end":"2026-06-28T19:58:18.412522Z","steps":["trace[1327352612] 'process raft request' (duration: 247.190689ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:58:18.412533Z","caller":"traceutil/trace.go:171","msg":"trace[71167579] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"247.338252ms","start":"2026-06-28T19:58:18.16518Z","end":"2026-06-28T19:58:18.412518Z","steps":["trace[71167579] 'process raft request' (duration: 247.116956ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:58:18.412583Z","caller":"traceutil/trace.go:171","msg":"trace[968661699] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"235.066823ms","start":"2026-06-28T19:58:18.177507Z","end":"2026-06-28T19:58:18.412574Z","steps":["trace[968661699] 'process raft request' (duration: 234.9646ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:58:18.412633Z","caller":"traceutil/trace.go:171","msg":"trace[1135299042] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"229.818612ms","start":"2026-06-28T19:58:18.182806Z","end":"2026-06-28T19:58:18.412625Z","steps":["trace[1135299042] 'process raft request' (duration: 229.698459ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:58:18.412637Z","caller":"traceutil/trace.go:171","msg":"trace[1574839056] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"223.634195ms","start":"2026-06-28T19:58:18.188988Z","end":"2026-06-28T19:58:18.412622Z","steps":["trace[1574839056] 'process raft request' (duration: 223.585254ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:58:18.413209Z","caller":"traceutil/trace.go:171","msg":"trace[228489649] transaction","detail":"{read_only:false; response_revision:505; number_of_response:1; }","duration":"275.085087ms","start":"2026-06-28T19:58:18.138109Z","end":"2026-06-28T19:58:18.413194Z","steps":["trace[228489649] 'process raft request' (duration: 273.659899ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:58:20.686716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.617967ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-06-28T19:58:20.974622Z","caller":"traceutil/trace.go:171","msg":"trace[984892212] transaction","detail":"{read_only:false; response_revision:569; number_of_response:1; }","duration":"101.187158ms","start":"2026-06-28T19:58:20.87341Z","end":"2026-06-28T19:58:20.974597Z","steps":["trace[984892212] 'process raft request' (duration: 101.096275ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:58:24.789316Z","caller":"traceutil/trace.go:171","msg":"trace[437645630] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"403.355132ms","start":"2026-06-28T19:58:24.385936Z","end":"2026-06-28T19:58:24.789291Z","steps":["trace[437645630] 'process raft request' (duration: 403.155857ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:58:24.789488Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:58:24.38592Z","time spent":"403.480105ms","remote":"127.0.0.1:40828","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-28T19:58:24.955293Z","caller":"traceutil/trace.go:171","msg":"trace[1096803255] transaction","detail":"{read_only:false; response_revision:595; number_of_response:1; }","duration":"384.041483ms","start":"2026-06-28T19:58:24.571203Z","end":"2026-06-28T19:58:24.955245Z","steps":["trace[1096803255] 'process raft request' (duration: 345.415436ms)","trace[1096803255] 'compare' (duration: 33.269833ms)"],"step_count":2} {"level":"warn","ts":"2026-06-28T19:58:24.955428Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:58:24.571174Z","time spent":"384.181397ms","remote":"127.0.0.1:40734","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036313,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-28T19:58:25.388572Z","caller":"traceutil/trace.go:171","msg":"trace[2058197184] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"383.90438ms","start":"2026-06-28T19:58:25.004635Z","end":"2026-06-28T19:58:25.388539Z","steps":["trace[2058197184] 'process raft request' (duration: 306.175732ms)","trace[2058197184] 'compare' (duration: 77.601364ms)"],"step_count":2} {"level":"warn","ts":"2026-06-28T19:58:25.388751Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:58:25.00461Z","time spent":"384.051153ms","remote":"127.0.0.1:40928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-28T19:58:25.419149Z","caller":"traceutil/trace.go:171","msg":"trace[1482997477] linearizableReadLoop","detail":"{readStateIndex:617; appliedIndex:615; }","duration":"264.37987ms","start":"2026-06-28T19:58:25.154745Z","end":"2026-06-28T19:58:25.419125Z","steps":["trace[1482997477] 'read index received' (duration: 156.02247ms)","trace[1482997477] 'applied index is now lower than readState.Index' (duration: 108.3565ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:58:25.419239Z","caller":"traceutil/trace.go:171","msg":"trace[907689657] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"403.354802ms","start":"2026-06-28T19:58:25.01585Z","end":"2026-06-28T19:58:25.419205Z","steps":["trace[907689657] 'process raft request' (duration: 403.107265ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:58:25.419417Z","caller":"traceutil/trace.go:171","msg":"trace[1641300953] transaction","detail":"{read_only:false; response_revision:598; number_of_response:1; }","duration":"212.887097ms","start":"2026-06-28T19:58:25.206519Z","end":"2026-06-28T19:58:25.419406Z","steps":["trace[1641300953] 'process raft request' (duration: 212.549207ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:58:25.419459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.711828ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-28T19:58:25.419489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.34719ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.177\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-06-28T19:58:25.419515Z","caller":"traceutil/trace.go:171","msg":"trace[1349739423] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:598; }","duration":"264.813152ms","start":"2026-06-28T19:58:25.154685Z","end":"2026-06-28T19:58:25.419498Z","steps":["trace[1349739423] 'agreement among raft nodes before linearized reading' (duration: 264.719119ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:58:25.419564Z","caller":"traceutil/trace.go:171","msg":"trace[483594667] range","detail":"{range_begin:/registry/masterleases/199.204.45.177; range_end:; response_count:1; response_revision:598; }","duration":"165.473664ms","start":"2026-06-28T19:58:25.254072Z","end":"2026-06-28T19:58:25.419546Z","steps":["trace[483594667] 'agreement among raft nodes before linearized reading' (duration: 165.31089ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:58:25.419655Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:58:25.015842Z","time spent":"403.499706ms","remote":"127.0.0.1:40890","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-28T19:58:25.745477Z","caller":"traceutil/trace.go:171","msg":"trace[1374855887] linearizableReadLoop","detail":"{readStateIndex:619; appliedIndex:618; }","duration":"321.112653ms","start":"2026-06-28T19:58:25.424338Z","end":"2026-06-28T19:58:25.74545Z","steps":["trace[1374855887] 'read index received' (duration: 241.279529ms)","trace[1374855887] 'applied index is now lower than readState.Index' (duration: 79.831474ms)"],"step_count":2} {"level":"warn","ts":"2026-06-28T19:58:25.745521Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:58:25.421281Z","time spent":"324.232807ms","remote":"127.0.0.1:40662","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-06-28T19:58:25.745968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.059328ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-06-28T19:58:25.745972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"321.619857ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/job-controller\" ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-06-28T19:58:25.746021Z","caller":"traceutil/trace.go:171","msg":"trace[810321584] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:598; }","duration":"284.12443ms","start":"2026-06-28T19:58:25.461884Z","end":"2026-06-28T19:58:25.746009Z","steps":["trace[810321584] 'agreement among raft nodes before linearized reading' (duration: 284.011517ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:58:25.746065Z","caller":"traceutil/trace.go:171","msg":"trace[735706547] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/job-controller; range_end:; response_count:1; response_revision:598; }","duration":"321.75635ms","start":"2026-06-28T19:58:25.424293Z","end":"2026-06-28T19:58:25.74605Z","steps":["trace[735706547] 'agreement among raft nodes before linearized reading' (duration: 321.581656ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:58:25.746188Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:58:25.424279Z","time spent":"321.863464ms","remote":"127.0.0.1:40850","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":215,"request content":"key:\"/registry/serviceaccounts/kube-system/job-controller\" "} {"level":"warn","ts":"2026-06-28T19:58:25.746188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.203971ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:58:25.746815Z","caller":"traceutil/trace.go:171","msg":"trace[1382852799] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:598; }","duration":"275.849898ms","start":"2026-06-28T19:58:25.470928Z","end":"2026-06-28T19:58:25.746778Z","steps":["trace[1382852799] 'agreement among raft nodes before linearized reading' (duration: 274.971714ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:58:26.007178Z","caller":"traceutil/trace.go:171","msg":"trace[1017103113] transaction","detail":"{read_only:false; response_revision:599; number_of_response:1; }","duration":"258.809641ms","start":"2026-06-28T19:58:25.748285Z","end":"2026-06-28T19:58:26.007095Z","steps":["trace[1017103113] 'process raft request' (duration: 243.651853ms)","trace[1017103113] 'compare' (duration: 14.972143ms)"],"step_count":2} {"level":"warn","ts":"2026-06-28T19:58:26.007291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.214117ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/job-controller\" ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-06-28T19:58:26.00737Z","caller":"traceutil/trace.go:171","msg":"trace[1405660507] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/job-controller; range_end:; response_count:1; response_revision:599; }","duration":"257.326621ms","start":"2026-06-28T19:58:25.750023Z","end":"2026-06-28T19:58:26.00735Z","steps":["trace[1405660507] 'agreement among raft nodes before linearized reading' (duration: 257.149696ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:58:26.007413Z","caller":"traceutil/trace.go:171","msg":"trace[561274875] linearizableReadLoop","detail":"{readStateIndex:620; appliedIndex:619; }","duration":"256.980641ms","start":"2026-06-28T19:58:25.750057Z","end":"2026-06-28T19:58:26.007037Z","steps":["trace[561274875] 'read index received' (duration: 241.892566ms)","trace[561274875] 'applied index is now lower than readState.Index' (duration: 15.086795ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:58:26.023667Z","caller":"traceutil/trace.go:171","msg":"trace[1190439745] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"272.158648ms","start":"2026-06-28T19:58:25.751492Z","end":"2026-06-28T19:58:26.02365Z","steps":["trace[1190439745] 'process raft request' (duration: 271.970023ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:58:26.52763Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5605186101488028731,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-28T19:58:27.028664Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5605186101488028731,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-28T19:58:27.529458Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5605186101488028731,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-28T19:58:27.818915Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.792909687s","expected-duration":"1s"} {"level":"warn","ts":"2026-06-28T19:58:28.472279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.999970677s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-06-28T19:58:28.47237Z","caller":"traceutil/trace.go:171","msg":"trace[2072729737] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000129051s","start":"2026-06-28T19:58:26.472222Z","end":"2026-06-28T19:58:28.472351Z","steps":["trace[2072729737] 'agreement among raft nodes before linearized reading' (duration: 2.000007547s)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:58:28.472421Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:58:26.4722Z","time spent":"2.000210553s","remote":"127.0.0.1:40646","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/06/28 19:58:28 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-06-28T19:58:28.492322Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"673.104756ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-28T19:58:28.492424Z","caller":"traceutil/trace.go:171","msg":"trace[215895938] linearizableReadLoop","detail":"{readStateIndex:622; appliedIndex:621; }","duration":"2.465385155s","start":"2026-06-28T19:58:26.027022Z","end":"2026-06-28T19:58:28.492407Z","steps":["trace[215895938] 'read index received' (duration: 1.792057873s)","trace[215895938] 'applied index is now lower than readState.Index' (duration: 673.326252ms)"],"step_count":2} {"level":"warn","ts":"2026-06-28T19:58:28.492858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.268417566s","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-06-28T19:58:28.492909Z","caller":"traceutil/trace.go:171","msg":"trace[592271028] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:601; }","duration":"2.268510808s","start":"2026-06-28T19:58:26.224385Z","end":"2026-06-28T19:58:28.492896Z","steps":["trace[592271028] 'agreement among raft nodes before linearized reading' (duration: 2.2682023s)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:58:28.492942Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:58:26.224364Z","time spent":"2.26857139s","remote":"127.0.0.1:40928","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-28T19:58:28.493168Z","caller":"traceutil/trace.go:171","msg":"trace[1465089243] transaction","detail":"{read_only:false; response_revision:601; number_of_response:1; }","duration":"2.467239995s","start":"2026-06-28T19:58:26.025915Z","end":"2026-06-28T19:58:28.493155Z","steps":["trace[1465089243] 'process raft request' (duration: 1.793230035s)","trace[1465089243] 'compare' (duration: 672.778077ms)"],"step_count":2} {"level":"warn","ts":"2026-06-28T19:58:28.493239Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:58:26.025897Z","time spent":"2.467298566s","remote":"127.0.0.1:40828","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2735,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-28T19:58:28.493388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.466372952s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-06-28T19:58:28.493466Z","caller":"traceutil/trace.go:171","msg":"trace[254402425] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:601; }","duration":"2.466449444s","start":"2026-06-28T19:58:26.026956Z","end":"2026-06-28T19:58:28.493405Z","steps":["trace[254402425] 'agreement among raft nodes before linearized reading' (duration: 2.466396963s)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:58:28.493493Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:58:26.026934Z","time spent":"2.466552847s","remote":"127.0.0.1:40938","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/endpointslices/default/kubernetes\" "} {"level":"warn","ts":"2026-06-28T19:58:28.493784Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"466.484497ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-28T19:58:28.493923Z","caller":"traceutil/trace.go:171","msg":"trace[592828475] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:601; }","duration":"466.651651ms","start":"2026-06-28T19:58:28.027257Z","end":"2026-06-28T19:58:28.493908Z","steps":["trace[592828475] 'agreement among raft nodes before linearized reading' (duration: 466.464126ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:58:28.493967Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:58:28.027238Z","time spent":"466.712124ms","remote":"127.0.0.1:40928","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-06-28T19:58:28.49397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.101374635s","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-06-28T19:58:28.494035Z","caller":"traceutil/trace.go:171","msg":"trace[1015962974] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:601; }","duration":"1.101482278s","start":"2026-06-28T19:58:27.392536Z","end":"2026-06-28T19:58:28.494018Z","steps":["trace[1015962974] 'agreement among raft nodes before linearized reading' (duration: 1.101299904s)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:58:28.494048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.269543146s","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-06-28T19:58:28.494076Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:58:27.392512Z","time spent":"1.101555481s","remote":"127.0.0.1:40928","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-28T19:58:28.4941Z","caller":"traceutil/trace.go:171","msg":"trace[730746046] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:601; }","duration":"2.269652409s","start":"2026-06-28T19:58:26.22443Z","end":"2026-06-28T19:58:28.494083Z","steps":["trace[730746046] 'agreement among raft nodes before linearized reading' (duration: 2.269476064s)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:58:28.494141Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:58:26.224398Z","time spent":"2.269734521s","remote":"127.0.0.1:40928","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-28T19:58:34.479988Z","caller":"traceutil/trace.go:171","msg":"trace[1397997636] transaction","detail":"{read_only:false; response_revision:685; number_of_response:1; }","duration":"215.577829ms","start":"2026-06-28T19:58:34.26437Z","end":"2026-06-28T19:58:34.479948Z","steps":["trace[1397997636] 'process raft request' (duration: 215.374774ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:58:35.380127Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.629884ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-28T19:58:35.380179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.644604ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:58:35.380258Z","caller":"traceutil/trace.go:171","msg":"trace[400586471] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:695; }","duration":"109.756858ms","start":"2026-06-28T19:58:35.270484Z","end":"2026-06-28T19:58:35.38024Z","steps":["trace[400586471] 'agreement among raft nodes before linearized reading' (duration: 109.566863ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:58:35.38031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.121757ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.177\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-06-28T19:58:35.380344Z","caller":"traceutil/trace.go:171","msg":"trace[102646350] range","detail":"{range_begin:/registry/masterleases/199.204.45.177; range_end:; response_count:1; response_revision:695; }","duration":"126.231479ms","start":"2026-06-28T19:58:35.254104Z","end":"2026-06-28T19:58:35.380336Z","steps":["trace[102646350] 'agreement among raft nodes before linearized reading' (duration: 126.130427ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:58:35.380357Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.176475ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/instance\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:58:35.380413Z","caller":"traceutil/trace.go:171","msg":"trace[1680349957] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/instance; range_end:; response_count:0; response_revision:695; }","duration":"140.249226ms","start":"2026-06-28T19:58:35.240151Z","end":"2026-06-28T19:58:35.380401Z","steps":["trace[1680349957] 'agreement among raft nodes before linearized reading' (duration: 140.162844ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:58:35.380598Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.446039ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" limit:10 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:58:35.380636Z","caller":"traceutil/trace.go:171","msg":"trace[65052421] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:695; }","duration":"109.49553ms","start":"2026-06-28T19:58:35.271132Z","end":"2026-06-28T19:58:35.380627Z","steps":["trace[65052421] 'agreement among raft nodes before linearized reading' (duration: 109.436839ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:58:35.380205Z","caller":"traceutil/trace.go:171","msg":"trace[1535664645] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:695; }","duration":"109.737287ms","start":"2026-06-28T19:58:35.270452Z","end":"2026-06-28T19:58:35.380189Z","steps":["trace[1535664645] 'agreement among raft nodes before linearized reading' (duration: 109.603333ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:58:35.380863Z","caller":"traceutil/trace.go:171","msg":"trace[1181817210] transaction","detail":"{read_only:false; response_revision:695; number_of_response:1; }","duration":"113.239831ms","start":"2026-06-28T19:58:35.267555Z","end":"2026-06-28T19:58:35.380794Z","steps":["trace[1181817210] 'process raft request' (duration: 99.025579ms)","trace[1181817210] 'compare' (duration: 13.255606ms)"],"step_count":2} {"level":"warn","ts":"2026-06-28T19:58:35.381016Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.900244ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:58:35.381059Z","caller":"traceutil/trace.go:171","msg":"trace[716636357] transaction","detail":"{read_only:false; number_of_response:1; response_revision:695; }","duration":"107.716872ms","start":"2026-06-28T19:58:35.273327Z","end":"2026-06-28T19:58:35.381043Z","steps":["trace[716636357] 'process raft request' (duration: 106.642334ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:58:35.381078Z","caller":"traceutil/trace.go:171","msg":"trace[1849947887] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:695; }","duration":"140.968856ms","start":"2026-06-28T19:58:35.240093Z","end":"2026-06-28T19:58:35.381062Z","steps":["trace[1849947887] 'agreement among raft nodes before linearized reading' (duration: 140.184725ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:58:44.97311Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5605186101488029025,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-28T19:58:44.986477Z","caller":"traceutil/trace.go:171","msg":"trace[68197920] linearizableReadLoop","detail":"{readStateIndex:788; appliedIndex:787; }","duration":"513.407528ms","start":"2026-06-28T19:58:44.473043Z","end":"2026-06-28T19:58:44.98645Z","steps":["trace[68197920] 'read index received' (duration: 513.238113ms)","trace[68197920] 'applied index is now lower than readState.Index' (duration: 165.125µs)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:58:44.986588Z","caller":"traceutil/trace.go:171","msg":"trace[1630122385] transaction","detail":"{read_only:false; response_revision:762; number_of_response:1; }","duration":"819.003164ms","start":"2026-06-28T19:58:44.167571Z","end":"2026-06-28T19:58:44.986575Z","steps":["trace[1630122385] 'process raft request' (duration: 818.682826ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:58:44.986706Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:58:44.167549Z","time spent":"819.074255ms","remote":"127.0.0.1:40928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-28T19:58:44.987523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"514.431275ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-2tlsc\" ","response":"range_response_count:1 size:3965"} {"level":"info","ts":"2026-06-28T19:58:44.987704Z","caller":"traceutil/trace.go:171","msg":"trace[649454738] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-2tlsc; range_end:; response_count:1; response_revision:762; }","duration":"514.62125ms","start":"2026-06-28T19:58:44.472995Z","end":"2026-06-28T19:58:44.987617Z","steps":["trace[649454738] 'agreement among raft nodes before linearized reading' (duration: 513.598533ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:58:44.98781Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:58:44.472976Z","time spent":"514.814645ms","remote":"127.0.0.1:40828","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-2tlsc\" "} {"level":"warn","ts":"2026-06-28T19:58:44.989171Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"401.977115ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-06-28T19:58:44.989217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"402.55253ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-28T19:58:44.989305Z","caller":"traceutil/trace.go:171","msg":"trace[1436106227] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:762; }","duration":"402.670234ms","start":"2026-06-28T19:58:44.586611Z","end":"2026-06-28T19:58:44.989281Z","steps":["trace[1436106227] 'agreement among raft nodes before linearized reading' (duration: 402.395516ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:58:44.989407Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:58:44.586601Z","time spent":"402.795657ms","remote":"127.0.0.1:40928","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-06-28T19:58:44.989324Z","caller":"traceutil/trace.go:171","msg":"trace[1664961070] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:762; }","duration":"402.110288ms","start":"2026-06-28T19:58:44.587159Z","end":"2026-06-28T19:58:44.989269Z","steps":["trace[1664961070] 'agreement among raft nodes before linearized reading' (duration: 401.836911ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:58:44.989638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"396.800406ms","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-06-28T19:58:44.989663Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:58:44.587149Z","time spent":"402.503089ms","remote":"127.0.0.1:40928","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-06-28T19:58:44.989757Z","caller":"traceutil/trace.go:171","msg":"trace[1674271192] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:762; }","duration":"396.924729ms","start":"2026-06-28T19:58:44.592757Z","end":"2026-06-28T19:58:44.989681Z","steps":["trace[1674271192] 'agreement among raft nodes before linearized reading' (duration: 396.671892ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:58:44.98987Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:58:44.592747Z","time spent":"397.104244ms","remote":"127.0.0.1:40928","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-06-28T19:58:44.990146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"404.953345ms","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-06-28T19:58:44.990201Z","caller":"traceutil/trace.go:171","msg":"trace[2038479922] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:762; }","duration":"405.030827ms","start":"2026-06-28T19:58:44.585147Z","end":"2026-06-28T19:58:44.990178Z","steps":["trace[2038479922] 'agreement among raft nodes before linearized reading' (duration: 404.915144ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:58:44.990232Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:58:44.58513Z","time spent":"405.094659ms","remote":"127.0.0.1:40928","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-06-28T19:58:44.990593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"516.982503ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:58:44.990634Z","caller":"traceutil/trace.go:171","msg":"trace[57076475] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:762; }","duration":"517.054235ms","start":"2026-06-28T19:58:44.473567Z","end":"2026-06-28T19:58:44.990622Z","steps":["trace[57076475] 'agreement among raft nodes before linearized reading' (duration: 516.971443ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:58:44.993718Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:58:44.473559Z","time spent":"517.104597ms","remote":"127.0.0.1:40646","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-28T19:58:45.215342Z","caller":"traceutil/trace.go:171","msg":"trace[963354233] linearizableReadLoop","detail":"{readStateIndex:789; appliedIndex:788; }","duration":"219.537276ms","start":"2026-06-28T19:58:44.995779Z","end":"2026-06-28T19:58:45.215316Z","steps":["trace[963354233] 'read index received' (duration: 140.608307ms)","trace[963354233] 'applied index is now lower than readState.Index' (duration: 78.927599ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:58:45.215407Z","caller":"traceutil/trace.go:171","msg":"trace[23674681] transaction","detail":"{read_only:false; response_revision:763; number_of_response:1; }","duration":"219.648609ms","start":"2026-06-28T19:58:44.995725Z","end":"2026-06-28T19:58:45.215374Z","steps":["trace[23674681] 'process raft request' (duration: 140.596986ms)","trace[23674681] 'compare' (duration: 78.879538ms)"],"step_count":2} {"level":"warn","ts":"2026-06-28T19:58:45.215726Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.926076ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:58:45.215789Z","caller":"traceutil/trace.go:171","msg":"trace[912242067] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:763; }","duration":"220.029748ms","start":"2026-06-28T19:58:44.995744Z","end":"2026-06-28T19:58:45.215774Z","steps":["trace[912242067] 'agreement among raft nodes before linearized reading' (duration: 219.890805ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:58:45.21833Z","caller":"traceutil/trace.go:171","msg":"trace[1332797968] transaction","detail":"{read_only:false; response_revision:764; number_of_response:1; }","duration":"222.33719ms","start":"2026-06-28T19:58:44.995972Z","end":"2026-06-28T19:58:45.218309Z","steps":["trace[1332797968] 'process raft request' (duration: 222.199327ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:58:45.218454Z","caller":"traceutil/trace.go:171","msg":"trace[294925130] transaction","detail":"{read_only:false; response_revision:767; number_of_response:1; }","duration":"218.465017ms","start":"2026-06-28T19:58:44.999975Z","end":"2026-06-28T19:58:45.21844Z","steps":["trace[294925130] 'process raft request' (duration: 218.352744ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:58:45.218676Z","caller":"traceutil/trace.go:171","msg":"trace[2014759241] transaction","detail":"{read_only:false; response_revision:765; number_of_response:1; }","duration":"222.641819ms","start":"2026-06-28T19:58:44.996017Z","end":"2026-06-28T19:58:45.218658Z","steps":["trace[2014759241] 'process raft request' (duration: 222.232828ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:58:45.218781Z","caller":"traceutil/trace.go:171","msg":"trace[1445739623] transaction","detail":"{read_only:false; response_revision:766; number_of_response:1; }","duration":"222.386352ms","start":"2026-06-28T19:58:44.996383Z","end":"2026-06-28T19:58:45.21877Z","steps":["trace[1445739623] 'process raft request' (duration: 221.907479ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:58:47.362366Z","caller":"traceutil/trace.go:171","msg":"trace[1614392237] transaction","detail":"{read_only:false; response_revision:774; number_of_response:1; }","duration":"136.344793ms","start":"2026-06-28T19:58:47.225992Z","end":"2026-06-28T19:58:47.362337Z","steps":["trace[1614392237] 'process raft request' (duration: 135.86923ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:58:47.362371Z","caller":"traceutil/trace.go:171","msg":"trace[871282606] transaction","detail":"{read_only:false; response_revision:775; number_of_response:1; }","duration":"134.905854ms","start":"2026-06-28T19:58:47.227443Z","end":"2026-06-28T19:58:47.362349Z","steps":["trace[871282606] 'process raft request' (duration: 134.814582ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:58:47.362547Z","caller":"traceutil/trace.go:171","msg":"trace[1551157779] transaction","detail":"{read_only:false; response_revision:776; number_of_response:1; }","duration":"134.298678ms","start":"2026-06-28T19:58:47.228239Z","end":"2026-06-28T19:58:47.362538Z","steps":["trace[1551157779] 'process raft request' (duration: 134.079472ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:58:57.562012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.315541ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-28T19:58:57.56215Z","caller":"traceutil/trace.go:171","msg":"trace[2084843953] linearizableReadLoop","detail":"{readStateIndex:919; appliedIndex:918; }","duration":"143.952606ms","start":"2026-06-28T19:58:57.418181Z","end":"2026-06-28T19:58:57.562133Z","steps":["trace[2084843953] 'read index received' (duration: 39.368567ms)","trace[2084843953] 'applied index is now lower than readState.Index' (duration: 104.582739ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:58:57.562228Z","caller":"traceutil/trace.go:171","msg":"trace[2092223453] transaction","detail":"{read_only:false; response_revision:889; number_of_response:1; }","duration":"150.525082ms","start":"2026-06-28T19:58:57.411693Z","end":"2026-06-28T19:58:57.562218Z","steps":["trace[2092223453] 'process raft request' (duration: 45.924403ms)","trace[2092223453] 'compare' (duration: 104.184798ms)"],"step_count":2} {"level":"warn","ts":"2026-06-28T19:58:57.56256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.353377ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-06-28T19:58:57.562565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.299465ms","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-06-28T19:58:57.562643Z","caller":"traceutil/trace.go:171","msg":"trace[1637873905] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:889; }","duration":"144.462749ms","start":"2026-06-28T19:58:57.418163Z","end":"2026-06-28T19:58:57.562625Z","steps":["trace[1637873905] 'agreement among raft nodes before linearized reading' (duration: 144.216292ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:58:57.562672Z","caller":"traceutil/trace.go:171","msg":"trace[2002736401] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:889; }","duration":"144.45314ms","start":"2026-06-28T19:58:57.418192Z","end":"2026-06-28T19:58:57.562646Z","steps":["trace[2002736401] 'agreement among raft nodes before linearized reading' (duration: 144.162932ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:59:13.903542Z","caller":"traceutil/trace.go:171","msg":"trace[1705857392] linearizableReadLoop","detail":"{readStateIndex:984; appliedIndex:983; }","duration":"273.893723ms","start":"2026-06-28T19:59:13.629624Z","end":"2026-06-28T19:59:13.903518Z","steps":["trace[1705857392] 'read index received' (duration: 273.775769ms)","trace[1705857392] 'applied index is now lower than readState.Index' (duration: 116.914µs)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:59:13.903584Z","caller":"traceutil/trace.go:171","msg":"trace[1867100869] transaction","detail":"{read_only:false; response_revision:950; number_of_response:1; }","duration":"414.881142ms","start":"2026-06-28T19:59:13.488678Z","end":"2026-06-28T19:59:13.903559Z","steps":["trace[1867100869] 'process raft request' (duration: 414.700297ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:59:13.90371Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:59:13.488667Z","time spent":"414.980554ms","remote":"127.0.0.1:40928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-28T19:59:13.903922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.265153ms","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-06-28T19:59:13.904019Z","caller":"traceutil/trace.go:171","msg":"trace[711147726] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:950; }","duration":"274.410666ms","start":"2026-06-28T19:59:13.629588Z","end":"2026-06-28T19:59:13.903999Z","steps":["trace[711147726] 'agreement among raft nodes before linearized reading' (duration: 274.061217ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:59:13.924623Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.507479ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-28T19:59:13.924662Z","caller":"traceutil/trace.go:171","msg":"trace[1078124448] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:951; }","duration":"251.566571ms","start":"2026-06-28T19:59:13.673087Z","end":"2026-06-28T19:59:13.924653Z","steps":["trace[1078124448] 'agreement among raft nodes before linearized reading' (duration: 251.457398ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:59:13.924615Z","caller":"traceutil/trace.go:171","msg":"trace[1959998600] transaction","detail":"{read_only:false; response_revision:951; number_of_response:1; }","duration":"233.361758ms","start":"2026-06-28T19:59:13.691208Z","end":"2026-06-28T19:59:13.92457Z","steps":["trace[1959998600] 'process raft request' (duration: 233.235885ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:59:13.924714Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.924897ms","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-06-28T19:59:13.924997Z","caller":"traceutil/trace.go:171","msg":"trace[757201535] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:951; }","duration":"233.254566ms","start":"2026-06-28T19:59:13.691728Z","end":"2026-06-28T19:59:13.924983Z","steps":["trace[757201535] 'agreement among raft nodes before linearized reading' (duration: 232.864216ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:59:14.027948Z","caller":"traceutil/trace.go:171","msg":"trace[1950567467] transaction","detail":"{read_only:false; response_revision:953; number_of_response:1; }","duration":"100.129454ms","start":"2026-06-28T19:59:13.927808Z","end":"2026-06-28T19:59:14.027937Z","steps":["trace[1950567467] 'process raft request' (duration: 99.039385ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:59:19.478304Z","caller":"traceutil/trace.go:171","msg":"trace[1539223691] linearizableReadLoop","detail":"{readStateIndex:1009; appliedIndex:1008; }","duration":"202.766767ms","start":"2026-06-28T19:59:19.275519Z","end":"2026-06-28T19:59:19.478286Z","steps":["trace[1539223691] 'read index received' (duration: 202.597753ms)","trace[1539223691] 'applied index is now lower than readState.Index' (duration: 168.134µs)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:59:19.478532Z","caller":"traceutil/trace.go:171","msg":"trace[1346607874] transaction","detail":"{read_only:false; response_revision:973; number_of_response:1; }","duration":"213.81887ms","start":"2026-06-28T19:59:19.264702Z","end":"2026-06-28T19:59:19.478521Z","steps":["trace[1346607874] 'process raft request' (duration: 213.46241ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:59:19.478734Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.200079ms","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-06-28T19:59:19.478776Z","caller":"traceutil/trace.go:171","msg":"trace[808315809] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:973; }","duration":"203.290551ms","start":"2026-06-28T19:59:19.275475Z","end":"2026-06-28T19:59:19.478766Z","steps":["trace[808315809] 'agreement among raft nodes before linearized reading' (duration: 203.217599ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:59:20.482508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"558.381218ms","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-06-28T19:59:20.482527Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.127167ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-28T19:59:20.482582Z","caller":"traceutil/trace.go:171","msg":"trace[1909541629] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:973; }","duration":"558.519851ms","start":"2026-06-28T19:59:19.924045Z","end":"2026-06-28T19:59:20.482565Z","steps":["trace[1909541629] 'range keys from in-memory index tree' (duration: 558.235104ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:59:20.482601Z","caller":"traceutil/trace.go:171","msg":"trace[1135465775] linearizableReadLoop","detail":"{readStateIndex:1010; appliedIndex:1009; }","duration":"495.52014ms","start":"2026-06-28T19:59:19.987067Z","end":"2026-06-28T19:59:20.482587Z","steps":["trace[1135465775] 'read index received' (duration: 229.2779ms)","trace[1135465775] 'applied index is now lower than readState.Index' (duration: 266.24109ms)"],"step_count":2} {"level":"warn","ts":"2026-06-28T19:59:20.482627Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:59:19.924032Z","time spent":"558.585883ms","remote":"127.0.0.1:40928","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-28T19:59:20.482653Z","caller":"traceutil/trace.go:171","msg":"trace[835062516] transaction","detail":"{read_only:false; response_revision:974; number_of_response:1; }","duration":"543.719769ms","start":"2026-06-28T19:59:19.938927Z","end":"2026-06-28T19:59:20.482647Z","steps":["trace[835062516] 'process raft request' (duration: 277.403986ms)","trace[835062516] 'compare' (duration: 265.924952ms)"],"step_count":2} {"level":"warn","ts":"2026-06-28T19:59:20.482693Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:59:19.93888Z","time spent":"543.79207ms","remote":"127.0.0.1:40928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-28T19:59:20.482763Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"495.696125ms","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-06-28T19:59:20.482811Z","caller":"traceutil/trace.go:171","msg":"trace[73960726] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:974; }","duration":"495.766037ms","start":"2026-06-28T19:59:19.987028Z","end":"2026-06-28T19:59:20.482794Z","steps":["trace[73960726] 'agreement among raft nodes before linearized reading' (duration: 495.648414ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:59:20.482852Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:59:19.987011Z","time spent":"495.830659ms","remote":"127.0.0.1:40928","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-06-28T19:59:20.494024Z","caller":"traceutil/trace.go:171","msg":"trace[300213038] transaction","detail":"{read_only:false; response_revision:975; number_of_response:1; }","duration":"445.912525ms","start":"2026-06-28T19:59:20.048096Z","end":"2026-06-28T19:59:20.494008Z","steps":["trace[300213038] 'process raft request' (duration: 445.806722ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:59:20.494136Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:59:20.048076Z","time spent":"445.997478ms","remote":"127.0.0.1:40928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-28T19:59:20.494297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"443.542512ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-06-28T19:59:20.494301Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"391.498372ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-28T19:59:20.494352Z","caller":"traceutil/trace.go:171","msg":"trace[1364246889] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:975; }","duration":"443.643205ms","start":"2026-06-28T19:59:20.050697Z","end":"2026-06-28T19:59:20.49434Z","steps":["trace[1364246889] 'agreement among raft nodes before linearized reading' (duration: 443.44916ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:59:20.494382Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:59:20.050677Z","time spent":"443.699967ms","remote":"127.0.0.1:40928","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-06-28T19:59:20.494386Z","caller":"traceutil/trace.go:171","msg":"trace[530062226] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:975; }","duration":"391.634585ms","start":"2026-06-28T19:59:20.102734Z","end":"2026-06-28T19:59:20.494369Z","steps":["trace[530062226] 'agreement among raft nodes before linearized reading' (duration: 391.474201ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:59:20.494447Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:59:20.102697Z","time spent":"391.737948ms","remote":"127.0.0.1:41100","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":13,"response size":29,"request content":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true "} {"level":"warn","ts":"2026-06-28T19:59:20.49447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"440.239324ms","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-06-28T19:59:20.494556Z","caller":"traceutil/trace.go:171","msg":"trace[1574427634] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:975; }","duration":"440.367658ms","start":"2026-06-28T19:59:20.054169Z","end":"2026-06-28T19:59:20.494537Z","steps":["trace[1574427634] 'agreement among raft nodes before linearized reading' (duration: 440.08594ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:59:20.494606Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:59:20.054151Z","time spent":"440.446491ms","remote":"127.0.0.1:40928","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-28T19:59:42.761196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.229196ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-28T19:59:42.761273Z","caller":"traceutil/trace.go:171","msg":"trace[1435134112] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1047; }","duration":"106.33898ms","start":"2026-06-28T19:59:42.654917Z","end":"2026-06-28T19:59:42.761256Z","steps":["trace[1435134112] 'range keys from in-memory index tree' (duration: 106.086353ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:59:42.985703Z","caller":"traceutil/trace.go:171","msg":"trace[977215583] transaction","detail":"{read_only:false; response_revision:1051; number_of_response:1; }","duration":"219.603993ms","start":"2026-06-28T19:59:42.766073Z","end":"2026-06-28T19:59:42.985677Z","steps":["trace[977215583] 'process raft request' (duration: 219.567392ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:59:42.985748Z","caller":"traceutil/trace.go:171","msg":"trace[1266185690] transaction","detail":"{read_only:false; response_revision:1049; number_of_response:1; }","duration":"219.935782ms","start":"2026-06-28T19:59:42.76575Z","end":"2026-06-28T19:59:42.985686Z","steps":["trace[1266185690] 'process raft request' (duration: 219.689306ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:59:42.985806Z","caller":"traceutil/trace.go:171","msg":"trace[1285487626] transaction","detail":"{read_only:false; response_revision:1050; number_of_response:1; }","duration":"219.933363ms","start":"2026-06-28T19:59:42.765836Z","end":"2026-06-28T19:59:42.98577Z","steps":["trace[1285487626] 'process raft request' (duration: 219.763248ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:59:43.785536Z","caller":"traceutil/trace.go:171","msg":"trace[2095428414] transaction","detail":"{read_only:false; response_revision:1052; number_of_response:1; }","duration":"167.507501ms","start":"2026-06-28T19:59:43.618003Z","end":"2026-06-28T19:59:43.78551Z","steps":["trace[2095428414] 'process raft request' (duration: 167.371048ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:59:44.865099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.651938ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-28T19:59:44.865164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"393.133355ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:59:44.865213Z","caller":"traceutil/trace.go:171","msg":"trace[228369018] range","detail":"{range_begin:/registry/csistoragecapacities/; range_end:/registry/csistoragecapacities0; response_count:0; response_revision:1052; }","duration":"241.822153ms","start":"2026-06-28T19:59:44.623368Z","end":"2026-06-28T19:59:44.86519Z","steps":["trace[228369018] 'count revisions from in-memory index tree' (duration: 241.572416ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:59:44.865245Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"696.537411ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:59:44.865257Z","caller":"traceutil/trace.go:171","msg":"trace[1060332395] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1052; }","duration":"393.241178ms","start":"2026-06-28T19:59:44.471996Z","end":"2026-06-28T19:59:44.865237Z","steps":["trace[1060332395] 'range keys from in-memory index tree' (duration: 393.069384ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:59:44.865294Z","caller":"traceutil/trace.go:171","msg":"trace[574853764] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:1052; }","duration":"696.608343ms","start":"2026-06-28T19:59:44.168661Z","end":"2026-06-28T19:59:44.86527Z","steps":["trace[574853764] 'count revisions from in-memory index tree' (duration: 696.48147ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:59:44.8653Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:59:44.471951Z","time spent":"393.341071ms","remote":"127.0.0.1:40646","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-28T19:59:44.865327Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:59:44.168642Z","time spent":"696.676984ms","remote":"127.0.0.1:54070","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":27,"request content":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true "} {"level":"warn","ts":"2026-06-28T19:59:44.865194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"790.091383ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:59:44.865415Z","caller":"traceutil/trace.go:171","msg":"trace[788311499] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:1052; }","duration":"790.340479ms","start":"2026-06-28T19:59:44.075051Z","end":"2026-06-28T19:59:44.865391Z","steps":["trace[788311499] 'count revisions from in-memory index tree' (duration: 789.972659ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:59:44.865495Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:59:44.075034Z","time spent":"790.432771ms","remote":"127.0.0.1:40782","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":27,"request content":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true "} {"level":"info","ts":"2026-06-28T19:59:44.916526Z","caller":"traceutil/trace.go:171","msg":"trace[748513169] transaction","detail":"{read_only:false; response_revision:1053; number_of_response:1; }","duration":"287.083273ms","start":"2026-06-28T19:59:44.629426Z","end":"2026-06-28T19:59:44.91651Z","steps":["trace[748513169] 'process raft request' (duration: 286.928739ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:59:44.916654Z","caller":"traceutil/trace.go:171","msg":"trace[842961625] linearizableReadLoop","detail":"{readStateIndex:1094; appliedIndex:1093; }","duration":"178.054492ms","start":"2026-06-28T19:59:44.738412Z","end":"2026-06-28T19:59:44.916466Z","steps":["trace[842961625] 'read index received' (duration: 177.874557ms)","trace[842961625] 'applied index is now lower than readState.Index' (duration: 178.995µs)"],"step_count":2} {"level":"warn","ts":"2026-06-28T19:59:44.916833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.246666ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:59:44.916891Z","caller":"traceutil/trace.go:171","msg":"trace[1360089803] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:1053; }","duration":"178.598387ms","start":"2026-06-28T19:59:44.738279Z","end":"2026-06-28T19:59:44.916878Z","steps":["trace[1360089803] 'agreement among raft nodes before linearized reading' (duration: 178.33169ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:59:44.916888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.245726ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-28T19:59:44.917175Z","caller":"traceutil/trace.go:171","msg":"trace[939856982] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1053; }","duration":"118.525943ms","start":"2026-06-28T19:59:44.798626Z","end":"2026-06-28T19:59:44.917152Z","steps":["trace[939856982] 'agreement among raft nodes before linearized reading' (duration: 118.119752ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:59:45.206773Z","caller":"traceutil/trace.go:171","msg":"trace[1325361266] transaction","detail":"{read_only:false; response_revision:1057; number_of_response:1; }","duration":"129.30817ms","start":"2026-06-28T19:59:45.077437Z","end":"2026-06-28T19:59:45.206745Z","steps":["trace[1325361266] 'process raft request' (duration: 129.267148ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:59:45.206959Z","caller":"traceutil/trace.go:171","msg":"trace[2479694] transaction","detail":"{read_only:false; response_revision:1056; number_of_response:1; }","duration":"130.033668ms","start":"2026-06-28T19:59:45.076919Z","end":"2026-06-28T19:59:45.206953Z","steps":["trace[2479694] 'process raft request' (duration: 122.613961ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:59:45.398067Z","caller":"traceutil/trace.go:171","msg":"trace[1255408004] transaction","detail":"{read_only:false; response_revision:1058; number_of_response:1; }","duration":"119.026786ms","start":"2026-06-28T19:59:45.279009Z","end":"2026-06-28T19:59:45.398035Z","steps":["trace[1255408004] 'process raft request' (duration: 47.91373ms)","trace[1255408004] 'compare' (duration: 70.959762ms)"],"step_count":2} {"level":"warn","ts":"2026-06-28T19:59:46.402681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.980041ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:59:46.402786Z","caller":"traceutil/trace.go:171","msg":"trace[1482538239] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:1059; }","duration":"241.143816ms","start":"2026-06-28T19:59:46.161617Z","end":"2026-06-28T19:59:46.402761Z","steps":["trace[1482538239] 'count revisions from in-memory index tree' (duration: 240.879308ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:59:46.403049Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.965457ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:59:46.403142Z","caller":"traceutil/trace.go:171","msg":"trace[1987293815] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:1059; }","duration":"101.06589ms","start":"2026-06-28T19:59:46.302046Z","end":"2026-06-28T19:59:46.403112Z","steps":["trace[1987293815] 'count revisions from in-memory index tree' (duration: 100.874975ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:59:47.445253Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5605186101488029717,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-28T19:59:47.478061Z","caller":"traceutil/trace.go:171","msg":"trace[1007732304] transaction","detail":"{read_only:false; response_revision:1060; number_of_response:1; }","duration":"555.595814ms","start":"2026-06-28T19:59:46.922438Z","end":"2026-06-28T19:59:47.478034Z","steps":["trace[1007732304] 'process raft request' (duration: 555.382568ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:59:47.478231Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:59:46.922405Z","time spent":"555.739858ms","remote":"127.0.0.1:40928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-28T19:59:47.782888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.317488ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-28T19:59:47.782997Z","caller":"traceutil/trace.go:171","msg":"trace[622585224] linearizableReadLoop","detail":"{readStateIndex:1103; appliedIndex:1101; }","duration":"837.819578ms","start":"2026-06-28T19:59:46.94516Z","end":"2026-06-28T19:59:47.78298Z","steps":["trace[622585224] 'read index received' (duration: 532.740258ms)","trace[622585224] 'applied index is now lower than readState.Index' (duration: 305.07802ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:59:47.783106Z","caller":"traceutil/trace.go:171","msg":"trace[1191493682] transaction","detail":"{read_only:false; response_revision:1061; number_of_response:1; }","duration":"609.392471ms","start":"2026-06-28T19:59:47.17368Z","end":"2026-06-28T19:59:47.783073Z","steps":["trace[1191493682] 'process raft request' (duration: 467.807746ms)","trace[1191493682] 'compare' (duration: 141.193344ms)"],"step_count":2} {"level":"warn","ts":"2026-06-28T19:59:47.783226Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"838.067605ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-06-28T19:59:47.783242Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"806.243701ms","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-06-28T19:59:47.783307Z","caller":"traceutil/trace.go:171","msg":"trace[1087117968] 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:1061; }","duration":"806.366654ms","start":"2026-06-28T19:59:46.976927Z","end":"2026-06-28T19:59:47.783293Z","steps":["trace[1087117968] 'agreement among raft nodes before linearized reading' (duration: 806.251541ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:59:47.783298Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:59:47.173654Z","time spent":"609.553214ms","remote":"127.0.0.1:40928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-28T19:59:47.783345Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:59:46.976898Z","time spent":"806.435256ms","remote":"127.0.0.1:45412","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":27,"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-06-28T19:59:47.78335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"572.495132ms","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-06-28T19:59:47.783378Z","caller":"traceutil/trace.go:171","msg":"trace[798889081] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1061; }","duration":"572.521363ms","start":"2026-06-28T19:59:47.210849Z","end":"2026-06-28T19:59:47.783371Z","steps":["trace[798889081] 'agreement among raft nodes before linearized reading' (duration: 572.444941ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:59:47.783412Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:59:47.210827Z","time spent":"572.577904ms","remote":"127.0.0.1:40928","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-06-28T19:59:47.783534Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.780271ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:59:47.783261Z","caller":"traceutil/trace.go:171","msg":"trace[961564589] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1061; }","duration":"838.147617ms","start":"2026-06-28T19:59:46.945104Z","end":"2026-06-28T19:59:47.783252Z","steps":["trace[961564589] 'agreement among raft nodes before linearized reading' (duration: 837.994222ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:59:47.783557Z","caller":"traceutil/trace.go:171","msg":"trace[203688923] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1061; }","duration":"310.843873ms","start":"2026-06-28T19:59:47.472706Z","end":"2026-06-28T19:59:47.783549Z","steps":["trace[203688923] 'agreement among raft nodes before linearized reading' (duration: 310.809533ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:59:47.783573Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:59:46.945079Z","time spent":"838.480796ms","remote":"127.0.0.1:40928","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-06-28T19:59:47.783582Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:59:47.472684Z","time spent":"310.892834ms","remote":"127.0.0.1:40646","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-28T19:59:47.783651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"653.237183ms","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-06-28T19:59:47.783707Z","caller":"traceutil/trace.go:171","msg":"trace[809708318] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1061; }","duration":"653.323075ms","start":"2026-06-28T19:59:47.13037Z","end":"2026-06-28T19:59:47.783693Z","steps":["trace[809708318] 'agreement among raft nodes before linearized reading' (duration: 653.151551ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:59:47.783742Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:59:47.130349Z","time spent":"653.385417ms","remote":"127.0.0.1:40928","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-06-28T19:59:47.783817Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"572.974075ms","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-06-28T19:59:47.783926Z","caller":"traceutil/trace.go:171","msg":"trace[84198826] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1061; }","duration":"573.134979ms","start":"2026-06-28T19:59:47.210769Z","end":"2026-06-28T19:59:47.783904Z","steps":["trace[84198826] 'agreement among raft nodes before linearized reading' (duration: 572.857302ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:59:47.783986Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:59:47.21075Z","time spent":"573.221891ms","remote":"127.0.0.1:40928","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-06-28T19:59:48.353561Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.818342ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-28T19:59:48.353638Z","caller":"traceutil/trace.go:171","msg":"trace[1318855072] transaction","detail":"{read_only:false; response_revision:1062; number_of_response:1; }","duration":"566.596505ms","start":"2026-06-28T19:59:47.787027Z","end":"2026-06-28T19:59:48.353624Z","steps":["trace[1318855072] 'process raft request' (duration: 255.646579ms)","trace[1318855072] 'compare' (duration: 310.550395ms)"],"step_count":2} {"level":"warn","ts":"2026-06-28T19:59:48.353694Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:59:47.787005Z","time spent":"566.654877ms","remote":"127.0.0.1:40928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-28T19:59:48.57203Z","caller":"traceutil/trace.go:171","msg":"trace[354744134] linearizableReadLoop","detail":"{readStateIndex:1107; appliedIndex:1103; }","duration":"761.34322ms","start":"2026-06-28T19:59:47.81065Z","end":"2026-06-28T19:59:48.571993Z","steps":["trace[354744134] 'read index received' (duration: 232.037174ms)","trace[354744134] 'applied index is now lower than readState.Index' (duration: 529.304306ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:59:48.572196Z","caller":"traceutil/trace.go:171","msg":"trace[1694276827] transaction","detail":"{read_only:false; response_revision:1064; number_of_response:1; }","duration":"784.385311ms","start":"2026-06-28T19:59:47.787761Z","end":"2026-06-28T19:59:48.572147Z","steps":["trace[1694276827] 'process raft request' (duration: 784.110834ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:59:48.572299Z","caller":"traceutil/trace.go:171","msg":"trace[972613548] transaction","detail":"{read_only:false; response_revision:1065; number_of_response:1; }","duration":"784.38366ms","start":"2026-06-28T19:59:47.7879Z","end":"2026-06-28T19:59:48.572283Z","steps":["trace[972613548] 'process raft request' (duration: 784.039861ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:59:48.572286Z","caller":"traceutil/trace.go:171","msg":"trace[1258729469] transaction","detail":"{read_only:false; response_revision:1063; number_of_response:1; }","duration":"784.422771ms","start":"2026-06-28T19:59:47.787739Z","end":"2026-06-28T19:59:48.572162Z","steps":["trace[1258729469] 'process raft request' (duration: 714.098856ms)","trace[1258729469] 'compare' (duration: 69.822282ms)"],"step_count":2} {"level":"warn","ts":"2026-06-28T19:59:48.572425Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:59:47.787878Z","time spent":"784.468373ms","remote":"127.0.0.1:40928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-28T19:59:48.572419Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:59:47.787744Z","time spent":"784.576725ms","remote":"127.0.0.1:40928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-28T19:59:48.572424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"761.75262ms","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-06-28T19:59:48.572504Z","caller":"traceutil/trace.go:171","msg":"trace[1164363857] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1065; }","duration":"761.860874ms","start":"2026-06-28T19:59:47.810622Z","end":"2026-06-28T19:59:48.572483Z","steps":["trace[1164363857] 'agreement among raft nodes before linearized reading' (duration: 761.657338ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:59:48.572543Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:59:47.787724Z","time spent":"784.695049ms","remote":"127.0.0.1:40928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-28T19:59:48.572563Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:59:47.810599Z","time spent":"761.954496ms","remote":"127.0.0.1:40928","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-28T19:59:48.572651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"396.576547ms","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-06-28T19:59:48.572732Z","caller":"traceutil/trace.go:171","msg":"trace[1466867545] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:1065; }","duration":"396.800653ms","start":"2026-06-28T19:59:48.175915Z","end":"2026-06-28T19:59:48.572716Z","steps":["trace[1466867545] 'agreement among raft nodes before linearized reading' (duration: 396.452154ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:59:48.572848Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:59:48.175901Z","time spent":"396.930946ms","remote":"127.0.0.1:40742","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":14,"response size":29,"request content":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true "} {"level":"info","ts":"2026-06-28T20:00:04.770045Z","caller":"traceutil/trace.go:171","msg":"trace[1078599326] transaction","detail":"{read_only:false; response_revision:1167; number_of_response:1; }","duration":"108.252471ms","start":"2026-06-28T20:00:04.661759Z","end":"2026-06-28T20:00:04.770012Z","steps":["trace[1078599326] 'process raft request' (duration: 99.471658ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T20:00:04.77021Z","caller":"traceutil/trace.go:171","msg":"trace[843674205] linearizableReadLoop","detail":"{readStateIndex:1215; appliedIndex:1213; }","duration":"100.897715ms","start":"2026-06-28T20:00:04.669287Z","end":"2026-06-28T20:00:04.770185Z","steps":["trace[843674205] 'read index received' (duration: 91.953778ms)","trace[843674205] 'applied index is now lower than readState.Index' (duration: 8.943017ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T20:00:04.77029Z","caller":"traceutil/trace.go:171","msg":"trace[172372270] transaction","detail":"{read_only:false; response_revision:1168; number_of_response:1; }","duration":"105.074296ms","start":"2026-06-28T20:00:04.665194Z","end":"2026-06-28T20:00:04.770268Z","steps":["trace[172372270] 'process raft request' (duration: 104.85158ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T20:00:04.770393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.08119ms","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-06-28T20:00:04.770425Z","caller":"traceutil/trace.go:171","msg":"trace[645344432] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1168; }","duration":"101.147312ms","start":"2026-06-28T20:00:04.669268Z","end":"2026-06-28T20:00:04.770416Z","steps":["trace[645344432] 'agreement among raft nodes before linearized reading' (duration: 101.004669ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T20:00:14.969557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.59152ms","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-06-28T20:00:14.969637Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.731504ms","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-06-28T20:00:14.969655Z","caller":"traceutil/trace.go:171","msg":"trace[1615937821] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1199; }","duration":"160.709243ms","start":"2026-06-28T20:00:14.808923Z","end":"2026-06-28T20:00:14.969632Z","steps":["trace[1615937821] 'range keys from in-memory index tree' (duration: 160.442516ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T20:00:14.969686Z","caller":"traceutil/trace.go:171","msg":"trace[2063789857] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1199; }","duration":"163.819527ms","start":"2026-06-28T20:00:14.805853Z","end":"2026-06-28T20:00:14.969672Z","steps":["trace[2063789857] 'range keys from in-memory index tree' (duration: 163.595591ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T20:00:14.969858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.147989ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-28T20:00:14.969921Z","caller":"traceutil/trace.go:171","msg":"trace[1545445136] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1199; }","duration":"163.253061ms","start":"2026-06-28T20:00:14.806655Z","end":"2026-06-28T20:00:14.969908Z","steps":["trace[1545445136] 'range keys from in-memory index tree' (duration: 163.011895ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T20:00:16.780537Z","caller":"traceutil/trace.go:171","msg":"trace[1688765796] transaction","detail":"{read_only:false; response_revision:1205; number_of_response:1; }","duration":"286.047884ms","start":"2026-06-28T20:00:16.494463Z","end":"2026-06-28T20:00:16.780511Z","steps":["trace[1688765796] 'process raft request' (duration: 285.89983ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T20:00:21.162148Z","caller":"traceutil/trace.go:171","msg":"trace[489941995] transaction","detail":"{read_only:false; response_revision:1240; number_of_response:1; }","duration":"120.140872ms","start":"2026-06-28T20:00:21.04198Z","end":"2026-06-28T20:00:21.162121Z","steps":["trace[489941995] 'process raft request' (duration: 119.837053ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T20:00:21.68161Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"322.948227ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T20:00:21.681702Z","caller":"traceutil/trace.go:171","msg":"trace[69060404] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1240; }","duration":"323.04845ms","start":"2026-06-28T20:00:21.358642Z","end":"2026-06-28T20:00:21.68169Z","steps":["trace[69060404] 'range keys from in-memory index tree' (duration: 322.935817ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T20:00:21.681898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.072212ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-28T20:00:21.681947Z","caller":"traceutil/trace.go:171","msg":"trace[948661491] transaction","detail":"{read_only:false; response_revision:1241; number_of_response:1; }","duration":"514.826678ms","start":"2026-06-28T20:00:21.16711Z","end":"2026-06-28T20:00:21.681937Z","steps":["trace[948661491] 'process raft request' (duration: 356.676174ms)","trace[948661491] 'compare' (duration: 157.61241ms)"],"step_count":2} {"level":"warn","ts":"2026-06-28T20:00:21.681983Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T20:00:21.167093Z","time spent":"514.872819ms","remote":"127.0.0.1:40928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-28T20:00:21.683464Z","caller":"traceutil/trace.go:171","msg":"trace[1004041882] linearizableReadLoop","detail":"{readStateIndex:1293; appliedIndex:1291; }","duration":"210.77635ms","start":"2026-06-28T20:00:21.472667Z","end":"2026-06-28T20:00:21.683443Z","steps":["trace[1004041882] 'read index received' (duration: 51.101835ms)","trace[1004041882] 'applied index is now lower than readState.Index' (duration: 159.673585ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T20:00:21.683501Z","caller":"traceutil/trace.go:171","msg":"trace[1211925211] transaction","detail":"{read_only:false; response_revision:1242; number_of_response:1; }","duration":"516.116133ms","start":"2026-06-28T20:00:21.167372Z","end":"2026-06-28T20:00:21.683488Z","steps":["trace[1211925211] 'process raft request' (duration: 515.977089ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T20:00:21.68357Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.895773ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T20:00:21.683594Z","caller":"traceutil/trace.go:171","msg":"trace[780708966] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1242; }","duration":"210.966925ms","start":"2026-06-28T20:00:21.47262Z","end":"2026-06-28T20:00:21.683587Z","steps":["trace[780708966] 'agreement among raft nodes before linearized reading' (duration: 210.912853ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T20:00:21.683625Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T20:00:21.167358Z","time spent":"516.193635ms","remote":"127.0.0.1:40928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-28T20:00:22.908553Z","caller":"traceutil/trace.go:171","msg":"trace[525232914] transaction","detail":"{read_only:false; response_revision:1245; number_of_response:1; }","duration":"295.819998ms","start":"2026-06-28T20:00:22.612709Z","end":"2026-06-28T20:00:22.908529Z","steps":["trace[525232914] 'process raft request' (duration: 295.650273ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T20:00:23.738821Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T20:00:23.008521Z","time spent":"730.292115ms","remote":"127.0.0.1:33206","response type":"/etcdserverpb.Maintenance/Status","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-06-28T20:00:23.739274Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"509.208947ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-28T20:00:23.739434Z","caller":"traceutil/trace.go:171","msg":"trace[1137874640] linearizableReadLoop","detail":"{readStateIndex:1298; appliedIndex:1296; }","duration":"573.073865ms","start":"2026-06-28T20:00:23.166345Z","end":"2026-06-28T20:00:23.739419Z","steps":["trace[1137874640] 'read index received' (duration: 63.735454ms)","trace[1137874640] 'applied index is now lower than readState.Index' (duration: 509.337201ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T20:00:23.739509Z","caller":"traceutil/trace.go:171","msg":"trace[442087666] transaction","detail":"{read_only:false; response_revision:1246; number_of_response:1; }","duration":"826.485772ms","start":"2026-06-28T20:00:22.913012Z","end":"2026-06-28T20:00:23.739498Z","steps":["trace[442087666] 'process raft request' (duration: 316.983957ms)","trace[442087666] 'compare' (duration: 508.93667ms)"],"step_count":2} {"level":"warn","ts":"2026-06-28T20:00:23.739567Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T20:00:22.912992Z","time spent":"826.546183ms","remote":"127.0.0.1:40928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-28T20:00:23.739696Z","caller":"traceutil/trace.go:171","msg":"trace[1710848642] transaction","detail":"{read_only:false; response_revision:1247; number_of_response:1; }","duration":"825.814274ms","start":"2026-06-28T20:00:22.913857Z","end":"2026-06-28T20:00:23.739671Z","steps":["trace[1710848642] 'process raft request' (duration: 825.513556ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T20:00:23.739825Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"573.484677ms","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-06-28T20:00:23.73984Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T20:00:22.913836Z","time spent":"825.916897ms","remote":"127.0.0.1:40928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-28T20:00:23.739865Z","caller":"traceutil/trace.go:171","msg":"trace[338252393] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1247; }","duration":"573.558809ms","start":"2026-06-28T20:00:23.166296Z","end":"2026-06-28T20:00:23.739855Z","steps":["trace[338252393] 'agreement among raft nodes before linearized reading' (duration: 573.441285ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T20:00:23.739894Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T20:00:23.166275Z","time spent":"573.612349ms","remote":"127.0.0.1:40928","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-28T20:00:23.995691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.334954ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-28T20:00:23.995841Z","caller":"traceutil/trace.go:171","msg":"trace[171754641] linearizableReadLoop","detail":"{readStateIndex:1299; appliedIndex:1298; }","duration":"256.359436ms","start":"2026-06-28T20:00:23.739467Z","end":"2026-06-28T20:00:23.995826Z","steps":["trace[171754641] 'read index received' (duration: 102.786265ms)","trace[171754641] 'applied index is now lower than readState.Index' (duration: 153.572211ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T20:00:23.995931Z","caller":"traceutil/trace.go:171","msg":"trace[946188294] transaction","detail":"{read_only:false; response_revision:1248; number_of_response:1; }","duration":"303.612727ms","start":"2026-06-28T20:00:23.692303Z","end":"2026-06-28T20:00:23.995916Z","steps":["trace[946188294] 'process raft request' (duration: 149.975255ms)","trace[946188294] 'compare' (duration: 153.227701ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T20:00:23.995949Z","caller":"traceutil/trace.go:171","msg":"trace[132099827] transaction","detail":"{read_only:false; response_revision:1249; number_of_response:1; }","duration":"251.127515ms","start":"2026-06-28T20:00:23.744807Z","end":"2026-06-28T20:00:23.995935Z","steps":["trace[132099827] 'process raft request' (duration: 250.980421ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T20:00:23.996011Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T20:00:23.692288Z","time spent":"303.681209ms","remote":"127.0.0.1:40928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-28T20:00:23.996062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.127764ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-06-28T20:00:23.996097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"523.363938ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T20:00:23.996112Z","caller":"traceutil/trace.go:171","msg":"trace[1742238608] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1249; }","duration":"306.204286ms","start":"2026-06-28T20:00:23.689895Z","end":"2026-06-28T20:00:23.996099Z","steps":["trace[1742238608] 'agreement among raft nodes before linearized reading' (duration: 306.046402ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T20:00:23.996112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.300932ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"warn","ts":"2026-06-28T20:00:23.996148Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T20:00:23.689882Z","time spent":"306.259539ms","remote":"127.0.0.1:40928","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-06-28T20:00:23.996151Z","caller":"traceutil/trace.go:171","msg":"trace[1749751788] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1249; }","duration":"523.45084ms","start":"2026-06-28T20:00:23.472685Z","end":"2026-06-28T20:00:23.996136Z","steps":["trace[1749751788] 'agreement among raft nodes before linearized reading' (duration: 523.207844ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T20:00:23.996184Z","caller":"traceutil/trace.go:171","msg":"trace[1493924294] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1249; }","duration":"305.392045ms","start":"2026-06-28T20:00:23.690775Z","end":"2026-06-28T20:00:23.996167Z","steps":["trace[1493924294] 'agreement among raft nodes before linearized reading' (duration: 305.152449ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T20:00:23.996191Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T20:00:23.472666Z","time spent":"523.514932ms","remote":"127.0.0.1:40638","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-28T20:00:23.996224Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T20:00:23.690771Z","time spent":"305.445107ms","remote":"127.0.0.1:40928","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":512,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-06-28T20:00:24.207813Z","caller":"traceutil/trace.go:171","msg":"trace[670104455] transaction","detail":"{read_only:false; response_revision:1250; number_of_response:1; }","duration":"207.261085ms","start":"2026-06-28T20:00:24.000528Z","end":"2026-06-28T20:00:24.207789Z","steps":["trace[670104455] 'process raft request' (duration: 207.024348ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T20:00:24.23941Z","caller":"traceutil/trace.go:171","msg":"trace[1271578386] transaction","detail":"{read_only:false; response_revision:1251; number_of_response:1; }","duration":"238.823564ms","start":"2026-06-28T20:00:24.000562Z","end":"2026-06-28T20:00:24.239386Z","steps":["trace[1271578386] 'process raft request' (duration: 238.68233ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T20:00:25.014279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"360.525858ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-28T20:00:25.014381Z","caller":"traceutil/trace.go:171","msg":"trace[90427837] linearizableReadLoop","detail":"{readStateIndex:1305; appliedIndex:1304; }","duration":"433.486851ms","start":"2026-06-28T20:00:24.580877Z","end":"2026-06-28T20:00:25.014364Z","steps":["trace[90427837] 'read index received' (duration: 72.819669ms)","trace[90427837] 'applied index is now lower than readState.Index' (duration: 360.665482ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T20:00:25.014451Z","caller":"traceutil/trace.go:171","msg":"trace[416912945] transaction","detail":"{read_only:false; response_revision:1254; number_of_response:1; }","duration":"436.183753ms","start":"2026-06-28T20:00:24.578257Z","end":"2026-06-28T20:00:25.01444Z","steps":["trace[416912945] 'process raft request' (duration: 75.427749ms)","trace[416912945] 'compare' (duration: 359.997844ms)"],"step_count":2} {"level":"warn","ts":"2026-06-28T20:00:25.014503Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T20:00:24.578212Z","time spent":"436.267995ms","remote":"127.0.0.1:40702","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":788,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-28T20:00:25.01482Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"433.936133ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:474"} {"level":"info","ts":"2026-06-28T20:00:25.014887Z","caller":"traceutil/trace.go:171","msg":"trace[1280821581] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1254; }","duration":"434.047756ms","start":"2026-06-28T20:00:24.580825Z","end":"2026-06-28T20:00:25.014873Z","steps":["trace[1280821581] 'agreement among raft nodes before linearized reading' (duration: 433.85049ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T20:00:25.014967Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T20:00:24.580784Z","time spent":"434.175089ms","remote":"127.0.0.1:40928","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":496,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-06-28T20:00:25.500844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"336.315547ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-28T20:00:25.501033Z","caller":"traceutil/trace.go:171","msg":"trace[1595041460] transaction","detail":"{read_only:false; response_revision:1257; number_of_response:1; }","duration":"481.797411ms","start":"2026-06-28T20:00:25.019215Z","end":"2026-06-28T20:00:25.501012Z","steps":["trace[1595041460] 'process raft request' (duration: 481.75776ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T20:00:25.501093Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T20:00:25.019202Z","time spent":"481.859872ms","remote":"127.0.0.1:40928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":459,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-28T20:00:25.501218Z","caller":"traceutil/trace.go:171","msg":"trace[698607362] transaction","detail":"{read_only:false; response_revision:1255; number_of_response:1; }","duration":"916.122273ms","start":"2026-06-28T20:00:24.585089Z","end":"2026-06-28T20:00:25.501211Z","steps":["trace[698607362] 'process raft request' (duration: 579.362724ms)","trace[698607362] 'compare' (duration: 336.06192ms)"],"step_count":2} {"level":"warn","ts":"2026-06-28T20:00:25.501253Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T20:00:24.585065Z","time spent":"916.174415ms","remote":"127.0.0.1:40702","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":773,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-28T20:00:25.501348Z","caller":"traceutil/trace.go:171","msg":"trace[513776514] linearizableReadLoop","detail":"{readStateIndex:1306; appliedIndex:1305; }","duration":"486.935578ms","start":"2026-06-28T20:00:25.014406Z","end":"2026-06-28T20:00:25.501342Z","steps":["trace[513776514] 'read index received' (duration: 150.059247ms)","trace[513776514] 'applied index is now lower than readState.Index' (duration: 336.875521ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T20:00:25.501403Z","caller":"traceutil/trace.go:171","msg":"trace[1635307255] transaction","detail":"{read_only:false; response_revision:1256; number_of_response:1; }","duration":"483.354142ms","start":"2026-06-28T20:00:25.018042Z","end":"2026-06-28T20:00:25.501396Z","steps":["trace[1635307255] 'process raft request' (duration: 482.877639ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T20:00:25.501438Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T20:00:25.018022Z","time spent":"483.397313ms","remote":"127.0.0.1:40702","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":836,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-28T20:00:25.501648Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"507.913782ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-28T20:00:25.501675Z","caller":"traceutil/trace.go:171","msg":"trace[1277681745] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:1257; }","duration":"507.942883ms","start":"2026-06-28T20:00:24.993726Z","end":"2026-06-28T20:00:25.501669Z","steps":["trace[1277681745] 'agreement among raft nodes before linearized reading' (duration: 507.882972ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T20:00:25.501694Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T20:00:24.993707Z","time spent":"507.982245ms","remote":"127.0.0.1:54082","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":4,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true "} {"level":"warn","ts":"2026-06-28T20:00:25.501835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.587482ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.177\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-06-28T20:00:25.501858Z","caller":"traceutil/trace.go:171","msg":"trace[1983672079] range","detail":"{range_begin:/registry/masterleases/199.204.45.177; range_end:; response_count:1; response_revision:1257; }","duration":"240.636563ms","start":"2026-06-28T20:00:25.261216Z","end":"2026-06-28T20:00:25.501853Z","steps":["trace[1983672079] 'agreement among raft nodes before linearized reading' (duration: 240.566861ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T20:00:25.745058Z","caller":"traceutil/trace.go:171","msg":"trace[2121662679] transaction","detail":"{read_only:false; response_revision:1258; number_of_response:1; }","duration":"192.549809ms","start":"2026-06-28T20:00:25.552484Z","end":"2026-06-28T20:00:25.745034Z","steps":["trace[2121662679] 'process raft request' (duration: 163.865938ms)","trace[2121662679] 'compare' (duration: 28.371693ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T20:00:31.89781Z","caller":"traceutil/trace.go:171","msg":"trace[1530611643] transaction","detail":"{read_only:false; response_revision:1308; number_of_response:1; }","duration":"122.191087ms","start":"2026-06-28T20:00:31.775594Z","end":"2026-06-28T20:00:31.897786Z","steps":["trace[1530611643] 'process raft request' (duration: 121.956171ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T20:00:32.580664Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5605186101488030244,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-28T20:00:33.081767Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5605186101488030244,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-28T20:00:33.285401Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.367213466s","expected-duration":"1s"} {"level":"info","ts":"2026-06-28T20:00:33.286082Z","caller":"traceutil/trace.go:171","msg":"trace[713955793] transaction","detail":"{read_only:false; response_revision:1310; number_of_response:1; }","duration":"1.373210167s","start":"2026-06-28T20:00:31.912844Z","end":"2026-06-28T20:00:33.286054Z","steps":["trace[713955793] 'process raft request' (duration: 1.373022272s)"],"step_count":1} {"level":"warn","ts":"2026-06-28T20:00:33.286423Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T20:00:31.91279Z","time spent":"1.373502455s","remote":"127.0.0.1:40828","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":13706,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-28T20:00:33.288892Z","caller":"traceutil/trace.go:171","msg":"trace[375838269] linearizableReadLoop","detail":"{readStateIndex:1364; appliedIndex:1362; }","duration":"1.209274768s","start":"2026-06-28T20:00:32.079581Z","end":"2026-06-28T20:00:33.288856Z","steps":["trace[375838269] 'read index received' (duration: 1.206224836s)","trace[375838269] 'applied index is now lower than readState.Index' (duration: 3.048832ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T20:00:33.289202Z","caller":"traceutil/trace.go:171","msg":"trace[1366172585] transaction","detail":"{read_only:false; response_revision:1311; number_of_response:1; }","duration":"1.25211484s","start":"2026-06-28T20:00:32.037074Z","end":"2026-06-28T20:00:33.289189Z","steps":["trace[1366172585] 'process raft request' (duration: 1.251631077s)"],"step_count":1} {"level":"warn","ts":"2026-06-28T20:00:33.289473Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T20:00:32.037053Z","time spent":"1.252189732s","remote":"127.0.0.1:40928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-28T20:00:33.289784Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.210197542s","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-06-28T20:00:33.289844Z","caller":"traceutil/trace.go:171","msg":"trace[544425059] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1311; }","duration":"1.210281165s","start":"2026-06-28T20:00:32.079537Z","end":"2026-06-28T20:00:33.289818Z","steps":["trace[544425059] 'agreement among raft nodes before linearized reading' (duration: 1.210144821s)"],"step_count":1} {"level":"warn","ts":"2026-06-28T20:00:33.289882Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T20:00:32.079518Z","time spent":"1.210352486s","remote":"127.0.0.1:40928","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-28T20:00:33.290117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.050357942s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-06-28T20:00:33.290158Z","caller":"traceutil/trace.go:171","msg":"trace[203217334] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1311; }","duration":"1.050435794s","start":"2026-06-28T20:00:32.239711Z","end":"2026-06-28T20:00:33.290146Z","steps":["trace[203217334] 'agreement among raft nodes before linearized reading' (duration: 1.050344592s)"],"step_count":1} {"level":"warn","ts":"2026-06-28T20:00:33.290188Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T20:00:32.239691Z","time spent":"1.050490066s","remote":"127.0.0.1:40928","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":512,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-28T20:00:33.290751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.023833909s","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-06-28T20:00:33.290797Z","caller":"traceutil/trace.go:171","msg":"trace[693104119] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1311; }","duration":"1.023907612s","start":"2026-06-28T20:00:32.266879Z","end":"2026-06-28T20:00:33.290787Z","steps":["trace[693104119] 'agreement among raft nodes before linearized reading' (duration: 1.023786728s)"],"step_count":1} {"level":"warn","ts":"2026-06-28T20:00:33.290831Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T20:00:32.266867Z","time spent":"1.023957553s","remote":"127.0.0.1:40928","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-06-28T20:00:33.291112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"818.430384ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T20:00:33.29115Z","caller":"traceutil/trace.go:171","msg":"trace[1156871535] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1311; }","duration":"818.503426ms","start":"2026-06-28T20:00:32.472638Z","end":"2026-06-28T20:00:33.291141Z","steps":["trace[1156871535] 'agreement among raft nodes before linearized reading' (duration: 818.452435ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T20:00:33.291176Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T20:00:32.472618Z","time spent":"818.552247ms","remote":"127.0.0.1:40646","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-28T20:00:33.291367Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.010089529s","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-06-28T20:00:33.291406Z","caller":"traceutil/trace.go:171","msg":"trace[1619681342] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1311; }","duration":"1.010145961s","start":"2026-06-28T20:00:32.281247Z","end":"2026-06-28T20:00:33.291393Z","steps":["trace[1619681342] 'agreement among raft nodes before linearized reading' (duration: 1.010056639s)"],"step_count":1} {"level":"warn","ts":"2026-06-28T20:00:33.291436Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T20:00:32.281236Z","time spent":"1.010193302s","remote":"127.0.0.1:40928","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" "} {"level":"info","ts":"2026-06-28T20:00:49.605421Z","caller":"traceutil/trace.go:171","msg":"trace[321156818] transaction","detail":"{read_only:false; response_revision:1394; number_of_response:1; }","duration":"112.932848ms","start":"2026-06-28T20:00:49.492448Z","end":"2026-06-28T20:00:49.605381Z","steps":["trace[321156818] 'process raft request' (duration: 62.300906ms)","trace[321156818] 'compare' (duration: 50.313273ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T20:01:32.342361Z","caller":"traceutil/trace.go:171","msg":"trace[211231420] transaction","detail":"{read_only:false; response_revision:1590; number_of_response:1; }","duration":"157.547695ms","start":"2026-06-28T20:01:32.18478Z","end":"2026-06-28T20:01:32.342328Z","steps":["trace[211231420] 'process raft request' (duration: 156.074961ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T20:01:43.87383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.277274ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-06-28T20:01:43.873883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.948168ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-28T20:01:43.873981Z","caller":"traceutil/trace.go:171","msg":"trace[2047644225] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1639; }","duration":"106.076431ms","start":"2026-06-28T20:01:43.767888Z","end":"2026-06-28T20:01:43.873965Z","steps":["trace[2047644225] 'range keys from in-memory index tree' (duration: 105.813445ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T20:01:43.873904Z","caller":"traceutil/trace.go:171","msg":"trace[2062200488] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1639; }","duration":"112.390576ms","start":"2026-06-28T20:01:43.761497Z","end":"2026-06-28T20:01:43.873887Z","steps":["trace[2062200488] 'range keys from in-memory index tree' (duration: 112.117109ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T20:01:50.090369Z","caller":"traceutil/trace.go:171","msg":"trace[1530659496] linearizableReadLoop","detail":"{readStateIndex:1738; appliedIndex:1736; }","duration":"132.108669ms","start":"2026-06-28T20:01:49.958237Z","end":"2026-06-28T20:01:50.090346Z","steps":["trace[1530659496] 'read index received' (duration: 131.955646ms)","trace[1530659496] 'applied index is now lower than readState.Index' (duration: 152.063µs)"],"step_count":2} {"level":"info","ts":"2026-06-28T20:01:50.090735Z","caller":"traceutil/trace.go:171","msg":"trace[1317835109] transaction","detail":"{read_only:false; response_revision:1670; number_of_response:1; }","duration":"137.782199ms","start":"2026-06-28T20:01:49.952923Z","end":"2026-06-28T20:01:50.090705Z","steps":["trace[1317835109] 'process raft request' (duration: 137.38012ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T20:01:50.090938Z","caller":"traceutil/trace.go:171","msg":"trace[1944480463] transaction","detail":"{read_only:false; response_revision:1669; number_of_response:1; }","duration":"137.77388ms","start":"2026-06-28T20:01:49.952893Z","end":"2026-06-28T20:01:50.090666Z","steps":["trace[1944480463] 'process raft request' (duration: 137.280698ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T20:01:50.091498Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.511019ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-28T20:01:50.091574Z","caller":"traceutil/trace.go:171","msg":"trace[2084928070] range","detail":"{range_begin:/registry/daemonsets/; range_end:/registry/daemonsets0; response_count:0; response_revision:1670; }","duration":"133.374248ms","start":"2026-06-28T20:01:49.958184Z","end":"2026-06-28T20:01:50.091558Z","steps":["trace[2084928070] 'agreement among raft nodes before linearized reading' (duration: 132.407806ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T20:02:32.336487Z","caller":"traceutil/trace.go:171","msg":"trace[591417577] transaction","detail":"{read_only:false; response_revision:1861; number_of_response:1; }","duration":"174.484471ms","start":"2026-06-28T20:02:32.161945Z","end":"2026-06-28T20:02:32.33643Z","steps":["trace[591417577] 'process raft request' (duration: 173.851304ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T20:02:34.644415Z","caller":"traceutil/trace.go:171","msg":"trace[289332927] transaction","detail":"{read_only:false; response_revision:1873; number_of_response:1; }","duration":"216.211034ms","start":"2026-06-28T20:02:34.428166Z","end":"2026-06-28T20:02:34.644377Z","steps":["trace[289332927] 'process raft request' (duration: 143.41616ms)","trace[289332927] 'compare' (duration: 72.060244ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T20:02:34.644441Z","caller":"traceutil/trace.go:171","msg":"trace[388212152] linearizableReadLoop","detail":"{readStateIndex:1950; appliedIndex:1949; }","duration":"171.725338ms","start":"2026-06-28T20:02:34.472681Z","end":"2026-06-28T20:02:34.644407Z","steps":["trace[388212152] 'read index received' (duration: 98.892204ms)","trace[388212152] 'applied index is now lower than readState.Index' (duration: 72.828974ms)"],"step_count":2} {"level":"warn","ts":"2026-06-28T20:02:34.644573Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.866552ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T20:02:34.644628Z","caller":"traceutil/trace.go:171","msg":"trace[2010164610] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1874; }","duration":"171.997435ms","start":"2026-06-28T20:02:34.47262Z","end":"2026-06-28T20:02:34.644617Z","steps":["trace[2010164610] 'agreement among raft nodes before linearized reading' (duration: 171.878482ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T20:02:34.644751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.085495ms","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-06-28T20:02:34.644856Z","caller":"traceutil/trace.go:171","msg":"trace[1828985987] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1874; }","duration":"100.242519ms","start":"2026-06-28T20:02:34.544591Z","end":"2026-06-28T20:02:34.644833Z","steps":["trace[1828985987] 'agreement among raft nodes before linearized reading' (duration: 100.032903ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T20:02:38.492564Z","caller":"traceutil/trace.go:171","msg":"trace[1584870563] transaction","detail":"{read_only:false; response_revision:1889; number_of_response:1; }","duration":"102.962351ms","start":"2026-06-28T20:02:38.389581Z","end":"2026-06-28T20:02:38.492544Z","steps":["trace[1584870563] 'process raft request' (duration: 96.005537ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T20:02:38.536915Z","caller":"traceutil/trace.go:171","msg":"trace[329651494] transaction","detail":"{read_only:false; response_revision:1890; number_of_response:1; }","duration":"147.313513ms","start":"2026-06-28T20:02:38.389581Z","end":"2026-06-28T20:02:38.536895Z","steps":["trace[329651494] 'process raft request' (duration: 147.119258ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T20:02:38.53703Z","caller":"traceutil/trace.go:171","msg":"trace[1813396616] transaction","detail":"{read_only:false; response_revision:1891; number_of_response:1; }","duration":"147.392425ms","start":"2026-06-28T20:02:38.389608Z","end":"2026-06-28T20:02:38.537001Z","steps":["trace[1813396616] 'process raft request' (duration: 147.251661ms)"],"step_count":1}