{"level":"warn","ts":"2026-06-26T03:08:35.649279Z","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-26T03:08:35.649359Z","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-26T03:08:35.649422Z","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-26T03:08:35.649431Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.177:2380"]} {"level":"info","ts":"2026-06-26T03:08:35.649455Z","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-26T03:08:35.65009Z","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-26T03:08:35.650166Z","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-26T03:08:35.655956Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.606648ms"} {"level":"info","ts":"2026-06-26T03:08:35.664425Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"7c53a18098324dc9","cluster-id":"4717e8aa221973c8"} {"level":"info","ts":"2026-06-26T03:08:35.664502Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7c53a18098324dc9 switched to configuration voters=()"} {"level":"info","ts":"2026-06-26T03:08:35.664522Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7c53a18098324dc9 became follower at term 0"} {"level":"info","ts":"2026-06-26T03:08:35.66453Z","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-26T03:08:35.664539Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7c53a18098324dc9 became follower at term 1"} {"level":"info","ts":"2026-06-26T03:08:35.664576Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7c53a18098324dc9 switched to configuration voters=(8958681657451367881)"} {"level":"warn","ts":"2026-06-26T03:08:35.676866Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-26T03:08:35.678227Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-26T03:08:35.680226Z","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-26T03:08:35.683283Z","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-26T03:08:35.683534Z","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-26T03:08:35.683747Z","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-26T03:08:35.68433Z","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-26T03:08:35.684359Z","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-26T03:08:35.684899Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7c53a18098324dc9 switched to configuration voters=(8958681657451367881)"} {"level":"info","ts":"2026-06-26T03:08:35.685087Z","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-26T03:08:35.689093Z","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-26T03:08:35.689192Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.177:2380"} {"level":"info","ts":"2026-06-26T03:08:35.68929Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.177:2380"} {"level":"info","ts":"2026-06-26T03:08:35.689453Z","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-26T03:08:35.689509Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-26T03:08:36.564948Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7c53a18098324dc9 is starting a new election at term 1"} {"level":"info","ts":"2026-06-26T03:08:36.565025Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7c53a18098324dc9 became pre-candidate at term 1"} {"level":"info","ts":"2026-06-26T03:08:36.565049Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7c53a18098324dc9 received MsgPreVoteResp from 7c53a18098324dc9 at term 1"} {"level":"info","ts":"2026-06-26T03:08:36.565068Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7c53a18098324dc9 became candidate at term 2"} {"level":"info","ts":"2026-06-26T03:08:36.565079Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7c53a18098324dc9 received MsgVoteResp from 7c53a18098324dc9 at term 2"} {"level":"info","ts":"2026-06-26T03:08:36.565095Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7c53a18098324dc9 became leader at term 2"} {"level":"info","ts":"2026-06-26T03:08:36.565108Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 7c53a18098324dc9 elected leader 7c53a18098324dc9 at term 2"} {"level":"info","ts":"2026-06-26T03:08:36.756299Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-26T03:08:36.768606Z","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-26T03:08:36.768625Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-26T03:08:36.768783Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-26T03:08:36.768955Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-26T03:08:36.769037Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-26T03:08:36.771712Z","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-26T03:08:36.771865Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-26T03:08:36.771912Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-26T03:08:36.772361Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-26T03:08:36.775094Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.177:2379"} {"level":"warn","ts":"2026-06-26T03:08:38.473538Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5605186041751392373,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-26T03:08:38.638818Z","caller":"traceutil/trace.go:171","msg":"trace[383704932] transaction","detail":"{read_only:false; response_revision:2; number_of_response:1; }","duration":"666.493121ms","start":"2026-06-26T03:08:37.972297Z","end":"2026-06-26T03:08:38.63879Z","steps":["trace[383704932] 'process raft request' (duration: 666.259662ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:08:38.639467Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:08:37.972285Z","time spent":"666.620416ms","remote":"127.0.0.1:33568","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":105,"response count":0,"response size":36,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T03:08:40.339985Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.268225887s","expected-duration":"1s"} {"level":"info","ts":"2026-06-26T03:08:40.340449Z","caller":"traceutil/trace.go:171","msg":"trace[888377336] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"2.28754068s","start":"2026-06-26T03:08:38.052868Z","end":"2026-06-26T03:08:40.340409Z","steps":["trace[888377336] 'process raft request' (duration: 2.287412866s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:08:40.340618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.367675379s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3171"} {"level":"info","ts":"2026-06-26T03:08:40.34069Z","caller":"traceutil/trace.go:171","msg":"trace[140740258] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"2.288110351s","start":"2026-06-26T03:08:38.05257Z","end":"2026-06-26T03:08:40.340681Z","steps":["trace[140740258] 'process raft request' (duration: 2.287579332s)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:08:40.340686Z","caller":"traceutil/trace.go:171","msg":"trace[470104806] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"2.2873007s","start":"2026-06-26T03:08:38.053354Z","end":"2026-06-26T03:08:40.340655Z","steps":["trace[470104806] 'process raft request' (duration: 2.28702753s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:08:40.340742Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:08:38.052548Z","time spent":"2.288173704s","remote":"127.0.0.1:33882","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":698,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-26T03:08:40.340825Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:08:38.053322Z","time spent":"2.287442825s","remote":"127.0.0.1:33960","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":920,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-26T03:08:40.340929Z","caller":"traceutil/trace.go:171","msg":"trace[1560452486] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"2.277894692s","start":"2026-06-26T03:08:38.06302Z","end":"2026-06-26T03:08:40.340914Z","steps":["trace[1560452486] 'process raft request' (duration: 2.277382292s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:08:40.341035Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:08:38.063006Z","time spent":"2.277976724s","remote":"127.0.0.1:33666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3159,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-26T03:08:40.341051Z","caller":"traceutil/trace.go:171","msg":"trace[559288951] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"2.287733817s","start":"2026-06-26T03:08:38.053306Z","end":"2026-06-26T03:08:40.34104Z","steps":["trace[559288951] 'process raft request' (duration: 2.287053242s)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:08:40.341058Z","caller":"traceutil/trace.go:171","msg":"trace[116457178] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"2.287738768s","start":"2026-06-26T03:08:38.053288Z","end":"2026-06-26T03:08:40.341026Z","steps":["trace[116457178] 'process raft request' (duration: 2.287050212s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:08:40.340645Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:08:38.05285Z","time spent":"2.287699786s","remote":"127.0.0.1:33960","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":971,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-26T03:08:40.341111Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:08:38.053292Z","time spent":"2.287792589s","remote":"127.0.0.1:33960","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":992,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-26T03:08:40.341181Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:08:38.053281Z","time spent":"2.287842621s","remote":"127.0.0.1:33960","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-26T03:08:40.340478Z","caller":"traceutil/trace.go:171","msg":"trace[574175215] linearizableReadLoop","detail":"{readStateIndex:13; appliedIndex:4; }","duration":"2.367537514s","start":"2026-06-26T03:08:37.972914Z","end":"2026-06-26T03:08:40.340451Z","steps":["trace[574175215] 'read index received' (duration: 665.717643ms)","trace[574175215] 'applied index is now lower than readState.Index' (duration: 1.701819061s)"],"step_count":2} {"level":"warn","ts":"2026-06-26T03:08:40.341305Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.367768033s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-26T03:08:40.341335Z","caller":"traceutil/trace.go:171","msg":"trace[581341953] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"2.271416751s","start":"2026-06-26T03:08:38.069905Z","end":"2026-06-26T03:08:40.341322Z","steps":["trace[581341953] 'process raft request' (duration: 2.270520537s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:08:40.341395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"623.203072ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/default\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-06-26T03:08:40.341407Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:08:38.069891Z","time spent":"2.271479582s","remote":"127.0.0.1:33736","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":849,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-26T03:08:40.34142Z","caller":"traceutil/trace.go:171","msg":"trace[1886654689] range","detail":"{range_begin:/registry/namespaces/default; range_end:; response_count:0; response_revision:10; }","duration":"623.256524ms","start":"2026-06-26T03:08:39.718157Z","end":"2026-06-26T03:08:40.341413Z","steps":["trace[1886654689] 'agreement among raft nodes before linearized reading' (duration: 623.220223ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:08:40.341439Z","caller":"traceutil/trace.go:171","msg":"trace[667672992] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"2.288294598s","start":"2026-06-26T03:08:38.053137Z","end":"2026-06-26T03:08:40.341432Z","steps":["trace[667672992] 'process raft request' (duration: 2.287173046s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:08:40.341448Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:08:39.71814Z","time spent":"623.302506ms","remote":"127.0.0.1:33606","response type":"/etcdserverpb.KV/Range","request count":0,"request size":30,"response count":0,"response size":26,"request content":"key:\"/registry/namespaces/default\" "} {"level":"warn","ts":"2026-06-26T03:08:40.341482Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:08:38.05313Z","time spent":"2.288332379s","remote":"127.0.0.1:33960","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":883,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-26T03:08:40.340692Z","caller":"traceutil/trace.go:171","msg":"trace[139478400] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:10; }","duration":"2.367781232s","start":"2026-06-26T03:08:37.972898Z","end":"2026-06-26T03:08:40.340679Z","steps":["trace[139478400] 'agreement among raft nodes before linearized reading' (duration: 2.367610036s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:08:40.341583Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:08:37.972891Z","time spent":"2.368678467s","remote":"127.0.0.1:33666","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":3193,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-06-26T03:08:40.341631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.389746869s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/system-node-critical\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-26T03:08:40.341665Z","caller":"traceutil/trace.go:171","msg":"trace[1869403236] range","detail":"{range_begin:/registry/priorityclasses/system-node-critical; range_end:; response_count:0; response_revision:10; }","duration":"1.38980046s","start":"2026-06-26T03:08:38.951856Z","end":"2026-06-26T03:08:40.341656Z","steps":["trace[1869403236] 'agreement among raft nodes before linearized reading' (duration: 1.389757718s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:08:40.341691Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:08:38.951845Z","time spent":"1.389840012s","remote":"127.0.0.1:33812","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":0,"response size":26,"request content":"key:\"/registry/priorityclasses/system-node-critical\" "} {"level":"info","ts":"2026-06-26T03:08:40.341346Z","caller":"traceutil/trace.go:171","msg":"trace[1066971965] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:0; response_revision:10; }","duration":"2.367828034s","start":"2026-06-26T03:08:37.973508Z","end":"2026-06-26T03:08:40.341336Z","steps":["trace[1066971965] 'agreement among raft nodes before linearized reading' (duration: 2.367758622s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:08:40.341815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.28890107s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-06-26T03:08:40.341815Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:08:37.9735Z","time spent":"2.368302051s","remote":"127.0.0.1:33562","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":0,"response size":26,"request content":"key:\"/registry/ranges/serviceips\" "} {"level":"warn","ts":"2026-06-26T03:08:40.341826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.238090521s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-26T03:08:40.341855Z","caller":"traceutil/trace.go:171","msg":"trace[1742297511] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"2.238151493s","start":"2026-06-26T03:08:38.103696Z","end":"2026-06-26T03:08:40.341848Z","steps":["trace[1742297511] 'agreement among raft nodes before linearized reading' (duration: 2.238094241s)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:08:40.341855Z","caller":"traceutil/trace.go:171","msg":"trace[1056627785] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:10; }","duration":"2.288942353s","start":"2026-06-26T03:08:38.052897Z","end":"2026-06-26T03:08:40.341839Z","steps":["trace[1056627785] 'agreement among raft nodes before linearized reading' (duration: 2.288896311s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:08:40.341882Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:08:38.103677Z","time spent":"2.238200555s","remote":"127.0.0.1:33606","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":26,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-06-26T03:08:40.341897Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:08:38.052892Z","time spent":"2.288994734s","remote":"127.0.0.1:33576","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":26,"request content":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" "} {"level":"warn","ts":"2026-06-26T03:08:40.341973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.390390362s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-26T03:08:40.341996Z","caller":"traceutil/trace.go:171","msg":"trace[854622628] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:10; }","duration":"1.390414223s","start":"2026-06-26T03:08:38.951577Z","end":"2026-06-26T03:08:40.341991Z","steps":["trace[854622628] 'agreement among raft nodes before linearized reading' (duration: 1.390381652s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:08:40.342013Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:08:38.95152Z","time spent":"1.390488426s","remote":"127.0.0.1:33804","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":26,"request content":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" "} {"level":"warn","ts":"2026-06-26T03:08:40.341857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.318700089s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-26T03:08:40.3421Z","caller":"traceutil/trace.go:171","msg":"trace[2079965178] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"2.318977759s","start":"2026-06-26T03:08:38.023117Z","end":"2026-06-26T03:08:40.342094Z","steps":["trace[2079965178] 'agreement among raft nodes before linearized reading' (duration: 2.31872546s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:08:40.34212Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:08:38.023097Z","time spent":"2.319017801s","remote":"127.0.0.1:33606","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":26,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-06-26T03:08:40.341597Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.30433503s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-26T03:08:40.342166Z","caller":"traceutil/trace.go:171","msg":"trace[872185363] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:10; }","duration":"1.304928592s","start":"2026-06-26T03:08:39.037227Z","end":"2026-06-26T03:08:40.342155Z","steps":["trace[872185363] 'agreement among raft nodes before linearized reading' (duration: 1.304348051s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:08:40.341826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.291505757s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.177\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-06-26T03:08:40.342206Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:08:39.037208Z","time spent":"1.304989855s","remote":"127.0.0.1:33484","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":26,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-26T03:08:40.342219Z","caller":"traceutil/trace.go:171","msg":"trace[771397597] range","detail":"{range_begin:/registry/masterleases/199.204.45.177; range_end:; response_count:0; response_revision:10; }","duration":"2.291924002s","start":"2026-06-26T03:08:38.050282Z","end":"2026-06-26T03:08:40.342206Z","steps":["trace[771397597] 'agreement among raft nodes before linearized reading' (duration: 2.291521927s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:08:40.342261Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:08:38.05026Z","time spent":"2.291987114s","remote":"127.0.0.1:33524","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":0,"response size":26,"request content":"key:\"/registry/masterleases/199.204.45.177\" "} {"level":"warn","ts":"2026-06-26T03:08:40.341764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.288925492s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-26T03:08:40.342367Z","caller":"traceutil/trace.go:171","msg":"trace[664717047] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"2.289529094s","start":"2026-06-26T03:08:38.052799Z","end":"2026-06-26T03:08:40.342328Z","steps":["trace[664717047] 'agreement among raft nodes before linearized reading' (duration: 2.288910591s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:08:40.342431Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:08:38.052792Z","time spent":"2.289600198s","remote":"127.0.0.1:33606","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":26,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-06-26T03:08:43.234981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.450319ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-26T03:08:43.235205Z","caller":"traceutil/trace.go:171","msg":"trace[806128385] transaction","detail":"{read_only:false; response_revision:294; number_of_response:1; }","duration":"125.772426ms","start":"2026-06-26T03:08:43.10941Z","end":"2026-06-26T03:08:43.235182Z","steps":["trace[806128385] 'process raft request' (duration: 125.734444ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:08:43.235217Z","caller":"traceutil/trace.go:171","msg":"trace[1839895778] transaction","detail":"{read_only:false; response_revision:292; number_of_response:1; }","duration":"172.21625ms","start":"2026-06-26T03:08:43.062963Z","end":"2026-06-26T03:08:43.235179Z","steps":["trace[1839895778] 'process raft request' (duration: 71.357404ms)","trace[1839895778] 'compare' (duration: 100.287124ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T03:08:43.235321Z","caller":"traceutil/trace.go:171","msg":"trace[521067649] transaction","detail":"{read_only:false; response_revision:293; number_of_response:1; }","duration":"158.698935ms","start":"2026-06-26T03:08:43.076601Z","end":"2026-06-26T03:08:43.2353Z","steps":["trace[521067649] 'process raft request' (duration: 158.485727ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:08:43.235332Z","caller":"traceutil/trace.go:171","msg":"trace[1496795481] linearizableReadLoop","detail":"{readStateIndex:300; appliedIndex:298; }","duration":"126.684909ms","start":"2026-06-26T03:08:43.108626Z","end":"2026-06-26T03:08:43.23531Z","steps":["trace[1496795481] 'read index received' (duration: 25.840945ms)","trace[1496795481] 'applied index is now lower than readState.Index' (duration: 100.842224ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T03:08:43.235481Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.837316ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4017"} {"level":"info","ts":"2026-06-26T03:08:43.235513Z","caller":"traceutil/trace.go:171","msg":"trace[1192107579] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:294; }","duration":"126.903497ms","start":"2026-06-26T03:08:43.108598Z","end":"2026-06-26T03:08:43.235502Z","steps":["trace[1192107579] 'agreement among raft nodes before linearized reading' (duration: 126.795533ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:08:43.240387Z","caller":"traceutil/trace.go:171","msg":"trace[653353354] transaction","detail":"{read_only:false; number_of_response:0; response_revision:294; }","duration":"101.232929ms","start":"2026-06-26T03:08:43.139129Z","end":"2026-06-26T03:08:43.240362Z","steps":["trace[653353354] 'process raft request' (duration: 101.062443ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:08:43.240913Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.147994ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:1 size:664"} {"level":"info","ts":"2026-06-26T03:08:43.240965Z","caller":"traceutil/trace.go:171","msg":"trace[361866168] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:1; response_revision:296; }","duration":"132.234537ms","start":"2026-06-26T03:08:43.108717Z","end":"2026-06-26T03:08:43.240952Z","steps":["trace[361866168] 'agreement among raft nodes before linearized reading' (duration: 132.138793ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:08:53.233186Z","caller":"traceutil/trace.go:171","msg":"trace[614311661] transaction","detail":"{read_only:false; response_revision:413; number_of_response:1; }","duration":"137.675465ms","start":"2026-06-26T03:08:53.095486Z","end":"2026-06-26T03:08:53.233161Z","steps":["trace[614311661] 'process raft request' (duration: 137.484576ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:08:53.60793Z","caller":"traceutil/trace.go:171","msg":"trace[1294866923] transaction","detail":"{read_only:false; response_revision:415; number_of_response:1; }","duration":"118.954633ms","start":"2026-06-26T03:08:53.488904Z","end":"2026-06-26T03:08:53.607859Z","steps":["trace[1294866923] 'process raft request' (duration: 103.358142ms)","trace[1294866923] 'compare' (duration: 15.099112ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T03:09:02.743274Z","caller":"traceutil/trace.go:171","msg":"trace[2136658905] transaction","detail":"{read_only:false; response_revision:435; number_of_response:1; }","duration":"320.079773ms","start":"2026-06-26T03:09:02.423177Z","end":"2026-06-26T03:09:02.743257Z","steps":["trace[2136658905] 'process raft request' (duration: 319.788382ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:09:02.743391Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:09:02.423158Z","time spent":"320.170583ms","remote":"127.0.0.1:33884","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4180,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T03:09:03.273673Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"470.029618ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-26T03:09:03.273782Z","caller":"traceutil/trace.go:171","msg":"trace[1342756079] transaction","detail":"{read_only:false; response_revision:436; number_of_response:1; }","duration":"527.197585ms","start":"2026-06-26T03:09:02.746567Z","end":"2026-06-26T03:09:03.273765Z","steps":["trace[1342756079] 'process raft request' (duration: 56.998847ms)","trace[1342756079] 'compare' (duration: 469.817037ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T03:09:03.27384Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:09:02.746546Z","time spent":"527.267846ms","remote":"127.0.0.1:33738","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-26T03:09:03.480925Z","caller":"traceutil/trace.go:171","msg":"trace[1847669827] transaction","detail":"{read_only:false; response_revision:439; number_of_response:1; }","duration":"728.771625ms","start":"2026-06-26T03:09:02.752136Z","end":"2026-06-26T03:09:03.480908Z","steps":["trace[1847669827] 'process raft request' (duration: 728.743285ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:09:03.481205Z","caller":"traceutil/trace.go:171","msg":"trace[304869280] transaction","detail":"{read_only:false; response_revision:438; number_of_response:1; }","duration":"731.939972ms","start":"2026-06-26T03:09:02.749254Z","end":"2026-06-26T03:09:03.481194Z","steps":["trace[304869280] 'process raft request' (duration: 731.594161ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:09:03.481224Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:09:02.752121Z","time spent":"728.870465ms","remote":"127.0.0.1:33738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T03:09:03.481347Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:09:02.749247Z","time spent":"731.990052ms","remote":"127.0.0.1:33912","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3678,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-26T03:09:03.480933Z","caller":"traceutil/trace.go:171","msg":"trace[739525628] transaction","detail":"{read_only:false; response_revision:437; number_of_response:1; }","duration":"733.439215ms","start":"2026-06-26T03:09:02.747468Z","end":"2026-06-26T03:09:03.480907Z","steps":["trace[739525628] 'process raft request' (duration: 729.282314ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:09:03.48184Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:09:02.747451Z","time spent":"734.274997ms","remote":"127.0.0.1:33738","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-26T03:09:03.713059Z","caller":"traceutil/trace.go:171","msg":"trace[1320533869] transaction","detail":"{read_only:false; response_revision:443; number_of_response:1; }","duration":"224.429959ms","start":"2026-06-26T03:09:03.488606Z","end":"2026-06-26T03:09:03.713036Z","steps":["trace[1320533869] 'process raft request' (duration: 224.325089ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:09:03.71314Z","caller":"traceutil/trace.go:171","msg":"trace[794727336] transaction","detail":"{read_only:false; response_revision:441; number_of_response:1; }","duration":"227.568488ms","start":"2026-06-26T03:09:03.485553Z","end":"2026-06-26T03:09:03.713122Z","steps":["trace[794727336] 'process raft request' (duration: 211.319334ms)","trace[794727336] 'compare' (duration: 15.852712ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T03:09:03.713279Z","caller":"traceutil/trace.go:171","msg":"trace[160993694] transaction","detail":"{read_only:false; response_revision:442; number_of_response:1; }","duration":"227.568427ms","start":"2026-06-26T03:09:03.485705Z","end":"2026-06-26T03:09:03.713273Z","steps":["trace[160993694] 'process raft request' (duration: 227.167636ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:09:04.527689Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"608.894401ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-26T03:09:04.52796Z","caller":"traceutil/trace.go:171","msg":"trace[1052759319] transaction","detail":"{read_only:false; response_revision:446; number_of_response:1; }","duration":"809.798947ms","start":"2026-06-26T03:09:03.718145Z","end":"2026-06-26T03:09:04.527944Z","steps":["trace[1052759319] 'process raft request' (duration: 809.627536ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:09:04.528098Z","caller":"traceutil/trace.go:171","msg":"trace[433384010] transaction","detail":"{read_only:false; response_revision:447; number_of_response:1; }","duration":"809.917997ms","start":"2026-06-26T03:09:03.71815Z","end":"2026-06-26T03:09:04.528068Z","steps":["trace[433384010] 'process raft request' (duration: 809.703686ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:09:04.528161Z","caller":"traceutil/trace.go:171","msg":"trace[1624960809] transaction","detail":"{read_only:false; response_revision:448; number_of_response:1; }","duration":"808.965935ms","start":"2026-06-26T03:09:03.719183Z","end":"2026-06-26T03:09:04.528149Z","steps":["trace[1624960809] 'process raft request' (duration: 808.715083ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:09:04.528227Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:09:03.719171Z","time spent":"809.024775ms","remote":"127.0.0.1:33912","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3795,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T03:09:04.528249Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:09:03.718138Z","time spent":"810.029448ms","remote":"127.0.0.1:33670","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4037,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T03:09:04.528247Z","caller":"traceutil/trace.go:171","msg":"trace[1613874005] transaction","detail":"{read_only:false; response_revision:445; number_of_response:1; }","duration":"810.090658ms","start":"2026-06-26T03:09:03.718117Z","end":"2026-06-26T03:09:04.528208Z","steps":["trace[1613874005] 'process raft request' (duration: 200.616534ms)","trace[1613874005] 'compare' (duration: 608.53864ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T03:09:04.528401Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:09:03.718101Z","time spent":"810.229188ms","remote":"127.0.0.1:33572","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":704,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-26T03:09:04.528403Z","caller":"traceutil/trace.go:171","msg":"trace[1103379889] transaction","detail":"{read_only:false; response_revision:449; number_of_response:1; }","duration":"808.177572ms","start":"2026-06-26T03:09:03.720199Z","end":"2026-06-26T03:09:04.528377Z","steps":["trace[1103379889] 'process raft request' (duration: 807.901951ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:09:04.528544Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:09:03.720177Z","time spent":"808.297072ms","remote":"127.0.0.1:33912","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3804,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T03:09:04.528033Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:09:03.71813Z","time spent":"809.866527ms","remote":"127.0.0.1:33738","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-26T03:09:04.947138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.190286ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-26T03:09:04.947231Z","caller":"traceutil/trace.go:171","msg":"trace[497004680] linearizableReadLoop","detail":"{readStateIndex:467; appliedIndex:466; }","duration":"413.338578ms","start":"2026-06-26T03:09:04.533878Z","end":"2026-06-26T03:09:04.947216Z","steps":["trace[497004680] 'read index received' (duration: 178.983481ms)","trace[497004680] 'applied index is now lower than readState.Index' (duration: 234.354047ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T03:09:04.947308Z","caller":"traceutil/trace.go:171","msg":"trace[568068470] transaction","detail":"{read_only:false; response_revision:450; number_of_response:1; }","duration":"413.588908ms","start":"2026-06-26T03:09:04.533709Z","end":"2026-06-26T03:09:04.947298Z","steps":["trace[568068470] 'process raft request' (duration: 179.174281ms)","trace[568068470] 'compare' (duration: 234.072866ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T03:09:04.947364Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:09:04.533692Z","time spent":"413.650579ms","remote":"127.0.0.1:33572","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":689,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-26T03:09:04.947634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"413.752889ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-7c96b6546b-dfhwb\" ","response":"range_response_count:1 size:4016"} {"level":"info","ts":"2026-06-26T03:09:04.947673Z","caller":"traceutil/trace.go:171","msg":"trace[1130263006] range","detail":"{range_begin:/registry/pods/kube-system/coredns-7c96b6546b-dfhwb; range_end:; response_count:1; response_revision:450; }","duration":"413.830049ms","start":"2026-06-26T03:09:04.533831Z","end":"2026-06-26T03:09:04.947661Z","steps":["trace[1130263006] 'agreement among raft nodes before linearized reading' (duration: 413.705759ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:09:04.9477Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:09:04.533815Z","time spent":"413.879229ms","remote":"127.0.0.1:33670","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":1,"response size":4038,"request content":"key:\"/registry/pods/kube-system/coredns-7c96b6546b-dfhwb\" "} {"level":"warn","ts":"2026-06-26T03:09:04.947878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"413.767359ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/coredns\" ","response":"range_response_count:1 size:4195"} {"level":"info","ts":"2026-06-26T03:09:04.947946Z","caller":"traceutil/trace.go:171","msg":"trace[440748124] range","detail":"{range_begin:/registry/deployments/kube-system/coredns; range_end:; response_count:1; response_revision:450; }","duration":"413.81708ms","start":"2026-06-26T03:09:04.534088Z","end":"2026-06-26T03:09:04.947905Z","steps":["trace[440748124] 'agreement among raft nodes before linearized reading' (duration: 413.759589ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:09:04.947973Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:09:04.534077Z","time spent":"413.889531ms","remote":"127.0.0.1:33884","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":4217,"request content":"key:\"/registry/deployments/kube-system/coredns\" "} {"level":"warn","ts":"2026-06-26T03:09:04.948189Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"412.852886ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/kube-system/coredns-67659f764b\" ","response":"range_response_count:1 size:3810"} {"level":"info","ts":"2026-06-26T03:09:04.948224Z","caller":"traceutil/trace.go:171","msg":"trace[1548889964] range","detail":"{range_begin:/registry/replicasets/kube-system/coredns-67659f764b; range_end:; response_count:1; response_revision:450; }","duration":"412.904526ms","start":"2026-06-26T03:09:04.535311Z","end":"2026-06-26T03:09:04.948216Z","steps":["trace[1548889964] 'agreement among raft nodes before linearized reading' (duration: 412.846736ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:09:04.948249Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:09:04.535302Z","time spent":"412.941467ms","remote":"127.0.0.1:33912","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":3832,"request content":"key:\"/registry/replicasets/kube-system/coredns-67659f764b\" "} {"level":"warn","ts":"2026-06-26T03:09:05.243888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.132224ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-26T03:09:05.244102Z","caller":"traceutil/trace.go:171","msg":"trace[1218632241] linearizableReadLoop","detail":"{readStateIndex:471; appliedIndex:469; }","duration":"238.401252ms","start":"2026-06-26T03:09:05.005686Z","end":"2026-06-26T03:09:05.244087Z","steps":["trace[1218632241] 'read index received' (duration: 3.127781ms)","trace[1218632241] 'applied index is now lower than readState.Index' (duration: 235.272571ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T03:09:05.244189Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.500493ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/kube-system/coredns-67659f764b\" ","response":"range_response_count:1 size:3810"} {"level":"info","ts":"2026-06-26T03:09:05.24422Z","caller":"traceutil/trace.go:171","msg":"trace[1197767041] range","detail":"{range_begin:/registry/replicasets/kube-system/coredns-67659f764b; range_end:; response_count:1; response_revision:456; }","duration":"238.594153ms","start":"2026-06-26T03:09:05.005618Z","end":"2026-06-26T03:09:05.244212Z","steps":["trace[1197767041] 'agreement among raft nodes before linearized reading' (duration: 238.520532ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:09:05.244491Z","caller":"traceutil/trace.go:171","msg":"trace[825337044] transaction","detail":"{read_only:false; response_revision:454; number_of_response:1; }","duration":"241.794804ms","start":"2026-06-26T03:09:05.002685Z","end":"2026-06-26T03:09:05.244479Z","steps":["trace[825337044] 'process raft request' (duration: 65.014358ms)","trace[825337044] 'compare' (duration: 176.004574ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T03:09:05.244763Z","caller":"traceutil/trace.go:171","msg":"trace[974173614] transaction","detail":"{read_only:false; response_revision:455; number_of_response:1; }","duration":"238.621962ms","start":"2026-06-26T03:09:05.006129Z","end":"2026-06-26T03:09:05.244751Z","steps":["trace[974173614] 'process raft request' (duration: 237.85737ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:09:05.244896Z","caller":"traceutil/trace.go:171","msg":"trace[780144317] transaction","detail":"{read_only:false; response_revision:456; number_of_response:1; }","duration":"236.926328ms","start":"2026-06-26T03:09:05.007961Z","end":"2026-06-26T03:09:05.244888Z","steps":["trace[780144317] 'process raft request' (duration: 236.077934ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:09:05.25209Z","caller":"traceutil/trace.go:171","msg":"trace[108706047] transaction","detail":"{read_only:false; response_revision:458; number_of_response:1; }","duration":"237.352329ms","start":"2026-06-26T03:09:05.014715Z","end":"2026-06-26T03:09:05.252067Z","steps":["trace[108706047] 'process raft request' (duration: 237.291789ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:09:05.252353Z","caller":"traceutil/trace.go:171","msg":"trace[276445897] transaction","detail":"{read_only:false; response_revision:457; number_of_response:1; }","duration":"240.058589ms","start":"2026-06-26T03:09:05.012285Z","end":"2026-06-26T03:09:05.252343Z","steps":["trace[276445897] 'process raft request' (duration: 239.605757ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:09:10.752324Z","caller":"traceutil/trace.go:171","msg":"trace[1677726159] transaction","detail":"{read_only:false; response_revision:481; number_of_response:1; }","duration":"193.379092ms","start":"2026-06-26T03:09:10.558912Z","end":"2026-06-26T03:09:10.752291Z","steps":["trace[1677726159] 'process raft request' (duration: 193.146511ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:09:17.861208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.737103ms","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-26T03:09:17.861272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.472002ms","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-26T03:09:17.861332Z","caller":"traceutil/trace.go:171","msg":"trace[1917731323] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:531; }","duration":"285.881695ms","start":"2026-06-26T03:09:17.575423Z","end":"2026-06-26T03:09:17.861305Z","steps":["trace[1917731323] 'range keys from in-memory index tree' (duration: 285.601513ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:09:17.861356Z","caller":"traceutil/trace.go:171","msg":"trace[2084913251] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:531; }","duration":"277.608252ms","start":"2026-06-26T03:09:17.583723Z","end":"2026-06-26T03:09:17.861332Z","steps":["trace[2084913251] 'range keys from in-memory index tree' (duration: 277.309009ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:09:18.752677Z","caller":"traceutil/trace.go:171","msg":"trace[697601424] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"887.813585ms","start":"2026-06-26T03:09:17.864839Z","end":"2026-06-26T03:09:18.752652Z","steps":["trace[697601424] 'process raft request' (duration: 887.637523ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:09:18.752825Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:09:17.864817Z","time spent":"887.924037ms","remote":"127.0.0.1:33738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T03:09:19.523121Z","caller":"traceutil/trace.go:171","msg":"trace[61405198] linearizableReadLoop","detail":"{readStateIndex:553; appliedIndex:551; }","duration":"838.938108ms","start":"2026-06-26T03:09:18.684159Z","end":"2026-06-26T03:09:19.523097Z","steps":["trace[61405198] 'read index received' (duration: 68.361415ms)","trace[61405198] 'applied index is now lower than readState.Index' (duration: 770.575613ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T03:09:19.523227Z","caller":"traceutil/trace.go:171","msg":"trace[1701786682] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"1.656578904s","start":"2026-06-26T03:09:17.866619Z","end":"2026-06-26T03:09:19.523198Z","steps":["trace[1701786682] 'process raft request' (duration: 1.614130509s)","trace[1701786682] 'compare' (duration: 42.195141ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T03:09:19.523275Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"839.10627ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T03:09:19.523362Z","caller":"traceutil/trace.go:171","msg":"trace[373821069] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:533; }","duration":"839.230932ms","start":"2026-06-26T03:09:18.68411Z","end":"2026-06-26T03:09:19.523341Z","steps":["trace[373821069] 'agreement among raft nodes before linearized reading' (duration: 839.100391ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:09:19.523371Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:09:17.866606Z","time spent":"1.656690884s","remote":"127.0.0.1:33738","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-26T03:09:19.523417Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:09:18.684089Z","time spent":"839.308872ms","remote":"127.0.0.1:33484","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-26T03:09:19.523828Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"731.467746ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T03:09:19.52391Z","caller":"traceutil/trace.go:171","msg":"trace[783594906] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:0; response_revision:533; }","duration":"731.598997ms","start":"2026-06-26T03:09:18.792292Z","end":"2026-06-26T03:09:19.523891Z","steps":["trace[783594906] 'agreement among raft nodes before linearized reading' (duration: 731.209403ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:09:19.523954Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:09:18.792277Z","time spent":"731.667438ms","remote":"127.0.0.1:33590","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":27,"request content":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" "} {"level":"warn","ts":"2026-06-26T03:09:19.523964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"735.076349ms","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-26T03:09:19.524038Z","caller":"traceutil/trace.go:171","msg":"trace[1215804569] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:533; }","duration":"735.18308ms","start":"2026-06-26T03:09:18.788832Z","end":"2026-06-26T03:09:19.524015Z","steps":["trace[1215804569] 'agreement among raft nodes before linearized reading' (duration: 734.432383ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:09:19.524095Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:09:18.788809Z","time spent":"735.2779ms","remote":"127.0.0.1:33738","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-26T03:09:20.133693Z","caller":"traceutil/trace.go:171","msg":"trace[7264206] transaction","detail":"{read_only:false; response_revision:559; number_of_response:1; }","duration":"296.428762ms","start":"2026-06-26T03:09:19.837221Z","end":"2026-06-26T03:09:20.13365Z","steps":["trace[7264206] 'process raft request' (duration: 296.37463ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:09:20.133872Z","caller":"traceutil/trace.go:171","msg":"trace[1726378597] transaction","detail":"{read_only:false; response_revision:558; number_of_response:1; }","duration":"306.001813ms","start":"2026-06-26T03:09:19.827835Z","end":"2026-06-26T03:09:20.133837Z","steps":["trace[1726378597] 'process raft request' (duration: 290.881673ms)","trace[1726378597] 'compare' (duration: 14.753355ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T03:09:20.133992Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:09:19.827829Z","time spent":"306.098003ms","remote":"127.0.0.1:33546","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":64462,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T03:09:20.134492Z","caller":"traceutil/trace.go:171","msg":"trace[991686444] transaction","detail":"{read_only:false; response_revision:560; number_of_response:1; }","duration":"275.662914ms","start":"2026-06-26T03:09:19.858809Z","end":"2026-06-26T03:09:20.134472Z","steps":["trace[991686444] 'process raft request' (duration: 275.445472ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:09:20.134738Z","caller":"traceutil/trace.go:171","msg":"trace[540361595] transaction","detail":"{read_only:false; response_revision:562; number_of_response:1; }","duration":"195.606591ms","start":"2026-06-26T03:09:19.939117Z","end":"2026-06-26T03:09:20.134724Z","steps":["trace[540361595] 'process raft request' (duration: 195.48148ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:09:20.134836Z","caller":"traceutil/trace.go:171","msg":"trace[1686529123] transaction","detail":"{read_only:false; response_revision:561; number_of_response:1; }","duration":"266.969141ms","start":"2026-06-26T03:09:19.867857Z","end":"2026-06-26T03:09:20.134826Z","steps":["trace[1686529123] 'process raft request' (duration: 266.509656ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:09:21.332381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.438801ms","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-26T03:09:21.332527Z","caller":"traceutil/trace.go:171","msg":"trace[1536390369] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:574; }","duration":"213.591412ms","start":"2026-06-26T03:09:21.118915Z","end":"2026-06-26T03:09:21.332506Z","steps":["trace[1536390369] 'range keys from in-memory index tree' (duration: 213.426661ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:09:21.332874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"457.686099ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-26T03:09:21.333309Z","caller":"traceutil/trace.go:171","msg":"trace[1496096033] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"1.063892206s","start":"2026-06-26T03:09:20.269378Z","end":"2026-06-26T03:09:21.33327Z","steps":["trace[1496096033] 'process raft request' (duration: 605.591961ms)","trace[1496096033] 'compare' (duration: 457.540708ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T03:09:21.333558Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:09:20.269355Z","time spent":"1.064041058s","remote":"127.0.0.1:33546","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":65190,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T03:09:21.333595Z","caller":"traceutil/trace.go:171","msg":"trace[1097118669] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"1.061786046s","start":"2026-06-26T03:09:20.271792Z","end":"2026-06-26T03:09:21.333578Z","steps":["trace[1097118669] 'process raft request' (duration: 1.061174669s)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:09:21.333683Z","caller":"traceutil/trace.go:171","msg":"trace[1156814642] linearizableReadLoop","detail":"{readStateIndex:599; appliedIndex:596; }","duration":"650.846501ms","start":"2026-06-26T03:09:20.682811Z","end":"2026-06-26T03:09:21.333657Z","steps":["trace[1156814642] 'read index received' (duration: 192.213391ms)","trace[1156814642] 'applied index is now lower than readState.Index' (duration: 458.6323ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T03:09:21.333694Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:09:20.271779Z","time spent":"1.061855297s","remote":"127.0.0.1:33546","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9134,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T03:09:21.333723Z","caller":"traceutil/trace.go:171","msg":"trace[1407276468] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"1.026644789s","start":"2026-06-26T03:09:20.307051Z","end":"2026-06-26T03:09:21.333696Z","steps":["trace[1407276468] 'process raft request' (duration: 1.026415486s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:09:21.333797Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:09:20.307027Z","time spent":"1.02674056s","remote":"127.0.0.1:33546","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":97665,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-26T03:09:21.333835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"651.026683ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-26T03:09:21.333848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"577.737578ms","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-26T03:09:21.333864Z","caller":"traceutil/trace.go:171","msg":"trace[1443459104] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:577; }","duration":"651.097313ms","start":"2026-06-26T03:09:20.682758Z","end":"2026-06-26T03:09:21.333855Z","steps":["trace[1443459104] 'agreement among raft nodes before linearized reading' (duration: 651.002472ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:09:21.333876Z","caller":"traceutil/trace.go:171","msg":"trace[501016649] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:577; }","duration":"577.764208ms","start":"2026-06-26T03:09:20.756102Z","end":"2026-06-26T03:09:21.333866Z","steps":["trace[501016649] 'agreement among raft nodes before linearized reading' (duration: 577.706878ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:09:21.3339Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:09:20.682738Z","time spent":"651.155464ms","remote":"127.0.0.1:33496","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-26T03:09:21.333904Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:09:20.756044Z","time spent":"577.853829ms","remote":"127.0.0.1:33738","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-26T03:09:21.646859Z","caller":"traceutil/trace.go:171","msg":"trace[938477684] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"112.011709ms","start":"2026-06-26T03:09:21.534803Z","end":"2026-06-26T03:09:21.646815Z","steps":["trace[938477684] 'process raft request' (duration: 63.659573ms)","trace[938477684] 'compare' (duration: 48.116834ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T03:09:21.647195Z","caller":"traceutil/trace.go:171","msg":"trace[1195670848] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"111.415263ms","start":"2026-06-26T03:09:21.535753Z","end":"2026-06-26T03:09:21.647168Z","steps":["trace[1195670848] 'process raft request' (duration: 110.985408ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:09:24.084435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.769545ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-26T03:09:24.084551Z","caller":"traceutil/trace.go:171","msg":"trace[1032085581] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"156.483824ms","start":"2026-06-26T03:09:23.928045Z","end":"2026-06-26T03:09:24.084528Z","steps":["trace[1032085581] 'process raft request' (duration: 43.543817ms)","trace[1032085581] 'compare' (duration: 112.644484ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T03:09:25.02854Z","caller":"traceutil/trace.go:171","msg":"trace[1430053985] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"293.483432ms","start":"2026-06-26T03:09:24.735032Z","end":"2026-06-26T03:09:25.028516Z","steps":["trace[1430053985] 'process raft request' (duration: 291.920753ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:09:25.202586Z","caller":"traceutil/trace.go:171","msg":"trace[1731583331] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"112.202309ms","start":"2026-06-26T03:09:25.090357Z","end":"2026-06-26T03:09:25.202559Z","steps":["trace[1731583331] 'process raft request' (duration: 23.107429ms)","trace[1731583331] 'compare' (duration: 88.924698ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T03:09:25.592801Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.094496ms","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-26T03:09:25.592873Z","caller":"traceutil/trace.go:171","msg":"trace[415229976] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:627; }","duration":"219.217138ms","start":"2026-06-26T03:09:25.373637Z","end":"2026-06-26T03:09:25.592854Z","steps":["trace[415229976] 'range keys from in-memory index tree' (duration: 218.910014ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:09:29.577783Z","caller":"traceutil/trace.go:171","msg":"trace[548315676] transaction","detail":"{read_only:false; response_revision:656; number_of_response:1; }","duration":"390.024145ms","start":"2026-06-26T03:09:29.18773Z","end":"2026-06-26T03:09:29.577754Z","steps":["trace[548315676] 'process raft request' (duration: 389.826573ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:09:29.577985Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:09:29.187705Z","time spent":"390.198117ms","remote":"127.0.0.1:33670","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T03:09:30.182165Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5605186041751393626,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-26T03:09:30.24549Z","caller":"traceutil/trace.go:171","msg":"trace[1608781607] linearizableReadLoop","detail":"{readStateIndex:682; appliedIndex:681; }","duration":"563.97815ms","start":"2026-06-26T03:09:29.68148Z","end":"2026-06-26T03:09:30.245458Z","steps":["trace[1608781607] 'read index received' (duration: 500.866571ms)","trace[1608781607] 'applied index is now lower than readState.Index' (duration: 63.110179ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T03:09:30.245556Z","caller":"traceutil/trace.go:171","msg":"trace[1770279645] transaction","detail":"{read_only:false; response_revision:657; number_of_response:1; }","duration":"607.026769ms","start":"2026-06-26T03:09:29.638495Z","end":"2026-06-26T03:09:30.245522Z","steps":["trace[1770279645] 'process raft request' (duration: 543.89069ms)","trace[1770279645] 'compare' (duration: 62.961267ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T03:09:30.245707Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:09:29.638466Z","time spent":"607.161431ms","remote":"127.0.0.1:33738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T03:09:30.245682Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"564.178142ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-26T03:09:30.245747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"530.890521ms","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-26T03:09:30.245784Z","caller":"traceutil/trace.go:171","msg":"trace[975705446] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:657; }","duration":"530.992162ms","start":"2026-06-26T03:09:29.714781Z","end":"2026-06-26T03:09:30.245773Z","steps":["trace[975705446] 'agreement among raft nodes before linearized reading' (duration: 530.83494ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:09:30.245786Z","caller":"traceutil/trace.go:171","msg":"trace[204243638] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:657; }","duration":"564.384725ms","start":"2026-06-26T03:09:29.681376Z","end":"2026-06-26T03:09:30.245761Z","steps":["trace[204243638] 'agreement among raft nodes before linearized reading' (duration: 564.211053ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:09:30.24582Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:09:29.714758Z","time spent":"531.054773ms","remote":"127.0.0.1:33738","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-26T03:09:30.245846Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:09:29.681348Z","time spent":"564.485257ms","remote":"127.0.0.1:33496","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-26T03:09:30.245879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"523.894629ms","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-26T03:09:30.245769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"498.198096ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-26T03:09:30.245911Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"524.61705ms","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-26T03:09:30.245942Z","caller":"traceutil/trace.go:171","msg":"trace[2012087887] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:657; }","duration":"498.432939ms","start":"2026-06-26T03:09:29.747498Z","end":"2026-06-26T03:09:30.24593Z","steps":["trace[2012087887] 'agreement among raft nodes before linearized reading' (duration: 498.174236ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:09:30.245941Z","caller":"traceutil/trace.go:171","msg":"trace[2085472472] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:657; }","duration":"523.976091ms","start":"2026-06-26T03:09:29.721945Z","end":"2026-06-26T03:09:30.245921Z","steps":["trace[2085472472] 'agreement among raft nodes before linearized reading' (duration: 523.761578ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:09:30.245952Z","caller":"traceutil/trace.go:171","msg":"trace[615666004] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:657; }","duration":"524.68746ms","start":"2026-06-26T03:09:29.721248Z","end":"2026-06-26T03:09:30.245936Z","steps":["trace[615666004] 'agreement among raft nodes before linearized reading' (duration: 524.586949ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:09:30.245979Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:09:29.747481Z","time spent":"498.4885ms","remote":"127.0.0.1:33484","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-26T03:09:30.245987Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:09:29.721223Z","time spent":"524.757231ms","remote":"127.0.0.1:33738","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-26T03:09:30.245997Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:09:29.721932Z","time spent":"524.049892ms","remote":"127.0.0.1:33738","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-26T03:09:32.683438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.56387166s","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-26T03:09:32.683581Z","caller":"traceutil/trace.go:171","msg":"trace[1657882394] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:660; }","duration":"1.564015562s","start":"2026-06-26T03:09:31.119537Z","end":"2026-06-26T03:09:32.683553Z","steps":["trace[1657882394] 'range keys from in-memory index tree' (duration: 1.56385603s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:09:32.683746Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.002375879s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T03:09:32.683849Z","caller":"traceutil/trace.go:171","msg":"trace[1895887045] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:660; }","duration":"2.002477331s","start":"2026-06-26T03:09:30.681343Z","end":"2026-06-26T03:09:32.68382Z","steps":["trace[1895887045] 'range keys from in-memory index tree' (duration: 2.002280418s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:09:32.683955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.390260426s","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-26T03:09:32.684022Z","caller":"traceutil/trace.go:171","msg":"trace[1999774720] range","detail":"{range_begin:/registry/masterleases/199.204.45.177; range_end:; response_count:1; response_revision:660; }","duration":"1.390363548s","start":"2026-06-26T03:09:31.293644Z","end":"2026-06-26T03:09:32.684007Z","steps":["trace[1999774720] 'range keys from in-memory index tree' (duration: 1.390114794s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:09:32.684074Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:09:31.293625Z","time spent":"1.390439219s","remote":"127.0.0.1:33524","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.204.45.177\" "} {"level":"warn","ts":"2026-06-26T03:09:32.683958Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:09:30.681298Z","time spent":"2.002594823s","remote":"127.0.0.1:33496","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-26T03:09:32.751748Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5605186041751393634,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-26T03:09:33.040298Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.118746481s","expected-duration":"1s"} {"level":"info","ts":"2026-06-26T03:09:33.040736Z","caller":"traceutil/trace.go:171","msg":"trace[1957012352] transaction","detail":"{read_only:false; response_revision:661; number_of_response:1; }","duration":"1.119335359s","start":"2026-06-26T03:09:31.921381Z","end":"2026-06-26T03:09:33.040717Z","steps":["trace[1957012352] 'process raft request' (duration: 1.119103376s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:09:33.040912Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:09:31.921353Z","time spent":"1.119476371s","remote":"127.0.0.1:33738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T03:09:33.045594Z","caller":"traceutil/trace.go:171","msg":"trace[1632680441] linearizableReadLoop","detail":"{readStateIndex:688; appliedIndex:685; }","duration":"794.354672ms","start":"2026-06-26T03:09:32.251229Z","end":"2026-06-26T03:09:33.045584Z","steps":["trace[1632680441] 'read index received' (duration: 789.33013ms)","trace[1632680441] 'applied index is now lower than readState.Index' (duration: 5.023852ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T03:09:33.045662Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:09:32.686476Z","time spent":"359.184564ms","remote":"127.0.0.1:33524","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-06-26T03:09:33.045931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"794.705107ms","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-26T03:09:33.045987Z","caller":"traceutil/trace.go:171","msg":"trace[573031672] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:662; }","duration":"794.822548ms","start":"2026-06-26T03:09:32.251148Z","end":"2026-06-26T03:09:33.04597Z","steps":["trace[573031672] 'agreement among raft nodes before linearized reading' (duration: 794.604905ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:09:33.046021Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:09:32.251118Z","time spent":"794.89405ms","remote":"127.0.0.1:33738","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-26T03:09:33.04614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"725.27136ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-06-26T03:09:33.046153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"759.098821ms","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-26T03:09:33.046225Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"356.071421ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T03:09:33.046235Z","caller":"traceutil/trace.go:171","msg":"trace[1468586131] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:662; }","duration":"759.247183ms","start":"2026-06-26T03:09:32.28697Z","end":"2026-06-26T03:09:33.046217Z","steps":["trace[1468586131] 'agreement among raft nodes before linearized reading' (duration: 758.992479ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:09:33.046259Z","caller":"traceutil/trace.go:171","msg":"trace[796175163] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:662; }","duration":"356.127431ms","start":"2026-06-26T03:09:32.690123Z","end":"2026-06-26T03:09:33.04625Z","steps":["trace[796175163] 'agreement among raft nodes before linearized reading' (duration: 356.08ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:09:33.046278Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"725.585114ms","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-26T03:09:33.046283Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:09:32.286941Z","time spent":"759.332514ms","remote":"127.0.0.1:33738","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-26T03:09:33.046289Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:09:32.690112Z","time spent":"356.171311ms","remote":"127.0.0.1:33484","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-26T03:09:33.046312Z","caller":"traceutil/trace.go:171","msg":"trace[755565337] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:662; }","duration":"725.651906ms","start":"2026-06-26T03:09:32.320648Z","end":"2026-06-26T03:09:33.0463Z","steps":["trace[755565337] 'agreement among raft nodes before linearized reading' (duration: 725.569805ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:09:33.046347Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:09:32.320628Z","time spent":"725.711496ms","remote":"127.0.0.1:33738","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-26T03:09:33.046184Z","caller":"traceutil/trace.go:171","msg":"trace[1390823594] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:662; }","duration":"725.360392ms","start":"2026-06-26T03:09:32.320813Z","end":"2026-06-26T03:09:33.046173Z","steps":["trace[1390823594] 'agreement among raft nodes before linearized reading' (duration: 725.257941ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:09:33.046461Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:09:32.320781Z","time spent":"725.670736ms","remote":"127.0.0.1:33738","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-26T03:09:33.045935Z","caller":"traceutil/trace.go:171","msg":"trace[864989789] transaction","detail":"{read_only:false; response_revision:662; number_of_response:1; }","duration":"359.321616ms","start":"2026-06-26T03:09:32.686562Z","end":"2026-06-26T03:09:33.045884Z","steps":["trace[864989789] 'process raft request' (duration: 358.97403ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:09:33.04674Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:09:32.686537Z","time spent":"360.114616ms","remote":"127.0.0.1:33572","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":759,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-26T03:09:34.755357Z","caller":"traceutil/trace.go:171","msg":"trace[158562716] transaction","detail":"{read_only:false; response_revision:676; number_of_response:1; }","duration":"283.837802ms","start":"2026-06-26T03:09:34.471492Z","end":"2026-06-26T03:09:34.755329Z","steps":["trace[158562716] 'process raft request' (duration: 283.65019ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:09:35.634327Z","caller":"traceutil/trace.go:171","msg":"trace[2107078233] transaction","detail":"{read_only:false; response_revision:699; number_of_response:1; }","duration":"240.754176ms","start":"2026-06-26T03:09:35.393545Z","end":"2026-06-26T03:09:35.634299Z","steps":["trace[2107078233] 'process raft request' (duration: 162.782462ms)","trace[2107078233] 'compare' (duration: 77.848222ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T03:09:35.640966Z","caller":"traceutil/trace.go:171","msg":"trace[1138462576] transaction","detail":"{read_only:false; response_revision:700; number_of_response:1; }","duration":"242.169958ms","start":"2026-06-26T03:09:35.398772Z","end":"2026-06-26T03:09:35.640942Z","steps":["trace[1138462576] 'process raft request' (duration: 242.029976ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:09:37.590681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.178268ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" ","response":"range_response_count:1 size:10377"} {"level":"info","ts":"2026-06-26T03:09:37.590792Z","caller":"traceutil/trace.go:171","msg":"trace[919281707] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io; range_end:; response_count:1; response_revision:735; }","duration":"216.389491ms","start":"2026-06-26T03:09:37.374378Z","end":"2026-06-26T03:09:37.590768Z","steps":["trace[919281707] 'range keys from in-memory index tree' (duration: 215.945254ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:09:45.15626Z","caller":"traceutil/trace.go:171","msg":"trace[1226770576] transaction","detail":"{read_only:false; response_revision:804; number_of_response:1; }","duration":"210.914837ms","start":"2026-06-26T03:09:44.945319Z","end":"2026-06-26T03:09:45.156234Z","steps":["trace[1226770576] 'process raft request' (duration: 210.755855ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:09:45.156819Z","caller":"traceutil/trace.go:171","msg":"trace[949294208] linearizableReadLoop","detail":"{readStateIndex:834; appliedIndex:833; }","duration":"105.172673ms","start":"2026-06-26T03:09:45.051621Z","end":"2026-06-26T03:09:45.156793Z","steps":["trace[949294208] 'read index received' (duration: 104.575032ms)","trace[949294208] 'applied index is now lower than readState.Index' (duration: 593.571µs)"],"step_count":2} {"level":"warn","ts":"2026-06-26T03:09:45.157055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.402596ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T03:09:45.157254Z","caller":"traceutil/trace.go:171","msg":"trace[62034483] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:804; }","duration":"105.60141ms","start":"2026-06-26T03:09:45.051567Z","end":"2026-06-26T03:09:45.157169Z","steps":["trace[62034483] 'agreement among raft nodes before linearized reading' (duration: 105.400027ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:09:49.18334Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5605186041751394019,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-26T03:09:49.560342Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.464716ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-06-26T03:09:49.569232Z","caller":"traceutil/trace.go:171","msg":"trace[2096023830] linearizableReadLoop","detail":"{readStateIndex:854; appliedIndex:852; }","duration":"886.851905ms","start":"2026-06-26T03:09:48.682357Z","end":"2026-06-26T03:09:49.569209Z","steps":["trace[2096023830] 'read index received' (duration: 581.679468ms)","trace[2096023830] 'applied index is now lower than readState.Index' (duration: 305.171497ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T03:09:49.569322Z","caller":"traceutil/trace.go:171","msg":"trace[2003949087] transaction","detail":"{read_only:false; response_revision:823; number_of_response:1; }","duration":"1.285665897s","start":"2026-06-26T03:09:48.283634Z","end":"2026-06-26T03:09:49.569299Z","steps":["trace[2003949087] 'process raft request' (duration: 1.285424563s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:09:49.569386Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"887.024347ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T03:09:49.569421Z","caller":"traceutil/trace.go:171","msg":"trace[1652067564] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:823; }","duration":"887.107389ms","start":"2026-06-26T03:09:48.682304Z","end":"2026-06-26T03:09:49.569411Z","steps":["trace[1652067564] 'agreement among raft nodes before linearized reading' (duration: 887.037148ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:09:49.569453Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:09:48.682285Z","time spent":"887.16082ms","remote":"127.0.0.1:33484","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-26T03:09:49.569549Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:09:48.283615Z","time spent":"1.28583254s","remote":"127.0.0.1:33670","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4028,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T03:09:49.569573Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"390.168815ms","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-26T03:09:49.569663Z","caller":"traceutil/trace.go:171","msg":"trace[427798597] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:823; }","duration":"390.312868ms","start":"2026-06-26T03:09:49.179332Z","end":"2026-06-26T03:09:49.569645Z","steps":["trace[427798597] 'agreement among raft nodes before linearized reading' (duration: 390.054884ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:09:49.569709Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:09:49.179312Z","time spent":"390.387869ms","remote":"127.0.0.1:33738","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-26T03:09:49.569755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.859508ms","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-26T03:09:49.569756Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"366.146203ms","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-26T03:09:49.569841Z","caller":"traceutil/trace.go:171","msg":"trace[1989750589] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:823; }","duration":"366.258505ms","start":"2026-06-26T03:09:49.203565Z","end":"2026-06-26T03:09:49.569823Z","steps":["trace[1989750589] 'agreement among raft nodes before linearized reading' (duration: 365.953649ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:09:49.569868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.821661ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-06-26T03:09:49.569889Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:09:49.203554Z","time spent":"366.326677ms","remote":"127.0.0.1:33738","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-26T03:09:49.56992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"370.318681ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-26T03:09:49.569966Z","caller":"traceutil/trace.go:171","msg":"trace[1925406320] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:823; }","duration":"370.381812ms","start":"2026-06-26T03:09:49.19957Z","end":"2026-06-26T03:09:49.569952Z","steps":["trace[1925406320] 'agreement among raft nodes before linearized reading' (duration: 370.262259ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:09:49.569996Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:09:49.199558Z","time spent":"370.431282ms","remote":"127.0.0.1:33738","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-26T03:09:49.569803Z","caller":"traceutil/trace.go:171","msg":"trace[1540099349] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:823; }","duration":"325.9555ms","start":"2026-06-26T03:09:49.243833Z","end":"2026-06-26T03:09:49.569788Z","steps":["trace[1540099349] 'agreement among raft nodes before linearized reading' (duration: 325.794377ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:09:49.570092Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:09:49.243821Z","time spent":"326.263566ms","remote":"127.0.0.1:33738","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-26T03:09:49.57007Z","caller":"traceutil/trace.go:171","msg":"trace[1870668650] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:823; }","duration":"369.929934ms","start":"2026-06-26T03:09:49.199987Z","end":"2026-06-26T03:09:49.569917Z","steps":["trace[1870668650] 'agreement among raft nodes before linearized reading' (duration: 369.720879ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:09:49.570139Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:09:49.199965Z","time spent":"370.160278ms","remote":"127.0.0.1:33738","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-26T03:10:03.76386Z","caller":"traceutil/trace.go:171","msg":"trace[1843446718] transaction","detail":"{read_only:false; response_revision:979; number_of_response:1; }","duration":"114.975341ms","start":"2026-06-26T03:10:03.648857Z","end":"2026-06-26T03:10:03.763832Z","steps":["trace[1843446718] 'process raft request' (duration: 114.790217ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:10:04.65217Z","caller":"traceutil/trace.go:171","msg":"trace[50881578] transaction","detail":"{read_only:false; response_revision:996; number_of_response:1; }","duration":"299.199709ms","start":"2026-06-26T03:10:04.352948Z","end":"2026-06-26T03:10:04.652147Z","steps":["trace[50881578] 'process raft request' (duration: 299.033974ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:10:04.908894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.310893ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-26T03:10:04.909078Z","caller":"traceutil/trace.go:171","msg":"trace[1387318665] linearizableReadLoop","detail":"{readStateIndex:1031; appliedIndex:1030; }","duration":"251.829127ms","start":"2026-06-26T03:10:04.657231Z","end":"2026-06-26T03:10:04.90906Z","steps":["trace[1387318665] 'read index received' (duration: 121.225488ms)","trace[1387318665] 'applied index is now lower than readState.Index' (duration: 130.601739ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T03:10:04.909144Z","caller":"traceutil/trace.go:171","msg":"trace[292680118] transaction","detail":"{read_only:false; response_revision:997; number_of_response:1; }","duration":"436.515474ms","start":"2026-06-26T03:10:04.472597Z","end":"2026-06-26T03:10:04.909113Z","steps":["trace[292680118] 'process raft request' (duration: 305.847863ms)","trace[292680118] 'compare' (duration: 130.085479ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T03:10:04.909344Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.084572ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-7c96b6546b-5t5bd\" ","response":"range_response_count:1 size:5072"} {"level":"info","ts":"2026-06-26T03:10:04.909434Z","caller":"traceutil/trace.go:171","msg":"trace[850257691] range","detail":"{range_begin:/registry/pods/kube-system/coredns-7c96b6546b-5t5bd; range_end:; response_count:1; response_revision:997; }","duration":"252.222145ms","start":"2026-06-26T03:10:04.657194Z","end":"2026-06-26T03:10:04.909416Z","steps":["trace[850257691] 'agreement among raft nodes before linearized reading' (duration: 251.9702ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:10:04.909554Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:10:04.472572Z","time spent":"436.779879ms","remote":"127.0.0.1:33738","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-26T03:10:05.152775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.47763ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-26T03:10:05.152876Z","caller":"traceutil/trace.go:171","msg":"trace[1304786073] linearizableReadLoop","detail":"{readStateIndex:1032; appliedIndex:1031; }","duration":"243.719369ms","start":"2026-06-26T03:10:04.909141Z","end":"2026-06-26T03:10:05.15286Z","steps":["trace[1304786073] 'read index received' (duration: 141.018614ms)","trace[1304786073] 'applied index is now lower than readState.Index' (duration: 102.699585ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T03:10:05.152976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"468.761587ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T03:10:05.153007Z","caller":"traceutil/trace.go:171","msg":"trace[2140767031] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:998; }","duration":"468.825519ms","start":"2026-06-26T03:10:04.684173Z","end":"2026-06-26T03:10:05.152998Z","steps":["trace[2140767031] 'agreement among raft nodes before linearized reading' (duration: 468.772668ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:10:05.152996Z","caller":"traceutil/trace.go:171","msg":"trace[1540913750] transaction","detail":"{read_only:false; response_revision:998; number_of_response:1; }","duration":"494.175235ms","start":"2026-06-26T03:10:04.658788Z","end":"2026-06-26T03:10:05.152963Z","steps":["trace[1540913750] 'process raft request' (duration: 391.426169ms)","trace[1540913750] 'compare' (duration: 102.221865ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T03:10:05.15304Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:10:04.684158Z","time spent":"468.872279ms","remote":"127.0.0.1:33484","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-26T03:10:05.153071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.326355ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-7c96b6546b-5t5bd\" ","response":"range_response_count:1 size:5072"} {"level":"info","ts":"2026-06-26T03:10:05.153119Z","caller":"traceutil/trace.go:171","msg":"trace[1321212241] range","detail":"{range_begin:/registry/pods/kube-system/coredns-7c96b6546b-5t5bd; range_end:; response_count:1; response_revision:998; }","duration":"240.411296ms","start":"2026-06-26T03:10:04.912695Z","end":"2026-06-26T03:10:05.153106Z","steps":["trace[1321212241] 'agreement among raft nodes before linearized reading' (duration: 240.276043ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:10:05.153145Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:10:04.658762Z","time spent":"494.305318ms","remote":"127.0.0.1:33912","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3297,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T03:10:05.374777Z","caller":"traceutil/trace.go:171","msg":"trace[13552649] transaction","detail":"{read_only:false; response_revision:1000; number_of_response:1; }","duration":"216.275599ms","start":"2026-06-26T03:10:05.158476Z","end":"2026-06-26T03:10:05.374751Z","steps":["trace[13552649] 'process raft request' (duration: 216.125966ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:10:05.379202Z","caller":"traceutil/trace.go:171","msg":"trace[895498874] transaction","detail":"{read_only:false; number_of_response:1; response_revision:1001; }","duration":"137.875183ms","start":"2026-06-26T03:10:05.241318Z","end":"2026-06-26T03:10:05.379193Z","steps":["trace[895498874] 'process raft request' (duration: 137.798841ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:10:23.115373Z","caller":"traceutil/trace.go:171","msg":"trace[1250536036] transaction","detail":"{read_only:false; response_revision:1061; number_of_response:1; }","duration":"100.026881ms","start":"2026-06-26T03:10:23.015322Z","end":"2026-06-26T03:10:23.115348Z","steps":["trace[1250536036] 'process raft request' (duration: 99.869057ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:10:55.395401Z","caller":"traceutil/trace.go:171","msg":"trace[163556178] transaction","detail":"{read_only:false; response_revision:1171; number_of_response:1; }","duration":"100.985922ms","start":"2026-06-26T03:10:55.294394Z","end":"2026-06-26T03:10:55.39538Z","steps":["trace[163556178] 'process raft request' (duration: 39.072946ms)","trace[163556178] 'compare' (duration: 61.809944ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T03:11:04.441444Z","caller":"traceutil/trace.go:171","msg":"trace[1583029610] linearizableReadLoop","detail":"{readStateIndex:1244; appliedIndex:1243; }","duration":"274.790658ms","start":"2026-06-26T03:11:04.166628Z","end":"2026-06-26T03:11:04.441418Z","steps":["trace[1583029610] 'read index received' (duration: 274.585242ms)","trace[1583029610] 'applied index is now lower than readState.Index' (duration: 204.416µs)"],"step_count":2} {"level":"info","ts":"2026-06-26T03:11:04.441503Z","caller":"traceutil/trace.go:171","msg":"trace[1783833104] transaction","detail":"{read_only:false; response_revision:1198; number_of_response:1; }","duration":"323.204669ms","start":"2026-06-26T03:11:04.118264Z","end":"2026-06-26T03:11:04.441469Z","steps":["trace[1783833104] 'process raft request' (duration: 322.977693ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:11:04.441648Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:11:04.118243Z","time spent":"323.330363ms","remote":"127.0.0.1:33738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T03:11:04.441685Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.033434ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-26T03:11:04.441723Z","caller":"traceutil/trace.go:171","msg":"trace[177293646] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1198; }","duration":"275.138088ms","start":"2026-06-26T03:11:04.166573Z","end":"2026-06-26T03:11:04.441711Z","steps":["trace[177293646] 'agreement among raft nodes before linearized reading' (duration: 274.988784ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:11:04.441765Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.336167ms","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-26T03:11:04.441795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.916663ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-06-26T03:11:04.441838Z","caller":"traceutil/trace.go:171","msg":"trace[224102720] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1198; }","duration":"256.43262ms","start":"2026-06-26T03:11:04.185385Z","end":"2026-06-26T03:11:04.441818Z","steps":["trace[224102720] 'agreement among raft nodes before linearized reading' (duration: 256.220494ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:11:04.44189Z","caller":"traceutil/trace.go:171","msg":"trace[82255425] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1198; }","duration":"265.063427ms","start":"2026-06-26T03:11:04.176806Z","end":"2026-06-26T03:11:04.44187Z","steps":["trace[82255425] 'agreement among raft nodes before linearized reading' (duration: 264.79428ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:11:04.441981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.560203ms","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-26T03:11:04.442032Z","caller":"traceutil/trace.go:171","msg":"trace[621823487] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1198; }","duration":"264.638235ms","start":"2026-06-26T03:11:04.17738Z","end":"2026-06-26T03:11:04.442018Z","steps":["trace[621823487] 'agreement among raft nodes before linearized reading' (duration: 264.377618ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:11:11.448413Z","caller":"traceutil/trace.go:171","msg":"trace[1233674488] transaction","detail":"{read_only:false; response_revision:1223; number_of_response:1; }","duration":"109.383355ms","start":"2026-06-26T03:11:11.338998Z","end":"2026-06-26T03:11:11.448382Z","steps":["trace[1233674488] 'process raft request' (duration: 108.427498ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:11:12.593096Z","caller":"traceutil/trace.go:171","msg":"trace[60935907] transaction","detail":"{read_only:false; response_revision:1226; number_of_response:1; }","duration":"107.266011ms","start":"2026-06-26T03:11:12.485791Z","end":"2026-06-26T03:11:12.593057Z","steps":["trace[60935907] 'process raft request' (duration: 107.106306ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:11:12.593484Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.605894ms","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-26T03:11:12.593573Z","caller":"traceutil/trace.go:171","msg":"trace[669784428] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1226; }","duration":"103.722317ms","start":"2026-06-26T03:11:12.489831Z","end":"2026-06-26T03:11:12.593554Z","steps":["trace[669784428] 'agreement among raft nodes before linearized reading' (duration: 103.468799ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:11:12.59394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.567293ms","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-26T03:11:12.594Z","caller":"traceutil/trace.go:171","msg":"trace[1906127500] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1226; }","duration":"103.671265ms","start":"2026-06-26T03:11:12.490313Z","end":"2026-06-26T03:11:12.593985Z","steps":["trace[1906127500] 'agreement among raft nodes before linearized reading' (duration: 103.329305ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:11:26.763688Z","caller":"traceutil/trace.go:171","msg":"trace[951364310] linearizableReadLoop","detail":"{readStateIndex:1324; appliedIndex:1323; }","duration":"125.212135ms","start":"2026-06-26T03:11:26.638456Z","end":"2026-06-26T03:11:26.763669Z","steps":["trace[951364310] 'read index received' (duration: 125.079751ms)","trace[951364310] 'applied index is now lower than readState.Index' (duration: 131.284µs)"],"step_count":2} {"level":"info","ts":"2026-06-26T03:11:26.763782Z","caller":"traceutil/trace.go:171","msg":"trace[1202576582] transaction","detail":"{read_only:false; response_revision:1273; number_of_response:1; }","duration":"153.402873ms","start":"2026-06-26T03:11:26.61037Z","end":"2026-06-26T03:11:26.763773Z","steps":["trace[1202576582] 'process raft request' (duration: 153.176406ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:11:26.763996Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.532675ms","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-26T03:11:26.764027Z","caller":"traceutil/trace.go:171","msg":"trace[1237104192] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1273; }","duration":"125.623178ms","start":"2026-06-26T03:11:26.638397Z","end":"2026-06-26T03:11:26.76402Z","steps":["trace[1237104192] 'agreement among raft nodes before linearized reading' (duration: 125.492434ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:11:26.784595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.805951ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T03:11:26.784667Z","caller":"traceutil/trace.go:171","msg":"trace[369336583] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1275; }","duration":"102.913656ms","start":"2026-06-26T03:11:26.681737Z","end":"2026-06-26T03:11:26.784651Z","steps":["trace[369336583] 'agreement among raft nodes before linearized reading' (duration: 102.788881ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:11:26.784843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.820885ms","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-26T03:11:26.784927Z","caller":"traceutil/trace.go:171","msg":"trace[2038153049] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1275; }","duration":"134.935528ms","start":"2026-06-26T03:11:26.649964Z","end":"2026-06-26T03:11:26.784899Z","steps":["trace[2038153049] 'agreement among raft nodes before linearized reading' (duration: 134.771973ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:11:26.951511Z","caller":"traceutil/trace.go:171","msg":"trace[1363788361] transaction","detail":"{read_only:false; response_revision:1282; number_of_response:1; }","duration":"134.071201ms","start":"2026-06-26T03:11:26.817418Z","end":"2026-06-26T03:11:26.951489Z","steps":["trace[1363788361] 'process raft request' (duration: 133.938868ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:11:27.017629Z","caller":"traceutil/trace.go:171","msg":"trace[1226528183] linearizableReadLoop","detail":"{readStateIndex:1335; appliedIndex:1333; }","duration":"198.368795ms","start":"2026-06-26T03:11:26.819232Z","end":"2026-06-26T03:11:27.017601Z","steps":["trace[1226528183] 'read index received' (duration: 132.177485ms)","trace[1226528183] 'applied index is now lower than readState.Index' (duration: 66.1904ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T03:11:27.017646Z","caller":"traceutil/trace.go:171","msg":"trace[1166217905] transaction","detail":"{read_only:false; response_revision:1283; number_of_response:1; }","duration":"199.385366ms","start":"2026-06-26T03:11:26.818235Z","end":"2026-06-26T03:11:27.01762Z","steps":["trace[1166217905] 'process raft request' (duration: 176.544789ms)","trace[1166217905] 'compare' (duration: 22.698273ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T03:11:27.017786Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.53077ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/local-path-storage/\" range_end:\"/registry/limitranges/local-path-storage0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T03:11:27.017958Z","caller":"traceutil/trace.go:171","msg":"trace[631582691] range","detail":"{range_begin:/registry/limitranges/local-path-storage/; range_end:/registry/limitranges/local-path-storage0; response_count:0; response_revision:1283; }","duration":"198.735816ms","start":"2026-06-26T03:11:26.819205Z","end":"2026-06-26T03:11:27.017941Z","steps":["trace[631582691] 'agreement among raft nodes before linearized reading' (duration: 198.4997ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:11:35.570459Z","caller":"traceutil/trace.go:171","msg":"trace[568535256] transaction","detail":"{read_only:false; response_revision:1333; number_of_response:1; }","duration":"699.523996ms","start":"2026-06-26T03:11:34.870903Z","end":"2026-06-26T03:11:35.570427Z","steps":["trace[568535256] 'process raft request' (duration: 699.360851ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:11:35.570629Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:11:34.870884Z","time spent":"699.675152ms","remote":"127.0.0.1:33738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T03:11:35.597005Z","caller":"traceutil/trace.go:171","msg":"trace[1870846400] transaction","detail":"{read_only:false; response_revision:1334; number_of_response:1; }","duration":"725.52595ms","start":"2026-06-26T03:11:34.87146Z","end":"2026-06-26T03:11:35.596985Z","steps":["trace[1870846400] 'process raft request' (duration: 725.428517ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:11:35.597137Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:11:34.871439Z","time spent":"725.627572ms","remote":"127.0.0.1:33738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T03:11:38.990333Z","caller":"traceutil/trace.go:171","msg":"trace[1056291555] transaction","detail":"{read_only:false; response_revision:1344; number_of_response:1; }","duration":"132.143346ms","start":"2026-06-26T03:11:38.858162Z","end":"2026-06-26T03:11:38.990306Z","steps":["trace[1056291555] 'process raft request' (duration: 131.92418ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:11:41.45296Z","caller":"traceutil/trace.go:171","msg":"trace[873913611] transaction","detail":"{read_only:false; response_revision:1354; number_of_response:1; }","duration":"115.087208ms","start":"2026-06-26T03:11:41.337838Z","end":"2026-06-26T03:11:41.452925Z","steps":["trace[873913611] 'process raft request' (duration: 113.702155ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:11:41.757917Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.75989ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-26T03:11:41.758091Z","caller":"traceutil/trace.go:171","msg":"trace[1585916015] transaction","detail":"{read_only:false; response_revision:1355; number_of_response:1; }","duration":"231.839869ms","start":"2026-06-26T03:11:41.526233Z","end":"2026-06-26T03:11:41.758073Z","steps":["trace[1585916015] 'process raft request' (duration: 87.836171ms)","trace[1585916015] 'compare' (duration: 143.623825ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T03:11:41.911672Z","caller":"traceutil/trace.go:171","msg":"trace[1660325048] transaction","detail":"{read_only:false; response_revision:1357; number_of_response:1; }","duration":"148.148765ms","start":"2026-06-26T03:11:41.763488Z","end":"2026-06-26T03:11:41.911637Z","steps":["trace[1660325048] 'process raft request' (duration: 136.235939ms)","trace[1660325048] 'compare' (duration: 11.669289ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T03:11:41.911688Z","caller":"traceutil/trace.go:171","msg":"trace[1378250948] transaction","detail":"{read_only:false; response_revision:1359; number_of_response:1; }","duration":"100.082277ms","start":"2026-06-26T03:11:41.811581Z","end":"2026-06-26T03:11:41.911664Z","steps":["trace[1378250948] 'process raft request' (duration: 100.036515ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:11:41.911844Z","caller":"traceutil/trace.go:171","msg":"trace[1425075482] linearizableReadLoop","detail":"{readStateIndex:1414; appliedIndex:1412; }","duration":"102.882663ms","start":"2026-06-26T03:11:41.808938Z","end":"2026-06-26T03:11:41.91182Z","steps":["trace[1425075482] 'read index received' (duration: 90.798631ms)","trace[1425075482] 'applied index is now lower than readState.Index' (duration: 12.080622ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T03:11:41.911866Z","caller":"traceutil/trace.go:171","msg":"trace[2099004250] transaction","detail":"{read_only:false; response_revision:1358; number_of_response:1; }","duration":"117.830484ms","start":"2026-06-26T03:11:41.793997Z","end":"2026-06-26T03:11:41.911827Z","steps":["trace[2099004250] 'process raft request' (duration: 117.535274ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:11:41.912055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.098071ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/default/test-pvc-pod\" ","response":"range_response_count:1 size:2476"} {"level":"info","ts":"2026-06-26T03:11:41.912379Z","caller":"traceutil/trace.go:171","msg":"trace[1516435781] range","detail":"{range_begin:/registry/pods/default/test-pvc-pod; range_end:; response_count:1; response_revision:1359; }","duration":"103.464611ms","start":"2026-06-26T03:11:41.808898Z","end":"2026-06-26T03:11:41.912363Z","steps":["trace[1516435781] 'agreement among raft nodes before linearized reading' (duration: 103.004807ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:11:42.941194Z","caller":"traceutil/trace.go:171","msg":"trace[1526770710] linearizableReadLoop","detail":"{readStateIndex:1416; appliedIndex:1415; }","duration":"114.065062ms","start":"2026-06-26T03:11:42.827107Z","end":"2026-06-26T03:11:42.941172Z","steps":["trace[1526770710] 'read index received' (duration: 113.884497ms)","trace[1526770710] 'applied index is now lower than readState.Index' (duration: 179.555µs)"],"step_count":2} {"level":"info","ts":"2026-06-26T03:11:42.94125Z","caller":"traceutil/trace.go:171","msg":"trace[209486264] transaction","detail":"{read_only:false; response_revision:1360; number_of_response:1; }","duration":"136.213175ms","start":"2026-06-26T03:11:42.805002Z","end":"2026-06-26T03:11:42.941215Z","steps":["trace[209486264] 'process raft request' (duration: 135.994808ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:11:42.941578Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.272508ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/default/test-pvc\" ","response":"range_response_count:1 size:1465"} {"level":"info","ts":"2026-06-26T03:11:42.941659Z","caller":"traceutil/trace.go:171","msg":"trace[565956890] range","detail":"{range_begin:/registry/persistentvolumeclaims/default/test-pvc; range_end:; response_count:1; response_revision:1360; }","duration":"114.569827ms","start":"2026-06-26T03:11:42.827073Z","end":"2026-06-26T03:11:42.941643Z","steps":["trace[565956890] 'agreement among raft nodes before linearized reading' (duration: 114.203286ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:11:48.096482Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.1951ms","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-26T03:11:48.096541Z","caller":"traceutil/trace.go:171","msg":"trace[420726310] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1379; }","duration":"256.289142ms","start":"2026-06-26T03:11:47.84024Z","end":"2026-06-26T03:11:48.096529Z","steps":["trace[420726310] 'range keys from in-memory index tree' (duration: 256.087216ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:11:48.096485Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.334345ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T03:11:48.096687Z","caller":"traceutil/trace.go:171","msg":"trace[1033404528] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:1379; }","duration":"266.568092ms","start":"2026-06-26T03:11:47.830081Z","end":"2026-06-26T03:11:48.096649Z","steps":["trace[1033404528] 'count revisions from in-memory index tree' (duration: 266.246212ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:11:48.096786Z","caller":"traceutil/trace.go:171","msg":"trace[1050002985] linearizableReadLoop","detail":"{readStateIndex:1438; appliedIndex:1436; }","duration":"160.63328ms","start":"2026-06-26T03:11:47.93612Z","end":"2026-06-26T03:11:48.096753Z","steps":["trace[1050002985] 'read index received' (duration: 113.2525ms)","trace[1050002985] 'applied index is now lower than readState.Index' (duration: 47.37965ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T03:11:48.096817Z","caller":"traceutil/trace.go:171","msg":"trace[2072122993] transaction","detail":"{read_only:false; response_revision:1380; number_of_response:1; }","duration":"188.562455ms","start":"2026-06-26T03:11:47.908235Z","end":"2026-06-26T03:11:48.096797Z","steps":["trace[2072122993] 'process raft request' (duration: 141.128044ms)","trace[2072122993] 'compare' (duration: 47.014969ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T03:11:48.09681Z","caller":"traceutil/trace.go:171","msg":"trace[1948433853] transaction","detail":"{read_only:false; response_revision:1381; number_of_response:1; }","duration":"163.077455ms","start":"2026-06-26T03:11:47.933724Z","end":"2026-06-26T03:11:48.096801Z","steps":["trace[1948433853] 'process raft request' (duration: 162.957272ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:11:48.096896Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.785004ms","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-26T03:11:48.096915Z","caller":"traceutil/trace.go:171","msg":"trace[1204295845] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1381; }","duration":"160.97165ms","start":"2026-06-26T03:11:47.935939Z","end":"2026-06-26T03:11:48.09691Z","steps":["trace[1204295845] 'agreement among raft nodes before linearized reading' (duration: 160.908268ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:11:48.493228Z","caller":"traceutil/trace.go:171","msg":"trace[2061066] transaction","detail":"{read_only:false; response_revision:1382; number_of_response:1; }","duration":"392.09255ms","start":"2026-06-26T03:11:48.101105Z","end":"2026-06-26T03:11:48.493197Z","steps":["trace[2061066] 'process raft request' (duration: 378.314322ms)","trace[2061066] 'compare' (duration: 13.471218ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T03:11:48.493405Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:11:48.101088Z","time spent":"392.221704ms","remote":"127.0.0.1:33738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T03:11:48.522558Z","caller":"traceutil/trace.go:171","msg":"trace[562363003] transaction","detail":"{read_only:false; response_revision:1383; number_of_response:1; }","duration":"420.989287ms","start":"2026-06-26T03:11:48.101548Z","end":"2026-06-26T03:11:48.522537Z","steps":["trace[562363003] 'process raft request' (duration: 420.76719ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:11:48.522674Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:11:48.101534Z","time spent":"421.081149ms","remote":"127.0.0.1:33738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T03:11:49.419122Z","caller":"traceutil/trace.go:171","msg":"trace[209465391] linearizableReadLoop","detail":"{readStateIndex:1441; appliedIndex:1440; }","duration":"351.525654ms","start":"2026-06-26T03:11:49.067574Z","end":"2026-06-26T03:11:49.4191Z","steps":["trace[209465391] 'read index received' (duration: 351.415731ms)","trace[209465391] 'applied index is now lower than readState.Index' (duration: 108.863µs)"],"step_count":2} {"level":"warn","ts":"2026-06-26T03:11:49.419332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"351.735211ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-26T03:11:49.419271Z","caller":"traceutil/trace.go:171","msg":"trace[422238183] transaction","detail":"{read_only:false; response_revision:1384; number_of_response:1; }","duration":"357.412757ms","start":"2026-06-26T03:11:49.061826Z","end":"2026-06-26T03:11:49.419239Z","steps":["trace[422238183] 'process raft request' (duration: 357.128449ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:11:49.419364Z","caller":"traceutil/trace.go:171","msg":"trace[629984657] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1384; }","duration":"351.795863ms","start":"2026-06-26T03:11:49.067558Z","end":"2026-06-26T03:11:49.419354Z","steps":["trace[629984657] 'agreement among raft nodes before linearized reading' (duration: 351.663599ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:11:49.4194Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:11:49.067551Z","time spent":"351.841294ms","remote":"127.0.0.1:33738","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-26T03:11:49.419425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.328026ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-26T03:11:49.419482Z","caller":"traceutil/trace.go:171","msg":"trace[242967585] range","detail":"{range_begin:/registry/deployments/; range_end:/registry/deployments0; response_count:0; response_revision:1384; }","duration":"129.445839ms","start":"2026-06-26T03:11:49.290024Z","end":"2026-06-26T03:11:49.419469Z","steps":["trace[242967585] 'agreement among raft nodes before linearized reading' (duration: 129.343855ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:11:49.419535Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:11:49.061797Z","time spent":"357.612825ms","remote":"127.0.0.1:33738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T03:11:49.419897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.412436ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-06-26T03:11:49.42004Z","caller":"traceutil/trace.go:171","msg":"trace[1569928915] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1384; }","duration":"299.607233ms","start":"2026-06-26T03:11:49.120415Z","end":"2026-06-26T03:11:49.420022Z","steps":["trace[1569928915] 'agreement among raft nodes before linearized reading' (duration: 298.86685ms)"],"step_count":1}