{"level":"warn","ts":"2026-05-29T02:07:54.640559Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-29T02:07:54.64064Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.115: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.115:2380","--initial-cluster=instance=https://199.204.45.115:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.115:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.115: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-05-29T02:07:54.640706Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-29T02:07:54.640719Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.115:2380"]} {"level":"info","ts":"2026-05-29T02:07:54.64074Z","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-05-29T02:07:54.641604Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.115:2379"]} {"level":"info","ts":"2026-05-29T02:07:54.641675Z","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.115:2380"],"listen-peer-urls":["https://199.204.45.115:2380"],"advertise-client-urls":["https://199.204.45.115:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.115:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.115: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-05-29T02:07:54.695396Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"53.514506ms"} {"level":"info","ts":"2026-05-29T02:07:54.846291Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"e3aaa5c123e150e0","cluster-id":"61ec519698823541"} {"level":"info","ts":"2026-05-29T02:07:54.846429Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 switched to configuration voters=()"} {"level":"info","ts":"2026-05-29T02:07:54.846463Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 became follower at term 0"} {"level":"info","ts":"2026-05-29T02:07:54.846484Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft e3aaa5c123e150e0 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-29T02:07:54.846508Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 became follower at term 1"} {"level":"info","ts":"2026-05-29T02:07:54.846565Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 switched to configuration voters=(16405106841599693024)"} {"level":"warn","ts":"2026-05-29T02:07:54.870707Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-29T02:07:54.879139Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-29T02:07:54.880329Z","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-05-29T02:07:54.882623Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"e3aaa5c123e150e0","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-29T02:07:54.88298Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"e3aaa5c123e150e0","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-29T02:07:54.88309Z","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-05-29T02:07:54.883141Z","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-05-29T02:07:54.883151Z","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-05-29T02:07:54.884288Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 switched to configuration voters=(16405106841599693024)"} {"level":"info","ts":"2026-05-29T02:07:54.893155Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"61ec519698823541","local-member-id":"e3aaa5c123e150e0","added-peer-id":"e3aaa5c123e150e0","added-peer-peer-urls":["https://199.204.45.115:2380"]} {"level":"info","ts":"2026-05-29T02:07:54.898022Z","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-05-29T02:07:54.898082Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.115:2380"} {"level":"info","ts":"2026-05-29T02:07:54.898123Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.115:2380"} {"level":"info","ts":"2026-05-29T02:07:54.898292Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"e3aaa5c123e150e0","initial-advertise-peer-urls":["https://199.204.45.115:2380"],"listen-peer-urls":["https://199.204.45.115:2380"],"advertise-client-urls":["https://199.204.45.115:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.115:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-29T02:07:54.89835Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-29T02:07:55.749348Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 is starting a new election at term 1"} {"level":"info","ts":"2026-05-29T02:07:55.749407Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-29T02:07:55.749429Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 received MsgPreVoteResp from e3aaa5c123e150e0 at term 1"} {"level":"info","ts":"2026-05-29T02:07:55.749452Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 became candidate at term 2"} {"level":"info","ts":"2026-05-29T02:07:55.749465Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 received MsgVoteResp from e3aaa5c123e150e0 at term 2"} {"level":"info","ts":"2026-05-29T02:07:55.749481Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 became leader at term 2"} {"level":"info","ts":"2026-05-29T02:07:55.749521Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: e3aaa5c123e150e0 elected leader e3aaa5c123e150e0 at term 2"} {"level":"info","ts":"2026-05-29T02:07:55.75277Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-29T02:07:55.757668Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-29T02:07:55.757715Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-29T02:07:55.758172Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-29T02:07:55.758212Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-29T02:07:55.761269Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-29T02:07:55.76141Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.115:2379"} {"level":"info","ts":"2026-05-29T02:07:55.757624Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"e3aaa5c123e150e0","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.115:2379]}","request-path":"/0/members/e3aaa5c123e150e0/attributes","cluster-id":"61ec519698823541","publish-timeout":"7s"} {"level":"info","ts":"2026-05-29T02:07:55.768204Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"61ec519698823541","local-member-id":"e3aaa5c123e150e0","cluster-version":"3.5"} {"level":"info","ts":"2026-05-29T02:07:55.768383Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-29T02:07:55.768421Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-29T02:07:57.454386Z","caller":"traceutil/trace.go:171","msg":"trace[1879094266] linearizableReadLoop","detail":"{readStateIndex:71; appliedIndex:70; }","duration":"209.810062ms","start":"2026-05-29T02:07:57.244552Z","end":"2026-05-29T02:07:57.454362Z","steps":["trace[1879094266] 'read index received' (duration: 206.376701ms)","trace[1879094266] 'applied index is now lower than readState.Index' (duration: 3.432711ms)"],"step_count":2} {"level":"info","ts":"2026-05-29T02:07:57.454493Z","caller":"traceutil/trace.go:171","msg":"trace[188245426] transaction","detail":"{read_only:false; response_revision:67; number_of_response:1; }","duration":"293.605416ms","start":"2026-05-29T02:07:57.160865Z","end":"2026-05-29T02:07:57.45447Z","steps":["trace[188245426] 'process raft request' (duration: 290.144784ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:07:57.454652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.057029ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-29T02:07:57.4547Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.745282ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-29T02:07:57.454744Z","caller":"traceutil/trace.go:171","msg":"trace[277525011] range","detail":"{range_begin:/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te; range_end:; response_count:0; response_revision:67; }","duration":"210.236723ms","start":"2026-05-29T02:07:57.244489Z","end":"2026-05-29T02:07:57.454726Z","steps":["trace[277525011] 'agreement among raft nodes before linearized reading' (duration: 210.080009ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T02:07:57.454792Z","caller":"traceutil/trace.go:171","msg":"trace[1614331725] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:67; }","duration":"138.895386ms","start":"2026-05-29T02:07:57.315869Z","end":"2026-05-29T02:07:57.454765Z","steps":["trace[1614331725] 'agreement among raft nodes before linearized reading' (duration: 138.757933ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:07:58.325116Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.054166ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-29T02:07:58.325223Z","caller":"traceutil/trace.go:171","msg":"trace[2057949629] transaction","detail":"{read_only:false; response_revision:155; number_of_response:1; }","duration":"153.538381ms","start":"2026-05-29T02:07:58.171668Z","end":"2026-05-29T02:07:58.325206Z","steps":["trace[2057949629] 'process raft request' (duration: 44.884351ms)","trace[2057949629] 'compare' (duration: 107.925683ms)"],"step_count":2} {"level":"info","ts":"2026-05-29T02:08:02.453265Z","caller":"traceutil/trace.go:171","msg":"trace[1497884654] transaction","detail":"{read_only:false; response_revision:305; number_of_response:1; }","duration":"832.803237ms","start":"2026-05-29T02:08:01.620439Z","end":"2026-05-29T02:08:02.453243Z","steps":["trace[1497884654] 'process raft request' (duration: 832.669864ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:08:02.453569Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:08:01.620421Z","time spent":"832.92001ms","remote":"127.0.0.1:39604","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5149,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-29T02:08:02.501214Z","caller":"traceutil/trace.go:171","msg":"trace[907477800] transaction","detail":"{read_only:false; response_revision:306; number_of_response:1; }","duration":"855.177687ms","start":"2026-05-29T02:08:01.646005Z","end":"2026-05-29T02:08:02.501183Z","steps":["trace[907477800] 'process raft request' (duration: 855.009083ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:08:02.501331Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:08:01.645983Z","time spent":"855.295589ms","remote":"127.0.0.1:39616","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":176,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-29T02:08:03.188433Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5827832128082272940,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-29T02:08:03.536314Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.028202239s","expected-duration":"1s"} {"level":"info","ts":"2026-05-29T02:08:03.536943Z","caller":"traceutil/trace.go:171","msg":"trace[579248811] transaction","detail":"{read_only:false; response_revision:307; number_of_response:1; }","duration":"1.028903046s","start":"2026-05-29T02:08:02.508024Z","end":"2026-05-29T02:08:03.536927Z","steps":["trace[579248811] 'process raft request' (duration: 1.028777423s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:08:03.537081Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:08:02.508006Z","time spent":"1.028995247s","remote":"127.0.0.1:39604","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7096,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-29T02:08:03.541039Z","caller":"traceutil/trace.go:171","msg":"trace[1022675025] linearizableReadLoop","detail":"{readStateIndex:318; appliedIndex:316; }","duration":"852.80653ms","start":"2026-05-29T02:08:02.688205Z","end":"2026-05-29T02:08:03.541011Z","steps":["trace[1022675025] 'read index received' (duration: 848.683483ms)","trace[1022675025] 'applied index is now lower than readState.Index' (duration: 4.122027ms)"],"step_count":2} {"level":"info","ts":"2026-05-29T02:08:03.54116Z","caller":"traceutil/trace.go:171","msg":"trace[73981068] transaction","detail":"{read_only:false; response_revision:308; number_of_response:1; }","duration":"1.031912107s","start":"2026-05-29T02:08:02.509239Z","end":"2026-05-29T02:08:03.541151Z","steps":["trace[73981068] 'process raft request' (duration: 1.031668481s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:08:03.541248Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:08:02.509207Z","time spent":"1.031979409s","remote":"127.0.0.1:39616","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":192,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-29T02:08:03.541577Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.298647ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-05-29T02:08:03.541612Z","caller":"traceutil/trace.go:171","msg":"trace[2096039257] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:308; }","duration":"285.359309ms","start":"2026-05-29T02:08:03.256242Z","end":"2026-05-29T02:08:03.541601Z","steps":["trace[2096039257] 'agreement among raft nodes before linearized reading' (duration: 285.288678ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:08:03.541694Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"853.476786ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-05-29T02:08:03.541747Z","caller":"traceutil/trace.go:171","msg":"trace[1773652661] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:308; }","duration":"853.546327ms","start":"2026-05-29T02:08:02.688183Z","end":"2026-05-29T02:08:03.54173Z","steps":["trace[1773652661] 'agreement among raft nodes before linearized reading' (duration: 853.434365ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:08:03.54173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"686.574949ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-05-29T02:08:03.541782Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:08:02.688169Z","time spent":"853.605369ms","remote":"127.0.0.1:39676","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-29T02:08:03.541908Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"427.91301ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-05-29T02:08:03.541947Z","caller":"traceutil/trace.go:171","msg":"trace[287079994] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:308; }","duration":"427.982242ms","start":"2026-05-29T02:08:03.113953Z","end":"2026-05-29T02:08:03.541936Z","steps":["trace[287079994] 'agreement among raft nodes before linearized reading' (duration: 427.911821ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:08:03.541983Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:08:03.113931Z","time spent":"428.044054ms","remote":"127.0.0.1:39676","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-05-29T02:08:03.541824Z","caller":"traceutil/trace.go:171","msg":"trace[959826678] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:308; }","duration":"686.716592ms","start":"2026-05-29T02:08:02.855086Z","end":"2026-05-29T02:08:03.541803Z","steps":["trace[959826678] 'agreement among raft nodes before linearized reading' (duration: 686.22315ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:08:03.542134Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:08:02.855036Z","time spent":"687.07656ms","remote":"127.0.0.1:39676","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-05-29T02:08:13.8256Z","caller":"traceutil/trace.go:171","msg":"trace[650133634] transaction","detail":"{read_only:false; response_revision:414; number_of_response:1; }","duration":"143.690669ms","start":"2026-05-29T02:08:13.681882Z","end":"2026-05-29T02:08:13.825573Z","steps":["trace[650133634] 'process raft request' (duration: 120.304395ms)","trace[650133634] 'compare' (duration: 23.2261ms)"],"step_count":2} {"level":"info","ts":"2026-05-29T02:08:13.825837Z","caller":"traceutil/trace.go:171","msg":"trace[701177604] transaction","detail":"{read_only:false; response_revision:415; number_of_response:1; }","duration":"142.91729ms","start":"2026-05-29T02:08:13.682894Z","end":"2026-05-29T02:08:13.825811Z","steps":["trace[701177604] 'process raft request' (duration: 142.641084ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T02:08:13.826151Z","caller":"traceutil/trace.go:171","msg":"trace[898979322] transaction","detail":"{read_only:false; response_revision:416; number_of_response:1; }","duration":"143.020073ms","start":"2026-05-29T02:08:13.683068Z","end":"2026-05-29T02:08:13.826089Z","steps":["trace[898979322] 'process raft request' (duration: 142.701885ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T02:08:19.505035Z","caller":"traceutil/trace.go:171","msg":"trace[168048721] transaction","detail":"{read_only:false; response_revision:428; number_of_response:1; }","duration":"118.669786ms","start":"2026-05-29T02:08:19.386337Z","end":"2026-05-29T02:08:19.505007Z","steps":["trace[168048721] 'process raft request' (duration: 118.503062ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T02:08:19.729916Z","caller":"traceutil/trace.go:171","msg":"trace[1900571811] transaction","detail":"{read_only:false; response_revision:432; number_of_response:1; }","duration":"152.447085ms","start":"2026-05-29T02:08:19.577448Z","end":"2026-05-29T02:08:19.729895Z","steps":["trace[1900571811] 'process raft request' (duration: 152.389764ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T02:08:19.729968Z","caller":"traceutil/trace.go:171","msg":"trace[68548933] transaction","detail":"{read_only:false; response_revision:431; number_of_response:1; }","duration":"154.437613ms","start":"2026-05-29T02:08:19.575503Z","end":"2026-05-29T02:08:19.72994Z","steps":["trace[68548933] 'process raft request' (duration: 154.228048ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T02:08:19.811077Z","caller":"traceutil/trace.go:171","msg":"trace[203582650] transaction","detail":"{read_only:false; response_revision:433; number_of_response:1; }","duration":"137.714695ms","start":"2026-05-29T02:08:19.673327Z","end":"2026-05-29T02:08:19.811042Z","steps":["trace[203582650] 'process raft request' (duration: 106.774338ms)","trace[203582650] 'compare' (duration: 30.745623ms)"],"step_count":2} {"level":"info","ts":"2026-05-29T02:08:19.81111Z","caller":"traceutil/trace.go:171","msg":"trace[812752480] transaction","detail":"{read_only:false; response_revision:434; number_of_response:1; }","duration":"137.658464ms","start":"2026-05-29T02:08:19.673398Z","end":"2026-05-29T02:08:19.811056Z","steps":["trace[812752480] 'process raft request' (duration: 137.545871ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T02:08:19.811136Z","caller":"traceutil/trace.go:171","msg":"trace[1551641699] transaction","detail":"{read_only:false; response_revision:435; number_of_response:1; }","duration":"137.251274ms","start":"2026-05-29T02:08:19.673865Z","end":"2026-05-29T02:08:19.811116Z","steps":["trace[1551641699] 'process raft request' (duration: 137.120441ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T02:08:19.811097Z","caller":"traceutil/trace.go:171","msg":"trace[865915269] transaction","detail":"{read_only:false; response_revision:436; number_of_response:1; }","duration":"135.478462ms","start":"2026-05-29T02:08:19.675603Z","end":"2026-05-29T02:08:19.811081Z","steps":["trace[865915269] 'process raft request' (duration: 135.431361ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:08:20.055498Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.52792ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-05-29T02:08:20.055495Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.585631ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-05-29T02:08:20.055534Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.772632ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-29T02:08:20.055573Z","caller":"traceutil/trace.go:171","msg":"trace[1196650439] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:441; }","duration":"204.633563ms","start":"2026-05-29T02:08:19.850919Z","end":"2026-05-29T02:08:20.055553Z","steps":["trace[1196650439] 'agreement among raft nodes before linearized reading' (duration: 59.971789ms)","trace[1196650439] 'range keys from in-memory index tree' (duration: 144.553471ms)"],"step_count":2} {"level":"info","ts":"2026-05-29T02:08:20.05559Z","caller":"traceutil/trace.go:171","msg":"trace[1477254485] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:441; }","duration":"204.712665ms","start":"2026-05-29T02:08:19.850861Z","end":"2026-05-29T02:08:20.055574Z","steps":["trace[1477254485] 'agreement among raft nodes before linearized reading' (duration: 60.00468ms)","trace[1477254485] 'range keys from in-memory index tree' (duration: 144.562771ms)"],"step_count":2} {"level":"info","ts":"2026-05-29T02:08:20.055611Z","caller":"traceutil/trace.go:171","msg":"trace[444507754] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:441; }","duration":"203.877674ms","start":"2026-05-29T02:08:19.851717Z","end":"2026-05-29T02:08:20.055594Z","steps":["trace[444507754] 'agreement among raft nodes before linearized reading' (duration: 59.165699ms)","trace[444507754] 'range keys from in-memory index tree' (duration: 144.582852ms)"],"step_count":2} {"level":"info","ts":"2026-05-29T02:08:20.055731Z","caller":"traceutil/trace.go:171","msg":"trace[658492751] transaction","detail":"{read_only:false; response_revision:442; number_of_response:1; }","duration":"169.643488ms","start":"2026-05-29T02:08:19.886057Z","end":"2026-05-29T02:08:20.0557Z","steps":["trace[658492751] 'process raft request' (duration: 143.742842ms)","trace[658492751] 'compare' (duration: 25.631959ms)"],"step_count":2} {"level":"info","ts":"2026-05-29T02:08:20.056139Z","caller":"traceutil/trace.go:171","msg":"trace[262899542] transaction","detail":"{read_only:false; number_of_response:1; response_revision:442; }","duration":"144.125031ms","start":"2026-05-29T02:08:19.911994Z","end":"2026-05-29T02:08:20.056119Z","steps":["trace[262899542] 'process raft request' (duration: 144.032398ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T02:08:33.945649Z","caller":"traceutil/trace.go:171","msg":"trace[419926938] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"436.034831ms","start":"2026-05-29T02:08:33.509594Z","end":"2026-05-29T02:08:33.945629Z","steps":["trace[419926938] 'process raft request' (duration: 435.934849ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:08:33.945758Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:08:33.509572Z","time spent":"436.135204ms","remote":"127.0.0.1:39480","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-29T02:08:35.531708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.999956145s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-05-29T02:08:35.531809Z","caller":"traceutil/trace.go:171","msg":"trace[1996903468] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000092938s","start":"2026-05-29T02:08:33.531694Z","end":"2026-05-29T02:08:35.531787Z","steps":["trace[1996903468] 'agreement among raft nodes before linearized reading' (duration: 1.999971075s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:08:35.531869Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:08:33.531686Z","time spent":"2.000172161s","remote":"127.0.0.1:60996","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-29T02:08:35.744754Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.797899565s","expected-duration":"1s"} {"level":"info","ts":"2026-05-29T02:08:35.745231Z","caller":"traceutil/trace.go:171","msg":"trace[215542055] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"2.235365501s","start":"2026-05-29T02:08:33.509837Z","end":"2026-05-29T02:08:35.745203Z","steps":["trace[215542055] 'process raft request' (duration: 2.235127225s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:08:35.745361Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:08:33.509828Z","time spent":"2.235470584s","remote":"127.0.0.1:39480","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-29T02:08:35.745352Z","caller":"traceutil/trace.go:171","msg":"trace[1724236971] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"2.227561252s","start":"2026-05-29T02:08:33.517755Z","end":"2026-05-29T02:08:35.745316Z","steps":["trace[1724236971] 'process raft request' (duration: 2.227371588s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:08:35.745523Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:08:33.517735Z","time spent":"2.227688786s","remote":"127.0.0.1:39480","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-29T02:08:35.745535Z","caller":"traceutil/trace.go:171","msg":"trace[1467222787] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"2.222770397s","start":"2026-05-29T02:08:33.522734Z","end":"2026-05-29T02:08:35.745504Z","steps":["trace[1467222787] 'process raft request' (duration: 2.222614543s)"],"step_count":1} {"level":"info","ts":"2026-05-29T02:08:35.745693Z","caller":"traceutil/trace.go:171","msg":"trace[854541359] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"2.224349355s","start":"2026-05-29T02:08:33.521328Z","end":"2026-05-29T02:08:35.745677Z","steps":["trace[854541359] 'process raft request' (duration: 2.223861263s)"],"step_count":1} {"level":"info","ts":"2026-05-29T02:08:35.745719Z","caller":"traceutil/trace.go:171","msg":"trace[2017513962] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"2.220470851s","start":"2026-05-29T02:08:33.525229Z","end":"2026-05-29T02:08:35.7457Z","steps":["trace[2017513962] 'process raft request' (duration: 2.220180374s)"],"step_count":1} {"level":"info","ts":"2026-05-29T02:08:35.74572Z","caller":"traceutil/trace.go:171","msg":"trace[335194676] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"2.215111502s","start":"2026-05-29T02:08:33.530585Z","end":"2026-05-29T02:08:35.745697Z","steps":["trace[335194676] 'process raft request' (duration: 2.214985129s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:08:35.745783Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:08:33.521313Z","time spent":"2.224417656s","remote":"127.0.0.1:39480","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-29T02:08:35.745819Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:08:33.525221Z","time spent":"2.220559574s","remote":"127.0.0.1:39480","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-29T02:08:35.745824Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:08:33.530573Z","time spent":"2.215213585s","remote":"127.0.0.1:39480","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-29T02:08:35.745868Z","caller":"traceutil/trace.go:171","msg":"trace[198278685] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"2.203836369s","start":"2026-05-29T02:08:33.542021Z","end":"2026-05-29T02:08:35.745857Z","steps":["trace[198278685] 'process raft request' (duration: 2.203622084s)"],"step_count":1} {"level":"info","ts":"2026-05-29T02:08:35.745724Z","caller":"traceutil/trace.go:171","msg":"trace[1993639243] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"2.215119802s","start":"2026-05-29T02:08:33.530571Z","end":"2026-05-29T02:08:35.74569Z","steps":["trace[1993639243] 'process raft request' (duration: 2.214887747s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:08:35.745934Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:08:33.530555Z","time spent":"2.215356558s","remote":"127.0.0.1:39480","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-29T02:08:35.745948Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:08:33.541995Z","time spent":"2.203906262s","remote":"127.0.0.1:39480","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-29T02:08:35.745949Z","caller":"traceutil/trace.go:171","msg":"trace[1731134222] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"2.203921271s","start":"2026-05-29T02:08:33.542013Z","end":"2026-05-29T02:08:35.745934Z","steps":["trace[1731134222] 'process raft request' (duration: 2.203682476s)"],"step_count":1} {"level":"info","ts":"2026-05-29T02:08:35.746023Z","caller":"traceutil/trace.go:171","msg":"trace[1527898598] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"2.064899083s","start":"2026-05-29T02:08:33.681114Z","end":"2026-05-29T02:08:35.746013Z","steps":["trace[1527898598] 'process raft request' (duration: 2.0647566s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:08:35.74602Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:08:33.541988Z","time spent":"2.203998094s","remote":"127.0.0.1:39480","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-29T02:08:35.746026Z","caller":"traceutil/trace.go:171","msg":"trace[1417878413] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"2.169761236s","start":"2026-05-29T02:08:33.576251Z","end":"2026-05-29T02:08:35.746012Z","steps":["trace[1417878413] 'process raft request' (duration: 2.169547681s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:08:35.746068Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:08:33.681093Z","time spent":"2.064957165s","remote":"127.0.0.1:39480","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-29T02:08:35.746095Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:08:33.576224Z","time spent":"2.169842279s","remote":"127.0.0.1:39480","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-29T02:08:35.746174Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:08:33.522714Z","time spent":"2.222891559s","remote":"127.0.0.1:39480","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-29T02:08:36.025628Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.673025ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-05-29T02:08:36.026019Z","caller":"traceutil/trace.go:171","msg":"trace[134765580] linearizableReadLoop","detail":"{readStateIndex:547; appliedIndex:539; }","duration":"2.494269245s","start":"2026-05-29T02:08:33.531717Z","end":"2026-05-29T02:08:36.025986Z","steps":["trace[134765580] 'read index received' (duration: 413.813525ms)","trace[134765580] 'applied index is now lower than readState.Index' (duration: 2.08045289s)"],"step_count":2} {"level":"info","ts":"2026-05-29T02:08:36.026275Z","caller":"traceutil/trace.go:171","msg":"trace[1401656859] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"2.073072611s","start":"2026-05-29T02:08:33.953151Z","end":"2026-05-29T02:08:36.026223Z","steps":["trace[1401656859] 'process raft request' (duration: 2.07260307s)"],"step_count":1} {"level":"info","ts":"2026-05-29T02:08:36.026422Z","caller":"traceutil/trace.go:171","msg":"trace[772610216] transaction","detail":"{read_only:false; number_of_response:1; response_revision:537; }","duration":"2.070094459s","start":"2026-05-29T02:08:33.956234Z","end":"2026-05-29T02:08:36.026328Z","steps":["trace[772610216] 'process raft request' (duration: 2.070011137s)"],"step_count":1} {"level":"info","ts":"2026-05-29T02:08:36.026575Z","caller":"traceutil/trace.go:171","msg":"trace[103628742] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"2.070635502s","start":"2026-05-29T02:08:33.955921Z","end":"2026-05-29T02:08:36.026556Z","steps":["trace[103628742] 'process raft request' (duration: 2.070146001s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:08:36.026595Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:08:33.953129Z","time spent":"2.073270796s","remote":"127.0.0.1:39946","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":980,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-29T02:08:36.026772Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:08:33.955912Z","time spent":"2.070735365s","remote":"127.0.0.1:39480","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10063,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-29T02:08:36.027072Z","caller":"traceutil/trace.go:171","msg":"trace[1449545950] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"2.073331277s","start":"2026-05-29T02:08:33.953717Z","end":"2026-05-29T02:08:36.027048Z","steps":["trace[1449545950] 'process raft request' (duration: 2.072312203s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:08:36.027175Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:08:33.953707Z","time spent":"2.073413899s","remote":"127.0.0.1:39946","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":995,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-29T02:08:36.027455Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:08:33.956224Z","time spent":"2.071184876s","remote":"127.0.0.1:39480","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":101,"response count":0,"response size":10112,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-29T02:08:36.283351Z","caller":"traceutil/trace.go:171","msg":"trace[1249738260] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"518.00141ms","start":"2026-05-29T02:08:35.765325Z","end":"2026-05-29T02:08:36.283326Z","steps":["trace[1249738260] 'process raft request' (duration: 517.916368ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T02:08:36.283568Z","caller":"traceutil/trace.go:171","msg":"trace[893262983] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"529.636402ms","start":"2026-05-29T02:08:35.753877Z","end":"2026-05-29T02:08:36.283513Z","steps":["trace[893262983] 'process raft request' (duration: 529.271213ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T02:08:36.283721Z","caller":"traceutil/trace.go:171","msg":"trace[1948943989] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"530.264727ms","start":"2026-05-29T02:08:35.753402Z","end":"2026-05-29T02:08:36.283667Z","steps":["trace[1948943989] 'process raft request' (duration: 509.493875ms)","trace[1948943989] 'compare' (duration: 20.116146ms)"],"step_count":2} {"level":"warn","ts":"2026-05-29T02:08:36.283765Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:08:35.753866Z","time spent":"529.772645ms","remote":"127.0.0.1:39480","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6888,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-29T02:08:36.283894Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:08:35.75338Z","time spent":"530.427511ms","remote":"127.0.0.1:39946","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1004,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-29T02:08:36.283951Z","caller":"traceutil/trace.go:171","msg":"trace[1923644859] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"515.91001ms","start":"2026-05-29T02:08:35.768024Z","end":"2026-05-29T02:08:36.283934Z","steps":["trace[1923644859] 'process raft request' (duration: 515.253834ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T02:08:36.284097Z","caller":"traceutil/trace.go:171","msg":"trace[142738992] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"520.821958ms","start":"2026-05-29T02:08:35.763206Z","end":"2026-05-29T02:08:36.284028Z","steps":["trace[142738992] 'process raft request' (duration: 520.010189ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:08:36.284192Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:08:35.763189Z","time spent":"520.945902ms","remote":"127.0.0.1:39946","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":998,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-29T02:08:36.284696Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:08:35.765317Z","time spent":"518.247327ms","remote":"127.0.0.1:39946","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":998,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-29T02:08:36.284712Z","caller":"traceutil/trace.go:171","msg":"trace[1225614668] linearizableReadLoop","detail":"{readStateIndex:564; appliedIndex:556; }","duration":"258.516463ms","start":"2026-05-29T02:08:36.026169Z","end":"2026-05-29T02:08:36.284686Z","steps":["trace[1225614668] 'read index received' (duration: 236.739857ms)","trace[1225614668] 'applied index is now lower than readState.Index' (duration: 21.775566ms)"],"step_count":2} {"level":"info","ts":"2026-05-29T02:08:36.28474Z","caller":"traceutil/trace.go:171","msg":"trace[940401643] transaction","detail":"{read_only:false; response_revision:545; number_of_response:1; }","duration":"481.865778ms","start":"2026-05-29T02:08:35.802861Z","end":"2026-05-29T02:08:36.284727Z","steps":["trace[940401643] 'process raft request' (duration: 481.778246ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:08:36.284978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.116789656s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-05-29T02:08:36.285024Z","caller":"traceutil/trace.go:171","msg":"trace[925152812] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:545; }","duration":"2.116833807s","start":"2026-05-29T02:08:34.168176Z","end":"2026-05-29T02:08:36.28501Z","steps":["trace[925152812] 'agreement among raft nodes before linearized reading' (duration: 2.116750505s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:08:36.285082Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:08:34.168132Z","time spent":"2.116917179s","remote":"127.0.0.1:39676","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-05-29T02:08:36.285146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.117644137s","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-05-29T02:08:36.285208Z","caller":"traceutil/trace.go:171","msg":"trace[536230156] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:545; }","duration":"2.117729589s","start":"2026-05-29T02:08:34.167457Z","end":"2026-05-29T02:08:36.285187Z","steps":["trace[536230156] 'agreement among raft nodes before linearized reading' (duration: 2.117646777s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:08:36.285238Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"752.421662ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-29T02:08:36.285257Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:08:34.167439Z","time spent":"2.117806071s","remote":"127.0.0.1:39676","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-29T02:08:36.28525Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:08:35.767999Z","time spent":"516.141256ms","remote":"127.0.0.1:39480","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30393,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-29T02:08:36.285275Z","caller":"traceutil/trace.go:171","msg":"trace[2052638715] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:545; }","duration":"752.480614ms","start":"2026-05-29T02:08:35.532784Z","end":"2026-05-29T02:08:36.285265Z","steps":["trace[2052638715] 'agreement among raft nodes before linearized reading' (duration: 752.431933ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:08:36.285304Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:08:35.532769Z","time spent":"752.529945ms","remote":"127.0.0.1:32772","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-29T02:08:36.285048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.239169522s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"warn","ts":"2026-05-29T02:08:36.285188Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:08:35.802835Z","time spent":"481.98916ms","remote":"127.0.0.1:39480","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17062,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-29T02:08:36.285429Z","caller":"traceutil/trace.go:171","msg":"trace[1495455726] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:545; }","duration":"2.239604993s","start":"2026-05-29T02:08:34.045814Z","end":"2026-05-29T02:08:36.285419Z","steps":["trace[1495455726] 'agreement among raft nodes before linearized reading' (duration: 2.238973298s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:08:36.28546Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:08:34.045795Z","time spent":"2.239656074s","remote":"127.0.0.1:39676","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-05-29T02:08:36.285607Z","caller":"traceutil/trace.go:171","msg":"trace[1111747762] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"517.303474ms","start":"2026-05-29T02:08:35.768286Z","end":"2026-05-29T02:08:36.28559Z","steps":["trace[1111747762] 'process raft request' (duration: 515.48007ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:08:36.285608Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.13474115s","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-05-29T02:08:36.285645Z","caller":"traceutil/trace.go:171","msg":"trace[1358246389] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"515.450459ms","start":"2026-05-29T02:08:35.770168Z","end":"2026-05-29T02:08:36.285619Z","steps":["trace[1358246389] 'process raft request' (duration: 514.321741ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:08:36.285709Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:08:35.770159Z","time spent":"515.517511ms","remote":"127.0.0.1:39480","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30374,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-29T02:08:36.285735Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:08:35.768274Z","time spent":"517.384276ms","remote":"127.0.0.1:39480","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28739,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-29T02:08:36.285768Z","caller":"traceutil/trace.go:171","msg":"trace[1998246754] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:545; }","duration":"2.135019407s","start":"2026-05-29T02:08:34.150646Z","end":"2026-05-29T02:08:36.285665Z","steps":["trace[1998246754] 'agreement among raft nodes before linearized reading' (duration: 2.134569926s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:08:36.285944Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:08:34.150615Z","time spent":"2.135313403s","remote":"127.0.0.1:39676","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-29T02:08:36.796848Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5827832128082273449,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-29T02:08:37.297459Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5827832128082273449,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-29T02:08:37.798153Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5827832128082273449,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-29T02:08:37.81296Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.549634819s","expected-duration":"1s"} {"level":"warn","ts":"2026-05-29T02:08:38.00668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.027212ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-29T02:08:38.006893Z","caller":"traceutil/trace.go:171","msg":"trace[544212939] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"1.966782764s","start":"2026-05-29T02:08:36.040081Z","end":"2026-05-29T02:08:38.006864Z","steps":["trace[544212939] 'process raft request' (duration: 1.773087105s)","trace[544212939] 'compare' (duration: 192.93654ms)"],"step_count":2} {"level":"warn","ts":"2026-05-29T02:08:38.007042Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:08:36.040062Z","time spent":"1.966899216s","remote":"127.0.0.1:39480","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9125,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-29T02:08:38.007134Z","caller":"traceutil/trace.go:171","msg":"trace[1865979560] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"1.962996592s","start":"2026-05-29T02:08:36.044093Z","end":"2026-05-29T02:08:38.00709Z","steps":["trace[1865979560] 'process raft request' (duration: 1.962780847s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:08:38.007245Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:08:36.044064Z","time spent":"1.963118175s","remote":"127.0.0.1:39480","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":64462,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-29T02:08:38.296656Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000864447s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-05-29T02:08:38.296893Z","caller":"traceutil/trace.go:171","msg":"trace[832419280] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.001133784s","start":"2026-05-29T02:08:36.295737Z","end":"2026-05-29T02:08:38.296871Z","steps":["trace[832419280] 'agreement among raft nodes before linearized reading' (duration: 2.000882828s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:08:38.297163Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:08:36.295725Z","time spent":"2.001421811s","remote":"127.0.0.1:60996","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/05/29 02:08:38 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"info","ts":"2026-05-29T02:08:38.673265Z","caller":"traceutil/trace.go:171","msg":"trace[1666729223] transaction","detail":"{read_only:false; number_of_response:0; response_revision:547; }","duration":"2.383778706s","start":"2026-05-29T02:08:36.289461Z","end":"2026-05-29T02:08:38.67324Z","steps":["trace[1666729223] 'process raft request' (duration: 2.383621382s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:08:38.673473Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:08:36.289441Z","time spent":"2.383945821s","remote":"127.0.0.1:39946","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-29T02:08:38.673405Z","caller":"traceutil/trace.go:171","msg":"trace[2013670764] transaction","detail":"{read_only:false; number_of_response:0; response_revision:547; }","duration":"2.383806748s","start":"2026-05-29T02:08:36.289578Z","end":"2026-05-29T02:08:38.673384Z","steps":["trace[2013670764] 'process raft request' (duration: 2.383573912s)"],"step_count":1} {"level":"info","ts":"2026-05-29T02:08:38.673578Z","caller":"traceutil/trace.go:171","msg":"trace[225109387] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"2.382028584s","start":"2026-05-29T02:08:36.291505Z","end":"2026-05-29T02:08:38.673534Z","steps":["trace[225109387] 'process raft request' (duration: 2.381669246s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:08:38.673769Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:08:36.28957Z","time spent":"2.384065214s","remote":"127.0.0.1:39946","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-29T02:08:38.6738Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:08:36.291493Z","time spent":"2.38226606s","remote":"127.0.0.1:39512","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":759,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-29T02:08:38.674299Z","caller":"traceutil/trace.go:171","msg":"trace[1617454324] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"2.382018754s","start":"2026-05-29T02:08:36.292258Z","end":"2026-05-29T02:08:38.674277Z","steps":["trace[1617454324] 'process raft request' (duration: 2.38101521s)"],"step_count":1} {"level":"info","ts":"2026-05-29T02:08:38.674308Z","caller":"traceutil/trace.go:171","msg":"trace[1766457214] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"2.380693202s","start":"2026-05-29T02:08:36.293603Z","end":"2026-05-29T02:08:38.674296Z","steps":["trace[1766457214] 'process raft request' (duration: 2.38061066s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:08:38.67441Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:08:36.292241Z","time spent":"2.382096316s","remote":"127.0.0.1:39676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-29T02:08:38.674651Z","caller":"traceutil/trace.go:171","msg":"trace[436479187] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"2.380391995s","start":"2026-05-29T02:08:36.294247Z","end":"2026-05-29T02:08:38.674638Z","steps":["trace[436479187] 'process raft request' (duration: 2.379998045s)"],"step_count":1} {"level":"info","ts":"2026-05-29T02:08:38.674648Z","caller":"traceutil/trace.go:171","msg":"trace[498589986] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"2.379576015s","start":"2026-05-29T02:08:36.295049Z","end":"2026-05-29T02:08:38.674625Z","steps":["trace[498589986] 'process raft request' (duration: 2.379475512s)"],"step_count":1} {"level":"info","ts":"2026-05-29T02:08:38.674736Z","caller":"traceutil/trace.go:171","msg":"trace[1225306648] transaction","detail":"{read_only:false; response_revision:553; number_of_response:1; }","duration":"2.369380549s","start":"2026-05-29T02:08:36.305335Z","end":"2026-05-29T02:08:38.674716Z","steps":["trace[1225306648] 'process raft request' (duration: 2.369233175s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:08:38.674833Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:08:36.294239Z","time spent":"2.380444686s","remote":"127.0.0.1:39676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-29T02:08:38.67492Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:08:36.295043Z","time spent":"2.379729959s","remote":"127.0.0.1:39676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-29T02:08:38.674993Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:08:36.305315Z","time spent":"2.369541673s","remote":"127.0.0.1:39946","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":986,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-29T02:08:38.67524Z","caller":"traceutil/trace.go:171","msg":"trace[157397557] transaction","detail":"{read_only:false; response_revision:554; number_of_response:1; }","duration":"2.348264719s","start":"2026-05-29T02:08:36.326961Z","end":"2026-05-29T02:08:38.675226Z","steps":["trace[157397557] 'process raft request' (duration: 2.347690675s)"],"step_count":1} {"level":"info","ts":"2026-05-29T02:08:38.675314Z","caller":"traceutil/trace.go:171","msg":"trace[100821504] transaction","detail":"{read_only:false; response_revision:555; number_of_response:1; }","duration":"2.347682395s","start":"2026-05-29T02:08:36.327609Z","end":"2026-05-29T02:08:38.675292Z","steps":["trace[100821504] 'process raft request' (duration: 2.347207903s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:08:38.675384Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:08:36.326936Z","time spent":"2.348370851s","remote":"127.0.0.1:39480","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58844,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-29T02:08:38.675448Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:08:36.327604Z","time spent":"2.347776747s","remote":"127.0.0.1:39480","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79947,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-29T02:08:38.675472Z","caller":"traceutil/trace.go:171","msg":"trace[1457838314] linearizableReadLoop","detail":"{readStateIndex:578; appliedIndex:564; }","duration":"2.379687048s","start":"2026-05-29T02:08:36.295771Z","end":"2026-05-29T02:08:38.675458Z","steps":["trace[1457838314] 'read index received' (duration: 1.517478582s)","trace[1457838314] 'applied index is now lower than readState.Index' (duration: 862.207476ms)"],"step_count":2} {"level":"info","ts":"2026-05-29T02:08:38.675495Z","caller":"traceutil/trace.go:171","msg":"trace[1702999467] transaction","detail":"{read_only:false; response_revision:557; number_of_response:1; }","duration":"2.311635194s","start":"2026-05-29T02:08:36.363845Z","end":"2026-05-29T02:08:38.675481Z","steps":["trace[1702999467] 'process raft request' (duration: 2.31145908s)"],"step_count":1} {"level":"info","ts":"2026-05-29T02:08:38.675427Z","caller":"traceutil/trace.go:171","msg":"trace[351562161] transaction","detail":"{read_only:false; response_revision:556; number_of_response:1; }","duration":"2.319360811s","start":"2026-05-29T02:08:36.356052Z","end":"2026-05-29T02:08:38.675413Z","steps":["trace[351562161] 'process raft request' (duration: 2.319139035s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:08:38.675721Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:08:36.35602Z","time spent":"2.319661078s","remote":"127.0.0.1:39480","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":150480,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-29T02:08:38.675722Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:08:36.363816Z","time spent":"2.311780797s","remote":"127.0.0.1:39480","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":97665,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-29T02:08:38.67603Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:08:36.29358Z","time spent":"2.381777648s","remote":"127.0.0.1:39676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-29T02:08:38.688141Z","caller":"traceutil/trace.go:171","msg":"trace[1913181567] transaction","detail":"{read_only:false; response_revision:559; number_of_response:1; }","duration":"670.6744ms","start":"2026-05-29T02:08:38.017452Z","end":"2026-05-29T02:08:38.688126Z","steps":["trace[1913181567] 'process raft request' (duration: 670.613498ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T02:08:38.688211Z","caller":"traceutil/trace.go:171","msg":"trace[1950486574] transaction","detail":"{read_only:false; response_revision:558; number_of_response:1; }","duration":"672.35622ms","start":"2026-05-29T02:08:38.015845Z","end":"2026-05-29T02:08:38.688201Z","steps":["trace[1950486574] 'process raft request' (duration: 672.141825ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:08:38.688261Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:08:38.017443Z","time spent":"670.746561ms","remote":"127.0.0.1:39480","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-29T02:08:38.688269Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:08:38.01583Z","time spent":"672.408511ms","remote":"127.0.0.1:39480","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7684,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-29T02:08:38.688413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"391.210699ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-29T02:08:38.688446Z","caller":"traceutil/trace.go:171","msg":"trace[1625629438] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:560; }","duration":"391.280201ms","start":"2026-05-29T02:08:38.29716Z","end":"2026-05-29T02:08:38.68844Z","steps":["trace[1625629438] 'agreement among raft nodes before linearized reading' (duration: 391.21582ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:08:38.688506Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:08:38.297135Z","time spent":"391.367383ms","remote":"127.0.0.1:32772","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-29T02:08:38.688547Z","caller":"traceutil/trace.go:171","msg":"trace[2031470174] transaction","detail":"{read_only:false; response_revision:560; number_of_response:1; }","duration":"184.300742ms","start":"2026-05-29T02:08:38.504236Z","end":"2026-05-29T02:08:38.688537Z","steps":["trace[2031470174] 'process raft request' (duration: 183.855981ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T02:08:42.098114Z","caller":"traceutil/trace.go:171","msg":"trace[1185563600] transaction","detail":"{read_only:false; response_revision:614; number_of_response:1; }","duration":"276.383755ms","start":"2026-05-29T02:08:41.821703Z","end":"2026-05-29T02:08:42.098087Z","steps":["trace[1185563600] 'process raft request' (duration: 275.578276ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T02:08:42.302049Z","caller":"traceutil/trace.go:171","msg":"trace[979514286] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"398.824972ms","start":"2026-05-29T02:08:41.903176Z","end":"2026-05-29T02:08:42.302001Z","steps":["trace[979514286] 'process raft request' (duration: 303.178912ms)","trace[979514286] 'compare' (duration: 95.310772ms)"],"step_count":2} {"level":"info","ts":"2026-05-29T02:08:42.302285Z","caller":"traceutil/trace.go:171","msg":"trace[2004138048] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"138.311651ms","start":"2026-05-29T02:08:42.163941Z","end":"2026-05-29T02:08:42.302253Z","steps":["trace[2004138048] 'process raft request' (duration: 138.006583ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:08:42.302487Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:08:41.903141Z","time spent":"399.066058ms","remote":"127.0.0.1:39676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-29T02:08:43.412215Z","caller":"traceutil/trace.go:171","msg":"trace[1431913898] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"107.767053ms","start":"2026-05-29T02:08:43.30441Z","end":"2026-05-29T02:08:43.412177Z","steps":["trace[1431913898] 'process raft request' (duration: 105.464147ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:08:44.191292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.072975ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-29T02:08:44.191582Z","caller":"traceutil/trace.go:171","msg":"trace[2088869113] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"159.497872ms","start":"2026-05-29T02:08:44.032049Z","end":"2026-05-29T02:08:44.191547Z","steps":["trace[2088869113] 'process raft request' (duration: 50.08638ms)","trace[2088869113] 'compare' (duration: 108.819458ms)"],"step_count":2} {"level":"warn","ts":"2026-05-29T02:08:44.328676Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.222295ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-05-29T02:08:44.328819Z","caller":"traceutil/trace.go:171","msg":"trace[1487558534] linearizableReadLoop","detail":"{readStateIndex:649; appliedIndex:648; }","duration":"127.737046ms","start":"2026-05-29T02:08:44.201045Z","end":"2026-05-29T02:08:44.328782Z","steps":["trace[1487558534] 'read index received' (duration: 96.713µs)","trace[1487558534] 'applied index is now lower than readState.Index' (duration: 127.639143ms)"],"step_count":2} {"level":"warn","ts":"2026-05-29T02:08:44.328914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.863239ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/envoy-gateway-gateway-helm-certgen:envoy-gateway-system\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-29T02:08:44.328974Z","caller":"traceutil/trace.go:171","msg":"trace[366410818] range","detail":"{range_begin:/registry/clusterrolebindings/envoy-gateway-gateway-helm-certgen:envoy-gateway-system; range_end:; response_count:0; response_revision:626; }","duration":"127.938891ms","start":"2026-05-29T02:08:44.201Z","end":"2026-05-29T02:08:44.328938Z","steps":["trace[366410818] 'agreement among raft nodes before linearized reading' (duration: 127.848168ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:08:44.935995Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.599956ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-29T02:08:44.936095Z","caller":"traceutil/trace.go:171","msg":"trace[1228928549] linearizableReadLoop","detail":"{readStateIndex:651; appliedIndex:649; }","duration":"230.071537ms","start":"2026-05-29T02:08:44.706007Z","end":"2026-05-29T02:08:44.936078Z","steps":["trace[1228928549] 'read index received' (duration: 11.793525ms)","trace[1228928549] 'applied index is now lower than readState.Index' (duration: 218.276772ms)"],"step_count":2} {"level":"info","ts":"2026-05-29T02:08:44.936163Z","caller":"traceutil/trace.go:171","msg":"trace[670807532] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"230.423666ms","start":"2026-05-29T02:08:44.705731Z","end":"2026-05-29T02:08:44.936155Z","steps":["trace[670807532] 'process raft request' (duration: 106.566374ms)","trace[670807532] 'compare' (duration: 123.501774ms)"],"step_count":2} {"level":"warn","ts":"2026-05-29T02:08:44.93637Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.337714ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-05-29T02:08:44.936452Z","caller":"traceutil/trace.go:171","msg":"trace[1405712021] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:628; }","duration":"230.446186ms","start":"2026-05-29T02:08:44.705985Z","end":"2026-05-29T02:08:44.936431Z","steps":["trace[1405712021] 'agreement among raft nodes before linearized reading' (duration: 230.233091ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:08:45.159019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.224779ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-29T02:08:45.159312Z","caller":"traceutil/trace.go:171","msg":"trace[318731936] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"219.048411ms","start":"2026-05-29T02:08:44.940245Z","end":"2026-05-29T02:08:45.159293Z","steps":["trace[318731936] 'process raft request' (duration: 218.976609ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T02:08:45.159483Z","caller":"traceutil/trace.go:171","msg":"trace[1699559526] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"441.667418ms","start":"2026-05-29T02:08:44.717794Z","end":"2026-05-29T02:08:45.159462Z","steps":["trace[1699559526] 'process raft request' (duration: 326.894145ms)","trace[1699559526] 'compare' (duration: 113.859121ms)"],"step_count":2} {"level":"warn","ts":"2026-05-29T02:08:45.159675Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:08:44.717769Z","time spent":"441.76546ms","remote":"127.0.0.1:39528","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036261,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-29T02:08:45.159968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"453.74313ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-29T02:08:45.159334Z","caller":"traceutil/trace.go:171","msg":"trace[2072750340] linearizableReadLoop","detail":"{readStateIndex:652; appliedIndex:651; }","duration":"223.190001ms","start":"2026-05-29T02:08:44.936114Z","end":"2026-05-29T02:08:45.159304Z","steps":["trace[2072750340] 'read index received' (duration: 108.456329ms)","trace[2072750340] 'applied index is now lower than readState.Index' (duration: 114.731022ms)"],"step_count":2} {"level":"info","ts":"2026-05-29T02:08:45.160227Z","caller":"traceutil/trace.go:171","msg":"trace[1101420901] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:630; }","duration":"453.882743ms","start":"2026-05-29T02:08:44.706163Z","end":"2026-05-29T02:08:45.160046Z","steps":["trace[1101420901] 'agreement among raft nodes before linearized reading' (duration: 453.534924ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:08:45.160284Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:08:44.706157Z","time spent":"454.114248ms","remote":"127.0.0.1:39676","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-05-29T02:08:45.897892Z","caller":"traceutil/trace.go:171","msg":"trace[1919913645] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"262.578772ms","start":"2026-05-29T02:08:45.635292Z","end":"2026-05-29T02:08:45.897871Z","steps":["trace[1919913645] 'process raft request' (duration: 262.115551ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:08:46.134288Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.801031ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-29T02:08:46.134463Z","caller":"traceutil/trace.go:171","msg":"trace[1803214338] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"170.041787ms","start":"2026-05-29T02:08:45.964406Z","end":"2026-05-29T02:08:46.134447Z","steps":["trace[1803214338] 'process raft request' (duration: 169.976325ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T02:08:46.134673Z","caller":"traceutil/trace.go:171","msg":"trace[2025797517] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"179.314301ms","start":"2026-05-29T02:08:45.955347Z","end":"2026-05-29T02:08:46.134662Z","steps":["trace[2025797517] 'process raft request' (duration: 57.078679ms)","trace[2025797517] 'compare' (duration: 121.653128ms)"],"step_count":2} {"level":"warn","ts":"2026-05-29T02:08:47.181222Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5827832128082273614,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-29T02:08:47.201758Z","caller":"traceutil/trace.go:171","msg":"trace[363698823] linearizableReadLoop","detail":"{readStateIndex:661; appliedIndex:660; }","duration":"521.584927ms","start":"2026-05-29T02:08:46.680151Z","end":"2026-05-29T02:08:47.201736Z","steps":["trace[363698823] 'read index received' (duration: 520.760267ms)","trace[363698823] 'applied index is now lower than readState.Index' (duration: 823.69µs)"],"step_count":2} {"level":"info","ts":"2026-05-29T02:08:47.201838Z","caller":"traceutil/trace.go:171","msg":"trace[766142524] transaction","detail":"{read_only:false; response_revision:638; number_of_response:1; }","duration":"663.726649ms","start":"2026-05-29T02:08:46.538071Z","end":"2026-05-29T02:08:47.201798Z","steps":["trace[766142524] 'process raft request' (duration: 663.117035ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:08:47.201972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"479.259544ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-05-29T02:08:47.201987Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:08:46.53805Z","time spent":"663.854333ms","remote":"127.0.0.1:39528","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036317,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-29T02:08:47.202016Z","caller":"traceutil/trace.go:171","msg":"trace[969948917] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:638; }","duration":"479.354436ms","start":"2026-05-29T02:08:46.72265Z","end":"2026-05-29T02:08:47.202004Z","steps":["trace[969948917] 'agreement among raft nodes before linearized reading' (duration: 479.205113ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:08:47.202057Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:08:46.72263Z","time spent":"479.419339ms","remote":"127.0.0.1:39676","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-05-29T02:08:47.202024Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"521.860413ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-l6rgf\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-05-29T02:08:47.202169Z","caller":"traceutil/trace.go:171","msg":"trace[1744920384] range","detail":"{range_begin:/registry/pods/kube-system/cilium-l6rgf; range_end:; response_count:1; response_revision:638; }","duration":"522.014027ms","start":"2026-05-29T02:08:46.680101Z","end":"2026-05-29T02:08:47.202115Z","steps":["trace[1744920384] 'agreement among raft nodes before linearized reading' (duration: 521.73376ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:08:47.202253Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:08:46.680078Z","time spent":"522.131069ms","remote":"127.0.0.1:39604","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16988,"request content":"key:\"/registry/pods/kube-system/cilium-l6rgf\" "} {"level":"warn","ts":"2026-05-29T02:08:47.202449Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.268694ms","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-05-29T02:08:47.202485Z","caller":"traceutil/trace.go:171","msg":"trace[1492255325] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:638; }","duration":"262.336816ms","start":"2026-05-29T02:08:46.940139Z","end":"2026-05-29T02:08:47.202476Z","steps":["trace[1492255325] 'agreement among raft nodes before linearized reading' (duration: 262.250574ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:08:48.032835Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5827832128082273617,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-29T02:08:48.5337Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5827832128082273617,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-29T02:08:48.568126Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.321377995s","expected-duration":"1s"} {"level":"info","ts":"2026-05-29T02:08:48.569385Z","caller":"traceutil/trace.go:171","msg":"trace[2044603423] transaction","detail":"{read_only:false; response_revision:643; number_of_response:1; }","duration":"1.340910977s","start":"2026-05-29T02:08:47.22844Z","end":"2026-05-29T02:08:48.569351Z","steps":["trace[2044603423] 'process raft request' (duration: 1.340330723s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:08:48.569579Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:08:47.228419Z","time spent":"1.341059811s","remote":"127.0.0.1:39604","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-29T02:08:49.531878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000008066s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-05-29T02:08:49.531968Z","caller":"traceutil/trace.go:171","msg":"trace[1812815922] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.00015321s","start":"2026-05-29T02:08:47.531794Z","end":"2026-05-29T02:08:49.531947Z","steps":["trace[1812815922] 'agreement among raft nodes before linearized reading' (duration: 2.000038907s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:08:49.532021Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:08:47.531776Z","time spent":"2.000233641s","remote":"127.0.0.1:60996","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/05/29 02:08:49 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-05-29T02:08:49.653093Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.084780241s","expected-duration":"1s"} {"level":"info","ts":"2026-05-29T02:08:49.653505Z","caller":"traceutil/trace.go:171","msg":"trace[974634297] linearizableReadLoop","detail":"{readStateIndex:667; appliedIndex:665; }","duration":"2.121600663s","start":"2026-05-29T02:08:47.531841Z","end":"2026-05-29T02:08:49.653441Z","steps":["trace[974634297] 'read index received' (duration: 1.036575536s)","trace[974634297] 'applied index is now lower than readState.Index' (duration: 1.085023767s)"],"step_count":2} {"level":"info","ts":"2026-05-29T02:08:49.653573Z","caller":"traceutil/trace.go:171","msg":"trace[220977317] transaction","detail":"{read_only:false; response_revision:644; number_of_response:1; }","duration":"2.384037251s","start":"2026-05-29T02:08:47.269488Z","end":"2026-05-29T02:08:49.653525Z","steps":["trace[220977317] 'process raft request' (duration: 2.383802606s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:08:49.653758Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:08:47.269463Z","time spent":"2.384216216s","remote":"127.0.0.1:39660","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-29T02:08:49.66588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"418.361195ms","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-05-29T02:08:49.66592Z","caller":"traceutil/trace.go:171","msg":"trace[1340220590] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:645; }","duration":"418.464007ms","start":"2026-05-29T02:08:49.247447Z","end":"2026-05-29T02:08:49.665911Z","steps":["trace[1340220590] 'agreement among raft nodes before linearized reading' (duration: 418.307894ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:08:49.665945Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:08:49.24742Z","time spent":"418.520049ms","remote":"127.0.0.1:39676","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-29T02:08:49.665959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.71987ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-29T02:08:49.666044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"890.9845ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.115\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-05-29T02:08:49.66609Z","caller":"traceutil/trace.go:171","msg":"trace[51259612] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:645; }","duration":"133.905484ms","start":"2026-05-29T02:08:49.532165Z","end":"2026-05-29T02:08:49.66607Z","steps":["trace[51259612] 'agreement among raft nodes before linearized reading' (duration: 133.700249ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T02:08:49.66613Z","caller":"traceutil/trace.go:171","msg":"trace[460685511] transaction","detail":"{read_only:false; response_revision:645; number_of_response:1; }","duration":"795.650178ms","start":"2026-05-29T02:08:48.870471Z","end":"2026-05-29T02:08:49.666121Z","steps":["trace[460685511] 'process raft request' (duration: 795.055553ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T02:08:49.666123Z","caller":"traceutil/trace.go:171","msg":"trace[816538631] range","detail":"{range_begin:/registry/masterleases/199.204.45.115; range_end:; response_count:1; response_revision:645; }","duration":"891.120494ms","start":"2026-05-29T02:08:48.774983Z","end":"2026-05-29T02:08:49.666104Z","steps":["trace[816538631] 'agreement among raft nodes before linearized reading' (duration: 890.846877ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:08:49.666175Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:08:48.774956Z","time spent":"891.210136ms","remote":"127.0.0.1:39470","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.204.45.115\" "} {"level":"warn","ts":"2026-05-29T02:08:49.666155Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"418.550229ms","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-05-29T02:08:49.66622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"417.697729ms","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-05-29T02:08:49.66629Z","caller":"traceutil/trace.go:171","msg":"trace[441686443] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:645; }","duration":"417.790781ms","start":"2026-05-29T02:08:49.248478Z","end":"2026-05-29T02:08:49.666269Z","steps":["trace[441686443] 'agreement among raft nodes before linearized reading' (duration: 417.478814ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:08:49.666204Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:08:48.870445Z","time spent":"795.711149ms","remote":"127.0.0.1:39676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-29T02:08:49.66628Z","caller":"traceutil/trace.go:171","msg":"trace[2064258764] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:645; }","duration":"418.722223ms","start":"2026-05-29T02:08:49.247513Z","end":"2026-05-29T02:08:49.666235Z","steps":["trace[2064258764] 'agreement among raft nodes before linearized reading' (duration: 418.474857ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:08:49.666338Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:08:49.248453Z","time spent":"417.876674ms","remote":"127.0.0.1:39676","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-05-29T02:08:49.666406Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"447.237702ms","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-05-29T02:08:49.666438Z","caller":"traceutil/trace.go:171","msg":"trace[1047220953] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:645; }","duration":"447.322884ms","start":"2026-05-29T02:08:49.219106Z","end":"2026-05-29T02:08:49.666429Z","steps":["trace[1047220953] 'agreement among raft nodes before linearized reading' (duration: 446.720469ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:08:49.666457Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:08:49.219063Z","time spent":"447.389996ms","remote":"127.0.0.1:39676","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-05-29T02:08:49.666353Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:08:49.247488Z","time spent":"418.854377ms","remote":"127.0.0.1:39676","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-05-29T02:08:59.099488Z","caller":"traceutil/trace.go:171","msg":"trace[2082726175] transaction","detail":"{read_only:false; response_revision:762; number_of_response:1; }","duration":"119.997018ms","start":"2026-05-29T02:08:58.979466Z","end":"2026-05-29T02:08:59.099463Z","steps":["trace[2082726175] 'process raft request' (duration: 119.843124ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T02:08:59.604659Z","caller":"traceutil/trace.go:171","msg":"trace[513930835] transaction","detail":"{read_only:false; response_revision:765; number_of_response:1; }","duration":"137.487791ms","start":"2026-05-29T02:08:59.46715Z","end":"2026-05-29T02:08:59.604638Z","steps":["trace[513930835] 'process raft request' (duration: 137.110562ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T02:08:59.896314Z","caller":"traceutil/trace.go:171","msg":"trace[249662159] transaction","detail":"{read_only:false; response_revision:770; number_of_response:1; }","duration":"117.971519ms","start":"2026-05-29T02:08:59.778318Z","end":"2026-05-29T02:08:59.89629Z","steps":["trace[249662159] 'process raft request' (duration: 117.918608ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T02:08:59.896487Z","caller":"traceutil/trace.go:171","msg":"trace[1194310507] transaction","detail":"{read_only:false; response_revision:768; number_of_response:1; }","duration":"118.934912ms","start":"2026-05-29T02:08:59.777537Z","end":"2026-05-29T02:08:59.896472Z","steps":["trace[1194310507] 'process raft request' (duration: 115.745026ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T02:08:59.896504Z","caller":"traceutil/trace.go:171","msg":"trace[342339534] transaction","detail":"{read_only:false; response_revision:769; number_of_response:1; }","duration":"118.438541ms","start":"2026-05-29T02:08:59.77804Z","end":"2026-05-29T02:08:59.896479Z","steps":["trace[342339534] 'process raft request' (duration: 118.124413ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T02:09:05.123148Z","caller":"traceutil/trace.go:171","msg":"trace[676275890] transaction","detail":"{read_only:false; response_revision:805; number_of_response:1; }","duration":"328.041583ms","start":"2026-05-29T02:09:04.795084Z","end":"2026-05-29T02:09:05.123125Z","steps":["trace[676275890] 'process raft request' (duration: 327.829938ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:09:05.123301Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:09:04.795061Z","time spent":"328.159347ms","remote":"127.0.0.1:39660","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-29T02:09:26.210115Z","caller":"traceutil/trace.go:171","msg":"trace[2115016506] transaction","detail":"{read_only:false; response_revision:974; number_of_response:1; }","duration":"141.620366ms","start":"2026-05-29T02:09:26.068468Z","end":"2026-05-29T02:09:26.210088Z","steps":["trace[2115016506] 'process raft request' (duration: 141.438521ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T02:09:26.210338Z","caller":"traceutil/trace.go:171","msg":"trace[963941614] transaction","detail":"{read_only:false; response_revision:975; number_of_response:1; }","duration":"141.80394ms","start":"2026-05-29T02:09:26.068493Z","end":"2026-05-29T02:09:26.210296Z","steps":["trace[963941614] 'process raft request' (duration: 141.558064ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T02:09:39.771397Z","caller":"traceutil/trace.go:171","msg":"trace[1457985276] linearizableReadLoop","detail":"{readStateIndex:1060; appliedIndex:1059; }","duration":"116.627507ms","start":"2026-05-29T02:09:39.654753Z","end":"2026-05-29T02:09:39.771381Z","steps":["trace[1457985276] 'read index received' (duration: 116.502604ms)","trace[1457985276] 'applied index is now lower than readState.Index' (duration: 124.023µs)"],"step_count":2} {"level":"info","ts":"2026-05-29T02:09:39.771494Z","caller":"traceutil/trace.go:171","msg":"trace[163354241] transaction","detail":"{read_only:false; response_revision:1022; number_of_response:1; }","duration":"127.095438ms","start":"2026-05-29T02:09:39.644389Z","end":"2026-05-29T02:09:39.771484Z","steps":["trace[163354241] 'process raft request' (duration: 126.853132ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:09:39.771599Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.837383ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-29T02:09:39.771619Z","caller":"traceutil/trace.go:171","msg":"trace[1616087949] range","detail":"{range_begin:/registry/networkpolicies/; range_end:/registry/networkpolicies0; response_count:0; response_revision:1022; }","duration":"116.901684ms","start":"2026-05-29T02:09:39.654711Z","end":"2026-05-29T02:09:39.771612Z","steps":["trace[1616087949] 'agreement among raft nodes before linearized reading' (duration: 116.853483ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T02:09:40.314935Z","caller":"traceutil/trace.go:171","msg":"trace[115267469] linearizableReadLoop","detail":"{readStateIndex:1061; appliedIndex:1060; }","duration":"142.801253ms","start":"2026-05-29T02:09:40.17211Z","end":"2026-05-29T02:09:40.314912Z","steps":["trace[115267469] 'read index received' (duration: 142.406854ms)","trace[115267469] 'applied index is now lower than readState.Index' (duration: 393.379µs)"],"step_count":2} {"level":"info","ts":"2026-05-29T02:09:40.315076Z","caller":"traceutil/trace.go:171","msg":"trace[596790379] transaction","detail":"{read_only:false; response_revision:1023; number_of_response:1; }","duration":"191.309563ms","start":"2026-05-29T02:09:40.123731Z","end":"2026-05-29T02:09:40.31504Z","steps":["trace[596790379] 'process raft request' (duration: 190.786491ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:09:40.315159Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.029958ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-05-29T02:09:40.315202Z","caller":"traceutil/trace.go:171","msg":"trace[1270061499] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1023; }","duration":"143.11259ms","start":"2026-05-29T02:09:40.172071Z","end":"2026-05-29T02:09:40.315183Z","steps":["trace[1270061499] 'agreement among raft nodes before linearized reading' (duration: 142.951197ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:09:40.815503Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5827832128082274473,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-29T02:09:41.315899Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5827832128082274473,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-29T02:09:41.816617Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5827832128082274473,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-29T02:09:41.995014Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.680608239s","expected-duration":"1s"} {"level":"info","ts":"2026-05-29T02:09:41.995482Z","caller":"traceutil/trace.go:171","msg":"trace[1357046926] transaction","detail":"{read_only:false; response_revision:1024; number_of_response:1; }","duration":"1.811307124s","start":"2026-05-29T02:09:40.184152Z","end":"2026-05-29T02:09:41.995459Z","steps":["trace[1357046926] 'process raft request' (duration: 1.811055898s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:09:41.995571Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:09:40.18414Z","time spent":"1.811376325s","remote":"127.0.0.1:39676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-29T02:09:42.083313Z","caller":"traceutil/trace.go:171","msg":"trace[1196753282] transaction","detail":"{read_only:false; response_revision:1025; number_of_response:1; }","duration":"1.763798648s","start":"2026-05-29T02:09:40.319473Z","end":"2026-05-29T02:09:42.083272Z","steps":["trace[1196753282] 'process raft request' (duration: 1.763382838s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:09:42.083645Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:09:40.319453Z","time spent":"1.763951451s","remote":"127.0.0.1:39676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-29T02:09:42.083672Z","caller":"traceutil/trace.go:171","msg":"trace[33681402] transaction","detail":"{read_only:false; response_revision:1026; number_of_response:1; }","duration":"1.653602844s","start":"2026-05-29T02:09:40.430023Z","end":"2026-05-29T02:09:42.083626Z","steps":["trace[33681402] 'process raft request' (duration: 1.652980039s)"],"step_count":1} {"level":"info","ts":"2026-05-29T02:09:42.083317Z","caller":"traceutil/trace.go:171","msg":"trace[892200050] linearizableReadLoop","detail":"{readStateIndex:1064; appliedIndex:1061; }","duration":"1.768295665s","start":"2026-05-29T02:09:40.315001Z","end":"2026-05-29T02:09:42.083297Z","steps":["trace[892200050] 'read index received' (duration: 1.680432665s)","trace[892200050] 'applied index is now lower than readState.Index' (duration: 87.86205ms)"],"step_count":2} {"level":"warn","ts":"2026-05-29T02:09:42.083846Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:09:40.429992Z","time spent":"1.653764908s","remote":"127.0.0.1:39676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-29T02:09:42.084096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.763211644s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-05-29T02:09:42.084174Z","caller":"traceutil/trace.go:171","msg":"trace[1086773297] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1026; }","duration":"1.763333547s","start":"2026-05-29T02:09:40.320827Z","end":"2026-05-29T02:09:42.08416Z","steps":["trace[1086773297] 'agreement among raft nodes before linearized reading' (duration: 1.763115852s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:09:42.084236Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:09:40.320807Z","time spent":"1.763417948s","remote":"127.0.0.1:39676","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-29T02:09:42.084381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"532.350035ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-29T02:09:42.08449Z","caller":"traceutil/trace.go:171","msg":"trace[1594037335] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:1026; }","duration":"532.492507ms","start":"2026-05-29T02:09:41.551987Z","end":"2026-05-29T02:09:42.084479Z","steps":["trace[1594037335] 'agreement among raft nodes before linearized reading' (duration: 532.359524ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:09:42.084552Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:09:41.551968Z","time spent":"532.57229ms","remote":"127.0.0.1:39676","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":8,"response size":30,"request content":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true "} {"level":"warn","ts":"2026-05-29T02:09:42.084616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.553543942s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-29T02:09:42.084662Z","caller":"traceutil/trace.go:171","msg":"trace[2125591222] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1026; }","duration":"1.553621253s","start":"2026-05-29T02:09:40.531029Z","end":"2026-05-29T02:09:42.08465Z","steps":["trace[2125591222] 'agreement among raft nodes before linearized reading' (duration: 1.553541992s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:09:42.084692Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:09:40.531009Z","time spent":"1.553677205s","remote":"127.0.0.1:60996","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-29T02:09:42.084987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.770775884s","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-05-29T02:09:42.085139Z","caller":"traceutil/trace.go:171","msg":"trace[315601218] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1026; }","duration":"1.770960359s","start":"2026-05-29T02:09:40.314165Z","end":"2026-05-29T02:09:42.085126Z","steps":["trace[315601218] 'agreement among raft nodes before linearized reading' (duration: 1.770745614s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:09:42.085318Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:09:40.314142Z","time spent":"1.771151103s","remote":"127.0.0.1:39676","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-05-29T02:09:42.085689Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.315079ms","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-05-29T02:09:42.086222Z","caller":"traceutil/trace.go:171","msg":"trace[1116496736] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1026; }","duration":"309.471607ms","start":"2026-05-29T02:09:41.776324Z","end":"2026-05-29T02:09:42.085796Z","steps":["trace[1116496736] 'agreement among raft nodes before linearized reading' (duration: 307.771166ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:09:42.086403Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:09:41.776309Z","time spent":"309.970569ms","remote":"127.0.0.1:39676","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-05-29T02:09:42.236049Z","caller":"traceutil/trace.go:171","msg":"trace[470575994] transaction","detail":"{read_only:false; response_revision:1027; number_of_response:1; }","duration":"147.311281ms","start":"2026-05-29T02:09:42.088714Z","end":"2026-05-29T02:09:42.236025Z","steps":["trace[470575994] 'process raft request' (duration: 146.231355ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T02:09:42.236249Z","caller":"traceutil/trace.go:171","msg":"trace[1129983343] transaction","detail":"{read_only:false; response_revision:1028; number_of_response:1; }","duration":"147.120047ms","start":"2026-05-29T02:09:42.089106Z","end":"2026-05-29T02:09:42.236226Z","steps":["trace[1129983343] 'process raft request' (duration: 146.967153ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T02:09:42.236319Z","caller":"traceutil/trace.go:171","msg":"trace[1414777735] linearizableReadLoop","detail":"{readStateIndex:1067; appliedIndex:1064; }","duration":"141.930722ms","start":"2026-05-29T02:09:42.094375Z","end":"2026-05-29T02:09:42.236305Z","steps":["trace[1414777735] 'read index received' (duration: 140.58281ms)","trace[1414777735] 'applied index is now lower than readState.Index' (duration: 1.346912ms)"],"step_count":2} {"level":"info","ts":"2026-05-29T02:09:42.236349Z","caller":"traceutil/trace.go:171","msg":"trace[759313588] transaction","detail":"{read_only:false; response_revision:1029; number_of_response:1; }","duration":"144.690088ms","start":"2026-05-29T02:09:42.091643Z","end":"2026-05-29T02:09:42.236333Z","steps":["trace[759313588] 'process raft request' (duration: 144.548975ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:09:42.236388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.999444ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-29T02:09:42.236419Z","caller":"traceutil/trace.go:171","msg":"trace[1585656298] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1029; }","duration":"142.043055ms","start":"2026-05-29T02:09:42.094366Z","end":"2026-05-29T02:09:42.236409Z","steps":["trace[1585656298] 'agreement among raft nodes before linearized reading' (duration: 141.979313ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T02:09:52.300644Z","caller":"traceutil/trace.go:171","msg":"trace[1442925713] transaction","detail":"{read_only:false; response_revision:1058; number_of_response:1; }","duration":"171.901939ms","start":"2026-05-29T02:09:52.128721Z","end":"2026-05-29T02:09:52.300623Z","steps":["trace[1442925713] 'process raft request' (duration: 171.778516ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T02:09:52.323459Z","caller":"traceutil/trace.go:171","msg":"trace[414129546] transaction","detail":"{read_only:false; response_revision:1059; number_of_response:1; }","duration":"191.426976ms","start":"2026-05-29T02:09:52.132Z","end":"2026-05-29T02:09:52.323427Z","steps":["trace[414129546] 'process raft request' (duration: 191.088408ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:10:05.462466Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.03039463s","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-05-29T02:10:05.462551Z","caller":"traceutil/trace.go:171","msg":"trace[1316689214] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1098; }","duration":"1.030535103s","start":"2026-05-29T02:10:04.431994Z","end":"2026-05-29T02:10:05.462529Z","steps":["trace[1316689214] 'range keys from in-memory index tree' (duration: 1.030217375s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:10:05.462561Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"971.44268ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-05-29T02:10:05.462598Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:10:04.431962Z","time spent":"1.030624854s","remote":"127.0.0.1:39676","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-05-29T02:10:05.462629Z","caller":"traceutil/trace.go:171","msg":"trace[1385904744] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1098; }","duration":"971.510091ms","start":"2026-05-29T02:10:04.491081Z","end":"2026-05-29T02:10:05.462591Z","steps":["trace[1385904744] 'range keys from in-memory index tree' (duration: 971.334618ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:10:05.46282Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"937.831217ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"warn","ts":"2026-05-29T02:10:05.463458Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:10:04.491063Z","time spent":"971.619704ms","remote":"127.0.0.1:39676","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-29T02:10:05.462837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"927.132341ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-29T02:10:05.463478Z","caller":"traceutil/trace.go:171","msg":"trace[1061694628] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1098; }","duration":"938.538254ms","start":"2026-05-29T02:10:04.524918Z","end":"2026-05-29T02:10:05.463456Z","steps":["trace[1061694628] 'range keys from in-memory index tree' (duration: 937.485078ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T02:10:05.46362Z","caller":"traceutil/trace.go:171","msg":"trace[591024134] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1098; }","duration":"927.93353ms","start":"2026-05-29T02:10:04.535666Z","end":"2026-05-29T02:10:05.463599Z","steps":["trace[591024134] 'range keys from in-memory index tree' (duration: 926.775313ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:10:05.463674Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:10:04.524901Z","time spent":"938.757629ms","remote":"127.0.0.1:39676","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-29T02:10:05.462915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.999182ms","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":"warn","ts":"2026-05-29T02:10:05.463739Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:10:04.535657Z","time spent":"928.039923ms","remote":"127.0.0.1:39676","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-05-29T02:10:05.46381Z","caller":"traceutil/trace.go:171","msg":"trace[1390937703] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:1098; }","duration":"144.914914ms","start":"2026-05-29T02:10:05.318879Z","end":"2026-05-29T02:10:05.463794Z","steps":["trace[1390937703] 'count revisions from in-memory index tree' (duration: 143.950071ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:10:05.462472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"944.282561ms","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-05-29T02:10:05.464178Z","caller":"traceutil/trace.go:171","msg":"trace[1056116408] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1098; }","duration":"946.058583ms","start":"2026-05-29T02:10:04.518064Z","end":"2026-05-29T02:10:05.464123Z","steps":["trace[1056116408] 'range keys from in-memory index tree' (duration: 943.988663ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:10:05.46295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"684.397139ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-05-29T02:10:05.464272Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:10:04.518032Z","time spent":"946.222217ms","remote":"127.0.0.1:39676","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-05-29T02:10:05.464319Z","caller":"traceutil/trace.go:171","msg":"trace[1144922574] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:1098; }","duration":"685.812962ms","start":"2026-05-29T02:10:04.778451Z","end":"2026-05-29T02:10:05.464264Z","steps":["trace[1144922574] 'count revisions from in-memory index tree' (duration: 684.309416ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:10:05.4645Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:10:04.778426Z","time spent":"686.054488ms","remote":"127.0.0.1:39864","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":8,"response size":30,"request content":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true "} {"level":"info","ts":"2026-05-29T02:10:05.575038Z","caller":"traceutil/trace.go:171","msg":"trace[323025930] transaction","detail":"{read_only:false; response_revision:1099; number_of_response:1; }","duration":"107.327966ms","start":"2026-05-29T02:10:05.467685Z","end":"2026-05-29T02:10:05.575013Z","steps":["trace[323025930] 'process raft request' (duration: 107.10199ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T02:10:05.60175Z","caller":"traceutil/trace.go:171","msg":"trace[1479247170] transaction","detail":"{read_only:false; response_revision:1100; number_of_response:1; }","duration":"133.650633ms","start":"2026-05-29T02:10:05.468073Z","end":"2026-05-29T02:10:05.601724Z","steps":["trace[1479247170] 'process raft request' (duration: 133.374417ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T02:10:05.601867Z","caller":"traceutil/trace.go:171","msg":"trace[1463719007] transaction","detail":"{read_only:false; response_revision:1101; number_of_response:1; }","duration":"133.641254ms","start":"2026-05-29T02:10:05.468194Z","end":"2026-05-29T02:10:05.601835Z","steps":["trace[1463719007] 'process raft request' (duration: 133.360257ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T02:10:05.602342Z","caller":"traceutil/trace.go:171","msg":"trace[1298758559] transaction","detail":"{read_only:false; response_revision:1102; number_of_response:1; }","duration":"133.982892ms","start":"2026-05-29T02:10:05.468348Z","end":"2026-05-29T02:10:05.602331Z","steps":["trace[1298758559] 'process raft request' (duration: 133.242354ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T02:10:05.602419Z","caller":"traceutil/trace.go:171","msg":"trace[411822645] transaction","detail":"{read_only:false; response_revision:1103; number_of_response:1; }","duration":"134.045293ms","start":"2026-05-29T02:10:05.468355Z","end":"2026-05-29T02:10:05.6024Z","steps":["trace[411822645] 'process raft request' (duration: 133.279875ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:10:08.106101Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5827832128082274683,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-29T02:10:08.302648Z","caller":"traceutil/trace.go:171","msg":"trace[1262068903] linearizableReadLoop","detail":"{readStateIndex:1148; appliedIndex:1147; }","duration":"696.790415ms","start":"2026-05-29T02:10:07.605838Z","end":"2026-05-29T02:10:08.302628Z","steps":["trace[1262068903] 'read index received' (duration: 696.768225ms)","trace[1262068903] 'applied index is now lower than readState.Index' (duration: 21.2µs)"],"step_count":2} {"level":"info","ts":"2026-05-29T02:10:08.302695Z","caller":"traceutil/trace.go:171","msg":"trace[991770897] transaction","detail":"{read_only:false; response_revision:1105; number_of_response:1; }","duration":"718.701749ms","start":"2026-05-29T02:10:07.583956Z","end":"2026-05-29T02:10:08.302658Z","steps":["trace[991770897] 'process raft request' (duration: 718.551565ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:10:08.302832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"696.98522ms","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-05-29T02:10:08.302868Z","caller":"traceutil/trace.go:171","msg":"trace[1456635465] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1105; }","duration":"697.074732ms","start":"2026-05-29T02:10:07.605785Z","end":"2026-05-29T02:10:08.302859Z","steps":["trace[1456635465] 'agreement among raft nodes before linearized reading' (duration: 696.948949ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:10:08.302847Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:10:07.583921Z","time spent":"718.816981ms","remote":"127.0.0.1:39676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-29T02:10:08.302903Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:10:07.605761Z","time spent":"697.134682ms","remote":"127.0.0.1:39676","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-05-29T02:10:08.421488Z","caller":"traceutil/trace.go:171","msg":"trace[1505205215] transaction","detail":"{read_only:false; response_revision:1106; number_of_response:1; }","duration":"161.091481ms","start":"2026-05-29T02:10:08.26037Z","end":"2026-05-29T02:10:08.421461Z","steps":["trace[1505205215] 'process raft request' (duration: 91.515157ms)","trace[1505205215] 'compare' (duration: 69.386139ms)"],"step_count":2} {"level":"info","ts":"2026-05-29T02:10:08.421556Z","caller":"traceutil/trace.go:171","msg":"trace[1820317053] transaction","detail":"{read_only:false; response_revision:1107; number_of_response:1; }","duration":"114.823044ms","start":"2026-05-29T02:10:08.306713Z","end":"2026-05-29T02:10:08.421536Z","steps":["trace[1820317053] 'process raft request' (duration: 114.740633ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T02:10:08.421583Z","caller":"traceutil/trace.go:171","msg":"trace[1870701012] linearizableReadLoop","detail":"{readStateIndex:1149; appliedIndex:1148; }","duration":"118.838331ms","start":"2026-05-29T02:10:08.302712Z","end":"2026-05-29T02:10:08.42155Z","steps":["trace[1870701012] 'read index received' (duration: 49.190526ms)","trace[1870701012] 'applied index is now lower than readState.Index' (duration: 69.643695ms)"],"step_count":2} {"level":"warn","ts":"2026-05-29T02:10:08.421776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"814.257263ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-05-29T02:10:08.42181Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"814.699854ms","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-05-29T02:10:08.421818Z","caller":"traceutil/trace.go:171","msg":"trace[691103190] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1107; }","duration":"814.326524ms","start":"2026-05-29T02:10:07.607481Z","end":"2026-05-29T02:10:08.421808Z","steps":["trace[691103190] 'agreement among raft nodes before linearized reading' (duration: 814.198491ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:10:08.421854Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:10:07.607472Z","time spent":"814.374595ms","remote":"127.0.0.1:39676","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-05-29T02:10:08.421855Z","caller":"traceutil/trace.go:171","msg":"trace[796644552] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1107; }","duration":"814.768775ms","start":"2026-05-29T02:10:07.607072Z","end":"2026-05-29T02:10:08.421841Z","steps":["trace[796644552] 'agreement among raft nodes before linearized reading' (duration: 814.614281ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:10:08.421898Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:10:07.607059Z","time spent":"814.827346ms","remote":"127.0.0.1:39676","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-29T02:10:08.422002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"815.988544ms","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-05-29T02:10:08.422368Z","caller":"traceutil/trace.go:171","msg":"trace[1355821691] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1107; }","duration":"816.479996ms","start":"2026-05-29T02:10:07.605874Z","end":"2026-05-29T02:10:08.422354Z","steps":["trace[1355821691] 'agreement among raft nodes before linearized reading' (duration: 815.82833ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:10:08.422426Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:10:07.605854Z","time spent":"816.558367ms","remote":"127.0.0.1:39676","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-05-29T02:10:08.588616Z","caller":"traceutil/trace.go:171","msg":"trace[570893094] transaction","detail":"{read_only:false; response_revision:1108; number_of_response:1; }","duration":"162.077034ms","start":"2026-05-29T02:10:08.426517Z","end":"2026-05-29T02:10:08.588594Z","steps":["trace[570893094] 'process raft request' (duration: 115.179053ms)","trace[570893094] 'compare' (duration: 46.798289ms)"],"step_count":2} {"level":"info","ts":"2026-05-29T02:10:08.596569Z","caller":"traceutil/trace.go:171","msg":"trace[1908515643] transaction","detail":"{read_only:false; response_revision:1109; number_of_response:1; }","duration":"169.564442ms","start":"2026-05-29T02:10:08.42698Z","end":"2026-05-29T02:10:08.596545Z","steps":["trace[1908515643] 'process raft request' (duration: 169.418959ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T02:10:08.596641Z","caller":"traceutil/trace.go:171","msg":"trace[296398821] transaction","detail":"{read_only:false; response_revision:1110; number_of_response:1; }","duration":"168.878996ms","start":"2026-05-29T02:10:08.42774Z","end":"2026-05-29T02:10:08.596619Z","steps":["trace[296398821] 'process raft request' (duration: 168.771193ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T02:10:26.732459Z","caller":"traceutil/trace.go:171","msg":"trace[1658609680] transaction","detail":"{read_only:false; response_revision:1216; number_of_response:1; }","duration":"289.12242ms","start":"2026-05-29T02:10:26.44331Z","end":"2026-05-29T02:10:26.732432Z","steps":["trace[1658609680] 'process raft request' (duration: 288.961896ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:10:27.411415Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"676.546049ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-29T02:10:27.411519Z","caller":"traceutil/trace.go:171","msg":"trace[1763375323] linearizableReadLoop","detail":"{readStateIndex:1266; appliedIndex:1265; }","duration":"671.283434ms","start":"2026-05-29T02:10:26.740218Z","end":"2026-05-29T02:10:27.411502Z","steps":["trace[1763375323] 'read index received' (duration: 31.611µs)","trace[1763375323] 'applied index is now lower than readState.Index' (duration: 671.250333ms)"],"step_count":2} {"level":"info","ts":"2026-05-29T02:10:27.411627Z","caller":"traceutil/trace.go:171","msg":"trace[293037381] transaction","detail":"{read_only:false; response_revision:1217; number_of_response:1; }","duration":"777.518632ms","start":"2026-05-29T02:10:26.634096Z","end":"2026-05-29T02:10:27.411615Z","steps":["trace[293037381] 'process raft request' (duration: 100.503752ms)","trace[293037381] 'compare' (duration: 676.206151ms)"],"step_count":2} {"level":"warn","ts":"2026-05-29T02:10:27.411683Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:10:26.634074Z","time spent":"777.577783ms","remote":"127.0.0.1:39676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-29T02:10:27.411917Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"652.764411ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"warn","ts":"2026-05-29T02:10:27.41196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"435.462177ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-29T02:10:27.41201Z","caller":"traceutil/trace.go:171","msg":"trace[1715214761] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:1217; }","duration":"435.562439ms","start":"2026-05-29T02:10:26.976435Z","end":"2026-05-29T02:10:27.411997Z","steps":["trace[1715214761] 'agreement among raft nodes before linearized reading' (duration: 435.459757ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T02:10:27.412008Z","caller":"traceutil/trace.go:171","msg":"trace[1690046506] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1217; }","duration":"652.888144ms","start":"2026-05-29T02:10:26.7591Z","end":"2026-05-29T02:10:27.411988Z","steps":["trace[1690046506] 'agreement among raft nodes before linearized reading' (duration: 652.634288ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:10:27.412013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"501.922096ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-05-29T02:10:27.412038Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:10:26.976415Z","time spent":"435.61848ms","remote":"127.0.0.1:39608","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":5,"response size":30,"request content":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true "} {"level":"info","ts":"2026-05-29T02:10:27.412093Z","caller":"traceutil/trace.go:171","msg":"trace[949278332] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1217; }","duration":"502.024657ms","start":"2026-05-29T02:10:26.910053Z","end":"2026-05-29T02:10:27.412078Z","steps":["trace[949278332] 'agreement among raft nodes before linearized reading' (duration: 501.874904ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:10:27.412102Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:10:26.759074Z","time spent":"653.015187ms","remote":"127.0.0.1:39676","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-29T02:10:27.412135Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:10:26.910039Z","time spent":"502.08683ms","remote":"127.0.0.1:39676","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-29T02:10:27.412255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"672.035722ms","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-05-29T02:10:27.412281Z","caller":"traceutil/trace.go:171","msg":"trace[203446982] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1217; }","duration":"672.093603ms","start":"2026-05-29T02:10:26.740181Z","end":"2026-05-29T02:10:27.412274Z","steps":["trace[203446982] 'agreement among raft nodes before linearized reading' (duration: 672.001981ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:10:27.412296Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:10:26.740163Z","time spent":"672.129754ms","remote":"127.0.0.1:39676","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-05-29T02:10:27.41232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"547.953015ms","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-05-29T02:10:27.412358Z","caller":"traceutil/trace.go:171","msg":"trace[1748751438] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1217; }","duration":"548.014257ms","start":"2026-05-29T02:10:26.864332Z","end":"2026-05-29T02:10:27.412346Z","steps":["trace[1748751438] 'agreement among raft nodes before linearized reading' (duration: 547.903294ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:10:27.412385Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:10:26.864314Z","time spent":"548.065509ms","remote":"127.0.0.1:39676","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-05-29T02:10:31.712166Z","caller":"traceutil/trace.go:171","msg":"trace[1328997389] transaction","detail":"{read_only:false; response_revision:1232; number_of_response:1; }","duration":"128.544679ms","start":"2026-05-29T02:10:31.583595Z","end":"2026-05-29T02:10:31.71214Z","steps":["trace[1328997389] 'process raft request' (duration: 109.648832ms)","trace[1328997389] 'compare' (duration: 18.800215ms)"],"step_count":2} {"level":"info","ts":"2026-05-29T02:10:31.774102Z","caller":"traceutil/trace.go:171","msg":"trace[1465063486] transaction","detail":"{read_only:false; response_revision:1234; number_of_response:1; }","duration":"190.281389ms","start":"2026-05-29T02:10:31.583796Z","end":"2026-05-29T02:10:31.774077Z","steps":["trace[1465063486] 'process raft request' (duration: 190.236688ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T02:10:31.774171Z","caller":"traceutil/trace.go:171","msg":"trace[1819324798] transaction","detail":"{read_only:false; response_revision:1233; number_of_response:1; }","duration":"190.475563ms","start":"2026-05-29T02:10:31.58367Z","end":"2026-05-29T02:10:31.774146Z","steps":["trace[1819324798] 'process raft request' (duration: 190.243478ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:10:40.036486Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.968593ms","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-05-29T02:10:40.036542Z","caller":"traceutil/trace.go:171","msg":"trace[2072147295] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1257; }","duration":"119.067806ms","start":"2026-05-29T02:10:39.917461Z","end":"2026-05-29T02:10:40.036529Z","steps":["trace[2072147295] 'range keys from in-memory index tree' (duration: 118.823859ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:10:40.036548Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"432.826174ms","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-05-29T02:10:40.036615Z","caller":"traceutil/trace.go:171","msg":"trace[1908900421] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1257; }","duration":"432.946407ms","start":"2026-05-29T02:10:39.603651Z","end":"2026-05-29T02:10:40.036597Z","steps":["trace[1908900421] 'range keys from in-memory index tree' (duration: 432.660201ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:10:40.036676Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:10:39.603632Z","time spent":"433.03538ms","remote":"127.0.0.1:39676","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-05-29T02:10:40.03671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.611396ms","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-05-29T02:10:40.036732Z","caller":"traceutil/trace.go:171","msg":"trace[735586528] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1257; }","duration":"110.632866ms","start":"2026-05-29T02:10:39.926093Z","end":"2026-05-29T02:10:40.036726Z","steps":["trace[735586528] 'range keys from in-memory index tree' (duration: 110.476982ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:10:40.037151Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.027849ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-29T02:10:40.037178Z","caller":"traceutil/trace.go:171","msg":"trace[1354366215] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1257; }","duration":"293.08215ms","start":"2026-05-29T02:10:39.744089Z","end":"2026-05-29T02:10:40.037171Z","steps":["trace[1354366215] 'range keys from in-memory index tree' (duration: 292.950507ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T02:10:41.137408Z","caller":"traceutil/trace.go:171","msg":"trace[1542822734] transaction","detail":"{read_only:false; response_revision:1262; number_of_response:1; }","duration":"311.974007ms","start":"2026-05-29T02:10:40.825382Z","end":"2026-05-29T02:10:41.137356Z","steps":["trace[1542822734] 'process raft request' (duration: 311.782042ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:10:41.137571Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:10:40.825362Z","time spent":"312.12923ms","remote":"127.0.0.1:39676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-29T02:10:42.277664Z","caller":"traceutil/trace.go:171","msg":"trace[82214382] transaction","detail":"{read_only:false; response_revision:1265; number_of_response:1; }","duration":"228.252367ms","start":"2026-05-29T02:10:42.049394Z","end":"2026-05-29T02:10:42.277647Z","steps":["trace[82214382] 'process raft request' (duration: 228.055963ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T02:10:42.277661Z","caller":"traceutil/trace.go:171","msg":"trace[1301342033] transaction","detail":"{read_only:false; response_revision:1267; number_of_response:1; }","duration":"224.974789ms","start":"2026-05-29T02:10:42.052665Z","end":"2026-05-29T02:10:42.277639Z","steps":["trace[1301342033] 'process raft request' (duration: 224.938278ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T02:10:42.277687Z","caller":"traceutil/trace.go:171","msg":"trace[973267663] transaction","detail":"{read_only:false; response_revision:1266; number_of_response:1; }","duration":"226.342102ms","start":"2026-05-29T02:10:42.05132Z","end":"2026-05-29T02:10:42.277662Z","steps":["trace[973267663] 'process raft request' (duration: 226.24878ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T02:10:46.571473Z","caller":"traceutil/trace.go:171","msg":"trace[20645547] transaction","detail":"{read_only:false; response_revision:1307; number_of_response:1; }","duration":"236.742007ms","start":"2026-05-29T02:10:46.334708Z","end":"2026-05-29T02:10:46.57145Z","steps":["trace[20645547] 'process raft request' (duration: 236.625935ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T02:10:46.823423Z","caller":"traceutil/trace.go:171","msg":"trace[552110693] linearizableReadLoop","detail":"{readStateIndex:1361; appliedIndex:1360; }","duration":"366.747891ms","start":"2026-05-29T02:10:46.456644Z","end":"2026-05-29T02:10:46.823392Z","steps":["trace[552110693] 'read index received' (duration: 114.915037ms)","trace[552110693] 'applied index is now lower than readState.Index' (duration: 251.831364ms)"],"step_count":2} {"level":"info","ts":"2026-05-29T02:10:46.823571Z","caller":"traceutil/trace.go:171","msg":"trace[1940399046] transaction","detail":"{read_only:false; response_revision:1308; number_of_response:1; }","duration":"487.776794ms","start":"2026-05-29T02:10:46.335746Z","end":"2026-05-29T02:10:46.823523Z","steps":["trace[1940399046] 'process raft request' (duration: 439.445741ms)","trace[1940399046] 'compare' (duration: 47.971714ms)"],"step_count":2} {"level":"warn","ts":"2026-05-29T02:10:46.823749Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:10:46.335727Z","time spent":"487.920567ms","remote":"127.0.0.1:39676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-29T02:10:46.823785Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.042745ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-29T02:10:46.823851Z","caller":"traceutil/trace.go:171","msg":"trace[518493874] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1308; }","duration":"292.151858ms","start":"2026-05-29T02:10:46.531682Z","end":"2026-05-29T02:10:46.823834Z","steps":["trace[518493874] 'agreement among raft nodes before linearized reading' (duration: 292.026455ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:10:46.823893Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"367.213872ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-29T02:10:46.823965Z","caller":"traceutil/trace.go:171","msg":"trace[1315779308] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:1308; }","duration":"367.333366ms","start":"2026-05-29T02:10:46.456615Z","end":"2026-05-29T02:10:46.823948Z","steps":["trace[1315779308] 'agreement among raft nodes before linearized reading' (duration: 366.926796ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:10:46.824026Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:10:46.4566Z","time spent":"367.409657ms","remote":"127.0.0.1:39670","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":28,"request content":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true "} {"level":"warn","ts":"2026-05-29T02:10:47.465832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.275123ms","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-05-29T02:10:47.465894Z","caller":"traceutil/trace.go:171","msg":"trace[392225411] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1308; }","duration":"309.395625ms","start":"2026-05-29T02:10:47.156486Z","end":"2026-05-29T02:10:47.465882Z","steps":["trace[392225411] 'range keys from in-memory index tree' (duration: 309.1395ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:10:47.46592Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:10:47.156461Z","time spent":"309.453677ms","remote":"127.0.0.1:39676","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-05-29T02:10:48.531115Z","caller":"traceutil/trace.go:171","msg":"trace[170874441] linearizableReadLoop","detail":"{readStateIndex:1364; appliedIndex:1363; }","duration":"192.188565ms","start":"2026-05-29T02:10:48.338905Z","end":"2026-05-29T02:10:48.531093Z","steps":["trace[170874441] 'read index received' (duration: 192.013001ms)","trace[170874441] 'applied index is now lower than readState.Index' (duration: 174.734µs)"],"step_count":2} {"level":"info","ts":"2026-05-29T02:10:48.531247Z","caller":"traceutil/trace.go:171","msg":"trace[63793077] transaction","detail":"{read_only:false; response_revision:1311; number_of_response:1; }","duration":"394.729743ms","start":"2026-05-29T02:10:48.136469Z","end":"2026-05-29T02:10:48.531199Z","steps":["trace[63793077] 'process raft request' (duration: 394.497908ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:10:48.531358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.385209ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-29T02:10:48.5314Z","caller":"traceutil/trace.go:171","msg":"trace[2121644224] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1311; }","duration":"192.492392ms","start":"2026-05-29T02:10:48.338896Z","end":"2026-05-29T02:10:48.531388Z","steps":["trace[2121644224] 'agreement among raft nodes before linearized reading' (duration: 192.297297ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:10:48.531421Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:10:48.136458Z","time spent":"394.873608ms","remote":"127.0.0.1:39676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-29T02:10:49.075333Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5827832128082275143,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-29T02:10:49.283693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.756065ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-29T02:10:49.283774Z","caller":"traceutil/trace.go:171","msg":"trace[1013702287] linearizableReadLoop","detail":"{readStateIndex:1365; appliedIndex:1364; }","duration":"708.913164ms","start":"2026-05-29T02:10:48.574849Z","end":"2026-05-29T02:10:49.283762Z","steps":["trace[1013702287] 'read index received' (duration: 547.033236ms)","trace[1013702287] 'applied index is now lower than readState.Index' (duration: 161.878648ms)"],"step_count":2} {"level":"info","ts":"2026-05-29T02:10:49.283943Z","caller":"traceutil/trace.go:171","msg":"trace[2037861265] transaction","detail":"{read_only:false; response_revision:1312; number_of_response:1; }","duration":"747.819812ms","start":"2026-05-29T02:10:48.536113Z","end":"2026-05-29T02:10:49.283933Z","steps":["trace[2037861265] 'process raft request' (duration: 585.746539ms)","trace[2037861265] 'compare' (duration: 161.484949ms)"],"step_count":2} {"level":"warn","ts":"2026-05-29T02:10:49.28399Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:10:48.536099Z","time spent":"747.868934ms","remote":"127.0.0.1:39676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-29T02:10:49.284165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"709.315183ms","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-05-29T02:10:49.28419Z","caller":"traceutil/trace.go:171","msg":"trace[1754758361] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1312; }","duration":"709.376785ms","start":"2026-05-29T02:10:48.574807Z","end":"2026-05-29T02:10:49.284183Z","steps":["trace[1754758361] 'agreement among raft nodes before linearized reading' (duration: 709.292093ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:10:49.28421Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:10:48.574789Z","time spent":"709.417105ms","remote":"127.0.0.1:39676","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-05-29T02:10:49.284281Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"536.381744ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-29T02:10:49.284305Z","caller":"traceutil/trace.go:171","msg":"trace[119004214] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:1312; }","duration":"536.427975ms","start":"2026-05-29T02:10:48.747869Z","end":"2026-05-29T02:10:49.284297Z","steps":["trace[119004214] 'agreement among raft nodes before linearized reading' (duration: 536.392974ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:10:49.284323Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:10:48.747853Z","time spent":"536.464276ms","remote":"127.0.0.1:54880","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true "} {"level":"warn","ts":"2026-05-29T02:10:49.284421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"449.014988ms","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-05-29T02:10:49.284472Z","caller":"traceutil/trace.go:171","msg":"trace[375080093] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1312; }","duration":"449.112431ms","start":"2026-05-29T02:10:48.835349Z","end":"2026-05-29T02:10:49.284462Z","steps":["trace[375080093] 'agreement among raft nodes before linearized reading' (duration: 448.961157ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:10:49.284495Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:10:48.835328Z","time spent":"449.162171ms","remote":"127.0.0.1:39676","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-29T02:10:49.284497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.542991ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-29T02:10:49.284511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"504.132602ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.115\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-05-29T02:10:49.284596Z","caller":"traceutil/trace.go:171","msg":"trace[941755386] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:1312; }","duration":"345.698545ms","start":"2026-05-29T02:10:48.938874Z","end":"2026-05-29T02:10:49.284573Z","steps":["trace[941755386] 'agreement among raft nodes before linearized reading' (duration: 345.535131ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:10:49.284647Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:10:48.938855Z","time spent":"345.780967ms","remote":"127.0.0.1:54796","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"info","ts":"2026-05-29T02:10:49.284689Z","caller":"traceutil/trace.go:171","msg":"trace[53223484] range","detail":"{range_begin:/registry/masterleases/199.204.45.115; range_end:; response_count:1; response_revision:1312; }","duration":"504.376238ms","start":"2026-05-29T02:10:48.780295Z","end":"2026-05-29T02:10:49.284671Z","steps":["trace[53223484] 'agreement among raft nodes before linearized reading' (duration: 504.098121ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:10:49.284789Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:10:48.780275Z","time spent":"504.49867ms","remote":"127.0.0.1:39470","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.204.45.115\" "} {"level":"info","ts":"2026-05-29T02:10:49.452722Z","caller":"traceutil/trace.go:171","msg":"trace[89668561] transaction","detail":"{read_only:false; response_revision:1315; number_of_response:1; }","duration":"129.254077ms","start":"2026-05-29T02:10:49.323445Z","end":"2026-05-29T02:10:49.452699Z","steps":["trace[89668561] 'process raft request' (duration: 129.202725ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T02:10:49.452766Z","caller":"traceutil/trace.go:171","msg":"trace[900772306] transaction","detail":"{read_only:false; response_revision:1313; number_of_response:1; }","duration":"164.592632ms","start":"2026-05-29T02:10:49.288151Z","end":"2026-05-29T02:10:49.452743Z","steps":["trace[900772306] 'process raft request' (duration: 119.612538ms)","trace[900772306] 'compare' (duration: 44.682197ms)"],"step_count":2} {"level":"info","ts":"2026-05-29T02:10:49.452993Z","caller":"traceutil/trace.go:171","msg":"trace[960041828] transaction","detail":"{read_only:false; response_revision:1314; number_of_response:1; }","duration":"164.717045ms","start":"2026-05-29T02:10:49.288265Z","end":"2026-05-29T02:10:49.452982Z","steps":["trace[960041828] 'process raft request' (duration: 164.313716ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T02:10:49.611502Z","caller":"traceutil/trace.go:171","msg":"trace[355549331] transaction","detail":"{read_only:false; response_revision:1317; number_of_response:1; }","duration":"100.454995ms","start":"2026-05-29T02:10:49.511011Z","end":"2026-05-29T02:10:49.611466Z","steps":["trace[355549331] 'process raft request' (duration: 48.380094ms)","trace[355549331] 'compare' (duration: 51.896217ms)"],"step_count":2} {"level":"info","ts":"2026-05-29T02:10:51.236478Z","caller":"traceutil/trace.go:171","msg":"trace[936161545] linearizableReadLoop","detail":"{readStateIndex:1372; appliedIndex:1371; }","duration":"372.899986ms","start":"2026-05-29T02:10:50.863561Z","end":"2026-05-29T02:10:51.236461Z","steps":["trace[936161545] 'read index received' (duration: 372.800454ms)","trace[936161545] 'applied index is now lower than readState.Index' (duration: 99.012µs)"],"step_count":2} {"level":"info","ts":"2026-05-29T02:10:51.23652Z","caller":"traceutil/trace.go:171","msg":"trace[582951991] transaction","detail":"{read_only:false; response_revision:1318; number_of_response:1; }","duration":"697.361258ms","start":"2026-05-29T02:10:50.539133Z","end":"2026-05-29T02:10:51.236495Z","steps":["trace[582951991] 'process raft request' (duration: 697.228355ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:10:51.236606Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"373.03067ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:474"} {"level":"info","ts":"2026-05-29T02:10:51.236629Z","caller":"traceutil/trace.go:171","msg":"trace[1461792546] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1318; }","duration":"373.101671ms","start":"2026-05-29T02:10:50.863521Z","end":"2026-05-29T02:10:51.236623Z","steps":["trace[1461792546] 'agreement among raft nodes before linearized reading' (duration: 373.002799ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:10:51.236648Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:10:50.863501Z","time spent":"373.142033ms","remote":"127.0.0.1:39676","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":497,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-05-29T02:10:51.236647Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:10:50.539106Z","time spent":"697.473041ms","remote":"127.0.0.1:39676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-29T02:10:51.788527Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5827832128082275163,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-29T02:10:52.289608Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5827832128082275163,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-29T02:10:52.790483Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5827832128082275163,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-29T02:10:53.29093Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5827832128082275163,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-29T02:10:53.792019Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5827832128082275163,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-29T02:10:54.02277Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.782973363s","expected-duration":"1s"} {"level":"info","ts":"2026-05-29T02:10:54.02338Z","caller":"traceutil/trace.go:171","msg":"trace[1071157176] transaction","detail":"{read_only:false; response_revision:1319; number_of_response:1; }","duration":"2.783635529s","start":"2026-05-29T02:10:51.239721Z","end":"2026-05-29T02:10:54.023357Z","steps":["trace[1071157176] 'process raft request' (duration: 2.78329283s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:10:54.023526Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:10:51.239704Z","time spent":"2.783748602s","remote":"127.0.0.1:39676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":459,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-29T02:10:54.395324Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.945769ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-29T02:10:54.396017Z","caller":"traceutil/trace.go:171","msg":"trace[63049514] transaction","detail":"{read_only:false; response_revision:1320; number_of_response:1; }","duration":"2.780461925s","start":"2026-05-29T02:10:51.615511Z","end":"2026-05-29T02:10:54.395973Z","steps":["trace[63049514] 'process raft request' (duration: 2.598786739s)","trace[63049514] 'compare' (duration: 180.844526ms)"],"step_count":2} {"level":"info","ts":"2026-05-29T02:10:54.39612Z","caller":"traceutil/trace.go:171","msg":"trace[2003727677] transaction","detail":"{read_only:false; response_revision:1321; number_of_response:1; }","duration":"397.492919ms","start":"2026-05-29T02:10:53.998491Z","end":"2026-05-29T02:10:54.395984Z","steps":["trace[2003727677] 'process raft request' (duration: 397.255693ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T02:10:54.396119Z","caller":"traceutil/trace.go:171","msg":"trace[906067505] linearizableReadLoop","detail":"{readStateIndex:1374; appliedIndex:1372; }","duration":"3.107920337s","start":"2026-05-29T02:10:51.288164Z","end":"2026-05-29T02:10:54.396085Z","steps":["trace[906067505] 'read index received' (duration: 2.734889206s)","trace[906067505] 'applied index is now lower than readState.Index' (duration: 373.028441ms)"],"step_count":2} {"level":"warn","ts":"2026-05-29T02:10:54.396327Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:10:51.615486Z","time spent":"2.78073167s","remote":"127.0.0.1:39676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-29T02:10:54.396439Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:10:53.998467Z","time spent":"397.736465ms","remote":"127.0.0.1:39676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-29T02:10:54.532924Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000096483s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-05-29T02:10:54.533121Z","caller":"traceutil/trace.go:171","msg":"trace[1423593304] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000347989s","start":"2026-05-29T02:10:52.532754Z","end":"2026-05-29T02:10:54.533102Z","steps":["trace[1423593304] 'agreement among raft nodes before linearized reading' (duration: 2.000134674s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:10:54.533206Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:10:52.532733Z","time spent":"2.000461522s","remote":"127.0.0.1:60996","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/05/29 02:10:54 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-05-29T02:10:54.646184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.34224ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-05-29T02:10:54.646296Z","caller":"traceutil/trace.go:171","msg":"trace[506938482] linearizableReadLoop","detail":"{readStateIndex:1376; appliedIndex:1375; }","duration":"250.011371ms","start":"2026-05-29T02:10:54.396266Z","end":"2026-05-29T02:10:54.646278Z","steps":["trace[506938482] 'read index received' (duration: 47.871µs)","trace[506938482] 'applied index is now lower than readState.Index' (duration: 249.96184ms)"],"step_count":2} {"level":"warn","ts":"2026-05-29T02:10:54.646466Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.250831707s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-29T02:10:54.646507Z","caller":"traceutil/trace.go:171","msg":"trace[1753160371] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:1321; }","duration":"1.25096357s","start":"2026-05-29T02:10:53.395531Z","end":"2026-05-29T02:10:54.646494Z","steps":["trace[1753160371] 'agreement among raft nodes before linearized reading' (duration: 1.250835067s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:10:54.646548Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:10:53.39551Z","time spent":"1.251026451s","remote":"127.0.0.1:54902","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true "} {"level":"warn","ts":"2026-05-29T02:10:54.646512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.358323748s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-29T02:10:54.647128Z","caller":"traceutil/trace.go:171","msg":"trace[2067572066] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1321; }","duration":"3.358975774s","start":"2026-05-29T02:10:51.288123Z","end":"2026-05-29T02:10:54.647099Z","steps":["trace[2067572066] 'agreement among raft nodes before linearized reading' (duration: 3.10803325s)","trace[2067572066] 'range keys from in-memory index tree' (duration: 250.039373ms)"],"step_count":2} {"level":"warn","ts":"2026-05-29T02:10:54.647226Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:10:51.288105Z","time spent":"3.359102596s","remote":"127.0.0.1:39676","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-29T02:10:54.646648Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.117491004s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-05-29T02:10:54.647337Z","caller":"traceutil/trace.go:171","msg":"trace[1212653122] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1321; }","duration":"3.118224711s","start":"2026-05-29T02:10:51.529101Z","end":"2026-05-29T02:10:54.647326Z","steps":["trace[1212653122] 'agreement among raft nodes before linearized reading' (duration: 3.117453783s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:10:54.647382Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:10:51.529079Z","time spent":"3.118283593s","remote":"127.0.0.1:39676","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-29T02:10:54.646683Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.282184864s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-05-29T02:10:54.64709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.191095864s","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-05-29T02:10:54.647507Z","caller":"traceutil/trace.go:171","msg":"trace[537413045] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1321; }","duration":"3.191571875s","start":"2026-05-29T02:10:51.455916Z","end":"2026-05-29T02:10:54.647488Z","steps":["trace[537413045] 'agreement among raft nodes before linearized reading' (duration: 3.190642233s)"],"step_count":1} {"level":"info","ts":"2026-05-29T02:10:54.647537Z","caller":"traceutil/trace.go:171","msg":"trace[1615057824] range","detail":"{range_begin:/registry/csidrivers/; range_end:/registry/csidrivers0; response_count:0; response_revision:1321; }","duration":"2.283085865s","start":"2026-05-29T02:10:52.364421Z","end":"2026-05-29T02:10:54.647507Z","steps":["trace[1615057824] 'agreement among raft nodes before linearized reading' (duration: 2.282189254s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:10:54.647567Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:10:51.455894Z","time spent":"3.191656357s","remote":"127.0.0.1:39676","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-05-29T02:10:54.64764Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:10:52.3644Z","time spent":"2.283201768s","remote":"127.0.0.1:39800","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":30,"request content":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true "} {"level":"warn","ts":"2026-05-29T02:10:54.646697Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.905539052s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-29T02:10:54.646532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.219782ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-05-29T02:10:54.646756Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.258289ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-29T02:10:54.647838Z","caller":"traceutil/trace.go:171","msg":"trace[1541518507] range","detail":"{range_begin:/registry/certificatesigningrequests/; range_end:/registry/certificatesigningrequests0; response_count:0; response_revision:1321; }","duration":"340.696127ms","start":"2026-05-29T02:10:54.307126Z","end":"2026-05-29T02:10:54.647822Z","steps":["trace[1541518507] 'agreement among raft nodes before linearized reading' (duration: 339.196251ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:10:54.647942Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:10:54.307105Z","time spent":"340.818159ms","remote":"127.0.0.1:39674","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":1,"response size":30,"request content":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true "} {"level":"info","ts":"2026-05-29T02:10:54.647842Z","caller":"traceutil/trace.go:171","msg":"trace[1152585637] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1321; }","duration":"114.364384ms","start":"2026-05-29T02:10:54.533464Z","end":"2026-05-29T02:10:54.647828Z","steps":["trace[1152585637] 'agreement among raft nodes before linearized reading' (duration: 113.282178ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:10:54.646799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.190853139s","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-05-29T02:10:54.6482Z","caller":"traceutil/trace.go:171","msg":"trace[487308987] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1321; }","duration":"3.192268531s","start":"2026-05-29T02:10:51.45591Z","end":"2026-05-29T02:10:54.648178Z","steps":["trace[487308987] 'agreement among raft nodes before linearized reading' (duration: 3.190859308s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:10:54.648249Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:10:51.455891Z","time spent":"3.192344844s","remote":"127.0.0.1:39676","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-29T02:10:54.646778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.405855413s","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-05-29T02:10:54.647771Z","caller":"traceutil/trace.go:171","msg":"trace[1633120353] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:1321; }","duration":"2.906636908s","start":"2026-05-29T02:10:51.741116Z","end":"2026-05-29T02:10:54.647753Z","steps":["trace[1633120353] 'agreement among raft nodes before linearized reading' (duration: 2.905562293s)"],"step_count":1} {"level":"info","ts":"2026-05-29T02:10:54.648389Z","caller":"traceutil/trace.go:171","msg":"trace[1407632021] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1321; }","duration":"1.407498391s","start":"2026-05-29T02:10:53.240877Z","end":"2026-05-29T02:10:54.648376Z","steps":["trace[1407632021] 'agreement among raft nodes before linearized reading' (duration: 1.405835372s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:10:54.648453Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:10:51.741096Z","time spent":"2.907318554s","remote":"127.0.0.1:54848","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true "} {"level":"warn","ts":"2026-05-29T02:10:54.648494Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:10:53.24085Z","time spent":"1.407630464s","remote":"127.0.0.1:39676","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-05-29T02:10:56.04658Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.320455062s","expected-duration":"1s"} {"level":"info","ts":"2026-05-29T02:10:56.047308Z","caller":"traceutil/trace.go:171","msg":"trace[905836816] transaction","detail":"{read_only:false; response_revision:1324; number_of_response:1; }","duration":"1.394737297s","start":"2026-05-29T02:10:54.652544Z","end":"2026-05-29T02:10:56.047281Z","steps":["trace[905836816] 'process raft request' (duration: 1.394649755s)"],"step_count":1} {"level":"info","ts":"2026-05-29T02:10:56.047313Z","caller":"traceutil/trace.go:171","msg":"trace[1405640216] transaction","detail":"{read_only:false; response_revision:1323; number_of_response:1; }","duration":"1.394776278s","start":"2026-05-29T02:10:54.652501Z","end":"2026-05-29T02:10:56.047277Z","steps":["trace[1405640216] 'process raft request' (duration: 1.394400549s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:10:56.047458Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:10:54.652536Z","time spent":"1.394843451s","remote":"127.0.0.1:39676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-29T02:10:56.047481Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:10:54.652494Z","time spent":"1.394898972s","remote":"127.0.0.1:39676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-29T02:10:56.047594Z","caller":"traceutil/trace.go:171","msg":"trace[1297574436] transaction","detail":"{read_only:false; response_revision:1326; number_of_response:1; }","duration":"1.393959869s","start":"2026-05-29T02:10:54.653614Z","end":"2026-05-29T02:10:56.047574Z","steps":["trace[1297574436] 'process raft request' (duration: 1.393818426s)"],"step_count":1} {"level":"info","ts":"2026-05-29T02:10:56.047629Z","caller":"traceutil/trace.go:171","msg":"trace[746978849] linearizableReadLoop","detail":"{readStateIndex:1382; appliedIndex:1376; }","duration":"1.391070451s","start":"2026-05-29T02:10:54.656504Z","end":"2026-05-29T02:10:56.047575Z","steps":["trace[746978849] 'read index received' (duration: 58.34344ms)","trace[746978849] 'applied index is now lower than readState.Index' (duration: 1.332726031s)"],"step_count":2} {"level":"info","ts":"2026-05-29T02:10:56.047668Z","caller":"traceutil/trace.go:171","msg":"trace[870719392] transaction","detail":"{read_only:false; response_revision:1325; number_of_response:1; }","duration":"1.394771009s","start":"2026-05-29T02:10:54.652783Z","end":"2026-05-29T02:10:56.047554Z","steps":["trace[870719392] 'process raft request' (duration: 1.394467702s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:10:56.04774Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.391220365s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-29T02:10:56.047797Z","caller":"traceutil/trace.go:171","msg":"trace[1692249732] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1327; }","duration":"1.391293066s","start":"2026-05-29T02:10:54.656487Z","end":"2026-05-29T02:10:56.04778Z","steps":["trace[1692249732] 'agreement among raft nodes before linearized reading' (duration: 1.391203874s)"],"step_count":1} {"level":"info","ts":"2026-05-29T02:10:56.047694Z","caller":"traceutil/trace.go:171","msg":"trace[2140936574] transaction","detail":"{read_only:false; response_revision:1327; number_of_response:1; }","duration":"1.393197771s","start":"2026-05-29T02:10:54.654404Z","end":"2026-05-29T02:10:56.047602Z","steps":["trace[2140936574] 'process raft request' (duration: 1.393115659s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:10:56.04786Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:10:54.656481Z","time spent":"1.391368238s","remote":"127.0.0.1:60996","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-29T02:10:56.04786Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:10:54.652778Z","time spent":"1.394985474s","remote":"127.0.0.1:39676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-29T02:10:56.047936Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:10:54.654386Z","time spent":"1.393468118s","remote":"127.0.0.1:39676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-29T02:10:56.047962Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:10:54.653609Z","time spent":"1.394046961s","remote":"127.0.0.1:39512","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":759,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-29T02:10:57.128314Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"744.723879ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-29T02:10:57.128571Z","caller":"traceutil/trace.go:171","msg":"trace[910231085] transaction","detail":"{read_only:false; response_revision:1329; number_of_response:1; }","duration":"726.9987ms","start":"2026-05-29T02:10:56.401543Z","end":"2026-05-29T02:10:57.128541Z","steps":["trace[910231085] 'process raft request' (duration: 726.914588ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:10:57.128671Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:10:56.401527Z","time spent":"727.097842ms","remote":"127.0.0.1:39676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-29T02:10:57.12891Z","caller":"traceutil/trace.go:171","msg":"trace[62212455] linearizableReadLoop","detail":"{readStateIndex:1383; appliedIndex:1382; }","duration":"1.079432484s","start":"2026-05-29T02:10:56.049436Z","end":"2026-05-29T02:10:57.128868Z","steps":["trace[62212455] 'read index received' (duration: 333.985388ms)","trace[62212455] 'applied index is now lower than readState.Index' (duration: 745.444566ms)"],"step_count":2} {"level":"info","ts":"2026-05-29T02:10:57.128998Z","caller":"traceutil/trace.go:171","msg":"trace[1833731768] transaction","detail":"{read_only:false; response_revision:1328; number_of_response:1; }","duration":"2.128471088s","start":"2026-05-29T02:10:55.000506Z","end":"2026-05-29T02:10:57.128977Z","steps":["trace[1833731768] 'process raft request' (duration: 1.38296081s)","trace[1833731768] 'compare' (duration: 744.526475ms)"],"step_count":2} {"level":"warn","ts":"2026-05-29T02:10:57.12909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.079614488s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-29T02:10:57.129104Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:10:55.000482Z","time spent":"2.128562919s","remote":"127.0.0.1:39676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-29T02:10:57.129129Z","caller":"traceutil/trace.go:171","msg":"trace[25876011] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1329; }","duration":"1.079727471s","start":"2026-05-29T02:10:56.049392Z","end":"2026-05-29T02:10:57.129119Z","steps":["trace[25876011] 'agreement among raft nodes before linearized reading' (duration: 1.079625849s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:10:57.129167Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:10:56.049372Z","time spent":"1.079787512s","remote":"127.0.0.1:32772","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-29T02:10:57.129318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"410.771362ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-29T02:10:57.129378Z","caller":"traceutil/trace.go:171","msg":"trace[2009023700] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1329; }","duration":"410.856575ms","start":"2026-05-29T02:10:56.718506Z","end":"2026-05-29T02:10:57.129363Z","steps":["trace[2009023700] 'agreement among raft nodes before linearized reading' (duration: 410.702731ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:10:57.129425Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:10:56.71849Z","time spent":"410.924546ms","remote":"127.0.0.1:39676","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-29T02:10:57.129474Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.466251ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:1 size:118712"} {"level":"warn","ts":"2026-05-29T02:10:57.129488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.336235ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/servicenodeports\" ","response":"range_response_count:1 size:118"} {"level":"info","ts":"2026-05-29T02:10:57.129571Z","caller":"traceutil/trace.go:171","msg":"trace[1389394085] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:1; response_revision:1329; }","duration":"137.609964ms","start":"2026-05-29T02:10:56.991938Z","end":"2026-05-29T02:10:57.129548Z","steps":["trace[1389394085] 'agreement among raft nodes before linearized reading' (duration: 137.269646ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T02:10:57.129641Z","caller":"traceutil/trace.go:171","msg":"trace[1450860433] range","detail":"{range_begin:/registry/ranges/servicenodeports; range_end:; response_count:1; response_revision:1329; }","duration":"139.54736ms","start":"2026-05-29T02:10:56.990046Z","end":"2026-05-29T02:10:57.129594Z","steps":["trace[1450860433] 'agreement among raft nodes before linearized reading' (duration: 139.256223ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T02:10:57.428652Z","caller":"traceutil/trace.go:171","msg":"trace[753521] transaction","detail":"{read_only:false; response_revision:1330; number_of_response:1; }","duration":"294.841181ms","start":"2026-05-29T02:10:57.133797Z","end":"2026-05-29T02:10:57.428638Z","steps":["trace[753521] 'process raft request' (duration: 294.657627ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T02:10:57.428623Z","caller":"traceutil/trace.go:171","msg":"trace[2026053621] linearizableReadLoop","detail":"{readStateIndex:1385; appliedIndex:1384; }","duration":"293.51359ms","start":"2026-05-29T02:10:57.135084Z","end":"2026-05-29T02:10:57.428597Z","steps":["trace[2026053621] 'read index received' (duration: 293.266645ms)","trace[2026053621] 'applied index is now lower than readState.Index' (duration: 245.975µs)"],"step_count":2} {"level":"warn","ts":"2026-05-29T02:10:57.428863Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.734266ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:1 size:118712"} {"level":"info","ts":"2026-05-29T02:10:57.429004Z","caller":"traceutil/trace.go:171","msg":"trace[332098980] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:1; response_revision:1330; }","duration":"293.911419ms","start":"2026-05-29T02:10:57.135066Z","end":"2026-05-29T02:10:57.428978Z","steps":["trace[332098980] 'agreement among raft nodes before linearized reading' (duration: 293.616052ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:10:57.429257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.074484ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/servicenodeports\" ","response":"range_response_count:1 size:118"} {"level":"info","ts":"2026-05-29T02:10:57.429311Z","caller":"traceutil/trace.go:171","msg":"trace[1761917723] range","detail":"{range_begin:/registry/ranges/servicenodeports; range_end:; response_count:1; response_revision:1330; }","duration":"294.152335ms","start":"2026-05-29T02:10:57.135151Z","end":"2026-05-29T02:10:57.429303Z","steps":["trace[1761917723] 'agreement among raft nodes before linearized reading' (duration: 294.076673ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:10:57.429452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.75535ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-29T02:10:57.430317Z","caller":"traceutil/trace.go:171","msg":"trace[486864011] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:1330; }","duration":"150.642441ms","start":"2026-05-29T02:10:57.279646Z","end":"2026-05-29T02:10:57.430289Z","steps":["trace[486864011] 'agreement among raft nodes before linearized reading' (duration: 149.779671ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:10:57.429693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.152074ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-29T02:10:57.430445Z","caller":"traceutil/trace.go:171","msg":"trace[529557387] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1330; }","duration":"291.903823ms","start":"2026-05-29T02:10:57.138522Z","end":"2026-05-29T02:10:57.430425Z","steps":["trace[529557387] 'agreement among raft nodes before linearized reading' (duration: 291.147105ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:10:58.121758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.924977ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-29T02:10:58.121938Z","caller":"traceutil/trace.go:171","msg":"trace[2113400868] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:1330; }","duration":"222.334407ms","start":"2026-05-29T02:10:57.899582Z","end":"2026-05-29T02:10:58.121917Z","steps":["trace[2113400868] 'count revisions from in-memory index tree' (duration: 221.845916ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:10:58.12226Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.448992ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-29T02:10:58.122371Z","caller":"traceutil/trace.go:171","msg":"trace[880273412] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:1330; }","duration":"154.744609ms","start":"2026-05-29T02:10:57.967607Z","end":"2026-05-29T02:10:58.122352Z","steps":["trace[880273412] 'count revisions from in-memory index tree' (duration: 154.275408ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:10:58.122259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.282399ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-29T02:10:58.122677Z","caller":"traceutil/trace.go:171","msg":"trace[1649325561] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:1330; }","duration":"149.766621ms","start":"2026-05-29T02:10:57.972868Z","end":"2026-05-29T02:10:58.122634Z","steps":["trace[1649325561] 'count revisions from in-memory index tree' (duration: 149.168197ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:10:58.817688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.580829ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-29T02:10:58.817978Z","caller":"traceutil/trace.go:171","msg":"trace[196512669] linearizableReadLoop","detail":"{readStateIndex:1389; appliedIndex:1386; }","duration":"513.919802ms","start":"2026-05-29T02:10:58.304038Z","end":"2026-05-29T02:10:58.817957Z","steps":["trace[196512669] 'read index received' (duration: 188.000476ms)","trace[196512669] 'applied index is now lower than readState.Index' (duration: 325.918216ms)"],"step_count":2} {"level":"info","ts":"2026-05-29T02:10:58.818007Z","caller":"traceutil/trace.go:171","msg":"trace[1892920961] transaction","detail":"{read_only:false; response_revision:1333; number_of_response:1; }","duration":"691.688925ms","start":"2026-05-29T02:10:58.126299Z","end":"2026-05-29T02:10:58.817988Z","steps":["trace[1892920961] 'process raft request' (duration: 691.517301ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T02:10:58.818015Z","caller":"traceutil/trace.go:171","msg":"trace[1961043625] transaction","detail":"{read_only:false; response_revision:1332; number_of_response:1; }","duration":"691.751127ms","start":"2026-05-29T02:10:58.126235Z","end":"2026-05-29T02:10:58.817986Z","steps":["trace[1961043625] 'process raft request' (duration: 365.787369ms)","trace[1961043625] 'compare' (duration: 325.462936ms)"],"step_count":2} {"level":"warn","ts":"2026-05-29T02:10:58.818094Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:10:58.126294Z","time spent":"691.755977ms","remote":"127.0.0.1:39676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-29T02:10:58.818109Z","caller":"traceutil/trace.go:171","msg":"trace[63294204] transaction","detail":"{read_only:false; response_revision:1334; number_of_response:1; }","duration":"691.717616ms","start":"2026-05-29T02:10:58.126376Z","end":"2026-05-29T02:10:58.818094Z","steps":["trace[63294204] 'process raft request' (duration: 691.528372ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:10:58.818148Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:10:58.126219Z","time spent":"691.856259ms","remote":"127.0.0.1:39676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-29T02:10:58.818194Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:10:58.126348Z","time spent":"691.795458ms","remote":"127.0.0.1:39676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-29T02:10:58.818342Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.545866ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-29T02:10:58.818376Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"514.322531ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-29T02:10:58.818422Z","caller":"traceutil/trace.go:171","msg":"trace[2010481032] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1334; }","duration":"286.670919ms","start":"2026-05-29T02:10:58.531733Z","end":"2026-05-29T02:10:58.818404Z","steps":["trace[2010481032] 'agreement among raft nodes before linearized reading' (duration: 286.518085ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T02:10:58.818459Z","caller":"traceutil/trace.go:171","msg":"trace[1339923729] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:1334; }","duration":"514.472975ms","start":"2026-05-29T02:10:58.303963Z","end":"2026-05-29T02:10:58.818436Z","steps":["trace[1339923729] 'agreement among raft nodes before linearized reading' (duration: 514.328681ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:10:58.818511Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:10:58.303926Z","time spent":"514.573337ms","remote":"127.0.0.1:58426","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true "} {"level":"info","ts":"2026-05-29T02:10:59.004682Z","caller":"traceutil/trace.go:171","msg":"trace[872791144] transaction","detail":"{read_only:false; response_revision:1335; number_of_response:1; }","duration":"110.322908ms","start":"2026-05-29T02:10:58.894331Z","end":"2026-05-29T02:10:59.004653Z","steps":["trace[872791144] 'process raft request' (duration: 27.956621ms)","trace[872791144] 'compare' (duration: 82.231554ms)"],"step_count":2} {"level":"info","ts":"2026-05-29T02:10:59.26092Z","caller":"traceutil/trace.go:171","msg":"trace[1282108473] transaction","detail":"{read_only:false; response_revision:1336; number_of_response:1; }","duration":"229.978807ms","start":"2026-05-29T02:10:59.030917Z","end":"2026-05-29T02:10:59.260896Z","steps":["trace[1282108473] 'process raft request' (duration: 229.836404ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T02:10:59.341625Z","caller":"traceutil/trace.go:171","msg":"trace[1799697623] transaction","detail":"{read_only:false; response_revision:1337; number_of_response:1; }","duration":"208.237203ms","start":"2026-05-29T02:10:59.133364Z","end":"2026-05-29T02:10:59.341602Z","steps":["trace[1799697623] 'process raft request' (duration: 208.13364ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:11:01.20919Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"386.601101ms","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-05-29T02:11:01.209269Z","caller":"traceutil/trace.go:171","msg":"trace[1489365553] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1340; }","duration":"386.716174ms","start":"2026-05-29T02:11:00.822534Z","end":"2026-05-29T02:11:01.20925Z","steps":["trace[1489365553] 'range keys from in-memory index tree' (duration: 386.436187ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:11:01.209312Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:11:00.822522Z","time spent":"386.781736ms","remote":"127.0.0.1:39676","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-29T02:11:01.209448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"386.524839ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-05-29T02:11:01.209526Z","caller":"traceutil/trace.go:171","msg":"trace[917616895] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1340; }","duration":"386.622391ms","start":"2026-05-29T02:11:00.822878Z","end":"2026-05-29T02:11:01.209501Z","steps":["trace[917616895] 'range keys from in-memory index tree' (duration: 386.382606ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:11:01.209619Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:11:00.82287Z","time spent":"386.705204ms","remote":"127.0.0.1:39676","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-29T02:11:01.209705Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"387.780399ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-05-29T02:11:01.209748Z","caller":"traceutil/trace.go:171","msg":"trace[970568988] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1340; }","duration":"387.859391ms","start":"2026-05-29T02:11:00.821876Z","end":"2026-05-29T02:11:01.209735Z","steps":["trace[970568988] 'range keys from in-memory index tree' (duration: 387.663737ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:11:01.209751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"677.50797ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-29T02:11:01.209943Z","caller":"traceutil/trace.go:171","msg":"trace[1160967813] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1340; }","duration":"677.630933ms","start":"2026-05-29T02:11:00.532172Z","end":"2026-05-29T02:11:01.209803Z","steps":["trace[1160967813] 'range keys from in-memory index tree' (duration: 677.400747ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:11:01.209992Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:11:00.532147Z","time spent":"677.833888ms","remote":"127.0.0.1:60996","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-29T02:11:01.209778Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:11:00.821857Z","time spent":"387.913843ms","remote":"127.0.0.1:39676","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-05-29T02:11:07.496142Z","caller":"traceutil/trace.go:171","msg":"trace[1697072899] transaction","detail":"{read_only:false; response_revision:1400; number_of_response:1; }","duration":"133.563849ms","start":"2026-05-29T02:11:07.362554Z","end":"2026-05-29T02:11:07.496118Z","steps":["trace[1697072899] 'process raft request' (duration: 133.438176ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T02:11:08.134357Z","caller":"traceutil/trace.go:171","msg":"trace[780428223] transaction","detail":"{read_only:false; response_revision:1403; number_of_response:1; }","duration":"161.243433ms","start":"2026-05-29T02:11:07.973089Z","end":"2026-05-29T02:11:08.134333Z","steps":["trace[780428223] 'process raft request' (duration: 161.100079ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:11:08.782146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.768179ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-29T02:11:08.782235Z","caller":"traceutil/trace.go:171","msg":"trace[411792714] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1403; }","duration":"250.910123ms","start":"2026-05-29T02:11:08.531305Z","end":"2026-05-29T02:11:08.782215Z","steps":["trace[411792714] 'range keys from in-memory index tree' (duration: 250.684278ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:11:08.782667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"483.895892ms","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-05-29T02:11:08.782738Z","caller":"traceutil/trace.go:171","msg":"trace[226835423] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1403; }","duration":"483.974354ms","start":"2026-05-29T02:11:08.298748Z","end":"2026-05-29T02:11:08.782722Z","steps":["trace[226835423] 'range keys from in-memory index tree' (duration: 483.740368ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:11:08.782778Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:11:08.298692Z","time spent":"484.076976ms","remote":"127.0.0.1:39676","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-05-29T02:11:53.777968Z","caller":"traceutil/trace.go:171","msg":"trace[2096953332] transaction","detail":"{read_only:false; response_revision:1611; number_of_response:1; }","duration":"129.287097ms","start":"2026-05-29T02:11:53.648658Z","end":"2026-05-29T02:11:53.777945Z","steps":["trace[2096953332] 'process raft request' (duration: 129.237565ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T02:11:53.778036Z","caller":"traceutil/trace.go:171","msg":"trace[478118545] transaction","detail":"{read_only:false; response_revision:1610; number_of_response:1; }","duration":"132.087042ms","start":"2026-05-29T02:11:53.645914Z","end":"2026-05-29T02:11:53.778001Z","steps":["trace[478118545] 'process raft request' (duration: 101.546422ms)","trace[478118545] 'compare' (duration: 30.290454ms)"],"step_count":2} {"level":"info","ts":"2026-05-29T02:11:53.778358Z","caller":"traceutil/trace.go:171","msg":"trace[18050391] transaction","detail":"{read_only:false; response_revision:1612; number_of_response:1; }","duration":"106.976861ms","start":"2026-05-29T02:11:53.67136Z","end":"2026-05-29T02:11:53.778337Z","steps":["trace[18050391] 'process raft request' (duration: 106.804147ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:11:54.419083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.010743ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-05-29T02:12:36.075715Z","caller":"traceutil/trace.go:171","msg":"trace[1147793865] linearizableReadLoop","detail":"{readStateIndex:1878; appliedIndex:1877; }","duration":"115.974143ms","start":"2026-05-29T02:12:35.959716Z","end":"2026-05-29T02:12:36.07569Z","steps":["trace[1147793865] 'read index received' (duration: 66.62783ms)","trace[1147793865] 'applied index is now lower than readState.Index' (duration: 49.345083ms)"],"step_count":2} {"level":"info","ts":"2026-05-29T02:12:36.075828Z","caller":"traceutil/trace.go:171","msg":"trace[603669332] transaction","detail":"{read_only:false; response_revision:1803; number_of_response:1; }","duration":"175.628538ms","start":"2026-05-29T02:12:35.900139Z","end":"2026-05-29T02:12:36.075767Z","steps":["trace[603669332] 'process raft request' (duration: 126.255834ms)","trace[603669332] 'compare' (duration: 49.161689ms)"],"step_count":2} {"level":"warn","ts":"2026-05-29T02:12:36.07597Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.319497ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-05-29T02:12:36.076013Z","caller":"traceutil/trace.go:171","msg":"trace[673014949] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1803; }","duration":"115.42023ms","start":"2026-05-29T02:12:35.960581Z","end":"2026-05-29T02:12:36.076001Z","steps":["trace[673014949] 'agreement among raft nodes before linearized reading' (duration: 115.258446ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:12:36.076065Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.168421ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-05-29T02:12:36.076117Z","caller":"traceutil/trace.go:171","msg":"trace[1271500922] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1803; }","duration":"114.241032ms","start":"2026-05-29T02:12:35.961863Z","end":"2026-05-29T02:12:36.076104Z","steps":["trace[1271500922] 'agreement among raft nodes before linearized reading' (duration: 114.100479ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:12:36.075916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.187618ms","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-05-29T02:12:36.076275Z","caller":"traceutil/trace.go:171","msg":"trace[1324130479] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1803; }","duration":"116.479045ms","start":"2026-05-29T02:12:35.959675Z","end":"2026-05-29T02:12:36.076154Z","steps":["trace[1324130479] 'agreement among raft nodes before linearized reading' (duration: 116.108786ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:12:36.345269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.576386ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-29T02:12:36.345376Z","caller":"traceutil/trace.go:171","msg":"trace[1616539400] transaction","detail":"{read_only:false; response_revision:1804; number_of_response:1; }","duration":"264.37729ms","start":"2026-05-29T02:12:36.080979Z","end":"2026-05-29T02:12:36.345357Z","steps":["trace[1616539400] 'process raft request' (duration: 122.63813ms)","trace[1616539400] 'compare' (duration: 141.487634ms)"],"step_count":2} {"level":"info","ts":"2026-05-29T02:12:36.585466Z","caller":"traceutil/trace.go:171","msg":"trace[2007637878] transaction","detail":"{read_only:false; response_revision:1806; number_of_response:1; }","duration":"503.911204ms","start":"2026-05-29T02:12:36.08152Z","end":"2026-05-29T02:12:36.585432Z","steps":["trace[2007637878] 'process raft request' (duration: 503.807112ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T02:12:36.585534Z","caller":"traceutil/trace.go:171","msg":"trace[66971161] transaction","detail":"{read_only:false; response_revision:1805; number_of_response:1; }","duration":"504.261273ms","start":"2026-05-29T02:12:36.081245Z","end":"2026-05-29T02:12:36.585506Z","steps":["trace[66971161] 'process raft request' (duration: 497.125215ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:12:36.585673Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:12:36.081234Z","time spent":"504.363185ms","remote":"127.0.0.1:39676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-29T02:12:36.58593Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:12:36.081497Z","time spent":"504.096369ms","remote":"127.0.0.1:39676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"}