{"level":"warn","ts":"2026-06-11T06:28:07.687351Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-11T06:28:07.687469Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.210: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.210:2380","--initial-cluster=instance=https://199.204.45.210:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.210:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.210:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-06-11T06:28:07.687544Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-11T06:28:07.687559Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.210:2380"]} {"level":"info","ts":"2026-06-11T06:28:07.687588Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-06-11T06:28:07.689082Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.210:2379"]} {"level":"info","ts":"2026-06-11T06:28:07.689159Z","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.210:2380"],"listen-peer-urls":["https://199.204.45.210:2380"],"advertise-client-urls":["https://199.204.45.210:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.210:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.210:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-06-11T06:28:07.743976Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"54.613394ms"} {"level":"info","ts":"2026-06-11T06:28:07.759147Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"1cac722af8b2b8a6","cluster-id":"ba0a336ca61ee41d"} {"level":"info","ts":"2026-06-11T06:28:07.759268Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 switched to configuration voters=()"} {"level":"info","ts":"2026-06-11T06:28:07.759297Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 became follower at term 0"} {"level":"info","ts":"2026-06-11T06:28:07.759344Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 1cac722af8b2b8a6 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-11T06:28:07.759568Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 became follower at term 1"} {"level":"info","ts":"2026-06-11T06:28:07.759637Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 switched to configuration voters=(2066151857942870182)"} {"level":"warn","ts":"2026-06-11T06:28:07.764469Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-11T06:28:07.765938Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-11T06:28:07.768569Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-06-11T06:28:07.77179Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"1cac722af8b2b8a6","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-11T06:28:07.774488Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-11T06:28:07.774712Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-11T06:28:07.774748Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-11T06:28:07.772066Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"1cac722af8b2b8a6","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-11T06:28:07.775732Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 switched to configuration voters=(2066151857942870182)"} {"level":"info","ts":"2026-06-11T06:28:07.776047Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"ba0a336ca61ee41d","local-member-id":"1cac722af8b2b8a6","added-peer-id":"1cac722af8b2b8a6","added-peer-peer-urls":["https://199.204.45.210:2380"]} {"level":"info","ts":"2026-06-11T06:28:07.77926Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-06-11T06:28:07.779399Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.210:2380"} {"level":"info","ts":"2026-06-11T06:28:07.779449Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.210:2380"} {"level":"info","ts":"2026-06-11T06:28:07.779568Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"1cac722af8b2b8a6","initial-advertise-peer-urls":["https://199.204.45.210:2380"],"listen-peer-urls":["https://199.204.45.210:2380"],"advertise-client-urls":["https://199.204.45.210:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.210:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-11T06:28:07.779595Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-11T06:28:07.960039Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 is starting a new election at term 1"} {"level":"info","ts":"2026-06-11T06:28:07.960114Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 became pre-candidate at term 1"} {"level":"info","ts":"2026-06-11T06:28:07.960149Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 received MsgPreVoteResp from 1cac722af8b2b8a6 at term 1"} {"level":"info","ts":"2026-06-11T06:28:07.960235Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 became candidate at term 2"} {"level":"info","ts":"2026-06-11T06:28:07.960249Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 received MsgVoteResp from 1cac722af8b2b8a6 at term 2"} {"level":"info","ts":"2026-06-11T06:28:07.960281Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 became leader at term 2"} {"level":"info","ts":"2026-06-11T06:28:07.960296Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 1cac722af8b2b8a6 elected leader 1cac722af8b2b8a6 at term 2"} {"level":"info","ts":"2026-06-11T06:28:07.961302Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-11T06:28:07.962008Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"1cac722af8b2b8a6","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.210:2379]}","request-path":"/0/members/1cac722af8b2b8a6/attributes","cluster-id":"ba0a336ca61ee41d","publish-timeout":"7s"} {"level":"info","ts":"2026-06-11T06:28:07.962043Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-11T06:28:07.962013Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-11T06:28:07.962266Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-11T06:28:07.962294Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-11T06:28:07.962689Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"ba0a336ca61ee41d","local-member-id":"1cac722af8b2b8a6","cluster-version":"3.5"} {"level":"info","ts":"2026-06-11T06:28:07.963158Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-11T06:28:07.963202Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-11T06:28:07.965349Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.210:2379"} {"level":"info","ts":"2026-06-11T06:28:07.965479Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-06-11T06:28:10.155257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.887304ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:14"} {"level":"info","ts":"2026-06-11T06:28:10.155418Z","caller":"traceutil/trace.go:171","msg":"trace[557241560] linearizableReadLoop","detail":"{readStateIndex:99; appliedIndex:98; }","duration":"284.532783ms","start":"2026-06-11T06:28:09.870868Z","end":"2026-06-11T06:28:10.1554Z","steps":["trace[557241560] 'read index received' (duration: 18.64µs)","trace[557241560] 'applied index is now lower than readState.Index' (duration: 284.512953ms)"],"step_count":2} {"level":"info","ts":"2026-06-11T06:28:10.155645Z","caller":"traceutil/trace.go:171","msg":"trace[32707166] transaction","detail":"{read_only:false; response_revision:94; number_of_response:1; }","duration":"615.004911ms","start":"2026-06-11T06:28:09.540491Z","end":"2026-06-11T06:28:10.155496Z","steps":["trace[32707166] 'process raft request' (duration: 319.906181ms)","trace[32707166] 'compare' (duration: 293.713009ms)"],"step_count":2} {"level":"warn","ts":"2026-06-11T06:28:10.155767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.887214ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/kube-system/\" range_end:\"/registry/limitranges/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-11T06:28:10.155841Z","caller":"traceutil/trace.go:171","msg":"trace[1961049851] range","detail":"{range_begin:/registry/limitranges/kube-system/; range_end:/registry/limitranges/kube-system0; response_count:0; response_revision:94; }","duration":"284.983457ms","start":"2026-06-11T06:28:09.870844Z","end":"2026-06-11T06:28:10.155827Z","steps":["trace[1961049851] 'agreement among raft nodes before linearized reading' (duration: 284.663847ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:28:10.155874Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:28:09.540481Z","time spent":"615.250579ms","remote":"127.0.0.1:36220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":636,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-11T06:28:10.659535Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13305496650913665017,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-11T06:28:11.160038Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13305496650913665017,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-11T06:28:11.316745Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.157917977s","expected-duration":"1s"} {"level":"info","ts":"2026-06-11T06:28:11.353322Z","caller":"traceutil/trace.go:171","msg":"trace[13272903] linearizableReadLoop","detail":"{readStateIndex:100; appliedIndex:99; }","duration":"1.194244563s","start":"2026-06-11T06:28:10.159055Z","end":"2026-06-11T06:28:11.353299Z","steps":["trace[13272903] 'read index received' (duration: 1.157882425s)","trace[13272903] 'applied index is now lower than readState.Index' (duration: 36.361098ms)"],"step_count":2} {"level":"info","ts":"2026-06-11T06:28:11.353608Z","caller":"traceutil/trace.go:171","msg":"trace[418821358] transaction","detail":"{read_only:false; response_revision:95; number_of_response:1; }","duration":"1.194826701s","start":"2026-06-11T06:28:10.158721Z","end":"2026-06-11T06:28:11.353548Z","steps":["trace[418821358] 'process raft request' (duration: 1.158331559s)","trace[418821358] 'compare' (duration: 36.131581ms)"],"step_count":2} {"level":"warn","ts":"2026-06-11T06:28:11.353699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.040315347s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-06-11T06:28:11.353683Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.144651749s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-11T06:28:11.353745Z","caller":"traceutil/trace.go:171","msg":"trace[897503366] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:95; }","duration":"1.04042758s","start":"2026-06-11T06:28:10.313305Z","end":"2026-06-11T06:28:11.353733Z","steps":["trace[897503366] 'agreement among raft nodes before linearized reading' (duration: 1.040262345s)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:28:11.353732Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.194606353s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/default/instance.18b7f2ef3062cb9f\" ","response":"range_response_count:1 size:654"} {"level":"warn","ts":"2026-06-11T06:28:11.35378Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:28:10.313269Z","time spent":"1.040503213s","remote":"127.0.0.1:36122","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-11T06:28:11.353785Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:28:10.158702Z","time spent":"1.195004576s","remote":"127.0.0.1:36324","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3453,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-11T06:28:11.353777Z","caller":"traceutil/trace.go:171","msg":"trace[1769052112] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:95; }","duration":"1.144803764s","start":"2026-06-11T06:28:10.208953Z","end":"2026-06-11T06:28:11.353756Z","steps":["trace[1769052112] 'agreement among raft nodes before linearized reading' (duration: 1.144546646s)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:28:11.353824Z","caller":"traceutil/trace.go:171","msg":"trace[1963179894] range","detail":"{range_begin:/registry/events/default/instance.18b7f2ef3062cb9f; range_end:; response_count:1; response_revision:95; }","duration":"1.194776529s","start":"2026-06-11T06:28:10.159029Z","end":"2026-06-11T06:28:11.353806Z","steps":["trace[1963179894] 'agreement among raft nodes before linearized reading' (duration: 1.194421968s)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:28:11.353829Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.144570677s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/system-node-critical\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-06-11T06:28:11.353918Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:28:10.159021Z","time spent":"1.194866271s","remote":"127.0.0.1:36220","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":677,"request content":"key:\"/registry/events/default/instance.18b7f2ef3062cb9f\" "} {"level":"warn","ts":"2026-06-11T06:28:11.35389Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:28:10.208942Z","time spent":"1.144924707s","remote":"127.0.0.1:36460","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":27,"request content":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" "} {"level":"info","ts":"2026-06-11T06:28:11.353934Z","caller":"traceutil/trace.go:171","msg":"trace[2103525564] range","detail":"{range_begin:/registry/priorityclasses/system-node-critical; range_end:; response_count:0; response_revision:95; }","duration":"1.14464667s","start":"2026-06-11T06:28:10.209229Z","end":"2026-06-11T06:28:11.353875Z","steps":["trace[2103525564] 'agreement among raft nodes before linearized reading' (duration: 1.144573057s)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:28:11.353972Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:28:10.209216Z","time spent":"1.144743312s","remote":"127.0.0.1:36482","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":0,"response size":27,"request content":"key:\"/registry/priorityclasses/system-node-critical\" "} {"level":"warn","ts":"2026-06-11T06:28:11.861458Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13305496650913665022,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-11T06:28:12.194533Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.61873ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-06-11T06:28:12.194753Z","caller":"traceutil/trace.go:171","msg":"trace[683093212] linearizableReadLoop","detail":"{readStateIndex:103; appliedIndex:100; }","duration":"834.108527ms","start":"2026-06-11T06:28:11.360628Z","end":"2026-06-11T06:28:12.194737Z","steps":["trace[683093212] 'read index received' (duration: 606.178498ms)","trace[683093212] 'applied index is now lower than readState.Index' (duration: 227.929089ms)"],"step_count":2} {"level":"info","ts":"2026-06-11T06:28:12.194865Z","caller":"traceutil/trace.go:171","msg":"trace[2043343107] transaction","detail":"{read_only:false; response_revision:96; number_of_response:1; }","duration":"834.942112ms","start":"2026-06-11T06:28:11.359878Z","end":"2026-06-11T06:28:12.19482Z","steps":["trace[2043343107] 'process raft request' (duration: 606.91594ms)","trace[2043343107] 'compare' (duration: 227.472846ms)"],"step_count":2} {"level":"info","ts":"2026-06-11T06:28:12.194915Z","caller":"traceutil/trace.go:171","msg":"trace[1520898533] transaction","detail":"{read_only:false; response_revision:98; number_of_response:1; }","duration":"831.015364ms","start":"2026-06-11T06:28:11.36385Z","end":"2026-06-11T06:28:12.194865Z","steps":["trace[1520898533] 'process raft request' (duration: 830.848059ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:28:12.195025Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:28:11.359862Z","time spent":"835.088806ms","remote":"127.0.0.1:36482","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":429,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-11T06:28:12.195075Z","caller":"traceutil/trace.go:171","msg":"trace[1783155990] transaction","detail":"{read_only:false; response_revision:97; number_of_response:1; }","duration":"834.659034ms","start":"2026-06-11T06:28:11.360363Z","end":"2026-06-11T06:28:12.195022Z","steps":["trace[1783155990] 'process raft request' (duration: 834.270762ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:28:12.19491Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"834.272582ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-11T06:28:12.195183Z","caller":"traceutil/trace.go:171","msg":"trace[1198449436] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:98; }","duration":"834.594791ms","start":"2026-06-11T06:28:11.360575Z","end":"2026-06-11T06:28:12.195169Z","steps":["trace[1198449436] 'agreement among raft nodes before linearized reading' (duration: 834.274392ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:28:12.195167Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:28:11.363835Z","time spent":"831.180509ms","remote":"127.0.0.1:36392","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-11T06:28:12.195222Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:28:11.360553Z","time spent":"834.658354ms","remote":"127.0.0.1:36476","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":0,"response size":27,"request content":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" "} {"level":"warn","ts":"2026-06-11T06:28:12.194961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"833.678514ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"} {"level":"info","ts":"2026-06-11T06:28:12.195289Z","caller":"traceutil/trace.go:171","msg":"trace[1656492294] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:98; }","duration":"834.021313ms","start":"2026-06-11T06:28:11.361249Z","end":"2026-06-11T06:28:12.19527Z","steps":["trace[1656492294] 'agreement among raft nodes before linearized reading' (duration: 833.688743ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:28:12.195336Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:28:11.361237Z","time spent":"834.083696ms","remote":"127.0.0.1:36392","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-11T06:28:12.195862Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:28:11.360349Z","time spent":"835.436817ms","remote":"127.0.0.1:36220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":642,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-11T06:28:12.508237Z","caller":"traceutil/trace.go:171","msg":"trace[2066406230] transaction","detail":"{read_only:false; response_revision:147; number_of_response:1; }","duration":"153.73568ms","start":"2026-06-11T06:28:12.354463Z","end":"2026-06-11T06:28:12.508199Z","steps":["trace[2066406230] 'process raft request' (duration: 153.442472ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:28:14.350246Z","caller":"traceutil/trace.go:171","msg":"trace[382103357] transaction","detail":"{read_only:false; response_revision:272; number_of_response:1; }","duration":"113.583939ms","start":"2026-06-11T06:28:14.236639Z","end":"2026-06-11T06:28:14.350223Z","steps":["trace[382103357] 'process raft request' (duration: 113.464385ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:28:19.211362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.853516ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-11T06:28:19.212227Z","caller":"traceutil/trace.go:171","msg":"trace[754199035] transaction","detail":"{read_only:false; response_revision:384; number_of_response:1; }","duration":"140.512734ms","start":"2026-06-11T06:28:19.071682Z","end":"2026-06-11T06:28:19.212195Z","steps":["trace[754199035] 'process raft request' (duration: 15.743221ms)","trace[754199035] 'compare' (duration: 123.757243ms)"],"step_count":2} {"level":"info","ts":"2026-06-11T06:28:19.212484Z","caller":"traceutil/trace.go:171","msg":"trace[347904738] transaction","detail":"{read_only:false; response_revision:386; number_of_response:1; }","duration":"133.775781ms","start":"2026-06-11T06:28:19.078634Z","end":"2026-06-11T06:28:19.212409Z","steps":["trace[347904738] 'process raft request' (duration: 133.72452ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:28:19.212548Z","caller":"traceutil/trace.go:171","msg":"trace[935387063] transaction","detail":"{read_only:false; response_revision:385; number_of_response:1; }","duration":"134.414782ms","start":"2026-06-11T06:28:19.078078Z","end":"2026-06-11T06:28:19.212493Z","steps":["trace[935387063] 'process raft request' (duration: 133.964449ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:28:24.895541Z","caller":"traceutil/trace.go:171","msg":"trace[1975690435] linearizableReadLoop","detail":"{readStateIndex:427; appliedIndex:426; }","duration":"112.495926ms","start":"2026-06-11T06:28:24.783015Z","end":"2026-06-11T06:28:24.895511Z","steps":["trace[1975690435] 'read index received' (duration: 112.365482ms)","trace[1975690435] 'applied index is now lower than readState.Index' (duration: 129.314µs)"],"step_count":2} {"level":"warn","ts":"2026-06-11T06:28:24.895847Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.713072ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-11T06:28:24.895933Z","caller":"traceutil/trace.go:171","msg":"trace[387167310] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:413; }","duration":"112.922199ms","start":"2026-06-11T06:28:24.782989Z","end":"2026-06-11T06:28:24.895911Z","steps":["trace[387167310] 'agreement among raft nodes before linearized reading' (duration: 112.63312ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:28:24.896534Z","caller":"traceutil/trace.go:171","msg":"trace[964754013] transaction","detail":"{read_only:false; response_revision:413; number_of_response:1; }","duration":"112.65516ms","start":"2026-06-11T06:28:24.782927Z","end":"2026-06-11T06:28:24.895582Z","steps":["trace[964754013] 'process raft request' (duration: 112.430883ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:28:25.366316Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.943617ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-11T06:28:25.366418Z","caller":"traceutil/trace.go:171","msg":"trace[98017993] transaction","detail":"{read_only:false; response_revision:415; number_of_response:1; }","duration":"465.89832ms","start":"2026-06-11T06:28:24.900502Z","end":"2026-06-11T06:28:25.3664Z","steps":["trace[98017993] 'process raft request' (duration: 335.786448ms)","trace[98017993] 'compare' (duration: 129.673689ms)"],"step_count":2} {"level":"warn","ts":"2026-06-11T06:28:25.36647Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:28:24.900487Z","time spent":"465.960642ms","remote":"127.0.0.1:36392","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-11T06:28:39.551813Z","caller":"traceutil/trace.go:171","msg":"trace[1900217114] transaction","detail":"{read_only:false; response_revision:478; number_of_response:1; }","duration":"125.34051ms","start":"2026-06-11T06:28:39.426453Z","end":"2026-06-11T06:28:39.551794Z","steps":["trace[1900217114] 'process raft request' (duration: 124.961709ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:28:40.112457Z","caller":"traceutil/trace.go:171","msg":"trace[355107220] transaction","detail":"{read_only:false; response_revision:479; number_of_response:1; }","duration":"115.455004ms","start":"2026-06-11T06:28:39.996987Z","end":"2026-06-11T06:28:40.112442Z","steps":["trace[355107220] 'process raft request' (duration: 115.357961ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:28:45.811073Z","caller":"traceutil/trace.go:171","msg":"trace[40816505] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"788.519022ms","start":"2026-06-11T06:28:45.022531Z","end":"2026-06-11T06:28:45.81105Z","steps":["trace[40816505] 'process raft request' (duration: 788.328367ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:28:45.81131Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:28:45.022513Z","time spent":"788.708277ms","remote":"127.0.0.1:36392","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-06-11T06:28:45.821968Z","caller":"traceutil/trace.go:171","msg":"trace[1141610971] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"667.597003ms","start":"2026-06-11T06:28:45.15435Z","end":"2026-06-11T06:28:45.821947Z","steps":["trace[1141610971] 'process raft request' (duration: 667.405938ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:28:45.822025Z","caller":"traceutil/trace.go:171","msg":"trace[9881006] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"667.637794ms","start":"2026-06-11T06:28:45.154357Z","end":"2026-06-11T06:28:45.821995Z","steps":["trace[9881006] 'process raft request' (duration: 667.430709ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:28:45.822076Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:28:45.154344Z","time spent":"667.680526ms","remote":"127.0.0.1:36192","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-06-11T06:28:45.82217Z","caller":"traceutil/trace.go:171","msg":"trace[603538155] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"655.594479ms","start":"2026-06-11T06:28:45.166555Z","end":"2026-06-11T06:28:45.822149Z","steps":["trace[603538155] 'process raft request' (duration: 655.389404ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:28:45.822249Z","caller":"traceutil/trace.go:171","msg":"trace[290950203] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"668.65458ms","start":"2026-06-11T06:28:45.153578Z","end":"2026-06-11T06:28:45.822232Z","steps":["trace[290950203] 'process raft request' (duration: 668.077086ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:28:45.822288Z","caller":"traceutil/trace.go:171","msg":"trace[1636981423] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"655.22709ms","start":"2026-06-11T06:28:45.167048Z","end":"2026-06-11T06:28:45.822275Z","steps":["trace[1636981423] 'process raft request' (duration: 654.937113ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:28:45.822326Z","caller":"traceutil/trace.go:171","msg":"trace[825852374] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"655.880396ms","start":"2026-06-11T06:28:45.16644Z","end":"2026-06-11T06:28:45.822321Z","steps":["trace[825852374] 'process raft request' (duration: 655.383744ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:28:45.822355Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:28:45.166423Z","time spent":"655.916956ms","remote":"127.0.0.1:36192","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-06-11T06:28:45.822293Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:28:45.153562Z","time spent":"668.713081ms","remote":"127.0.0.1:36192","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-11T06:28:45.822353Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:28:45.167024Z","time spent":"655.297302ms","remote":"127.0.0.1:36192","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-06-11T06:28:45.822241Z","caller":"traceutil/trace.go:171","msg":"trace[238949046] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"648.059033ms","start":"2026-06-11T06:28:45.174151Z","end":"2026-06-11T06:28:45.82221Z","steps":["trace[238949046] 'process raft request' (duration: 647.869958ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:28:45.82249Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:28:45.174141Z","time spent":"648.328309ms","remote":"127.0.0.1:36192","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-06-11T06:28:45.822503Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:28:45.166551Z","time spent":"655.695961ms","remote":"127.0.0.1:36192","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-11T06:28:45.822638Z","caller":"traceutil/trace.go:171","msg":"trace[754991282] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"512.326791ms","start":"2026-06-11T06:28:45.310302Z","end":"2026-06-11T06:28:45.822629Z","steps":["trace[754991282] 'process raft request' (duration: 512.057615ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:28:45.822677Z","caller":"traceutil/trace.go:171","msg":"trace[2140282208] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"153.641673ms","start":"2026-06-11T06:28:45.669027Z","end":"2026-06-11T06:28:45.822669Z","steps":["trace[2140282208] 'process raft request' (duration: 153.388747ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:28:45.822713Z","caller":"traceutil/trace.go:171","msg":"trace[1109993887] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"644.400124ms","start":"2026-06-11T06:28:45.178306Z","end":"2026-06-11T06:28:45.822706Z","steps":["trace[1109993887] 'process raft request' (duration: 643.83145ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:28:45.822744Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:28:45.178303Z","time spent":"644.427175ms","remote":"127.0.0.1:36192","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-06-11T06:28:45.822811Z","caller":"traceutil/trace.go:171","msg":"trace[1590387125] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"618.140028ms","start":"2026-06-11T06:28:45.204664Z","end":"2026-06-11T06:28:45.822804Z","steps":["trace[1590387125] 'process raft request' (duration: 617.599225ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:28:45.822645Z","caller":"traceutil/trace.go:171","msg":"trace[1198049458] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"644.369093ms","start":"2026-06-11T06:28:45.178255Z","end":"2026-06-11T06:28:45.822624Z","steps":["trace[1198049458] 'process raft request' (duration: 643.81837ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:28:45.822846Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:28:45.204637Z","time spent":"618.19382ms","remote":"127.0.0.1:36192","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-06-11T06:28:45.822877Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:28:45.178247Z","time spent":"644.594658ms","remote":"127.0.0.1:36192","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-11T06:28:45.822686Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:28:45.310268Z","time spent":"512.399632ms","remote":"127.0.0.1:36192","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-11T06:28:45.822889Z","caller":"traceutil/trace.go:171","msg":"trace[163216155] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"656.369127ms","start":"2026-06-11T06:28:45.166496Z","end":"2026-06-11T06:28:45.822865Z","steps":["trace[163216155] 'process raft request' (duration: 655.368233ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:28:45.822483Z","caller":"traceutil/trace.go:171","msg":"trace[640580787] linearizableReadLoop","detail":"{readStateIndex:556; appliedIndex:543; }","duration":"298.802326ms","start":"2026-06-11T06:28:45.523664Z","end":"2026-06-11T06:28:45.822466Z","steps":["trace[640580787] 'read index received' (duration: 287.259093ms)","trace[640580787] 'applied index is now lower than readState.Index' (duration: 11.542123ms)"],"step_count":2} {"level":"warn","ts":"2026-06-11T06:28:45.822588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.91424ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-11T06:28:45.822974Z","caller":"traceutil/trace.go:171","msg":"trace[455948320] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:538; }","duration":"299.342531ms","start":"2026-06-11T06:28:45.523615Z","end":"2026-06-11T06:28:45.822957Z","steps":["trace[455948320] 'agreement among raft nodes before linearized reading' (duration: 298.905751ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:28:45.822988Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:28:45.166493Z","time spent":"656.44788ms","remote":"127.0.0.1:36192","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-06-11T06:28:45.823015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.493231ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-11T06:28:45.82304Z","caller":"traceutil/trace.go:171","msg":"trace[1003339602] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:538; }","duration":"248.518742ms","start":"2026-06-11T06:28:45.574513Z","end":"2026-06-11T06:28:45.823032Z","steps":["trace[1003339602] 'agreement among raft nodes before linearized reading' (duration: 248.465181ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:28:45.822159Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:28:45.154339Z","time spent":"667.759497ms","remote":"127.0.0.1:36192","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-11T06:28:45.993297Z","caller":"traceutil/trace.go:171","msg":"trace[1655464833] transaction","detail":"{read_only:false; number_of_response:1; response_revision:543; }","duration":"151.655204ms","start":"2026-06-11T06:28:45.841616Z","end":"2026-06-11T06:28:45.993271Z","steps":["trace[1655464833] 'process raft request' (duration: 151.335716ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:28:45.993425Z","caller":"traceutil/trace.go:171","msg":"trace[540539268] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"151.814168ms","start":"2026-06-11T06:28:45.841601Z","end":"2026-06-11T06:28:45.993415Z","steps":["trace[540539268] 'process raft request' (duration: 151.291315ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:28:45.99329Z","caller":"traceutil/trace.go:171","msg":"trace[1243573655] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"151.563741ms","start":"2026-06-11T06:28:45.841701Z","end":"2026-06-11T06:28:45.993264Z","steps":["trace[1243573655] 'process raft request' (duration: 151.51556ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:28:45.993306Z","caller":"traceutil/trace.go:171","msg":"trace[1212533790] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"156.184836ms","start":"2026-06-11T06:28:45.837102Z","end":"2026-06-11T06:28:45.993287Z","steps":["trace[1212533790] 'process raft request' (duration: 101.737879ms)","trace[1212533790] 'compare' (duration: 53.875923ms)"],"step_count":2} {"level":"info","ts":"2026-06-11T06:28:45.993524Z","caller":"traceutil/trace.go:171","msg":"trace[1765580130] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"151.837988ms","start":"2026-06-11T06:28:45.841656Z","end":"2026-06-11T06:28:45.993494Z","steps":["trace[1765580130] 'process raft request' (duration: 151.363166ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:28:45.993578Z","caller":"traceutil/trace.go:171","msg":"trace[746723658] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"155.956669ms","start":"2026-06-11T06:28:45.837611Z","end":"2026-06-11T06:28:45.993568Z","steps":["trace[746723658] 'process raft request' (duration: 155.219361ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:28:45.993656Z","caller":"traceutil/trace.go:171","msg":"trace[1568180115] transaction","detail":"{read_only:false; response_revision:545; number_of_response:1; }","duration":"151.94266ms","start":"2026-06-11T06:28:45.841693Z","end":"2026-06-11T06:28:45.993636Z","steps":["trace[1568180115] 'process raft request' (duration: 151.440758ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:28:45.995306Z","caller":"traceutil/trace.go:171","msg":"trace[853124867] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"105.427639ms","start":"2026-06-11T06:28:45.889862Z","end":"2026-06-11T06:28:45.99529Z","steps":["trace[853124867] 'process raft request' (duration: 105.392859ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:28:45.99534Z","caller":"traceutil/trace.go:171","msg":"trace[2043077457] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"149.617194ms","start":"2026-06-11T06:28:45.845703Z","end":"2026-06-11T06:28:45.99532Z","steps":["trace[2043077457] 'process raft request' (duration: 149.43999ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:28:45.995452Z","caller":"traceutil/trace.go:171","msg":"trace[2134301310] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"149.796069ms","start":"2026-06-11T06:28:45.845644Z","end":"2026-06-11T06:28:45.99544Z","steps":["trace[2134301310] 'process raft request' (duration: 149.374489ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:28:45.995529Z","caller":"traceutil/trace.go:171","msg":"trace[1446092771] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"144.826386ms","start":"2026-06-11T06:28:45.850626Z","end":"2026-06-11T06:28:45.995452Z","steps":["trace[1446092771] 'process raft request' (duration: 144.58238ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:28:46.303645Z","caller":"traceutil/trace.go:171","msg":"trace[965718732] transaction","detail":"{read_only:false; response_revision:553; number_of_response:1; }","duration":"268.518764ms","start":"2026-06-11T06:28:46.035096Z","end":"2026-06-11T06:28:46.303615Z","steps":["trace[965718732] 'process raft request' (duration: 221.492029ms)","trace[965718732] 'compare' (duration: 44.111123ms)"],"step_count":2} {"level":"info","ts":"2026-06-11T06:28:46.303805Z","caller":"traceutil/trace.go:171","msg":"trace[84084243] transaction","detail":"{read_only:false; response_revision:554; number_of_response:1; }","duration":"268.551964ms","start":"2026-06-11T06:28:46.035223Z","end":"2026-06-11T06:28:46.303775Z","steps":["trace[84084243] 'process raft request' (duration: 268.291678ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:28:46.304062Z","caller":"traceutil/trace.go:171","msg":"trace[1005641375] transaction","detail":"{read_only:false; response_revision:555; number_of_response:1; }","duration":"268.543775ms","start":"2026-06-11T06:28:46.035501Z","end":"2026-06-11T06:28:46.304044Z","steps":["trace[1005641375] 'process raft request' (duration: 268.212227ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:28:46.304175Z","caller":"traceutil/trace.go:171","msg":"trace[552055897] transaction","detail":"{read_only:false; response_revision:556; number_of_response:1; }","duration":"258.761873ms","start":"2026-06-11T06:28:46.04538Z","end":"2026-06-11T06:28:46.304142Z","steps":["trace[552055897] 'process raft request' (duration: 258.419945ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:28:46.304347Z","caller":"traceutil/trace.go:171","msg":"trace[345497212] transaction","detail":"{read_only:false; response_revision:557; number_of_response:1; }","duration":"258.354994ms","start":"2026-06-11T06:28:46.04598Z","end":"2026-06-11T06:28:46.304335Z","steps":["trace[345497212] 'process raft request' (duration: 257.921293ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:28:46.304394Z","caller":"traceutil/trace.go:171","msg":"trace[602226926] transaction","detail":"{read_only:false; response_revision:558; number_of_response:1; }","duration":"236.564168ms","start":"2026-06-11T06:28:46.067821Z","end":"2026-06-11T06:28:46.304385Z","steps":["trace[602226926] 'process raft request' (duration: 236.168179ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:28:46.304325Z","caller":"traceutil/trace.go:171","msg":"trace[374788890] transaction","detail":"{read_only:false; response_revision:559; number_of_response:1; }","duration":"225.691381ms","start":"2026-06-11T06:28:46.078613Z","end":"2026-06-11T06:28:46.304304Z","steps":["trace[374788890] 'process raft request' (duration: 225.6352ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:28:46.994438Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13305496650913665965,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-11T06:28:47.408253Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"395.940762ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-11T06:28:47.408382Z","caller":"traceutil/trace.go:171","msg":"trace[1060738624] transaction","detail":"{read_only:false; response_revision:572; number_of_response:1; }","duration":"944.838361ms","start":"2026-06-11T06:28:46.463522Z","end":"2026-06-11T06:28:47.40836Z","steps":["trace[1060738624] 'process raft request' (duration: 548.663923ms)","trace[1060738624] 'compare' (duration: 395.787968ms)"],"step_count":2} {"level":"warn","ts":"2026-06-11T06:28:47.408451Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:28:46.463511Z","time spent":"944.907442ms","remote":"127.0.0.1:36192","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":23057,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-11T06:28:47.426957Z","caller":"traceutil/trace.go:171","msg":"trace[1517409252] linearizableReadLoop","detail":"{readStateIndex:593; appliedIndex:591; }","duration":"933.080072ms","start":"2026-06-11T06:28:46.493855Z","end":"2026-06-11T06:28:47.426935Z","steps":["trace[1517409252] 'read index received' (duration: 518.275847ms)","trace[1517409252] 'applied index is now lower than readState.Index' (duration: 414.803105ms)"],"step_count":2} {"level":"info","ts":"2026-06-11T06:28:47.427002Z","caller":"traceutil/trace.go:171","msg":"trace[1372173737] transaction","detail":"{read_only:false; response_revision:573; number_of_response:1; }","duration":"948.106322ms","start":"2026-06-11T06:28:46.47885Z","end":"2026-06-11T06:28:47.426956Z","steps":["trace[1372173737] 'process raft request' (duration: 947.985199ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:28:47.427172Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"933.303517ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-11T06:28:47.42722Z","caller":"traceutil/trace.go:171","msg":"trace[564164926] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:573; }","duration":"933.41329ms","start":"2026-06-11T06:28:46.493794Z","end":"2026-06-11T06:28:47.427207Z","steps":["trace[564164926] 'agreement among raft nodes before linearized reading' (duration: 933.232815ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:28:47.427255Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:28:46.493775Z","time spent":"933.472682ms","remote":"127.0.0.1:36392","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-11T06:28:47.427464Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:28:46.478817Z","time spent":"948.480521ms","remote":"127.0.0.1:36192","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":19834,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-11T06:28:53.684479Z","caller":"traceutil/trace.go:171","msg":"trace[1843922602] linearizableReadLoop","detail":"{readStateIndex:649; appliedIndex:648; }","duration":"224.623796ms","start":"2026-06-11T06:28:53.459828Z","end":"2026-06-11T06:28:53.684452Z","steps":["trace[1843922602] 'read index received' (duration: 223.713913ms)","trace[1843922602] 'applied index is now lower than readState.Index' (duration: 909.023µs)"],"step_count":2} {"level":"info","ts":"2026-06-11T06:28:53.684545Z","caller":"traceutil/trace.go:171","msg":"trace[665978333] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"460.110129ms","start":"2026-06-11T06:28:53.224388Z","end":"2026-06-11T06:28:53.684498Z","steps":["trace[665978333] 'process raft request' (duration: 459.523524ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:28:53.6847Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:28:53.224351Z","time spent":"460.266623ms","remote":"127.0.0.1:36230","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036153,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-11T06:28:53.68475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.913024ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-11T06:28:53.684801Z","caller":"traceutil/trace.go:171","msg":"trace[442631399] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:627; }","duration":"225.036686ms","start":"2026-06-11T06:28:53.459748Z","end":"2026-06-11T06:28:53.684785Z","steps":["trace[442631399] 'agreement among raft nodes before linearized reading' (duration: 224.867102ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:28:53.6848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.267601ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-11T06:28:53.684911Z","caller":"traceutil/trace.go:171","msg":"trace[1754600438] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:627; }","duration":"161.433635ms","start":"2026-06-11T06:28:53.523448Z","end":"2026-06-11T06:28:53.684881Z","steps":["trace[1754600438] 'agreement among raft nodes before linearized reading' (duration: 161.24618ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:28:54.306797Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"343.400057ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-11T06:28:54.306981Z","caller":"traceutil/trace.go:171","msg":"trace[491875761] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"430.660748ms","start":"2026-06-11T06:28:53.876302Z","end":"2026-06-11T06:28:54.306963Z","steps":["trace[491875761] 'process raft request' (duration: 86.989034ms)","trace[491875761] 'compare' (duration: 343.271834ms)"],"step_count":2} {"level":"warn","ts":"2026-06-11T06:28:54.307048Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:28:53.876285Z","time spent":"430.73506ms","remote":"127.0.0.1:36392","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-11T06:28:54.307133Z","caller":"traceutil/trace.go:171","msg":"trace[764090440] linearizableReadLoop","detail":"{readStateIndex:653; appliedIndex:651; }","duration":"324.346245ms","start":"2026-06-11T06:28:53.982778Z","end":"2026-06-11T06:28:54.307124Z","steps":["trace[764090440] 'read index received' (duration: 302.306058ms)","trace[764090440] 'applied index is now lower than readState.Index' (duration: 22.039137ms)"],"step_count":2} {"level":"warn","ts":"2026-06-11T06:28:54.307308Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.528189ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-xql9q\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-06-11T06:28:54.307341Z","caller":"traceutil/trace.go:171","msg":"trace[769729866] range","detail":"{range_begin:/registry/pods/kube-system/cilium-xql9q; range_end:; response_count:1; response_revision:631; }","duration":"324.599421ms","start":"2026-06-11T06:28:53.982733Z","end":"2026-06-11T06:28:54.307332Z","steps":["trace[769729866] 'agreement among raft nodes before linearized reading' (duration: 324.426856ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:28:54.307368Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:28:53.982713Z","time spent":"324.649311ms","remote":"127.0.0.1:36324","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-xql9q\" "} {"level":"info","ts":"2026-06-11T06:28:54.307476Z","caller":"traceutil/trace.go:171","msg":"trace[2097612858] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"428.31465ms","start":"2026-06-11T06:28:53.879141Z","end":"2026-06-11T06:28:54.307456Z","steps":["trace[2097612858] 'process raft request' (duration: 427.751066ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:28:54.30761Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:28:53.879128Z","time spent":"428.404582ms","remote":"127.0.0.1:36392","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-11T06:28:54.368679Z","caller":"traceutil/trace.go:171","msg":"trace[385754075] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"126.500554ms","start":"2026-06-11T06:28:54.242151Z","end":"2026-06-11T06:28:54.368652Z","steps":["trace[385754075] 'process raft request' (duration: 121.053849ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:28:54.968842Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13305496650913666171,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-11T06:28:55.469742Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13305496650913666171,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-11T06:28:55.970805Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13305496650913666171,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-11T06:28:56.217945Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.79887491s","expected-duration":"1s"} {"level":"info","ts":"2026-06-11T06:28:56.273107Z","caller":"traceutil/trace.go:171","msg":"trace[1324679211] linearizableReadLoop","detail":"{readStateIndex:656; appliedIndex:655; }","duration":"1.805124795s","start":"2026-06-11T06:28:54.467966Z","end":"2026-06-11T06:28:56.273091Z","steps":["trace[1324679211] 'read index received' (duration: 1.750264046s)","trace[1324679211] 'applied index is now lower than readState.Index' (duration: 54.859939ms)"],"step_count":2} {"level":"info","ts":"2026-06-11T06:28:56.273123Z","caller":"traceutil/trace.go:171","msg":"trace[4705577] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"1.854109288s","start":"2026-06-11T06:28:54.418976Z","end":"2026-06-11T06:28:56.273086Z","steps":["trace[4705577] 'process raft request' (duration: 1.799233028s)","trace[4705577] 'compare' (duration: 54.414959ms)"],"step_count":2} {"level":"warn","ts":"2026-06-11T06:28:56.273278Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.80529947s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-11T06:28:56.273309Z","caller":"traceutil/trace.go:171","msg":"trace[728021496] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:635; }","duration":"1.805374791s","start":"2026-06-11T06:28:54.467925Z","end":"2026-06-11T06:28:56.2733Z","steps":["trace[728021496] 'agreement among raft nodes before linearized reading' (duration: 1.805260939s)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:28:56.273332Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:28:54.467905Z","time spent":"1.805421342s","remote":"127.0.0.1:36392","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-11T06:28:56.273389Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.751914707s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-11T06:28:56.273336Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:28:54.418955Z","time spent":"1.854253771s","remote":"127.0.0.1:36448","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1044,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-11T06:28:56.273498Z","caller":"traceutil/trace.go:171","msg":"trace[208675398] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:635; }","duration":"1.752065331s","start":"2026-06-11T06:28:54.521405Z","end":"2026-06-11T06:28:56.273471Z","steps":["trace[208675398] 'agreement among raft nodes before linearized reading' (duration: 1.751912657s)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:28:56.273568Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"542.115139ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-06-11T06:28:56.273561Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:28:54.521384Z","time spent":"1.752164414s","remote":"127.0.0.1:36122","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-06-11T06:28:56.273592Z","caller":"traceutil/trace.go:171","msg":"trace[1270483292] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:635; }","duration":"542.17028ms","start":"2026-06-11T06:28:55.731415Z","end":"2026-06-11T06:28:56.273586Z","steps":["trace[1270483292] 'agreement among raft nodes before linearized reading' (duration: 542.106419ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:28:56.273611Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:28:55.7314Z","time spent":"542.207321ms","remote":"127.0.0.1:36392","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-11T06:28:56.273642Z","caller":"traceutil/trace.go:171","msg":"trace[1853477274] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"300.917305ms","start":"2026-06-11T06:28:55.972169Z","end":"2026-06-11T06:28:56.273086Z","steps":["trace[1853477274] 'process raft request' (duration: 300.864074ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:28:56.273924Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:28:55.972144Z","time spent":"301.692724ms","remote":"127.0.0.1:36392","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-06-11T06:28:57.015344Z","caller":"traceutil/trace.go:171","msg":"trace[1793602046] transaction","detail":"{read_only:false; response_revision:640; number_of_response:1; }","duration":"288.25926ms","start":"2026-06-11T06:28:56.727051Z","end":"2026-06-11T06:28:57.01531Z","steps":["trace[1793602046] 'process raft request' (duration: 286.518117ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:28:57.190381Z","caller":"traceutil/trace.go:171","msg":"trace[530557816] transaction","detail":"{read_only:false; response_revision:641; number_of_response:1; }","duration":"194.59831ms","start":"2026-06-11T06:28:56.995758Z","end":"2026-06-11T06:28:57.190356Z","steps":["trace[530557816] 'process raft request' (duration: 158.815943ms)","trace[530557816] 'compare' (duration: 35.679104ms)"],"step_count":2} {"level":"info","ts":"2026-06-11T06:28:57.209185Z","caller":"traceutil/trace.go:171","msg":"trace[1577993877] transaction","detail":"{read_only:false; response_revision:643; number_of_response:1; }","duration":"142.316706ms","start":"2026-06-11T06:28:57.066847Z","end":"2026-06-11T06:28:57.209164Z","steps":["trace[1577993877] 'process raft request' (duration: 142.272605ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:28:57.209217Z","caller":"traceutil/trace.go:171","msg":"trace[1569507722] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"176.913392ms","start":"2026-06-11T06:28:57.032283Z","end":"2026-06-11T06:28:57.209197Z","steps":["trace[1569507722] 'process raft request' (duration: 176.705677ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:28:58.49056Z","caller":"traceutil/trace.go:171","msg":"trace[491148787] transaction","detail":"{read_only:false; response_revision:655; number_of_response:1; }","duration":"339.11319ms","start":"2026-06-11T06:28:58.151427Z","end":"2026-06-11T06:28:58.49054Z","steps":["trace[491148787] 'process raft request' (duration: 338.651939ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:28:58.490836Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:28:58.151371Z","time spent":"339.284634ms","remote":"127.0.0.1:36230","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036285,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-11T06:28:58.498071Z","caller":"traceutil/trace.go:171","msg":"trace[1351564034] linearizableReadLoop","detail":"{readStateIndex:678; appliedIndex:676; }","duration":"167.368866ms","start":"2026-06-11T06:28:58.330683Z","end":"2026-06-11T06:28:58.498052Z","steps":["trace[1351564034] 'read index received' (duration: 159.332117ms)","trace[1351564034] 'applied index is now lower than readState.Index' (duration: 8.035719ms)"],"step_count":2} {"level":"warn","ts":"2026-06-11T06:28:58.498294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.049002ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-11T06:28:58.498318Z","caller":"traceutil/trace.go:171","msg":"trace[261684003] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:655; }","duration":"151.126714ms","start":"2026-06-11T06:28:58.347184Z","end":"2026-06-11T06:28:58.498311Z","steps":["trace[261684003] 'agreement among raft nodes before linearized reading' (duration: 150.989831ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:28:58.498386Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.979606ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-06-11T06:28:58.498383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.73836ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-11T06:28:58.498453Z","caller":"traceutil/trace.go:171","msg":"trace[1480787861] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:655; }","duration":"144.075998ms","start":"2026-06-11T06:28:58.35436Z","end":"2026-06-11T06:28:58.498436Z","steps":["trace[1480787861] 'agreement among raft nodes before linearized reading' (duration: 143.901424ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:28:58.498474Z","caller":"traceutil/trace.go:171","msg":"trace[1227363135] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:655; }","duration":"143.860823ms","start":"2026-06-11T06:28:58.354595Z","end":"2026-06-11T06:28:58.498456Z","steps":["trace[1227363135] 'agreement among raft nodes before linearized reading' (duration: 143.613937ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:28:58.499436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.74932ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-11T06:28:58.499497Z","caller":"traceutil/trace.go:171","msg":"trace[1295471966] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:655; }","duration":"168.845132ms","start":"2026-06-11T06:28:58.330642Z","end":"2026-06-11T06:28:58.499487Z","steps":["trace[1295471966] 'agreement among raft nodes before linearized reading' (duration: 167.465438ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:29:11.582187Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13305496650913666490,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-11T06:29:11.892791Z","caller":"traceutil/trace.go:171","msg":"trace[1333412673] linearizableReadLoop","detail":"{readStateIndex:831; appliedIndex:830; }","duration":"810.915917ms","start":"2026-06-11T06:29:11.081854Z","end":"2026-06-11T06:29:11.89277Z","steps":["trace[1333412673] 'read index received' (duration: 810.743353ms)","trace[1333412673] 'applied index is now lower than readState.Index' (duration: 171.464µs)"],"step_count":2} {"level":"info","ts":"2026-06-11T06:29:11.892929Z","caller":"traceutil/trace.go:171","msg":"trace[1779100047] transaction","detail":"{read_only:false; response_revision:803; number_of_response:1; }","duration":"818.559586ms","start":"2026-06-11T06:29:11.074336Z","end":"2026-06-11T06:29:11.892896Z","steps":["trace[1779100047] 'process raft request' (duration: 818.30966ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:29:11.893015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"811.144052ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-626gd\" ","response":"range_response_count:1 size:3965"} {"level":"warn","ts":"2026-06-11T06:29:11.893009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"473.010466ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-11T06:29:11.893051Z","caller":"traceutil/trace.go:171","msg":"trace[1118070831] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-626gd; range_end:; response_count:1; response_revision:803; }","duration":"811.237736ms","start":"2026-06-11T06:29:11.081802Z","end":"2026-06-11T06:29:11.89304Z","steps":["trace[1118070831] 'agreement among raft nodes before linearized reading' (duration: 811.089061ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:29:11.893067Z","caller":"traceutil/trace.go:171","msg":"trace[795554027] range","detail":"{range_begin:/registry/controllerrevisions/; range_end:/registry/controllerrevisions0; response_count:0; response_revision:803; }","duration":"473.12252ms","start":"2026-06-11T06:29:11.41993Z","end":"2026-06-11T06:29:11.893052Z","steps":["trace[795554027] 'agreement among raft nodes before linearized reading' (duration: 473.002616ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:29:11.893088Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:29:11.08178Z","time spent":"811.300137ms","remote":"127.0.0.1:36324","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3988,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-626gd\" "} {"level":"warn","ts":"2026-06-11T06:29:11.893096Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:29:11.419911Z","time spent":"473.179881ms","remote":"127.0.0.1:36608","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":2,"response size":30,"request content":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true "} {"level":"warn","ts":"2026-06-11T06:29:11.893112Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:29:11.074313Z","time spent":"818.715971ms","remote":"127.0.0.1:36392","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-11T06:29:11.893191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"419.797099ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-11T06:29:11.893298Z","caller":"traceutil/trace.go:171","msg":"trace[583502186] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:803; }","duration":"419.970923ms","start":"2026-06-11T06:29:11.473302Z","end":"2026-06-11T06:29:11.893273Z","steps":["trace[583502186] 'agreement among raft nodes before linearized reading' (duration: 419.746858ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:29:11.893358Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:29:11.473281Z","time spent":"420.063956ms","remote":"127.0.0.1:36192","response type":"/etcdserverpb.KV/Range","request count":0,"request size":120,"response count":31,"response size":30,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true "} {"level":"warn","ts":"2026-06-11T06:29:11.894131Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"370.445226ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-11T06:29:11.89419Z","caller":"traceutil/trace.go:171","msg":"trace[62851709] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:803; }","duration":"370.527658ms","start":"2026-06-11T06:29:11.523649Z","end":"2026-06-11T06:29:11.894177Z","steps":["trace[62851709] 'agreement among raft nodes before linearized reading' (duration: 370.135409ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:29:11.894224Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:29:11.523639Z","time spent":"370.577859ms","remote":"127.0.0.1:36122","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-06-11T06:29:12.233767Z","caller":"traceutil/trace.go:171","msg":"trace[1380654751] linearizableReadLoop","detail":"{readStateIndex:832; appliedIndex:831; }","duration":"211.727964ms","start":"2026-06-11T06:29:12.022016Z","end":"2026-06-11T06:29:12.233744Z","steps":["trace[1380654751] 'read index received' (duration: 211.295164ms)","trace[1380654751] 'applied index is now lower than readState.Index' (duration: 431.85µs)"],"step_count":2} {"level":"warn","ts":"2026-06-11T06:29:12.233887Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.843957ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-11T06:29:12.233856Z","caller":"traceutil/trace.go:171","msg":"trace[899717325] transaction","detail":"{read_only:false; response_revision:804; number_of_response:1; }","duration":"334.080945ms","start":"2026-06-11T06:29:11.899739Z","end":"2026-06-11T06:29:12.23382Z","steps":["trace[899717325] 'process raft request' (duration: 333.688306ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:29:12.233944Z","caller":"traceutil/trace.go:171","msg":"trace[1626234532] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:804; }","duration":"211.94741ms","start":"2026-06-11T06:29:12.021987Z","end":"2026-06-11T06:29:12.233934Z","steps":["trace[1626234532] 'agreement among raft nodes before linearized reading' (duration: 211.845488ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:29:12.234077Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:29:11.899724Z","time spent":"334.245219ms","remote":"127.0.0.1:36324","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4028,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-11T06:29:16.064213Z","caller":"traceutil/trace.go:171","msg":"trace[282902140] transaction","detail":"{read_only:false; response_revision:819; number_of_response:1; }","duration":"105.862131ms","start":"2026-06-11T06:29:15.958301Z","end":"2026-06-11T06:29:16.064163Z","steps":["trace[282902140] 'process raft request' (duration: 105.719298ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:29:16.241253Z","caller":"traceutil/trace.go:171","msg":"trace[1924971147] transaction","detail":"{read_only:false; response_revision:820; number_of_response:1; }","duration":"178.240816ms","start":"2026-06-11T06:29:16.062981Z","end":"2026-06-11T06:29:16.241222Z","steps":["trace[1924971147] 'process raft request' (duration: 152.665553ms)","trace[1924971147] 'compare' (duration: 25.428849ms)"],"step_count":2} {"level":"info","ts":"2026-06-11T06:29:16.314527Z","caller":"traceutil/trace.go:171","msg":"trace[2108731746] transaction","detail":"{read_only:false; response_revision:821; number_of_response:1; }","duration":"242.667571ms","start":"2026-06-11T06:29:16.071835Z","end":"2026-06-11T06:29:16.314502Z","steps":["trace[2108731746] 'process raft request' (duration: 242.512697ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:29:32.857662Z","caller":"traceutil/trace.go:171","msg":"trace[1462492658] transaction","detail":"{read_only:false; response_revision:965; number_of_response:1; }","duration":"105.887573ms","start":"2026-06-11T06:29:32.751756Z","end":"2026-06-11T06:29:32.857644Z","steps":["trace[1462492658] 'process raft request' (duration: 105.729929ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:29:32.857824Z","caller":"traceutil/trace.go:171","msg":"trace[89572236] linearizableReadLoop","detail":"{readStateIndex:998; appliedIndex:997; }","duration":"104.727944ms","start":"2026-06-11T06:29:32.752889Z","end":"2026-06-11T06:29:32.857617Z","steps":["trace[89572236] 'read index received' (duration: 104.634062ms)","trace[89572236] 'applied index is now lower than readState.Index' (duration: 91.802µs)"],"step_count":2} {"level":"warn","ts":"2026-06-11T06:29:32.858029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.103883ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-11T06:29:32.858112Z","caller":"traceutil/trace.go:171","msg":"trace[91374514] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:965; }","duration":"105.228266ms","start":"2026-06-11T06:29:32.752866Z","end":"2026-06-11T06:29:32.858095Z","steps":["trace[91374514] 'agreement among raft nodes before linearized reading' (duration: 104.951319ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:29:32.921495Z","caller":"traceutil/trace.go:171","msg":"trace[689955709] transaction","detail":"{read_only:false; response_revision:966; number_of_response:1; }","duration":"166.968087ms","start":"2026-06-11T06:29:32.754505Z","end":"2026-06-11T06:29:32.921473Z","steps":["trace[689955709] 'process raft request' (duration: 166.782512ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:29:32.921584Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.10415ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-11T06:29:32.92162Z","caller":"traceutil/trace.go:171","msg":"trace[1158452942] transaction","detail":"{read_only:false; response_revision:967; number_of_response:1; }","duration":"166.633337ms","start":"2026-06-11T06:29:32.754969Z","end":"2026-06-11T06:29:32.921603Z","steps":["trace[1158452942] 'process raft request' (duration: 166.429082ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:29:32.921657Z","caller":"traceutil/trace.go:171","msg":"trace[1238282959] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:967; }","duration":"165.229623ms","start":"2026-06-11T06:29:32.756408Z","end":"2026-06-11T06:29:32.921638Z","steps":["trace[1238282959] 'agreement among raft nodes before linearized reading' (duration: 165.029398ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:29:33.115654Z","caller":"traceutil/trace.go:171","msg":"trace[1394785610] transaction","detail":"{read_only:false; response_revision:968; number_of_response:1; }","duration":"253.481928ms","start":"2026-06-11T06:29:32.862158Z","end":"2026-06-11T06:29:33.11564Z","steps":["trace[1394785610] 'process raft request' (duration: 253.397176ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:29:33.120321Z","caller":"traceutil/trace.go:171","msg":"trace[1582525689] linearizableReadLoop","detail":"{readStateIndex:1002; appliedIndex:1001; }","duration":"101.621207ms","start":"2026-06-11T06:29:33.018681Z","end":"2026-06-11T06:29:33.120302Z","steps":["trace[1582525689] 'read index received' (duration: 96.956931ms)","trace[1582525689] 'applied index is now lower than readState.Index' (duration: 4.662956ms)"],"step_count":2} {"level":"info","ts":"2026-06-11T06:29:33.120476Z","caller":"traceutil/trace.go:171","msg":"trace[995556186] transaction","detail":"{read_only:false; response_revision:969; number_of_response:1; }","duration":"194.776254ms","start":"2026-06-11T06:29:32.925676Z","end":"2026-06-11T06:29:33.120452Z","steps":["trace[995556186] 'process raft request' (duration: 194.514248ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:29:33.120521Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.841813ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.210\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-06-11T06:29:33.120559Z","caller":"traceutil/trace.go:171","msg":"trace[739513318] range","detail":"{range_begin:/registry/masterleases/199.204.45.210; range_end:; response_count:1; response_revision:969; }","duration":"101.922964ms","start":"2026-06-11T06:29:33.018625Z","end":"2026-06-11T06:29:33.120548Z","steps":["trace[739513318] 'agreement among raft nodes before linearized reading' (duration: 101.75181ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:29:47.447369Z","caller":"traceutil/trace.go:171","msg":"trace[606344273] transaction","detail":"{read_only:false; response_revision:1015; number_of_response:1; }","duration":"518.809971ms","start":"2026-06-11T06:29:46.928534Z","end":"2026-06-11T06:29:47.447344Z","steps":["trace[606344273] 'process raft request' (duration: 518.672408ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:29:47.447386Z","caller":"traceutil/trace.go:171","msg":"trace[372923354] linearizableReadLoop","detail":"{readStateIndex:1051; appliedIndex:1051; }","duration":"473.503729ms","start":"2026-06-11T06:29:46.973841Z","end":"2026-06-11T06:29:47.447345Z","steps":["trace[372923354] 'read index received' (duration: 473.489899ms)","trace[372923354] 'applied index is now lower than readState.Index' (duration: 11.27µs)"],"step_count":2} {"level":"warn","ts":"2026-06-11T06:29:47.447527Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:29:46.928504Z","time spent":"518.949575ms","remote":"127.0.0.1:36392","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-11T06:29:47.447792Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"473.922619ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-11T06:29:47.447856Z","caller":"traceutil/trace.go:171","msg":"trace[977847435] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1015; }","duration":"474.036052ms","start":"2026-06-11T06:29:46.973805Z","end":"2026-06-11T06:29:47.447841Z","steps":["trace[977847435] 'agreement among raft nodes before linearized reading' (duration: 473.850158ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:29:47.447895Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:29:46.973789Z","time spent":"474.098643ms","remote":"127.0.0.1:36392","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-11T06:29:47.528554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"355.614008ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-06-11T06:29:47.528557Z","caller":"traceutil/trace.go:171","msg":"trace[1882158084] transaction","detail":"{read_only:false; response_revision:1016; number_of_response:1; }","duration":"215.726294ms","start":"2026-06-11T06:29:47.312792Z","end":"2026-06-11T06:29:47.528518Z","steps":["trace[1882158084] 'process raft request' (duration: 189.006302ms)","trace[1882158084] 'compare' (duration: 26.484196ms)"],"step_count":2} {"level":"warn","ts":"2026-06-11T06:29:47.5286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"361.349311ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-06-11T06:29:47.528614Z","caller":"traceutil/trace.go:171","msg":"trace[1308882678] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1016; }","duration":"355.691691ms","start":"2026-06-11T06:29:47.172908Z","end":"2026-06-11T06:29:47.5286Z","steps":["trace[1308882678] 'agreement among raft nodes before linearized reading' (duration: 355.532247ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:29:47.52866Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:29:47.1729Z","time spent":"355.751172ms","remote":"127.0.0.1:36392","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-11T06:29:47.528673Z","caller":"traceutil/trace.go:171","msg":"trace[1169908561] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1016; }","duration":"361.463824ms","start":"2026-06-11T06:29:47.16718Z","end":"2026-06-11T06:29:47.528643Z","steps":["trace[1169908561] 'agreement among raft nodes before linearized reading' (duration: 361.285719ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:29:47.528746Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:29:47.167159Z","time spent":"361.578976ms","remote":"127.0.0.1:36392","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-06-11T06:29:47.529069Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"555.199343ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-11T06:29:47.529125Z","caller":"traceutil/trace.go:171","msg":"trace[1492447403] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1016; }","duration":"555.277404ms","start":"2026-06-11T06:29:46.973821Z","end":"2026-06-11T06:29:47.529098Z","steps":["trace[1492447403] 'agreement among raft nodes before linearized reading' (duration: 555.10067ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:29:47.529162Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:29:46.973809Z","time spent":"555.345045ms","remote":"127.0.0.1:36392","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-11T06:29:48.263987Z","caller":"traceutil/trace.go:171","msg":"trace[1468200489] transaction","detail":"{read_only:false; response_revision:1021; number_of_response:1; }","duration":"411.456603ms","start":"2026-06-11T06:29:47.852504Z","end":"2026-06-11T06:29:48.26396Z","steps":["trace[1468200489] 'process raft request' (duration: 411.303119ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:29:48.264135Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:29:47.852482Z","time spent":"411.580165ms","remote":"127.0.0.1:36392","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-06-11T06:29:49.179751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"843.085584ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-11T06:29:49.179885Z","caller":"traceutil/trace.go:171","msg":"trace[219624506] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/; range_end:/registry/apiregistration.k8s.io/apiservices0; response_count:0; response_revision:1021; }","duration":"843.268178ms","start":"2026-06-11T06:29:48.336596Z","end":"2026-06-11T06:29:49.179864Z","steps":["trace[219624506] 'count revisions from in-memory index tree' (duration: 842.975761ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:29:49.179936Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:29:48.336581Z","time spent":"843.34215ms","remote":"127.0.0.1:36658","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":29,"response size":30,"request content":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true "} {"level":"warn","ts":"2026-06-11T06:29:49.75424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.137694612s","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-06-11T06:29:49.754337Z","caller":"traceutil/trace.go:171","msg":"trace[935349942] linearizableReadLoop","detail":"{readStateIndex:1058; appliedIndex:1057; }","duration":"1.08958129s","start":"2026-06-11T06:29:48.664739Z","end":"2026-06-11T06:29:49.754321Z","steps":["trace[935349942] 'read index received' (duration: 47.441µs)","trace[935349942] 'applied index is now lower than readState.Index' (duration: 1.089532749s)"],"step_count":2} {"level":"warn","ts":"2026-06-11T06:29:49.754476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.089730153s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-11T06:29:49.754503Z","caller":"traceutil/trace.go:171","msg":"trace[1087639023] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:1021; }","duration":"1.089806225s","start":"2026-06-11T06:29:48.664688Z","end":"2026-06-11T06:29:49.754494Z","steps":["trace[1087639023] 'agreement among raft nodes before linearized reading' (duration: 1.089730133s)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:29:49.754538Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:29:48.664667Z","time spent":"1.089861597s","remote":"127.0.0.1:36562","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":8,"response size":30,"request content":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true "} {"level":"warn","ts":"2026-06-11T06:29:49.754681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.040203456s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-11T06:29:49.754727Z","caller":"traceutil/trace.go:171","msg":"trace[1212848173] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; response_count:0; response_revision:1021; }","duration":"1.040287889s","start":"2026-06-11T06:29:48.714427Z","end":"2026-06-11T06:29:49.754715Z","steps":["trace[1212848173] 'agreement among raft nodes before linearized reading' (duration: 1.040201616s)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:29:49.754749Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:29:48.714411Z","time spent":"1.040333399s","remote":"127.0.0.1:36482","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":2,"response size":30,"request content":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true "} {"level":"warn","ts":"2026-06-11T06:29:49.754842Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.591227ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-06-11T06:29:49.754867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.878214ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-11T06:29:49.75488Z","caller":"traceutil/trace.go:171","msg":"trace[1896138239] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1021; }","duration":"231.919395ms","start":"2026-06-11T06:29:49.522957Z","end":"2026-06-11T06:29:49.754876Z","steps":["trace[1896138239] 'agreement among raft nodes before linearized reading' (duration: 231.893034ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:29:49.754881Z","caller":"traceutil/trace.go:171","msg":"trace[462260702] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1021; }","duration":"206.657119ms","start":"2026-06-11T06:29:49.548212Z","end":"2026-06-11T06:29:49.754869Z","steps":["trace[462260702] 'agreement among raft nodes before linearized reading' (duration: 206.513746ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:29:49.754976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.58464ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-11T06:29:49.754989Z","caller":"traceutil/trace.go:171","msg":"trace[637361682] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1021; }","duration":"303.59712ms","start":"2026-06-11T06:29:49.451387Z","end":"2026-06-11T06:29:49.754985Z","steps":["trace[637361682] 'agreement among raft nodes before linearized reading' (duration: 303.554709ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:29:49.755001Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:29:49.451328Z","time spent":"303.669961ms","remote":"127.0.0.1:36392","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-11T06:29:49.755066Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.971172ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-06-11T06:29:49.755092Z","caller":"traceutil/trace.go:171","msg":"trace[2115927555] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1021; }","duration":"164.022554ms","start":"2026-06-11T06:29:49.591062Z","end":"2026-06-11T06:29:49.755084Z","steps":["trace[2115927555] 'agreement among raft nodes before linearized reading' (duration: 163.943342ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:29:49.755253Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.25881ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-11T06:29:49.755278Z","caller":"traceutil/trace.go:171","msg":"trace[490964778] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1021; }","duration":"164.29593ms","start":"2026-06-11T06:29:49.590975Z","end":"2026-06-11T06:29:49.75527Z","steps":["trace[490964778] 'agreement among raft nodes before linearized reading' (duration: 164.225948ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:29:49.755267Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"963.915847ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-11T06:29:49.75536Z","caller":"traceutil/trace.go:171","msg":"trace[1159276859] range","detail":"{range_begin:/registry/storageclasses/; range_end:/registry/storageclasses0; response_count:0; response_revision:1021; }","duration":"964.070461ms","start":"2026-06-11T06:29:48.791267Z","end":"2026-06-11T06:29:49.755338Z","steps":["trace[1159276859] 'agreement among raft nodes before linearized reading' (duration: 963.894526ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:29:49.755398Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.027848ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-06-11T06:29:49.755425Z","caller":"traceutil/trace.go:171","msg":"trace[1153826544] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1021; }","duration":"165.08009ms","start":"2026-06-11T06:29:49.590338Z","end":"2026-06-11T06:29:49.755418Z","steps":["trace[1153826544] 'agreement among raft nodes before linearized reading' (duration: 165.013278ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:29:49.755433Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:29:48.791249Z","time spent":"964.167823ms","remote":"127.0.0.1:36498","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":28,"request content":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true "} {"level":"warn","ts":"2026-06-11T06:29:53.138783Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13305496650913666996,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-11T06:29:53.437021Z","caller":"traceutil/trace.go:171","msg":"trace[68924221] linearizableReadLoop","detail":"{readStateIndex:1071; appliedIndex:1070; }","duration":"798.318405ms","start":"2026-06-11T06:29:52.638684Z","end":"2026-06-11T06:29:53.437003Z","steps":["trace[68924221] 'read index received' (duration: 798.157341ms)","trace[68924221] 'applied index is now lower than readState.Index' (duration: 160.404µs)"],"step_count":2} {"level":"warn","ts":"2026-06-11T06:29:53.437177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"798.474439ms","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-06-11T06:29:53.437182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"619.933986ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-11T06:29:53.437214Z","caller":"traceutil/trace.go:171","msg":"trace[862594170] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:1034; }","duration":"798.574152ms","start":"2026-06-11T06:29:52.638627Z","end":"2026-06-11T06:29:53.437201Z","steps":["trace[862594170] 'agreement among raft nodes before linearized reading' (duration: 798.48832ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:29:53.437219Z","caller":"traceutil/trace.go:171","msg":"trace[929394070] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:1034; }","duration":"620.022098ms","start":"2026-06-11T06:29:52.817187Z","end":"2026-06-11T06:29:53.437209Z","steps":["trace[929394070] 'agreement among raft nodes before linearized reading' (duration: 619.948386ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:29:53.437169Z","caller":"traceutil/trace.go:171","msg":"trace[1445290348] transaction","detail":"{read_only:false; response_revision:1034; number_of_response:1; }","duration":"847.297657ms","start":"2026-06-11T06:29:52.589812Z","end":"2026-06-11T06:29:53.437109Z","steps":["trace[1445290348] 'process raft request' (duration: 847.078692ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:29:53.437252Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:29:52.817168Z","time spent":"620.07438ms","remote":"127.0.0.1:41114","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":1,"response size":30,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"warn","ts":"2026-06-11T06:29:53.437252Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:29:52.638596Z","time spent":"798.646253ms","remote":"127.0.0.1:36568","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":8,"response size":30,"request content":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true "} {"level":"warn","ts":"2026-06-11T06:29:53.437465Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"417.388258ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.210\" ","response":"range_response_count:1 size:135"} {"level":"warn","ts":"2026-06-11T06:29:53.437495Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:29:52.589787Z","time spent":"847.500053ms","remote":"127.0.0.1:36392","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-06-11T06:29:53.437548Z","caller":"traceutil/trace.go:171","msg":"trace[753176739] range","detail":"{range_begin:/registry/masterleases/199.204.45.210; range_end:; response_count:1; response_revision:1034; }","duration":"417.513903ms","start":"2026-06-11T06:29:53.020017Z","end":"2026-06-11T06:29:53.437531Z","steps":["trace[753176739] 'agreement among raft nodes before linearized reading' (duration: 417.314347ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:29:53.437592Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:29:53.019996Z","time spent":"417.586795ms","remote":"127.0.0.1:36172","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.210\" "} {"level":"warn","ts":"2026-06-11T06:29:54.036487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.495943ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-06-11T06:29:54.036563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.156206ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-06-11T06:29:54.036496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.681755ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-11T06:29:54.036594Z","caller":"traceutil/trace.go:171","msg":"trace[311843361] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1035; }","duration":"245.936691ms","start":"2026-06-11T06:29:53.790651Z","end":"2026-06-11T06:29:54.036588Z","steps":["trace[311843361] 'range keys from in-memory index tree' (duration: 245.550472ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:29:54.036597Z","caller":"traceutil/trace.go:171","msg":"trace[109853360] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1035; }","duration":"252.224438ms","start":"2026-06-11T06:29:53.78436Z","end":"2026-06-11T06:29:54.036585Z","steps":["trace[109853360] 'range keys from in-memory index tree' (duration: 252.043954ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:29:54.036668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.734506ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-11T06:29:54.036746Z","caller":"traceutil/trace.go:171","msg":"trace[1200314608] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1035; }","duration":"245.830888ms","start":"2026-06-11T06:29:53.790901Z","end":"2026-06-11T06:29:54.036732Z","steps":["trace[1200314608] 'range keys from in-memory index tree' (duration: 245.624604ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:29:54.036886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.588618ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-11T06:29:54.036914Z","caller":"traceutil/trace.go:171","msg":"trace[1976731977] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1035; }","duration":"246.6391ms","start":"2026-06-11T06:29:53.790269Z","end":"2026-06-11T06:29:54.036908Z","steps":["trace[1976731977] 'range keys from in-memory index tree' (duration: 246.507226ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:29:54.036897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.801374ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-11T06:29:54.036943Z","caller":"traceutil/trace.go:171","msg":"trace[1847624159] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:1035; }","duration":"328.893816ms","start":"2026-06-11T06:29:53.708039Z","end":"2026-06-11T06:29:54.036933Z","steps":["trace[1847624159] 'count revisions from in-memory index tree' (duration: 328.721303ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:29:54.036562Z","caller":"traceutil/trace.go:171","msg":"trace[627952821] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1035; }","duration":"260.608906ms","start":"2026-06-11T06:29:53.775936Z","end":"2026-06-11T06:29:54.036545Z","steps":["trace[627952821] 'range keys from in-memory index tree' (duration: 260.359369ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:29:54.036975Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:29:53.708004Z","time spent":"328.959849ms","remote":"127.0.0.1:36290","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":0,"response size":28,"request content":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true "} {"level":"info","ts":"2026-06-11T06:30:12.417973Z","caller":"traceutil/trace.go:171","msg":"trace[693464921] linearizableReadLoop","detail":"{readStateIndex:1135; appliedIndex:1134; }","duration":"189.752224ms","start":"2026-06-11T06:30:12.228196Z","end":"2026-06-11T06:30:12.417948Z","steps":["trace[693464921] 'read index received' (duration: 189.508188ms)","trace[693464921] 'applied index is now lower than readState.Index' (duration: 242.286µs)"],"step_count":2} {"level":"info","ts":"2026-06-11T06:30:12.418003Z","caller":"traceutil/trace.go:171","msg":"trace[1787428170] transaction","detail":"{read_only:false; response_revision:1094; number_of_response:1; }","duration":"192.773739ms","start":"2026-06-11T06:30:12.225207Z","end":"2026-06-11T06:30:12.417981Z","steps":["trace[1787428170] 'process raft request' (duration: 192.549603ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:30:12.418226Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.875936ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-06-11T06:30:12.41828Z","caller":"traceutil/trace.go:171","msg":"trace[514237460] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1094; }","duration":"189.960239ms","start":"2026-06-11T06:30:12.228307Z","end":"2026-06-11T06:30:12.418268Z","steps":["trace[514237460] 'agreement among raft nodes before linearized reading' (duration: 189.816755ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:30:12.418286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.99642ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-06-11T06:30:12.418349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.522538ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-06-11T06:30:12.418408Z","caller":"traceutil/trace.go:171","msg":"trace[1606066887] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1094; }","duration":"189.58332ms","start":"2026-06-11T06:30:12.22881Z","end":"2026-06-11T06:30:12.418393Z","steps":["trace[1606066887] 'agreement among raft nodes before linearized reading' (duration: 189.422106ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:30:12.418403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.964559ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-11T06:30:12.41848Z","caller":"traceutil/trace.go:171","msg":"trace[1430772517] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1094; }","duration":"188.086451ms","start":"2026-06-11T06:30:12.230376Z","end":"2026-06-11T06:30:12.418462Z","steps":["trace[1430772517] 'agreement among raft nodes before linearized reading' (duration: 187.784954ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:30:12.418498Z","caller":"traceutil/trace.go:171","msg":"trace[87395823] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1094; }","duration":"190.318848ms","start":"2026-06-11T06:30:12.228154Z","end":"2026-06-11T06:30:12.418473Z","steps":["trace[87395823] 'agreement among raft nodes before linearized reading' (duration: 189.894657ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:30:13.605554Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:30:13.027665Z","time spent":"577.880383ms","remote":"127.0.0.1:36172","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-06-11T06:30:13.838246Z","caller":"traceutil/trace.go:171","msg":"trace[414457078] linearizableReadLoop","detail":"{readStateIndex:1142; appliedIndex:1141; }","duration":"136.17096ms","start":"2026-06-11T06:30:13.70205Z","end":"2026-06-11T06:30:13.838221Z","steps":["trace[414457078] 'read index received' (duration: 135.990765ms)","trace[414457078] 'applied index is now lower than readState.Index' (duration: 178.814µs)"],"step_count":2} {"level":"info","ts":"2026-06-11T06:30:13.838278Z","caller":"traceutil/trace.go:171","msg":"trace[718605900] transaction","detail":"{read_only:false; response_revision:1100; number_of_response:1; }","duration":"231.070002ms","start":"2026-06-11T06:30:13.607172Z","end":"2026-06-11T06:30:13.838242Z","steps":["trace[718605900] 'process raft request' (duration: 230.856157ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:30:13.838405Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.334643ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-11T06:30:13.838449Z","caller":"traceutil/trace.go:171","msg":"trace[1199572684] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:1100; }","duration":"136.402055ms","start":"2026-06-11T06:30:13.702034Z","end":"2026-06-11T06:30:13.838436Z","steps":["trace[1199572684] 'agreement among raft nodes before linearized reading' (duration: 136.291922ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:30:34.983063Z","caller":"traceutil/trace.go:171","msg":"trace[780735570] linearizableReadLoop","detail":"{readStateIndex:1267; appliedIndex:1266; }","duration":"459.64092ms","start":"2026-06-11T06:30:34.523386Z","end":"2026-06-11T06:30:34.983027Z","steps":["trace[780735570] 'read index received' (duration: 459.365643ms)","trace[780735570] 'applied index is now lower than readState.Index' (duration: 274.337µs)"],"step_count":2} {"level":"info","ts":"2026-06-11T06:30:34.983561Z","caller":"traceutil/trace.go:171","msg":"trace[1988140969] transaction","detail":"{read_only:false; response_revision:1219; number_of_response:1; }","duration":"646.309427ms","start":"2026-06-11T06:30:34.337215Z","end":"2026-06-11T06:30:34.983524Z","steps":["trace[1988140969] 'process raft request' (duration: 645.637361ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:30:34.983944Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:30:34.337195Z","time spent":"646.44543ms","remote":"127.0.0.1:36392","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-06-11T06:30:34.984768Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"461.351793ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-11T06:30:34.985402Z","caller":"traceutil/trace.go:171","msg":"trace[1069818757] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1219; }","duration":"462.04888ms","start":"2026-06-11T06:30:34.523334Z","end":"2026-06-11T06:30:34.985383Z","steps":["trace[1069818757] 'agreement among raft nodes before linearized reading' (duration: 461.347912ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:30:34.985448Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:30:34.523315Z","time spent":"462.123632ms","remote":"127.0.0.1:36122","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-06-11T06:30:34.999707Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.400773ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-11T06:30:34.999773Z","caller":"traceutil/trace.go:171","msg":"trace[281655645] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1220; }","duration":"246.520616ms","start":"2026-06-11T06:30:34.753237Z","end":"2026-06-11T06:30:34.999757Z","steps":["trace[281655645] 'agreement among raft nodes before linearized reading' (duration: 246.318121ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:30:34.999826Z","caller":"traceutil/trace.go:171","msg":"trace[1679891278] transaction","detail":"{read_only:false; response_revision:1220; number_of_response:1; }","duration":"307.430052ms","start":"2026-06-11T06:30:34.692367Z","end":"2026-06-11T06:30:34.999797Z","steps":["trace[1679891278] 'process raft request' (duration: 306.92248ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:30:34.999978Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:30:34.692352Z","time spent":"307.529264ms","remote":"127.0.0.1:36392","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-06-11T06:30:35.000007Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.745295ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-11T06:30:35.000033Z","caller":"traceutil/trace.go:171","msg":"trace[1434400776] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1220; }","duration":"300.792176ms","start":"2026-06-11T06:30:34.699233Z","end":"2026-06-11T06:30:35.000025Z","steps":["trace[1434400776] 'agreement among raft nodes before linearized reading' (duration: 300.727514ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:30:35.000051Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:30:34.699224Z","time spent":"300.822156ms","remote":"127.0.0.1:36392","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-11T06:30:35.000139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.192931ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-11T06:30:35.000153Z","caller":"traceutil/trace.go:171","msg":"trace[1140953733] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1220; }","duration":"308.243192ms","start":"2026-06-11T06:30:34.691905Z","end":"2026-06-11T06:30:35.000148Z","steps":["trace[1140953733] 'agreement among raft nodes before linearized reading' (duration: 308.195051ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:30:35.000168Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:30:34.691885Z","time spent":"308.279413ms","remote":"127.0.0.1:36392","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-11T06:30:35.000315Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.891385ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-11T06:30:35.000377Z","caller":"traceutil/trace.go:171","msg":"trace[261701857] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1220; }","duration":"240.993798ms","start":"2026-06-11T06:30:34.759369Z","end":"2026-06-11T06:30:35.000362Z","steps":["trace[261701857] 'agreement among raft nodes before linearized reading' (duration: 240.141347ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:30:35.000465Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.0672ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-11T06:30:35.00049Z","caller":"traceutil/trace.go:171","msg":"trace[921474302] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1220; }","duration":"241.129001ms","start":"2026-06-11T06:30:34.759352Z","end":"2026-06-11T06:30:35.000481Z","steps":["trace[921474302] 'agreement among raft nodes before linearized reading' (duration: 241.07132ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:30:47.206366Z","caller":"traceutil/trace.go:171","msg":"trace[39774909] linearizableReadLoop","detail":"{readStateIndex:1309; appliedIndex:1308; }","duration":"158.184067ms","start":"2026-06-11T06:30:47.048087Z","end":"2026-06-11T06:30:47.206271Z","steps":["trace[39774909] 'read index received' (duration: 158.004162ms)","trace[39774909] 'applied index is now lower than readState.Index' (duration: 178.275µs)"],"step_count":2} {"level":"info","ts":"2026-06-11T06:30:47.206415Z","caller":"traceutil/trace.go:171","msg":"trace[920245703] transaction","detail":"{read_only:false; response_revision:1259; number_of_response:1; }","duration":"168.7443ms","start":"2026-06-11T06:30:47.03764Z","end":"2026-06-11T06:30:47.206384Z","steps":["trace[920245703] 'process raft request' (duration: 168.435612ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:30:47.206707Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.807549ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-11T06:30:47.206738Z","caller":"traceutil/trace.go:171","msg":"trace[1627667610] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1259; }","duration":"143.85355ms","start":"2026-06-11T06:30:47.062876Z","end":"2026-06-11T06:30:47.20673Z","steps":["trace[1627667610] 'agreement among raft nodes before linearized reading' (duration: 143.721727ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:30:47.206781Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.52466ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-06-11T06:30:47.206794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.530118ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-06-11T06:30:47.206844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.888705ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-06-11T06:30:47.206838Z","caller":"traceutil/trace.go:171","msg":"trace[419772522] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1259; }","duration":"157.615422ms","start":"2026-06-11T06:30:47.049208Z","end":"2026-06-11T06:30:47.206823Z","steps":["trace[419772522] 'agreement among raft nodes before linearized reading' (duration: 157.406147ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:30:47.206866Z","caller":"traceutil/trace.go:171","msg":"trace[719969587] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1259; }","duration":"150.950606ms","start":"2026-06-11T06:30:47.055909Z","end":"2026-06-11T06:30:47.206859Z","steps":["trace[719969587] 'agreement among raft nodes before linearized reading' (duration: 150.895265ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:30:47.206879Z","caller":"traceutil/trace.go:171","msg":"trace[1478887585] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1259; }","duration":"140.64426ms","start":"2026-06-11T06:30:47.066214Z","end":"2026-06-11T06:30:47.206858Z","steps":["trace[1478887585] 'agreement among raft nodes before linearized reading' (duration: 140.373834ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:30:47.20742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.306635ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-06-11T06:30:47.207514Z","caller":"traceutil/trace.go:171","msg":"trace[766416077] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1259; }","duration":"159.432408ms","start":"2026-06-11T06:30:47.048061Z","end":"2026-06-11T06:30:47.207493Z","steps":["trace[766416077] 'agreement among raft nodes before linearized reading' (duration: 159.199032ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:30:47.316585Z","caller":"traceutil/trace.go:171","msg":"trace[2098051725] transaction","detail":"{read_only:false; response_revision:1260; number_of_response:1; }","duration":"105.24729ms","start":"2026-06-11T06:30:47.211311Z","end":"2026-06-11T06:30:47.316558Z","steps":["trace[2098051725] 'process raft request' (duration: 94.561603ms)","trace[2098051725] 'compare' (duration: 10.561214ms)"],"step_count":2} {"level":"info","ts":"2026-06-11T06:30:47.33609Z","caller":"traceutil/trace.go:171","msg":"trace[944341256] transaction","detail":"{read_only:false; response_revision:1261; number_of_response:1; }","duration":"124.486209ms","start":"2026-06-11T06:30:47.211582Z","end":"2026-06-11T06:30:47.336068Z","steps":["trace[944341256] 'process raft request' (duration: 124.335215ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:30:47.336378Z","caller":"traceutil/trace.go:171","msg":"trace[1183534987] transaction","detail":"{read_only:false; response_revision:1262; number_of_response:1; }","duration":"124.715694ms","start":"2026-06-11T06:30:47.211634Z","end":"2026-06-11T06:30:47.33635Z","steps":["trace[1183534987] 'process raft request' (duration: 124.399017ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:30:47.336532Z","caller":"traceutil/trace.go:171","msg":"trace[1905434008] transaction","detail":"{read_only:false; response_revision:1264; number_of_response:1; }","duration":"124.630623ms","start":"2026-06-11T06:30:47.211896Z","end":"2026-06-11T06:30:47.336527Z","steps":["trace[1905434008] 'process raft request' (duration: 124.452898ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:30:47.336511Z","caller":"traceutil/trace.go:171","msg":"trace[1220630991] transaction","detail":"{read_only:false; response_revision:1263; number_of_response:1; }","duration":"124.677674ms","start":"2026-06-11T06:30:47.211812Z","end":"2026-06-11T06:30:47.336489Z","steps":["trace[1220630991] 'process raft request' (duration: 124.448908ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:30:49.619624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.095675ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-11T06:30:49.619694Z","caller":"traceutil/trace.go:171","msg":"trace[1676905136] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:1274; }","duration":"303.200577ms","start":"2026-06-11T06:30:49.316478Z","end":"2026-06-11T06:30:49.619679Z","steps":["trace[1676905136] 'count revisions from in-memory index tree' (duration: 303.041484ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:30:49.619733Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:30:49.316467Z","time spent":"303.255999ms","remote":"127.0.0.1:36566","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":13,"response size":30,"request content":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true "} {"level":"warn","ts":"2026-06-11T06:30:49.620011Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.412892ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-06-11T06:30:49.620046Z","caller":"traceutil/trace.go:171","msg":"trace[682604964] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1274; }","duration":"299.466514ms","start":"2026-06-11T06:30:49.32057Z","end":"2026-06-11T06:30:49.620037Z","steps":["trace[682604964] 'range keys from in-memory index tree' (duration: 299.268469ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:30:49.620245Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.517202ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-11T06:30:49.620278Z","caller":"traceutil/trace.go:171","msg":"trace[231254784] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1274; }","duration":"280.569464ms","start":"2026-06-11T06:30:49.3397Z","end":"2026-06-11T06:30:49.62027Z","steps":["trace[231254784] 'range keys from in-memory index tree' (duration: 280.414589ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:30:49.620438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.803789ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-06-11T06:30:49.620469Z","caller":"traceutil/trace.go:171","msg":"trace[795604865] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1274; }","duration":"280.86023ms","start":"2026-06-11T06:30:49.339601Z","end":"2026-06-11T06:30:49.620462Z","steps":["trace[795604865] 'range keys from in-memory index tree' (duration: 280.607564ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:30:49.620629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.120042ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-06-11T06:30:49.620663Z","caller":"traceutil/trace.go:171","msg":"trace[1935058390] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1274; }","duration":"280.168433ms","start":"2026-06-11T06:30:49.340485Z","end":"2026-06-11T06:30:49.620653Z","steps":["trace[1935058390] 'range keys from in-memory index tree' (duration: 280.04977ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:30:49.620816Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.126882ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-06-11T06:30:49.620846Z","caller":"traceutil/trace.go:171","msg":"trace[1774176491] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1274; }","duration":"280.170754ms","start":"2026-06-11T06:30:49.340668Z","end":"2026-06-11T06:30:49.620839Z","steps":["trace[1774176491] 'range keys from in-memory index tree' (duration: 280.065481ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:30:51.742222Z","caller":"traceutil/trace.go:171","msg":"trace[1873461670] transaction","detail":"{read_only:false; response_revision:1293; number_of_response:1; }","duration":"106.027398ms","start":"2026-06-11T06:30:51.636179Z","end":"2026-06-11T06:30:51.742207Z","steps":["trace[1873461670] 'process raft request' (duration: 105.881975ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:30:52.807016Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"587.275776ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-11T06:30:52.807166Z","caller":"traceutil/trace.go:171","msg":"trace[732242109] transaction","detail":"{read_only:false; response_revision:1296; number_of_response:1; }","duration":"1.05905576s","start":"2026-06-11T06:30:51.748099Z","end":"2026-06-11T06:30:52.807155Z","steps":["trace[732242109] 'process raft request' (duration: 1.05901619s)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:30:52.807205Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:30:51.748087Z","time spent":"1.059101821s","remote":"127.0.0.1:36392","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-06-11T06:30:52.807225Z","caller":"traceutil/trace.go:171","msg":"trace[1647452409] transaction","detail":"{read_only:false; response_revision:1294; number_of_response:1; }","duration":"1.061737636s","start":"2026-06-11T06:30:51.745466Z","end":"2026-06-11T06:30:52.807203Z","steps":["trace[1647452409] 'process raft request' (duration: 474.220433ms)","trace[1647452409] 'compare' (duration: 587.180203ms)"],"step_count":2} {"level":"warn","ts":"2026-06-11T06:30:52.807326Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:30:51.745447Z","time spent":"1.061830148s","remote":"127.0.0.1:36392","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-11T06:30:52.807417Z","caller":"traceutil/trace.go:171","msg":"trace[182785048] linearizableReadLoop","detail":"{readStateIndex:1348; appliedIndex:1344; }","duration":"865.725727ms","start":"2026-06-11T06:30:51.941686Z","end":"2026-06-11T06:30:52.807412Z","steps":["trace[182785048] 'read index received' (duration: 278.013739ms)","trace[182785048] 'applied index is now lower than readState.Index' (duration: 587.711398ms)"],"step_count":2} {"level":"info","ts":"2026-06-11T06:30:52.807339Z","caller":"traceutil/trace.go:171","msg":"trace[990518870] transaction","detail":"{read_only:false; response_revision:1295; number_of_response:1; }","duration":"1.061662964s","start":"2026-06-11T06:30:51.74567Z","end":"2026-06-11T06:30:52.807333Z","steps":["trace[990518870] 'process raft request' (duration: 1.061415638s)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:30:52.807478Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:30:51.745655Z","time spent":"1.061807448s","remote":"127.0.0.1:36392","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-11T06:30:52.807516Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"865.82885ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-11T06:30:52.807538Z","caller":"traceutil/trace.go:171","msg":"trace[500499052] range","detail":"{range_begin:/registry/deployments/; range_end:/registry/deployments0; response_count:0; response_revision:1297; }","duration":"865.891482ms","start":"2026-06-11T06:30:51.941642Z","end":"2026-06-11T06:30:52.807534Z","steps":["trace[500499052] 'agreement among raft nodes before linearized reading' (duration: 865.83573ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:30:52.807554Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:30:51.941622Z","time spent":"865.928412ms","remote":"127.0.0.1:36574","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":4,"response size":30,"request content":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true "} {"level":"warn","ts":"2026-06-11T06:30:52.807605Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.711955ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-11T06:30:52.807645Z","caller":"traceutil/trace.go:171","msg":"trace[423634272] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:1297; }","duration":"341.799156ms","start":"2026-06-11T06:30:52.465841Z","end":"2026-06-11T06:30:52.80764Z","steps":["trace[423634272] 'agreement among raft nodes before linearized reading' (duration: 341.733985ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:30:52.807661Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:30:52.465822Z","time spent":"341.834868ms","remote":"127.0.0.1:40960","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true "} {"level":"info","ts":"2026-06-11T06:30:52.80768Z","caller":"traceutil/trace.go:171","msg":"trace[1954085211] transaction","detail":"{read_only:false; response_revision:1297; number_of_response:1; }","duration":"1.058334821s","start":"2026-06-11T06:30:51.749339Z","end":"2026-06-11T06:30:52.807674Z","steps":["trace[1954085211] 'process raft request' (duration: 1.057797428s)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:30:52.807708Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:30:51.749333Z","time spent":"1.058359612s","remote":"127.0.0.1:36392","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-11T06:30:53.242212Z","caller":"traceutil/trace.go:171","msg":"trace[1024172801] transaction","detail":"{read_only:false; response_revision:1298; number_of_response:1; }","duration":"135.481633ms","start":"2026-06-11T06:30:53.106706Z","end":"2026-06-11T06:30:53.242187Z","steps":["trace[1024172801] 'process raft request' (duration: 97.553418ms)","trace[1024172801] 'compare' (duration: 37.621187ms)"],"step_count":2} {"level":"info","ts":"2026-06-11T06:30:53.864981Z","caller":"traceutil/trace.go:171","msg":"trace[1511492776] transaction","detail":"{read_only:false; response_revision:1301; number_of_response:1; }","duration":"116.401686ms","start":"2026-06-11T06:30:53.74856Z","end":"2026-06-11T06:30:53.864962Z","steps":["trace[1511492776] 'process raft request' (duration: 116.269363ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:30:55.230329Z","caller":"traceutil/trace.go:171","msg":"trace[12718826] transaction","detail":"{read_only:false; response_revision:1305; number_of_response:1; }","duration":"413.82677ms","start":"2026-06-11T06:30:54.816474Z","end":"2026-06-11T06:30:55.230301Z","steps":["trace[12718826] 'process raft request' (duration: 413.774108ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:30:55.230366Z","caller":"traceutil/trace.go:171","msg":"trace[1648247718] transaction","detail":"{read_only:false; response_revision:1303; number_of_response:1; }","duration":"414.073016ms","start":"2026-06-11T06:30:54.816257Z","end":"2026-06-11T06:30:55.23033Z","steps":["trace[1648247718] 'process raft request' (duration: 370.710597ms)","trace[1648247718] 'compare' (duration: 43.058631ms)"],"step_count":2} {"level":"warn","ts":"2026-06-11T06:30:55.230489Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:30:54.816467Z","time spent":"413.942513ms","remote":"127.0.0.1:36392","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-11T06:30:55.230512Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:30:54.816224Z","time spent":"414.203089ms","remote":"127.0.0.1:36392","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-11T06:30:55.231162Z","caller":"traceutil/trace.go:171","msg":"trace[862421856] transaction","detail":"{read_only:false; response_revision:1304; number_of_response:1; }","duration":"414.719442ms","start":"2026-06-11T06:30:54.81642Z","end":"2026-06-11T06:30:55.231139Z","steps":["trace[862421856] 'process raft request' (duration: 413.756067ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:30:55.231259Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:30:54.81641Z","time spent":"414.801654ms","remote":"127.0.0.1:36392","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-06-11T06:30:55.474938Z","caller":"traceutil/trace.go:171","msg":"trace[1276496856] transaction","detail":"{read_only:false; response_revision:1306; number_of_response:1; }","duration":"163.260913ms","start":"2026-06-11T06:30:55.31165Z","end":"2026-06-11T06:30:55.474911Z","steps":["trace[1276496856] 'process raft request' (duration: 150.857804ms)","trace[1276496856] 'compare' (duration: 12.276686ms)"],"step_count":2} {"level":"info","ts":"2026-06-11T06:30:55.55432Z","caller":"traceutil/trace.go:171","msg":"trace[2093468929] transaction","detail":"{read_only:false; response_revision:1307; number_of_response:1; }","duration":"225.437601ms","start":"2026-06-11T06:30:55.328857Z","end":"2026-06-11T06:30:55.554295Z","steps":["trace[2093468929] 'process raft request' (duration: 225.302328ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:30:56.100418Z","caller":"traceutil/trace.go:171","msg":"trace[913226574] transaction","detail":"{read_only:false; response_revision:1308; number_of_response:1; }","duration":"227.558444ms","start":"2026-06-11T06:30:55.872835Z","end":"2026-06-11T06:30:56.100393Z","steps":["trace[913226574] 'process raft request' (duration: 227.38428ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:30:56.911178Z","caller":"traceutil/trace.go:171","msg":"trace[674422155] linearizableReadLoop","detail":"{readStateIndex:1361; appliedIndex:1360; }","duration":"267.703104ms","start":"2026-06-11T06:30:56.643452Z","end":"2026-06-11T06:30:56.911155Z","steps":["trace[674422155] 'read index received' (duration: 267.559169ms)","trace[674422155] 'applied index is now lower than readState.Index' (duration: 142.905µs)"],"step_count":2} {"level":"info","ts":"2026-06-11T06:30:56.911223Z","caller":"traceutil/trace.go:171","msg":"trace[1929269493] transaction","detail":"{read_only:false; response_revision:1309; number_of_response:1; }","duration":"344.250549ms","start":"2026-06-11T06:30:56.566936Z","end":"2026-06-11T06:30:56.911186Z","steps":["trace[1929269493] 'process raft request' (duration: 344.097574ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:30:56.911358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.895239ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-11T06:30:56.911559Z","caller":"traceutil/trace.go:171","msg":"trace[916489119] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:0; response_revision:1309; }","duration":"268.144444ms","start":"2026-06-11T06:30:56.643403Z","end":"2026-06-11T06:30:56.911547Z","steps":["trace[916489119] 'agreement among raft nodes before linearized reading' (duration: 267.890138ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:30:56.911518Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:30:56.566913Z","time spent":"344.517626ms","remote":"127.0.0.1:36220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":788,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-11T06:31:00.274949Z","caller":"traceutil/trace.go:171","msg":"trace[345145575] transaction","detail":"{read_only:false; response_revision:1341; number_of_response:1; }","duration":"157.126701ms","start":"2026-06-11T06:31:00.117798Z","end":"2026-06-11T06:31:00.274924Z","steps":["trace[345145575] 'process raft request' (duration: 156.875055ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:31:04.427022Z","caller":"traceutil/trace.go:171","msg":"trace[1291831519] transaction","detail":"{read_only:false; response_revision:1376; number_of_response:1; }","duration":"136.081315ms","start":"2026-06-11T06:31:04.290915Z","end":"2026-06-11T06:31:04.426996Z","steps":["trace[1291831519] 'process raft request' (duration: 135.88146ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:31:05.468675Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13305496650913667766,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-11T06:31:05.718188Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.07010164s","expected-duration":"1s"} {"level":"info","ts":"2026-06-11T06:31:05.718704Z","caller":"traceutil/trace.go:171","msg":"trace[12526858] transaction","detail":"{read_only:false; response_revision:1377; number_of_response:1; }","duration":"1.070698026s","start":"2026-06-11T06:31:04.647984Z","end":"2026-06-11T06:31:05.718682Z","steps":["trace[12526858] 'process raft request' (duration: 1.070372387s)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:31:05.718708Z","caller":"traceutil/trace.go:171","msg":"trace[476734154] linearizableReadLoop","detail":"{readStateIndex:1431; appliedIndex:1430; }","duration":"750.9436ms","start":"2026-06-11T06:31:04.967732Z","end":"2026-06-11T06:31:05.718675Z","steps":["trace[476734154] 'read index received' (duration: 750.59163ms)","trace[476734154] 'applied index is now lower than readState.Index' (duration: 349.86µs)"],"step_count":2} {"level":"warn","ts":"2026-06-11T06:31:05.718827Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:31:04.647954Z","time spent":"1.070796139s","remote":"127.0.0.1:36392","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-11T06:31:05.718926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"751.175415ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-11T06:31:05.718998Z","caller":"traceutil/trace.go:171","msg":"trace[1663875462] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1377; }","duration":"751.264608ms","start":"2026-06-11T06:31:04.967716Z","end":"2026-06-11T06:31:05.718981Z","steps":["trace[1663875462] 'agreement among raft nodes before linearized reading' (duration: 751.054702ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:31:05.719053Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:31:04.967696Z","time spent":"751.34435ms","remote":"127.0.0.1:36392","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-11T06:31:05.94475Z","caller":"traceutil/trace.go:171","msg":"trace[1674987831] linearizableReadLoop","detail":"{readStateIndex:1433; appliedIndex:1431; }","duration":"225.937314ms","start":"2026-06-11T06:31:05.718788Z","end":"2026-06-11T06:31:05.944726Z","steps":["trace[1674987831] 'read index received' (duration: 225.643166ms)","trace[1674987831] 'applied index is now lower than readState.Index' (duration: 293.157µs)"],"step_count":2} {"level":"warn","ts":"2026-06-11T06:31:05.944933Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"947.238065ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-11T06:31:05.944949Z","caller":"traceutil/trace.go:171","msg":"trace[1452412848] transaction","detail":"{read_only:false; response_revision:1379; number_of_response:1; }","duration":"247.292517ms","start":"2026-06-11T06:31:05.697641Z","end":"2026-06-11T06:31:05.944933Z","steps":["trace[1452412848] 'process raft request' (duration: 247.0086ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:31:05.945028Z","caller":"traceutil/trace.go:171","msg":"trace[1878007676] transaction","detail":"{read_only:false; response_revision:1378; number_of_response:1; }","duration":"399.968213ms","start":"2026-06-11T06:31:05.545051Z","end":"2026-06-11T06:31:05.945019Z","steps":["trace[1878007676] 'process raft request' (duration: 399.387758ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:31:05.945051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"675.306558ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-11T06:31:05.945103Z","caller":"traceutil/trace.go:171","msg":"trace[78343795] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1379; }","duration":"675.36198ms","start":"2026-06-11T06:31:05.269726Z","end":"2026-06-11T06:31:05.945088Z","steps":["trace[78343795] 'agreement among raft nodes before linearized reading' (duration: 675.271777ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:31:05.945077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"947.634235ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:532"} {"level":"warn","ts":"2026-06-11T06:31:05.945114Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:31:05.545037Z","time spent":"400.021344ms","remote":"127.0.0.1:36392","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-06-11T06:31:05.945148Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:31:05.26972Z","time spent":"675.419401ms","remote":"127.0.0.1:36392","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-11T06:31:05.94516Z","caller":"traceutil/trace.go:171","msg":"trace[938451674] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1379; }","duration":"947.756598ms","start":"2026-06-11T06:31:04.997386Z","end":"2026-06-11T06:31:05.945143Z","steps":["trace[938451674] 'agreement among raft nodes before linearized reading' (duration: 947.542213ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:31:05.944956Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"676.94468ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"warn","ts":"2026-06-11T06:31:05.9452Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:31:04.997375Z","time spent":"947.817229ms","remote":"127.0.0.1:36392","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":555,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "} {"level":"info","ts":"2026-06-11T06:31:05.945222Z","caller":"traceutil/trace.go:171","msg":"trace[711963450] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1379; }","duration":"677.259208ms","start":"2026-06-11T06:31:05.267953Z","end":"2026-06-11T06:31:05.945212Z","steps":["trace[711963450] 'agreement among raft nodes before linearized reading' (duration: 676.872588ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:31:05.945261Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:31:05.267911Z","time spent":"677.34067ms","remote":"127.0.0.1:36392","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-06-11T06:31:05.945274Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"421.209583ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-11T06:31:05.945301Z","caller":"traceutil/trace.go:171","msg":"trace[1461294920] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1379; }","duration":"421.273055ms","start":"2026-06-11T06:31:05.524018Z","end":"2026-06-11T06:31:05.945292Z","steps":["trace[1461294920] 'agreement among raft nodes before linearized reading' (duration: 421.234454ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:31:05.944979Z","caller":"traceutil/trace.go:171","msg":"trace[1199856639] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:1379; }","duration":"947.349348ms","start":"2026-06-11T06:31:04.997619Z","end":"2026-06-11T06:31:05.944969Z","steps":["trace[1199856639] 'agreement among raft nodes before linearized reading' (duration: 947.222704ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:31:05.945333Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:31:05.524Z","time spent":"421.328176ms","remote":"127.0.0.1:36122","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-06-11T06:31:05.945376Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:31:04.997596Z","time spent":"947.765198ms","remote":"127.0.0.1:36248","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":5,"response size":30,"request content":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true "} {"level":"warn","ts":"2026-06-11T06:31:05.945587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"675.197236ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-06-11T06:31:05.945758Z","caller":"traceutil/trace.go:171","msg":"trace[1008350606] transaction","detail":"{read_only:false; response_revision:1380; number_of_response:1; }","duration":"223.180273ms","start":"2026-06-11T06:31:05.722567Z","end":"2026-06-11T06:31:05.945747Z","steps":["trace[1008350606] 'process raft request' (duration: 223.042789ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:31:05.945676Z","caller":"traceutil/trace.go:171","msg":"trace[1751600400] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1379; }","duration":"675.333659ms","start":"2026-06-11T06:31:05.270322Z","end":"2026-06-11T06:31:05.945655Z","steps":["trace[1751600400] 'agreement among raft nodes before linearized reading' (duration: 674.483447ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:31:05.945922Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:31:05.270302Z","time spent":"675.580566ms","remote":"127.0.0.1:36392","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-11T06:31:08.150989Z","caller":"traceutil/trace.go:171","msg":"trace[1377590041] transaction","detail":"{read_only:false; response_revision:1390; number_of_response:1; }","duration":"166.083485ms","start":"2026-06-11T06:31:07.984872Z","end":"2026-06-11T06:31:08.150955Z","steps":["trace[1377590041] 'process raft request' (duration: 128.611933ms)","trace[1377590041] 'compare' (duration: 37.279667ms)"],"step_count":2} {"level":"info","ts":"2026-06-11T06:31:08.151254Z","caller":"traceutil/trace.go:171","msg":"trace[1725984325] transaction","detail":"{read_only:false; response_revision:1391; number_of_response:1; }","duration":"165.901209ms","start":"2026-06-11T06:31:07.985326Z","end":"2026-06-11T06:31:08.151228Z","steps":["trace[1725984325] 'process raft request' (duration: 165.583431ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:31:08.152091Z","caller":"traceutil/trace.go:171","msg":"trace[232082667] transaction","detail":"{read_only:false; response_revision:1392; number_of_response:1; }","duration":"166.191176ms","start":"2026-06-11T06:31:07.98588Z","end":"2026-06-11T06:31:08.152072Z","steps":["trace[232082667] 'process raft request' (duration: 165.93691ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:31:08.152416Z","caller":"traceutil/trace.go:171","msg":"trace[468971391] transaction","detail":"{read_only:false; response_revision:1393; number_of_response:1; }","duration":"166.260498ms","start":"2026-06-11T06:31:07.986146Z","end":"2026-06-11T06:31:08.152406Z","steps":["trace[468971391] 'process raft request' (duration: 165.780196ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:31:08.472572Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.227375ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-06-11T06:31:08.472651Z","caller":"traceutil/trace.go:171","msg":"trace[1303556948] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1393; }","duration":"196.357599ms","start":"2026-06-11T06:31:08.276272Z","end":"2026-06-11T06:31:08.47263Z","steps":["trace[1303556948] 'range keys from in-memory index tree' (duration: 196.05948ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:31:08.797048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.558428ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-11T06:31:08.797377Z","caller":"traceutil/trace.go:171","msg":"trace[557972958] transaction","detail":"{read_only:false; response_revision:1395; number_of_response:1; }","duration":"239.181928ms","start":"2026-06-11T06:31:08.558163Z","end":"2026-06-11T06:31:08.797345Z","steps":["trace[557972958] 'process raft request' (duration: 63.065755ms)","trace[557972958] 'compare' (duration: 175.275771ms)"],"step_count":2} {"level":"warn","ts":"2026-06-11T06:31:08.797541Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.628626ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-11T06:31:08.797611Z","caller":"traceutil/trace.go:171","msg":"trace[358746073] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:1395; }","duration":"174.727678ms","start":"2026-06-11T06:31:08.622871Z","end":"2026-06-11T06:31:08.797599Z","steps":["trace[358746073] 'agreement among raft nodes before linearized reading' (duration: 174.621336ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:31:08.79793Z","caller":"traceutil/trace.go:171","msg":"trace[1147492786] linearizableReadLoop","detail":"{readStateIndex:1450; appliedIndex:1449; }","duration":"174.383518ms","start":"2026-06-11T06:31:08.622902Z","end":"2026-06-11T06:31:08.797286Z","steps":["trace[1147492786] 'read index received' (duration: 33.221µs)","trace[1147492786] 'applied index is now lower than readState.Index' (duration: 174.348727ms)"],"step_count":2} {"level":"info","ts":"2026-06-11T06:31:22.399991Z","caller":"traceutil/trace.go:171","msg":"trace[1139327550] linearizableReadLoop","detail":"{readStateIndex:1512; appliedIndex:1511; }","duration":"183.866643ms","start":"2026-06-11T06:31:22.216091Z","end":"2026-06-11T06:31:22.399958Z","steps":["trace[1139327550] 'read index received' (duration: 143.225521ms)","trace[1139327550] 'applied index is now lower than readState.Index' (duration: 40.639642ms)"],"step_count":2} {"level":"info","ts":"2026-06-11T06:31:22.400049Z","caller":"traceutil/trace.go:171","msg":"trace[1364270661] transaction","detail":"{read_only:false; response_revision:1455; number_of_response:1; }","duration":"209.868949ms","start":"2026-06-11T06:31:22.190137Z","end":"2026-06-11T06:31:22.400006Z","steps":["trace[1364270661] 'process raft request' (duration: 169.331178ms)","trace[1364270661] 'compare' (duration: 40.343226ms)"],"step_count":2} {"level":"warn","ts":"2026-06-11T06:31:22.400319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.476604ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-06-11T06:31:22.400376Z","caller":"traceutil/trace.go:171","msg":"trace[13952417] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1455; }","duration":"183.573347ms","start":"2026-06-11T06:31:22.21679Z","end":"2026-06-11T06:31:22.400363Z","steps":["trace[13952417] 'agreement among raft nodes before linearized reading' (duration: 183.408602ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:31:22.400407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.284925ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-06-11T06:31:22.400538Z","caller":"traceutil/trace.go:171","msg":"trace[148124403] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1455; }","duration":"184.461389ms","start":"2026-06-11T06:31:22.216053Z","end":"2026-06-11T06:31:22.400515Z","steps":["trace[148124403] 'agreement among raft nodes before linearized reading' (duration: 184.082419ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:31:22.400591Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.819171ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-11T06:31:22.400623Z","caller":"traceutil/trace.go:171","msg":"trace[907327123] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1455; }","duration":"181.870393ms","start":"2026-06-11T06:31:22.218744Z","end":"2026-06-11T06:31:22.400614Z","steps":["trace[907327123] 'agreement among raft nodes before linearized reading' (duration: 181.786211ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:31:22.400731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.775444ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:531"} {"level":"info","ts":"2026-06-11T06:31:22.400844Z","caller":"traceutil/trace.go:171","msg":"trace[396210080] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1455; }","duration":"180.924097ms","start":"2026-06-11T06:31:22.219891Z","end":"2026-06-11T06:31:22.400815Z","steps":["trace[396210080] 'agreement among raft nodes before linearized reading' (duration: 180.582849ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:31:22.536935Z","caller":"traceutil/trace.go:171","msg":"trace[1106543531] transaction","detail":"{read_only:false; response_revision:1459; number_of_response:1; }","duration":"129.992668ms","start":"2026-06-11T06:31:22.406921Z","end":"2026-06-11T06:31:22.536913Z","steps":["trace[1106543531] 'process raft request' (duration: 129.933437ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:31:22.537115Z","caller":"traceutil/trace.go:171","msg":"trace[395197530] transaction","detail":"{read_only:false; response_revision:1458; number_of_response:1; }","duration":"130.628036ms","start":"2026-06-11T06:31:22.406449Z","end":"2026-06-11T06:31:22.537077Z","steps":["trace[395197530] 'process raft request' (duration: 130.363879ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:31:22.537052Z","caller":"traceutil/trace.go:171","msg":"trace[1180471827] transaction","detail":"{read_only:false; response_revision:1457; number_of_response:1; }","duration":"131.002245ms","start":"2026-06-11T06:31:22.405984Z","end":"2026-06-11T06:31:22.536986Z","steps":["trace[1180471827] 'process raft request' (duration: 127.446953ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:31:23.447101Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.995175ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-11T06:31:23.447252Z","caller":"traceutil/trace.go:171","msg":"trace[1903192854] transaction","detail":"{read_only:false; response_revision:1461; number_of_response:1; }","duration":"268.349433ms","start":"2026-06-11T06:31:23.178871Z","end":"2026-06-11T06:31:23.447221Z","steps":["trace[1903192854] 'process raft request' (duration: 142.149333ms)","trace[1903192854] 'compare' (duration: 125.739458ms)"],"step_count":2} {"level":"info","ts":"2026-06-11T06:32:02.887541Z","caller":"traceutil/trace.go:171","msg":"trace[420117414] transaction","detail":"{read_only:false; response_revision:1642; number_of_response:1; }","duration":"101.239663ms","start":"2026-06-11T06:32:02.786242Z","end":"2026-06-11T06:32:02.887482Z","steps":["trace[420117414] 'process raft request' (duration: 44.161154ms)","trace[420117414] 'compare' (duration: 56.772782ms)"],"step_count":2} {"level":"info","ts":"2026-06-11T06:32:48.885351Z","caller":"traceutil/trace.go:171","msg":"trace[91023505] transaction","detail":"{read_only:false; response_revision:1851; number_of_response:1; }","duration":"103.386752ms","start":"2026-06-11T06:32:48.781936Z","end":"2026-06-11T06:32:48.885323Z","steps":["trace[91023505] 'process raft request' (duration: 103.217468ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:34:45.893085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.516828ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-11T06:34:45.893169Z","caller":"traceutil/trace.go:171","msg":"trace[1672388389] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2408; }","duration":"154.638402ms","start":"2026-06-11T06:34:45.738512Z","end":"2026-06-11T06:34:45.89315Z","steps":["trace[1672388389] 'range keys from in-memory index tree' (duration: 154.315784ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:34:51.296036Z","caller":"traceutil/trace.go:171","msg":"trace[972499553] transaction","detail":"{read_only:false; response_revision:2438; number_of_response:1; }","duration":"120.864042ms","start":"2026-06-11T06:34:51.175138Z","end":"2026-06-11T06:34:51.296002Z","steps":["trace[972499553] 'process raft request' (duration: 120.119314ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:34:51.653217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.789018ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-11T06:34:51.653353Z","caller":"traceutil/trace.go:171","msg":"trace[1988352364] linearizableReadLoop","detail":"{readStateIndex:2540; appliedIndex:2539; }","duration":"113.90144ms","start":"2026-06-11T06:34:51.539415Z","end":"2026-06-11T06:34:51.653317Z","steps":["trace[1988352364] 'read index received' (duration: 7.949558ms)","trace[1988352364] 'applied index is now lower than readState.Index' (duration: 105.950372ms)"],"step_count":2} {"level":"warn","ts":"2026-06-11T06:34:51.653525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.114066ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-11T06:34:51.653611Z","caller":"traceutil/trace.go:171","msg":"trace[1065536031] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2440; }","duration":"114.266099ms","start":"2026-06-11T06:34:51.539329Z","end":"2026-06-11T06:34:51.653595Z","steps":["trace[1065536031] 'agreement among raft nodes before linearized reading' (duration: 114.082884ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:34:51.653791Z","caller":"traceutil/trace.go:171","msg":"trace[895042230] transaction","detail":"{read_only:false; response_revision:2440; number_of_response:1; }","duration":"221.933364ms","start":"2026-06-11T06:34:51.431784Z","end":"2026-06-11T06:34:51.653718Z","steps":["trace[895042230] 'process raft request' (duration: 115.544541ms)","trace[895042230] 'compare' (duration: 105.657075ms)"],"step_count":2}