{"level":"warn","ts":"2026-06-09T15:51:21.893066Z","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-09T15:51:21.893171Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.65: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.65:2380","--initial-cluster=instance=https://199.204.45.65:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.65:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.65: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-09T15:51:21.893252Z","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-09T15:51:21.893308Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.65:2380"]} {"level":"info","ts":"2026-06-09T15:51:21.89334Z","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-09T15:51:21.893987Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.65:2379"]} {"level":"info","ts":"2026-06-09T15:51:21.894061Z","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.65:2380"],"listen-peer-urls":["https://199.204.45.65:2380"],"advertise-client-urls":["https://199.204.45.65:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.65:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.65: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-09T15:51:21.897133Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.798581ms"} {"level":"info","ts":"2026-06-09T15:51:21.903003Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"cf8c3a138c9a77a2","cluster-id":"c278183e1f634dff"} {"level":"info","ts":"2026-06-09T15:51:21.903115Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 switched to configuration voters=()"} {"level":"info","ts":"2026-06-09T15:51:21.903159Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 became follower at term 0"} {"level":"info","ts":"2026-06-09T15:51:21.90318Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft cf8c3a138c9a77a2 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-09T15:51:21.903189Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 became follower at term 1"} {"level":"info","ts":"2026-06-09T15:51:21.90337Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 switched to configuration voters=(14955392318228297634)"} {"level":"warn","ts":"2026-06-09T15:51:21.91097Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-09T15:51:21.912507Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-09T15:51:21.914744Z","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-09T15:51:21.917096Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"cf8c3a138c9a77a2","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-09T15:51:21.919017Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"cf8c3a138c9a77a2","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-09T15:51:21.91916Z","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-09T15:51:21.921009Z","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-09T15:51:21.921044Z","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-09T15:51:21.921962Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 switched to configuration voters=(14955392318228297634)"} {"level":"info","ts":"2026-06-09T15:51:21.924236Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"c278183e1f634dff","local-member-id":"cf8c3a138c9a77a2","added-peer-id":"cf8c3a138c9a77a2","added-peer-peer-urls":["https://199.204.45.65:2380"]} {"level":"info","ts":"2026-06-09T15:51:21.925028Z","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-09T15:51:21.925225Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.65:2380"} {"level":"info","ts":"2026-06-09T15:51:21.925259Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.65:2380"} {"level":"info","ts":"2026-06-09T15:51:21.927182Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"cf8c3a138c9a77a2","initial-advertise-peer-urls":["https://199.204.45.65:2380"],"listen-peer-urls":["https://199.204.45.65:2380"],"advertise-client-urls":["https://199.204.45.65:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.65:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-09T15:51:21.927222Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-09T15:51:22.204244Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 is starting a new election at term 1"} {"level":"info","ts":"2026-06-09T15:51:22.204305Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 became pre-candidate at term 1"} {"level":"info","ts":"2026-06-09T15:51:22.204324Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 received MsgPreVoteResp from cf8c3a138c9a77a2 at term 1"} {"level":"info","ts":"2026-06-09T15:51:22.204336Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 became candidate at term 2"} {"level":"info","ts":"2026-06-09T15:51:22.204341Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 received MsgVoteResp from cf8c3a138c9a77a2 at term 2"} {"level":"info","ts":"2026-06-09T15:51:22.204352Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 became leader at term 2"} {"level":"info","ts":"2026-06-09T15:51:22.204359Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: cf8c3a138c9a77a2 elected leader cf8c3a138c9a77a2 at term 2"} {"level":"info","ts":"2026-06-09T15:51:22.205196Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"cf8c3a138c9a77a2","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.65:2379]}","request-path":"/0/members/cf8c3a138c9a77a2/attributes","cluster-id":"c278183e1f634dff","publish-timeout":"7s"} {"level":"info","ts":"2026-06-09T15:51:22.205278Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-09T15:51:22.205388Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-09T15:51:22.205455Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-09T15:51:22.205685Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-09T15:51:22.206141Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-09T15:51:22.206432Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"c278183e1f634dff","local-member-id":"cf8c3a138c9a77a2","cluster-version":"3.5"} {"level":"info","ts":"2026-06-09T15:51:22.206531Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-09T15:51:22.206563Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-09T15:51:22.207188Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.65:2379"} {"level":"info","ts":"2026-06-09T15:51:22.207768Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-09T15:51:24.086031Z","caller":"traceutil/trace.go:171","msg":"trace[1219192477] linearizableReadLoop","detail":"{readStateIndex:48; appliedIndex:46; }","duration":"315.657672ms","start":"2026-06-09T15:51:23.770357Z","end":"2026-06-09T15:51:24.086015Z","steps":["trace[1219192477] 'read index received' (duration: 304.16503ms)","trace[1219192477] 'applied index is now lower than readState.Index' (duration: 11.491972ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T15:51:24.086075Z","caller":"traceutil/trace.go:171","msg":"trace[1933490688] transaction","detail":"{read_only:false; response_revision:43; number_of_response:1; }","duration":"317.391189ms","start":"2026-06-09T15:51:23.76864Z","end":"2026-06-09T15:51:24.086031Z","steps":["trace[1933490688] 'process raft request' (duration: 305.775882ms)","trace[1933490688] 'compare' (duration: 11.267636ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T15:51:24.086297Z","caller":"traceutil/trace.go:171","msg":"trace[200272273] transaction","detail":"{read_only:false; response_revision:44; number_of_response:1; }","duration":"316.040235ms","start":"2026-06-09T15:51:23.770242Z","end":"2026-06-09T15:51:24.086282Z","steps":["trace[200272273] 'process raft request' (duration: 315.56617ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:51:24.086359Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:51:23.778303Z","time spent":"308.054007ms","remote":"127.0.0.1:43646","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-06-09T15:51:24.086648Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:51:23.768624Z","time spent":"317.515944ms","remote":"127.0.0.1:43658","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":357,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-09T15:51:24.086771Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:51:23.770231Z","time spent":"316.107368ms","remote":"127.0.0.1:43962","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":826,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-09T15:51:24.087105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.719287ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/system-node-high\" ","response":"range_response_count:1 size:1132"} {"level":"info","ts":"2026-06-09T15:51:24.087172Z","caller":"traceutil/trace.go:171","msg":"trace[1614649759] range","detail":"{range_begin:/registry/flowschemas/system-node-high; range_end:; response_count:1; response_revision:45; }","duration":"316.854372ms","start":"2026-06-09T15:51:23.770305Z","end":"2026-06-09T15:51:24.08716Z","steps":["trace[1614649759] 'agreement among raft nodes before linearized reading' (duration: 316.712817ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:51:24.087206Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:51:23.770287Z","time spent":"316.911704ms","remote":"127.0.0.1:43962","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":1,"response size":1156,"request content":"key:\"/registry/flowschemas/system-node-high\" "} {"level":"info","ts":"2026-06-09T15:51:24.087357Z","caller":"traceutil/trace.go:171","msg":"trace[1897483341] transaction","detail":"{read_only:false; response_revision:45; number_of_response:1; }","duration":"300.401719ms","start":"2026-06-09T15:51:23.786945Z","end":"2026-06-09T15:51:24.087346Z","steps":["trace[1897483341] 'process raft request' (duration: 299.030044ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:51:24.08742Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:51:23.786906Z","time spent":"300.481821ms","remote":"127.0.0.1:43780","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-09T15:51:54.986073Z","caller":"traceutil/trace.go:171","msg":"trace[97511513] transaction","detail":"{read_only:false; response_revision:486; number_of_response:1; }","duration":"177.564384ms","start":"2026-06-09T15:51:54.80849Z","end":"2026-06-09T15:51:54.986054Z","steps":["trace[97511513] 'process raft request' (duration: 177.409559ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:52:00.057714Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8620627102956008367,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-09T15:52:00.210244Z","caller":"traceutil/trace.go:171","msg":"trace[740857599] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"830.403476ms","start":"2026-06-09T15:51:59.379819Z","end":"2026-06-09T15:52:00.210223Z","steps":["trace[740857599] 'process raft request' (duration: 830.306823ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:52:00.21044Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:51:59.379799Z","time spent":"830.51085ms","remote":"127.0.0.1:43622","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-09T15:52:00.230991Z","caller":"traceutil/trace.go:171","msg":"trace[1146026904] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"848.278001ms","start":"2026-06-09T15:51:59.382673Z","end":"2026-06-09T15:52:00.230951Z","steps":["trace[1146026904] 'process raft request' (duration: 848.096356ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T15:52:00.231073Z","caller":"traceutil/trace.go:171","msg":"trace[1188331700] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"848.345144ms","start":"2026-06-09T15:51:59.382714Z","end":"2026-06-09T15:52:00.231059Z","steps":["trace[1188331700] 'process raft request' (duration: 848.170218ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:52:00.231211Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:51:59.38271Z","time spent":"848.448377ms","remote":"127.0.0.1:43622","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-09T15:52:00.231209Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:51:59.382663Z","time spent":"848.459168ms","remote":"127.0.0.1:43622","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-09T15:52:00.231334Z","caller":"traceutil/trace.go:171","msg":"trace[1604692555] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"836.788932ms","start":"2026-06-09T15:51:59.394533Z","end":"2026-06-09T15:52:00.231322Z","steps":["trace[1604692555] 'process raft request' (duration: 836.456602ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T15:52:00.231362Z","caller":"traceutil/trace.go:171","msg":"trace[352607776] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"833.261339ms","start":"2026-06-09T15:51:59.398072Z","end":"2026-06-09T15:52:00.231333Z","steps":["trace[352607776] 'process raft request' (duration: 832.97854ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:52:00.231378Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:51:59.394526Z","time spent":"836.831273ms","remote":"127.0.0.1:43622","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-09T15:52:00.23139Z","caller":"traceutil/trace.go:171","msg":"trace[118975011] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"837.69ms","start":"2026-06-09T15:51:59.393669Z","end":"2026-06-09T15:52:00.231359Z","steps":["trace[118975011] 'process raft request' (duration: 837.280227ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:52:00.23143Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:51:59.398054Z","time spent":"833.341811ms","remote":"127.0.0.1:43622","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-09T15:52:00.231447Z","caller":"traceutil/trace.go:171","msg":"trace[1354349807] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"833.293549ms","start":"2026-06-09T15:51:59.398144Z","end":"2026-06-09T15:52:00.231437Z","steps":["trace[1354349807] 'process raft request' (duration: 832.992219ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:52:00.231487Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:51:59.398139Z","time spent":"833.328491ms","remote":"127.0.0.1:43622","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-09T15:52:00.231523Z","caller":"traceutil/trace.go:171","msg":"trace[1095124692] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"831.636326ms","start":"2026-06-09T15:51:59.399858Z","end":"2026-06-09T15:52:00.231494Z","steps":["trace[1095124692] 'process raft request' (duration: 831.346476ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:52:00.231519Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:51:59.393653Z","time spent":"837.798344ms","remote":"127.0.0.1:43622","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-09T15:52:00.23155Z","caller":"traceutil/trace.go:171","msg":"trace[358416013] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"822.865254ms","start":"2026-06-09T15:51:59.40865Z","end":"2026-06-09T15:52:00.231515Z","steps":["trace[358416013] 'process raft request' (duration: 822.621846ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:52:00.23159Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:51:59.399851Z","time spent":"831.709438ms","remote":"127.0.0.1:43622","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-09T15:52:00.231618Z","caller":"traceutil/trace.go:171","msg":"trace[1998413477] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"820.26647ms","start":"2026-06-09T15:51:59.411336Z","end":"2026-06-09T15:52:00.231602Z","steps":["trace[1998413477] 'process raft request' (duration: 820.058244ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:52:00.23167Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:51:59.411325Z","time spent":"820.321202ms","remote":"127.0.0.1:43622","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-09T15:52:00.231668Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:51:59.408629Z","time spent":"822.984228ms","remote":"127.0.0.1:43622","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-09T15:52:00.231805Z","caller":"traceutil/trace.go:171","msg":"trace[1354259074] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"803.776099ms","start":"2026-06-09T15:51:59.428018Z","end":"2026-06-09T15:52:00.231794Z","steps":["trace[1354259074] 'process raft request' (duration: 803.48837ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:52:00.231866Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:51:59.427946Z","time spent":"803.894263ms","remote":"127.0.0.1:43622","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-09T15:52:00.232075Z","caller":"traceutil/trace.go:171","msg":"trace[888598438] linearizableReadLoop","detail":"{readStateIndex:561; appliedIndex:550; }","duration":"675.076527ms","start":"2026-06-09T15:51:59.556988Z","end":"2026-06-09T15:52:00.232064Z","steps":["trace[888598438] 'read index received' (duration: 653.814973ms)","trace[888598438] 'applied index is now lower than readState.Index' (duration: 21.260764ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T15:52:00.23213Z","caller":"traceutil/trace.go:171","msg":"trace[563785489] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"668.293939ms","start":"2026-06-09T15:51:59.563831Z","end":"2026-06-09T15:52:00.232125Z","steps":["trace[563785489] 'process raft request' (duration: 667.827994ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:52:00.23217Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:51:59.563803Z","time spent":"668.340921ms","remote":"127.0.0.1:43622","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-09T15:52:00.232297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"675.308805ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T15:52:00.232346Z","caller":"traceutil/trace.go:171","msg":"trace[1088403908] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:543; }","duration":"675.404558ms","start":"2026-06-09T15:51:59.556928Z","end":"2026-06-09T15:52:00.232333Z","steps":["trace[1088403908] 'agreement among raft nodes before linearized reading' (duration: 675.276514ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:52:00.23238Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:51:59.556901Z","time spent":"675.47191ms","remote":"127.0.0.1:43594","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-09T15:52:00.244408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"519.109818ms","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-09T15:52:00.244687Z","caller":"traceutil/trace.go:171","msg":"trace[50258284] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:546; }","duration":"519.433888ms","start":"2026-06-09T15:51:59.725237Z","end":"2026-06-09T15:52:00.244671Z","steps":["trace[50258284] 'agreement among raft nodes before linearized reading' (duration: 519.119728ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:52:00.244766Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:51:59.725209Z","time spent":"519.545282ms","remote":"127.0.0.1:43780","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-09T15:52:00.244961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"397.278607ms","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-09T15:52:00.245032Z","caller":"traceutil/trace.go:171","msg":"trace[146566853] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:546; }","duration":"397.362509ms","start":"2026-06-09T15:51:59.84765Z","end":"2026-06-09T15:52:00.245012Z","steps":["trace[146566853] 'agreement among raft nodes before linearized reading' (duration: 397.276986ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:52:00.245123Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:51:59.847636Z","time spent":"397.456102ms","remote":"127.0.0.1:43780","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-09T15:52:00.245615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.785742ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-06-09T15:52:00.244828Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.358792ms","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-09T15:52:00.248088Z","caller":"traceutil/trace.go:171","msg":"trace[891954338] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:546; }","duration":"342.685879ms","start":"2026-06-09T15:51:59.905389Z","end":"2026-06-09T15:52:00.248074Z","steps":["trace[891954338] 'agreement among raft nodes before linearized reading' (duration: 339.347262ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T15:52:00.248126Z","caller":"traceutil/trace.go:171","msg":"trace[1328513144] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:546; }","duration":"244.353505ms","start":"2026-06-09T15:52:00.003584Z","end":"2026-06-09T15:52:00.247937Z","steps":["trace[1328513144] 'agreement among raft nodes before linearized reading' (duration: 241.018398ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:52:00.248139Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:51:59.905367Z","time spent":"342.755902ms","remote":"127.0.0.1:43780","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-09T15:52:06.805982Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"548.435681ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T15:52:06.806093Z","caller":"traceutil/trace.go:171","msg":"trace[1399225474] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:639; }","duration":"548.592726ms","start":"2026-06-09T15:52:06.257477Z","end":"2026-06-09T15:52:06.80607Z","steps":["trace[1399225474] 'range keys from in-memory index tree' (duration: 548.356288ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:52:06.806101Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"505.143638ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-06-09T15:52:06.806144Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:52:06.257462Z","time spent":"548.671548ms","remote":"127.0.0.1:43768","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":29,"request content":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" "} {"level":"info","ts":"2026-06-09T15:52:06.806188Z","caller":"traceutil/trace.go:171","msg":"trace[188041256] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:639; }","duration":"505.245491ms","start":"2026-06-09T15:52:06.300919Z","end":"2026-06-09T15:52:06.806165Z","steps":["trace[188041256] 'range keys from in-memory index tree' (duration: 504.942821ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:52:06.806149Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.041093ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-09T15:52:06.806245Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:52:06.300732Z","time spent":"505.5038ms","remote":"127.0.0.1:43780","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-09T15:52:06.806265Z","caller":"traceutil/trace.go:171","msg":"trace[269074462] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:639; }","duration":"248.179087ms","start":"2026-06-09T15:52:06.558048Z","end":"2026-06-09T15:52:06.806227Z","steps":["trace[269074462] 'range keys from in-memory index tree' (duration: 247.970081ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:52:06.806508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"505.741927ms","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-09T15:52:06.80654Z","caller":"traceutil/trace.go:171","msg":"trace[967258280] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:639; }","duration":"505.798179ms","start":"2026-06-09T15:52:06.300731Z","end":"2026-06-09T15:52:06.806529Z","steps":["trace[967258280] 'range keys from in-memory index tree' (duration: 505.589043ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:52:06.806566Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:52:06.300715Z","time spent":"505.84607ms","remote":"127.0.0.1:43780","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-09T15:52:06.80693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"506.270174ms","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-09T15:52:06.806964Z","caller":"traceutil/trace.go:171","msg":"trace[579363600] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:639; }","duration":"506.324096ms","start":"2026-06-09T15:52:06.30063Z","end":"2026-06-09T15:52:06.806954Z","steps":["trace[579363600] 'range keys from in-memory index tree' (duration: 506.14919ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:52:06.806987Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:52:06.30058Z","time spent":"506.399869ms","remote":"127.0.0.1:43780","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-09T15:52:06.807007Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"506.281014ms","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-09T15:52:06.807049Z","caller":"traceutil/trace.go:171","msg":"trace[1634426256] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:639; }","duration":"506.335447ms","start":"2026-06-09T15:52:06.300702Z","end":"2026-06-09T15:52:06.807037Z","steps":["trace[1634426256] 'range keys from in-memory index tree' (duration: 506.205812ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:52:06.807077Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:52:06.300697Z","time spent":"506.372868ms","remote":"127.0.0.1:43780","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-09T15:52:08.197718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"802.792027ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-09T15:52:08.198216Z","caller":"traceutil/trace.go:171","msg":"trace[1294196476] transaction","detail":"{read_only:false; response_revision:641; number_of_response:1; }","duration":"1.386815454s","start":"2026-06-09T15:52:06.811307Z","end":"2026-06-09T15:52:08.198123Z","steps":["trace[1294196476] 'process raft request' (duration: 583.099727ms)","trace[1294196476] 'compare' (duration: 802.596841ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T15:52:08.198289Z","caller":"traceutil/trace.go:171","msg":"trace[216903066] linearizableReadLoop","detail":"{readStateIndex:668; appliedIndex:665; }","duration":"1.228124347s","start":"2026-06-09T15:52:06.970141Z","end":"2026-06-09T15:52:08.198265Z","steps":["trace[216903066] 'read index received' (duration: 424.359618ms)","trace[216903066] 'applied index is now lower than readState.Index' (duration: 803.763619ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T15:52:08.198435Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:52:06.811284Z","time spent":"1.387035762s","remote":"127.0.0.1:43780","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T15:52:08.198397Z","caller":"traceutil/trace.go:171","msg":"trace[697847161] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"1.386793703s","start":"2026-06-09T15:52:06.81155Z","end":"2026-06-09T15:52:08.198344Z","steps":["trace[697847161] 'process raft request' (duration: 1.386494764s)"],"step_count":1} {"level":"info","ts":"2026-06-09T15:52:08.19842Z","caller":"traceutil/trace.go:171","msg":"trace[958026318] transaction","detail":"{read_only:false; response_revision:643; number_of_response:1; }","duration":"1.386421012s","start":"2026-06-09T15:52:06.811972Z","end":"2026-06-09T15:52:08.198393Z","steps":["trace[958026318] 'process raft request' (duration: 1.386240126s)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:52:08.198614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.228454877s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-dkbxf\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-06-09T15:52:08.198684Z","caller":"traceutil/trace.go:171","msg":"trace[708339192] range","detail":"{range_begin:/registry/pods/kube-system/cilium-dkbxf; range_end:; response_count:1; response_revision:643; }","duration":"1.228565591s","start":"2026-06-09T15:52:06.970099Z","end":"2026-06-09T15:52:08.198664Z","steps":["trace[708339192] 'agreement among raft nodes before linearized reading' (duration: 1.228379165s)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:52:08.198734Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:52:06.811967Z","time spent":"1.38667846s","remote":"127.0.0.1:43780","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T15:52:08.198758Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:52:06.97008Z","time spent":"1.228663404s","remote":"127.0.0.1:43728","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16985,"request content":"key:\"/registry/pods/kube-system/cilium-dkbxf\" "} {"level":"warn","ts":"2026-06-09T15:52:08.198803Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:52:06.811542Z","time spent":"1.387137254s","remote":"127.0.0.1:43780","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T15:52:08.696858Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.301409185s","expected-duration":"1s"} {"level":"warn","ts":"2026-06-09T15:52:08.804172Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.462946ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-09T15:52:08.805172Z","caller":"traceutil/trace.go:171","msg":"trace[856075392] transaction","detail":"{read_only:false; response_revision:644; number_of_response:1; }","duration":"1.599128688s","start":"2026-06-09T15:52:07.205996Z","end":"2026-06-09T15:52:08.805125Z","steps":["trace[856075392] 'process raft request' (duration: 1.491553846s)","trace[856075392] 'compare' (duration: 105.697201ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T15:52:08.805317Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:52:07.205967Z","time spent":"1.599261422s","remote":"127.0.0.1:43656","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036301,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T15:52:09.035333Z","caller":"traceutil/trace.go:171","msg":"trace[1346981828] transaction","detail":"{read_only:false; response_revision:645; number_of_response:1; }","duration":"1.3583847s","start":"2026-06-09T15:52:07.676908Z","end":"2026-06-09T15:52:09.035292Z","steps":["trace[1346981828] 'process raft request' (duration: 1.285967009s)","trace[1346981828] 'compare' (duration: 72.248425ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T15:52:09.035482Z","caller":"traceutil/trace.go:171","msg":"trace[1342212682] transaction","detail":"{read_only:false; response_revision:646; number_of_response:1; }","duration":"819.653371ms","start":"2026-06-09T15:52:08.215806Z","end":"2026-06-09T15:52:09.035459Z","steps":["trace[1342212682] 'process raft request' (duration: 819.434074ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:52:09.035539Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:52:07.676885Z","time spent":"1.358547674s","remote":"127.0.0.1:43780","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T15:52:09.035636Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:52:08.215779Z","time spent":"819.774274ms","remote":"127.0.0.1:43728","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T15:52:09.03581Z","caller":"traceutil/trace.go:171","msg":"trace[1557365932] linearizableReadLoop","detail":"{readStateIndex:670; appliedIndex:668; }","duration":"837.313349ms","start":"2026-06-09T15:52:08.198486Z","end":"2026-06-09T15:52:09.035799Z","steps":["trace[1557365932] 'read index received' (duration: 498.620248ms)","trace[1557365932] 'applied index is now lower than readState.Index' (duration: 338.692251ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T15:52:09.035903Z","caller":"traceutil/trace.go:171","msg":"trace[1827348919] transaction","detail":"{read_only:false; response_revision:647; number_of_response:1; }","duration":"141.392291ms","start":"2026-06-09T15:52:08.894503Z","end":"2026-06-09T15:52:09.035895Z","steps":["trace[1827348919] 'process raft request' (duration: 140.787441ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:52:09.035987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.470028653s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T15:52:09.036049Z","caller":"traceutil/trace.go:171","msg":"trace[95340672] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:647; }","duration":"1.470122835s","start":"2026-06-09T15:52:07.565913Z","end":"2026-06-09T15:52:09.036036Z","steps":["trace[95340672] 'agreement among raft nodes before linearized reading' (duration: 1.469981611s)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:52:09.036081Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:52:07.565892Z","time spent":"1.470182938s","remote":"127.0.0.1:43598","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-09T15:52:09.036435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.617487ms","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-09T15:52:09.036487Z","caller":"traceutil/trace.go:171","msg":"trace[846215345] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:647; }","duration":"168.721801ms","start":"2026-06-09T15:52:08.867752Z","end":"2026-06-09T15:52:09.036474Z","steps":["trace[846215345] 'agreement among raft nodes before linearized reading' (duration: 168.334288ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:52:09.542191Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8620627102956008589,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-09T15:52:10.043376Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8620627102956008589,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-09T15:52:10.496849Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.45632901s","expected-duration":"1s"} {"level":"warn","ts":"2026-06-09T15:52:11.683759Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.186771646s","expected-duration":"1s"} {"level":"warn","ts":"2026-06-09T15:52:11.791566Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.857790403s","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T15:52:11.791715Z","caller":"traceutil/trace.go:171","msg":"trace[279427204] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:647; }","duration":"1.857945608s","start":"2026-06-09T15:52:09.933747Z","end":"2026-06-09T15:52:11.791692Z","steps":["trace[279427204] 'range keys from in-memory index tree' (duration: 1.857775042s)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:52:11.792097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.294967398s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-09T15:52:11.792444Z","caller":"traceutil/trace.go:171","msg":"trace[1688242931] transaction","detail":"{read_only:false; response_revision:648; number_of_response:1; }","duration":"2.751980691s","start":"2026-06-09T15:52:09.040451Z","end":"2026-06-09T15:52:11.792431Z","steps":["trace[1688242931] 'process raft request' (duration: 1.456599059s)","trace[1688242931] 'compare' (duration: 1.29440539s)"],"step_count":2} {"level":"warn","ts":"2026-06-09T15:52:11.792547Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:52:09.04044Z","time spent":"2.752036923s","remote":"127.0.0.1:43780","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T15:52:11.792658Z","caller":"traceutil/trace.go:171","msg":"trace[944197653] linearizableReadLoop","detail":"{readStateIndex:673; appliedIndex:672; }","duration":"2.751131714s","start":"2026-06-09T15:52:09.041499Z","end":"2026-06-09T15:52:11.792631Z","steps":["trace[944197653] 'read index received' (duration: 1.455537666s)","trace[944197653] 'applied index is now lower than readState.Index' (duration: 1.295590028s)"],"step_count":2} {"level":"warn","ts":"2026-06-09T15:52:11.823796Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.782290227s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/job-controller\" ","response":"range_response_count:1 size:193"} {"level":"warn","ts":"2026-06-09T15:52:11.823813Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.616045213s","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-09T15:52:11.823889Z","caller":"traceutil/trace.go:171","msg":"trace[1405431996] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:648; }","duration":"1.616135575s","start":"2026-06-09T15:52:10.207735Z","end":"2026-06-09T15:52:11.823871Z","steps":["trace[1405431996] 'agreement among raft nodes before linearized reading' (duration: 1.615922439s)"],"step_count":1} {"level":"info","ts":"2026-06-09T15:52:11.823896Z","caller":"traceutil/trace.go:171","msg":"trace[1767592824] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/job-controller; range_end:; response_count:1; response_revision:648; }","duration":"2.782391819s","start":"2026-06-09T15:52:09.041475Z","end":"2026-06-09T15:52:11.823867Z","steps":["trace[1767592824] 'agreement among raft nodes before linearized reading' (duration: 2.75133238s)","trace[1767592824] 'range keys from in-memory index tree' (duration: 30.928915ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T15:52:11.823944Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:52:09.041464Z","time spent":"2.782470722s","remote":"127.0.0.1:43746","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":217,"request content":"key:\"/registry/serviceaccounts/kube-system/job-controller\" "} {"level":"warn","ts":"2026-06-09T15:52:11.823946Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:52:10.207678Z","time spent":"1.616247179s","remote":"127.0.0.1:43780","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-09T15:52:11.823976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.615929298s","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-09T15:52:11.824059Z","caller":"traceutil/trace.go:171","msg":"trace[1996016981] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:648; }","duration":"1.616028902s","start":"2026-06-09T15:52:10.20801Z","end":"2026-06-09T15:52:11.824039Z","steps":["trace[1996016981] 'agreement among raft nodes before linearized reading' (duration: 1.615785644s)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:52:11.824103Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:52:10.208005Z","time spent":"1.616091024s","remote":"127.0.0.1:43780","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-09T15:52:11.823976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.616084514s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-06-09T15:52:11.823796Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.267435222s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T15:52:11.824297Z","caller":"traceutil/trace.go:171","msg":"trace[1722501374] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:648; }","duration":"1.267966729s","start":"2026-06-09T15:52:10.556293Z","end":"2026-06-09T15:52:11.824259Z","steps":["trace[1722501374] 'agreement among raft nodes before linearized reading' (duration: 1.267401101s)"],"step_count":1} {"level":"info","ts":"2026-06-09T15:52:11.82426Z","caller":"traceutil/trace.go:171","msg":"trace[497599556] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:648; }","duration":"1.616329172s","start":"2026-06-09T15:52:10.207857Z","end":"2026-06-09T15:52:11.824187Z","steps":["trace[497599556] 'agreement among raft nodes before linearized reading' (duration: 1.615949509s)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:52:11.824365Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:52:10.556275Z","time spent":"1.268057972s","remote":"127.0.0.1:43598","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-09T15:52:11.824439Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:52:10.207794Z","time spent":"1.61658544s","remote":"127.0.0.1:43780","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-09T15:52:13.75208Z","caller":"traceutil/trace.go:171","msg":"trace[720686556] linearizableReadLoop","detail":"{readStateIndex:706; appliedIndex:705; }","duration":"195.036948ms","start":"2026-06-09T15:52:13.557023Z","end":"2026-06-09T15:52:13.75206Z","steps":["trace[720686556] 'read index received' (duration: 194.896613ms)","trace[720686556] 'applied index is now lower than readState.Index' (duration: 139.415µs)"],"step_count":2} {"level":"info","ts":"2026-06-09T15:52:13.752117Z","caller":"traceutil/trace.go:171","msg":"trace[1733822445] transaction","detail":"{read_only:false; response_revision:680; number_of_response:1; }","duration":"296.939427ms","start":"2026-06-09T15:52:13.455158Z","end":"2026-06-09T15:52:13.752097Z","steps":["trace[1733822445] 'process raft request' (duration: 296.73706ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:52:13.752287Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.224843ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T15:52:13.752326Z","caller":"traceutil/trace.go:171","msg":"trace[623772266] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:680; }","duration":"195.346337ms","start":"2026-06-09T15:52:13.55697Z","end":"2026-06-09T15:52:13.752317Z","steps":["trace[623772266] 'agreement among raft nodes before linearized reading' (duration: 195.195792ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T15:52:24.122652Z","caller":"traceutil/trace.go:171","msg":"trace[399574686] linearizableReadLoop","detail":"{readStateIndex:821; appliedIndex:820; }","duration":"235.233261ms","start":"2026-06-09T15:52:23.887395Z","end":"2026-06-09T15:52:24.122628Z","steps":["trace[399574686] 'read index received' (duration: 235.044185ms)","trace[399574686] 'applied index is now lower than readState.Index' (duration: 188.186µs)"],"step_count":2} {"level":"warn","ts":"2026-06-09T15:52:24.122892Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.472459ms","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-09T15:52:24.122976Z","caller":"traceutil/trace.go:171","msg":"trace[143120969] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:792; }","duration":"235.609403ms","start":"2026-06-09T15:52:23.887352Z","end":"2026-06-09T15:52:24.122961Z","steps":["trace[143120969] 'agreement among raft nodes before linearized reading' (duration: 235.396477ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T15:52:24.122732Z","caller":"traceutil/trace.go:171","msg":"trace[320753911] transaction","detail":"{read_only:false; response_revision:792; number_of_response:1; }","duration":"266.672043ms","start":"2026-06-09T15:52:23.856029Z","end":"2026-06-09T15:52:24.122701Z","steps":["trace[320753911] 'process raft request' (duration: 266.457446ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:52:24.123346Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.912893ms","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-09T15:52:24.123414Z","caller":"traceutil/trace.go:171","msg":"trace[1353280145] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:792; }","duration":"236.015516ms","start":"2026-06-09T15:52:23.887378Z","end":"2026-06-09T15:52:24.123394Z","steps":["trace[1353280145] 'agreement among raft nodes before linearized reading' (duration: 235.83257ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:52:24.123398Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.893193ms","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-09T15:52:24.123478Z","caller":"traceutil/trace.go:171","msg":"trace[325947757] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:792; }","duration":"235.983845ms","start":"2026-06-09T15:52:23.887476Z","end":"2026-06-09T15:52:24.12346Z","steps":["trace[325947757] 'agreement among raft nodes before linearized reading' (duration: 235.775619ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T15:52:24.567895Z","caller":"traceutil/trace.go:171","msg":"trace[1923136499] transaction","detail":"{read_only:false; response_revision:793; number_of_response:1; }","duration":"440.984712ms","start":"2026-06-09T15:52:24.126882Z","end":"2026-06-09T15:52:24.567867Z","steps":["trace[1923136499] 'process raft request' (duration: 423.18764ms)","trace[1923136499] 'compare' (duration: 17.296786ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T15:52:24.568061Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:52:24.126862Z","time spent":"441.125597ms","remote":"127.0.0.1:43780","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T15:52:24.568397Z","caller":"traceutil/trace.go:171","msg":"trace[669122168] transaction","detail":"{read_only:false; response_revision:795; number_of_response:1; }","duration":"440.464086ms","start":"2026-06-09T15:52:24.127912Z","end":"2026-06-09T15:52:24.568376Z","steps":["trace[669122168] 'process raft request' (duration: 440.102074ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:52:24.568478Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:52:24.127905Z","time spent":"440.533258ms","remote":"127.0.0.1:43780","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T15:52:24.568473Z","caller":"traceutil/trace.go:171","msg":"trace[867772772] transaction","detail":"{read_only:false; response_revision:794; number_of_response:1; }","duration":"441.352825ms","start":"2026-06-09T15:52:24.127083Z","end":"2026-06-09T15:52:24.568436Z","steps":["trace[867772772] 'process raft request' (duration: 440.824338ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:52:24.568669Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:52:24.127073Z","time spent":"441.487339ms","remote":"127.0.0.1:43780","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T15:52:28.172968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"401.224634ms","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-09T15:52:28.173129Z","caller":"traceutil/trace.go:171","msg":"trace[135743144] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:811; }","duration":"401.416499ms","start":"2026-06-09T15:52:27.771687Z","end":"2026-06-09T15:52:28.173104Z","steps":["trace[135743144] 'count revisions from in-memory index tree' (duration: 401.10837ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:52:28.173183Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.797813ms","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-09T15:52:28.173283Z","caller":"traceutil/trace.go:171","msg":"trace[59716990] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/; range_end:/registry/apiregistration.k8s.io/apiservices0; response_count:0; response_revision:811; }","duration":"310.960458ms","start":"2026-06-09T15:52:27.862299Z","end":"2026-06-09T15:52:28.173259Z","steps":["trace[59716990] 'count revisions from in-memory index tree' (duration: 310.68262ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:52:28.17324Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:52:27.77167Z","time spent":"401.553774ms","remote":"127.0.0.1:43756","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":29,"request content":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true "} {"level":"warn","ts":"2026-06-09T15:52:28.173338Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:52:27.8622Z","time spent":"311.054481ms","remote":"127.0.0.1:44064","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":29,"response size":31,"request content":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true "} {"level":"info","ts":"2026-06-09T15:52:28.856673Z","caller":"traceutil/trace.go:171","msg":"trace[327293965] transaction","detail":"{read_only:false; response_revision:812; number_of_response:1; }","duration":"680.428579ms","start":"2026-06-09T15:52:28.17622Z","end":"2026-06-09T15:52:28.856648Z","steps":["trace[327293965] 'process raft request' (duration: 680.283154ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:52:28.85686Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:52:28.176198Z","time spent":"680.579014ms","remote":"127.0.0.1:43780","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T15:52:29.312131Z","caller":"traceutil/trace.go:171","msg":"trace[1679459361] linearizableReadLoop","detail":"{readStateIndex:845; appliedIndex:842; }","duration":"756.173758ms","start":"2026-06-09T15:52:28.555932Z","end":"2026-06-09T15:52:29.312106Z","steps":["trace[1679459361] 'read index received' (duration: 300.689508ms)","trace[1679459361] 'applied index is now lower than readState.Index' (duration: 455.48285ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T15:52:29.312183Z","caller":"traceutil/trace.go:171","msg":"trace[78990988] transaction","detail":"{read_only:false; response_revision:813; number_of_response:1; }","duration":"1.129952997s","start":"2026-06-09T15:52:28.182178Z","end":"2026-06-09T15:52:29.312131Z","steps":["trace[78990988] 'process raft request' (duration: 1.129669908s)"],"step_count":1} {"level":"info","ts":"2026-06-09T15:52:29.312262Z","caller":"traceutil/trace.go:171","msg":"trace[1269815042] transaction","detail":"{read_only:false; response_revision:814; number_of_response:1; }","duration":"885.52136ms","start":"2026-06-09T15:52:28.426729Z","end":"2026-06-09T15:52:29.312251Z","steps":["trace[1269815042] 'process raft request' (duration: 885.303713ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:52:29.312339Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:52:28.182153Z","time spent":"1.130104311s","remote":"127.0.0.1:43728","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4027,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T15:52:29.312485Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:52:28.426705Z","time spent":"885.586473ms","remote":"127.0.0.1:43724","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4904,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T15:52:29.312745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"756.818838ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T15:52:29.312844Z","caller":"traceutil/trace.go:171","msg":"trace[1351189701] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:814; }","duration":"756.953792ms","start":"2026-06-09T15:52:28.555861Z","end":"2026-06-09T15:52:29.312815Z","steps":["trace[1351189701] 'agreement among raft nodes before linearized reading' (duration: 756.672553ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:52:29.312901Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:52:28.555835Z","time spent":"757.052586ms","remote":"127.0.0.1:43598","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-09T15:52:29.318296Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.844544ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-06-09T15:52:29.318355Z","caller":"traceutil/trace.go:171","msg":"trace[1426760889] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:815; }","duration":"131.960077ms","start":"2026-06-09T15:52:29.186381Z","end":"2026-06-09T15:52:29.318341Z","steps":["trace[1426760889] 'agreement among raft nodes before linearized reading' (duration: 131.817773ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:52:29.318471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"464.226201ms","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-09T15:52:29.318497Z","caller":"traceutil/trace.go:171","msg":"trace[1631663251] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:815; }","duration":"464.318004ms","start":"2026-06-09T15:52:28.854173Z","end":"2026-06-09T15:52:29.318491Z","steps":["trace[1631663251] 'agreement among raft nodes before linearized reading' (duration: 464.273883ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:52:29.318521Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:52:28.854151Z","time spent":"464.362805ms","remote":"127.0.0.1:43696","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":0,"response size":29,"request content":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true "} {"level":"warn","ts":"2026-06-09T15:52:29.318877Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"733.944942ms","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-09T15:52:29.318904Z","caller":"traceutil/trace.go:171","msg":"trace[188945424] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:815; }","duration":"734.19074ms","start":"2026-06-09T15:52:28.584707Z","end":"2026-06-09T15:52:29.318898Z","steps":["trace[188945424] 'agreement among raft nodes before linearized reading' (duration: 733.926782ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:52:29.318928Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:52:28.584697Z","time spent":"734.223661ms","remote":"127.0.0.1:43780","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-09T15:52:29.31921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"738.365285ms","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-09T15:52:29.319276Z","caller":"traceutil/trace.go:171","msg":"trace[517708206] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:815; }","duration":"738.480768ms","start":"2026-06-09T15:52:28.58078Z","end":"2026-06-09T15:52:29.319261Z","steps":["trace[517708206] 'agreement among raft nodes before linearized reading' (duration: 738.300952ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:52:29.319318Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:52:28.580757Z","time spent":"738.55298ms","remote":"127.0.0.1:43780","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-09T15:52:29.319611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"735.325106ms","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-09T15:52:29.319652Z","caller":"traceutil/trace.go:171","msg":"trace[523034653] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:815; }","duration":"735.380068ms","start":"2026-06-09T15:52:28.584262Z","end":"2026-06-09T15:52:29.319642Z","steps":["trace[523034653] 'agreement among raft nodes before linearized reading' (duration: 734.679616ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:52:29.319679Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:52:28.584255Z","time spent":"735.418379ms","remote":"127.0.0.1:43780","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-09T15:53:03.65745Z","caller":"traceutil/trace.go:171","msg":"trace[1050386288] linearizableReadLoop","detail":"{readStateIndex:1063; appliedIndex:1062; }","duration":"170.555327ms","start":"2026-06-09T15:53:03.486873Z","end":"2026-06-09T15:53:03.657428Z","steps":["trace[1050386288] 'read index received' (duration: 170.378381ms)","trace[1050386288] 'applied index is now lower than readState.Index' (duration: 176.096µs)"],"step_count":2} {"level":"info","ts":"2026-06-09T15:53:03.657574Z","caller":"traceutil/trace.go:171","msg":"trace[949151340] transaction","detail":"{read_only:false; response_revision:1024; number_of_response:1; }","duration":"171.031573ms","start":"2026-06-09T15:53:03.486531Z","end":"2026-06-09T15:53:03.657563Z","steps":["trace[949151340] 'process raft request' (duration: 170.765364ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:53:03.657761Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.203464ms","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-09T15:53:03.657839Z","caller":"traceutil/trace.go:171","msg":"trace[133046963] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1024; }","duration":"166.313278ms","start":"2026-06-09T15:53:03.491508Z","end":"2026-06-09T15:53:03.657822Z","steps":["trace[133046963] 'agreement among raft nodes before linearized reading' (duration: 166.123022ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:53:03.657945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.177829ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T15:53:03.657991Z","caller":"traceutil/trace.go:171","msg":"trace[1682518564] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1024; }","duration":"100.273072ms","start":"2026-06-09T15:53:03.557708Z","end":"2026-06-09T15:53:03.657981Z","steps":["trace[1682518564] 'agreement among raft nodes before linearized reading' (duration: 100.1952ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:53:03.658125Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.706076ms","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-09T15:53:03.658181Z","caller":"traceutil/trace.go:171","msg":"trace[656639721] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1024; }","duration":"164.792868ms","start":"2026-06-09T15:53:03.493375Z","end":"2026-06-09T15:53:03.658168Z","steps":["trace[656639721] 'agreement among raft nodes before linearized reading' (duration: 164.645544ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:53:03.658517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.339483ms","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-09T15:53:03.658579Z","caller":"traceutil/trace.go:171","msg":"trace[1238399374] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1024; }","duration":"171.724605ms","start":"2026-06-09T15:53:03.486839Z","end":"2026-06-09T15:53:03.658564Z","steps":["trace[1238399374] 'agreement among raft nodes before linearized reading' (duration: 171.288271ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:53:04.333909Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8620627102956009403,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-09T15:53:04.724503Z","caller":"traceutil/trace.go:171","msg":"trace[759198424] transaction","detail":"{read_only:false; response_revision:1025; number_of_response:1; }","duration":"1.061023583s","start":"2026-06-09T15:53:03.663454Z","end":"2026-06-09T15:53:04.724478Z","steps":["trace[759198424] 'process raft request' (duration: 989.474769ms)","trace[759198424] 'compare' (duration: 71.292986ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T15:53:04.724719Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:53:03.663436Z","time spent":"1.061137818s","remote":"127.0.0.1:43780","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T15:53:05.578408Z","caller":"traceutil/trace.go:171","msg":"trace[1851658721] transaction","detail":"{read_only:false; response_revision:1026; number_of_response:1; }","duration":"1.914646057s","start":"2026-06-09T15:53:03.663738Z","end":"2026-06-09T15:53:05.578384Z","steps":["trace[1851658721] 'process raft request' (duration: 1.914364888s)"],"step_count":1} {"level":"info","ts":"2026-06-09T15:53:05.578555Z","caller":"traceutil/trace.go:171","msg":"trace[960110131] transaction","detail":"{read_only:false; response_revision:1027; number_of_response:1; }","duration":"1.913626533s","start":"2026-06-09T15:53:03.664916Z","end":"2026-06-09T15:53:05.578543Z","steps":["trace[960110131] 'process raft request' (duration: 1.913412306s)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:53:05.578633Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:53:03.664911Z","time spent":"1.913686016s","remote":"127.0.0.1:43780","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T15:53:05.57864Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:53:03.663717Z","time spent":"1.91477664s","remote":"127.0.0.1:43780","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T15:53:05.578695Z","caller":"traceutil/trace.go:171","msg":"trace[82827129] linearizableReadLoop","detail":"{readStateIndex:1066; appliedIndex:1063; }","duration":"1.745703064s","start":"2026-06-09T15:53:03.832977Z","end":"2026-06-09T15:53:05.57868Z","steps":["trace[82827129] 'read index received' (duration: 819.920537ms)","trace[82827129] 'applied index is now lower than readState.Index' (duration: 925.781817ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T15:53:05.578804Z","caller":"traceutil/trace.go:171","msg":"trace[205108140] transaction","detail":"{read_only:false; response_revision:1028; number_of_response:1; }","duration":"1.061214087s","start":"2026-06-09T15:53:04.517552Z","end":"2026-06-09T15:53:05.578766Z","steps":["trace[205108140] 'process raft request' (duration: 1.060945948s)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:53:05.578834Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.640044516s","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-09T15:53:05.578864Z","caller":"traceutil/trace.go:171","msg":"trace[363401365] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:1028; }","duration":"1.640115518s","start":"2026-06-09T15:53:03.938741Z","end":"2026-06-09T15:53:05.578856Z","steps":["trace[363401365] 'agreement among raft nodes before linearized reading' (duration: 1.640064576s)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:53:05.578861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.74588914s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-06-09T15:53:05.578886Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:53:03.938717Z","time spent":"1.64016379s","remote":"127.0.0.1:43662","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":5,"response size":31,"request content":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true "} {"level":"info","ts":"2026-06-09T15:53:05.578893Z","caller":"traceutil/trace.go:171","msg":"trace[1662495339] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:1028; }","duration":"1.745954782s","start":"2026-06-09T15:53:03.832928Z","end":"2026-06-09T15:53:05.578883Z","steps":["trace[1662495339] 'agreement among raft nodes before linearized reading' (duration: 1.745823498s)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:53:05.578905Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:53:04.517534Z","time spent":"1.0613209s","remote":"127.0.0.1:43780","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T15:53:05.57895Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:53:03.832909Z","time spent":"1.746006344s","remote":"127.0.0.1:43876","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":68,"response size":31,"request content":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true "} {"level":"warn","ts":"2026-06-09T15:53:05.57903Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.001734596s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-06-09T15:53:05.579029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"809.024547ms","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-09T15:53:05.579049Z","caller":"traceutil/trace.go:171","msg":"trace[1600104497] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:1028; }","duration":"1.001808408s","start":"2026-06-09T15:53:04.577236Z","end":"2026-06-09T15:53:05.579044Z","steps":["trace[1600104497] 'agreement among raft nodes before linearized reading' (duration: 1.001761947s)"],"step_count":1} {"level":"info","ts":"2026-06-09T15:53:05.579061Z","caller":"traceutil/trace.go:171","msg":"trace[155637732] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:1028; }","duration":"809.082339ms","start":"2026-06-09T15:53:04.769969Z","end":"2026-06-09T15:53:05.579052Z","steps":["trace[155637732] 'agreement among raft nodes before linearized reading' (duration: 809.026408ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:53:05.579087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.020894701s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-09T15:53:05.57909Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:53:04.769953Z","time spent":"809.12857ms","remote":"127.0.0.1:43950","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":13,"response size":31,"request content":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true "} {"level":"info","ts":"2026-06-09T15:53:05.579109Z","caller":"traceutil/trace.go:171","msg":"trace[1826007996] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1028; }","duration":"1.020950723s","start":"2026-06-09T15:53:04.558146Z","end":"2026-06-09T15:53:05.579096Z","steps":["trace[1826007996] 'agreement among raft nodes before linearized reading' (duration: 1.020930732s)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:53:05.579123Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:53:04.558122Z","time spent":"1.020997215s","remote":"127.0.0.1:43598","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-09T15:53:05.579216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"674.957792ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T15:53:05.579247Z","caller":"traceutil/trace.go:171","msg":"trace[1404912422] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:1028; }","duration":"675.014474ms","start":"2026-06-09T15:53:04.904222Z","end":"2026-06-09T15:53:05.579237Z","steps":["trace[1404912422] 'agreement among raft nodes before linearized reading' (duration: 674.968443ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:53:05.579261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.060762ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.65\" ","response":"range_response_count:1 size:133"} {"level":"warn","ts":"2026-06-09T15:53:05.579261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.264410348s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-09T15:53:05.579272Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:53:04.904207Z","time spent":"675.057216ms","remote":"127.0.0.1:37836","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"info","ts":"2026-06-09T15:53:05.57929Z","caller":"traceutil/trace.go:171","msg":"trace[1948208559] range","detail":"{range_begin:/registry/masterleases/199.204.45.65; range_end:; response_count:1; response_revision:1028; }","duration":"251.123254ms","start":"2026-06-09T15:53:05.328158Z","end":"2026-06-09T15:53:05.579281Z","steps":["trace[1948208559] 'agreement among raft nodes before linearized reading' (duration: 251.028511ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:53:05.579066Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:53:04.577214Z","time spent":"1.00184706s","remote":"127.0.0.1:43656","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":9,"response size":31,"request content":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true "} {"level":"info","ts":"2026-06-09T15:53:05.579294Z","caller":"traceutil/trace.go:171","msg":"trace[913908618] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:1028; }","duration":"1.2644806s","start":"2026-06-09T15:53:04.314805Z","end":"2026-06-09T15:53:05.579286Z","steps":["trace[913908618] 'agreement among raft nodes before linearized reading' (duration: 1.264419878s)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:53:05.579321Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:53:04.314785Z","time spent":"1.264528412s","remote":"127.0.0.1:43688","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":29,"request content":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true "} {"level":"warn","ts":"2026-06-09T15:53:05.579563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"561.426169ms","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-09T15:53:05.579615Z","caller":"traceutil/trace.go:171","msg":"trace[1349196232] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1028; }","duration":"561.514721ms","start":"2026-06-09T15:53:05.01809Z","end":"2026-06-09T15:53:05.579604Z","steps":["trace[1349196232] 'agreement among raft nodes before linearized reading' (duration: 561.293694ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:53:05.579668Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:53:05.018069Z","time spent":"561.568954ms","remote":"127.0.0.1:43780","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-09T15:53:23.843619Z","caller":"traceutil/trace.go:171","msg":"trace[1707542994] linearizableReadLoop","detail":"{readStateIndex:1129; appliedIndex:1128; }","duration":"181.807732ms","start":"2026-06-09T15:53:23.661788Z","end":"2026-06-09T15:53:23.843596Z","steps":["trace[1707542994] 'read index received' (duration: 181.672478ms)","trace[1707542994] 'applied index is now lower than readState.Index' (duration: 133.774µs)"],"step_count":2} {"level":"info","ts":"2026-06-09T15:53:23.843666Z","caller":"traceutil/trace.go:171","msg":"trace[1506839554] transaction","detail":"{read_only:false; response_revision:1086; number_of_response:1; }","duration":"189.461443ms","start":"2026-06-09T15:53:23.654173Z","end":"2026-06-09T15:53:23.843635Z","steps":["trace[1506839554] 'process raft request' (duration: 189.259716ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:53:23.844291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.048875ms","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-09T15:53:23.844338Z","caller":"traceutil/trace.go:171","msg":"trace[537662653] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1086; }","duration":"180.129008ms","start":"2026-06-09T15:53:23.664196Z","end":"2026-06-09T15:53:23.844325Z","steps":["trace[537662653] 'agreement among raft nodes before linearized reading' (duration: 179.58427ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:53:23.84444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.448827ms","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-09T15:53:23.844465Z","caller":"traceutil/trace.go:171","msg":"trace[865696472] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1086; }","duration":"100.486258ms","start":"2026-06-09T15:53:23.743972Z","end":"2026-06-09T15:53:23.844458Z","steps":["trace[865696472] 'agreement among raft nodes before linearized reading' (duration: 99.826977ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:53:23.844583Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.778605ms","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-09T15:53:23.844651Z","caller":"traceutil/trace.go:171","msg":"trace[1072514695] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1086; }","duration":"182.884328ms","start":"2026-06-09T15:53:23.661748Z","end":"2026-06-09T15:53:23.844632Z","steps":["trace[1072514695] 'agreement among raft nodes before linearized reading' (duration: 181.998299ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T15:53:25.94796Z","caller":"traceutil/trace.go:171","msg":"trace[159931747] linearizableReadLoop","detail":"{readStateIndex:1136; appliedIndex:1135; }","duration":"384.707604ms","start":"2026-06-09T15:53:25.563221Z","end":"2026-06-09T15:53:25.947929Z","steps":["trace[159931747] 'read index received' (duration: 384.450696ms)","trace[159931747] 'applied index is now lower than readState.Index' (duration: 255.298µs)"],"step_count":2} {"level":"info","ts":"2026-06-09T15:53:25.948123Z","caller":"traceutil/trace.go:171","msg":"trace[1875989377] transaction","detail":"{read_only:false; response_revision:1092; number_of_response:1; }","duration":"542.069189ms","start":"2026-06-09T15:53:25.406022Z","end":"2026-06-09T15:53:25.948091Z","steps":["trace[1875989377] 'process raft request' (duration: 541.705617ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:53:25.948228Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"384.991103ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T15:53:25.948276Z","caller":"traceutil/trace.go:171","msg":"trace[906845786] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1092; }","duration":"385.108517ms","start":"2026-06-09T15:53:25.563153Z","end":"2026-06-09T15:53:25.948262Z","steps":["trace[906845786] 'agreement among raft nodes before linearized reading' (duration: 384.926421ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:53:25.948287Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:53:25.405998Z","time spent":"542.195763ms","remote":"127.0.0.1:43610","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":118,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T15:53:25.948319Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:53:25.563117Z","time spent":"385.19479ms","remote":"127.0.0.1:43598","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-09T15:53:25.952538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.805669ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T15:53:25.952611Z","caller":"traceutil/trace.go:171","msg":"trace[351407480] range","detail":"{range_begin:/registry/validatingwebhookconfigurations/; range_end:/registry/validatingwebhookconfigurations0; response_count:0; response_revision:1093; }","duration":"286.908763ms","start":"2026-06-09T15:53:25.665683Z","end":"2026-06-09T15:53:25.952592Z","steps":["trace[351407480] 'agreement among raft nodes before linearized reading' (duration: 286.816009ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T15:53:26.968666Z","caller":"traceutil/trace.go:171","msg":"trace[552441863] transaction","detail":"{read_only:false; response_revision:1098; number_of_response:1; }","duration":"106.092972ms","start":"2026-06-09T15:53:26.862545Z","end":"2026-06-09T15:53:26.968638Z","steps":["trace[552441863] 'process raft request' (duration: 105.941587ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:53:34.524576Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8620627102956009646,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-09T15:53:34.538643Z","caller":"traceutil/trace.go:171","msg":"trace[1571424153] linearizableReadLoop","detail":"{readStateIndex:1164; appliedIndex:1163; }","duration":"514.306342ms","start":"2026-06-09T15:53:34.024314Z","end":"2026-06-09T15:53:34.538621Z","steps":["trace[1571424153] 'read index received' (duration: 514.104956ms)","trace[1571424153] 'applied index is now lower than readState.Index' (duration: 200.636µs)"],"step_count":2} {"level":"info","ts":"2026-06-09T15:53:34.538703Z","caller":"traceutil/trace.go:171","msg":"trace[1873995234] transaction","detail":"{read_only:false; response_revision:1119; number_of_response:1; }","duration":"539.136633ms","start":"2026-06-09T15:53:33.999533Z","end":"2026-06-09T15:53:34.538669Z","steps":["trace[1873995234] 'process raft request' (duration: 538.940436ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:53:34.538868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"491.54457ms","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-09T15:53:34.538869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"514.542001ms","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-09T15:53:34.538915Z","caller":"traceutil/trace.go:171","msg":"trace[585006008] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1119; }","duration":"491.653543ms","start":"2026-06-09T15:53:34.047248Z","end":"2026-06-09T15:53:34.538902Z","steps":["trace[585006008] 'agreement among raft nodes before linearized reading' (duration: 491.507029ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T15:53:34.538958Z","caller":"traceutil/trace.go:171","msg":"trace[687337504] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1119; }","duration":"514.682825ms","start":"2026-06-09T15:53:34.02426Z","end":"2026-06-09T15:53:34.538943Z","steps":["trace[687337504] 'agreement among raft nodes before linearized reading' (duration: 514.457557ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:53:34.538971Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:53:34.047226Z","time spent":"491.737776ms","remote":"127.0.0.1:43780","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-09T15:53:34.538986Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:53:34.02424Z","time spent":"514.738877ms","remote":"127.0.0.1:43780","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-09T15:53:34.538987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.339236ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-09T15:53:34.53896Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.476858ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-09T15:53:34.539033Z","caller":"traceutil/trace.go:171","msg":"trace[1688799443] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:1119; }","duration":"131.443209ms","start":"2026-06-09T15:53:34.407575Z","end":"2026-06-09T15:53:34.539018Z","steps":["trace[1688799443] 'agreement among raft nodes before linearized reading' (duration: 131.367247ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:53:34.539034Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"489.7078ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-06-09T15:53:34.538864Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:53:33.999505Z","time spent":"539.254587ms","remote":"127.0.0.1:43780","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T15:53:34.539049Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"485.246994ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-06-09T15:53:34.539072Z","caller":"traceutil/trace.go:171","msg":"trace[2067780800] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1119; }","duration":"489.764532ms","start":"2026-06-09T15:53:34.049297Z","end":"2026-06-09T15:53:34.539061Z","steps":["trace[2067780800] 'agreement among raft nodes before linearized reading' (duration: 489.583036ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T15:53:34.539066Z","caller":"traceutil/trace.go:171","msg":"trace[690244031] range","detail":"{range_begin:/registry/roles/; range_end:/registry/roles0; response_count:0; response_revision:1119; }","duration":"233.694716ms","start":"2026-06-09T15:53:34.305345Z","end":"2026-06-09T15:53:34.53904Z","steps":["trace[690244031] 'agreement among raft nodes before linearized reading' (duration: 233.447198ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:53:34.539109Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:53:34.049287Z","time spent":"489.815724ms","remote":"127.0.0.1:43780","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-09T15:53:34.539106Z","caller":"traceutil/trace.go:171","msg":"trace[982650539] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1119; }","duration":"485.313877ms","start":"2026-06-09T15:53:34.053778Z","end":"2026-06-09T15:53:34.539092Z","steps":["trace[982650539] 'agreement among raft nodes before linearized reading' (duration: 485.082119ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:53:34.539144Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:53:34.053746Z","time spent":"485.390499ms","remote":"127.0.0.1:43780","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-06-09T15:53:34.803101Z","caller":"traceutil/trace.go:171","msg":"trace[1665134047] transaction","detail":"{read_only:false; response_revision:1120; number_of_response:1; }","duration":"259.57284ms","start":"2026-06-09T15:53:34.543506Z","end":"2026-06-09T15:53:34.803079Z","steps":["trace[1665134047] 'process raft request' (duration: 254.325619ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T15:53:34.828655Z","caller":"traceutil/trace.go:171","msg":"trace[276822050] transaction","detail":"{read_only:false; response_revision:1121; number_of_response:1; }","duration":"284.983359ms","start":"2026-06-09T15:53:34.543657Z","end":"2026-06-09T15:53:34.828641Z","steps":["trace[276822050] 'process raft request' (duration: 284.727521ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T15:53:34.828635Z","caller":"traceutil/trace.go:171","msg":"trace[1570342818] transaction","detail":"{read_only:false; response_revision:1122; number_of_response:1; }","duration":"284.755202ms","start":"2026-06-09T15:53:34.543855Z","end":"2026-06-09T15:53:34.82861Z","steps":["trace[1570342818] 'process raft request' (duration: 284.67203ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T15:53:34.829378Z","caller":"traceutil/trace.go:171","msg":"trace[1281244502] transaction","detail":"{read_only:false; response_revision:1123; number_of_response:1; }","duration":"285.168266ms","start":"2026-06-09T15:53:34.54417Z","end":"2026-06-09T15:53:34.829339Z","steps":["trace[1281244502] 'process raft request' (duration: 284.402261ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:53:35.89229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"403.045072ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-09T15:53:35.892386Z","caller":"traceutil/trace.go:171","msg":"trace[1817317728] linearizableReadLoop","detail":"{readStateIndex:1171; appliedIndex:1170; }","duration":"332.80794ms","start":"2026-06-09T15:53:35.559563Z","end":"2026-06-09T15:53:35.892371Z","steps":["trace[1817317728] 'read index received' (duration: 64.612µs)","trace[1817317728] 'applied index is now lower than readState.Index' (duration: 332.741768ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T15:53:35.89246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"332.897823ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T15:53:35.892477Z","caller":"traceutil/trace.go:171","msg":"trace[663258694] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1125; }","duration":"332.964486ms","start":"2026-06-09T15:53:35.559506Z","end":"2026-06-09T15:53:35.892471Z","steps":["trace[663258694] 'agreement among raft nodes before linearized reading' (duration: 332.900713ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:53:35.892499Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:53:35.559476Z","time spent":"333.017187ms","remote":"127.0.0.1:43598","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-09T15:53:35.892652Z","caller":"traceutil/trace.go:171","msg":"trace[1217887096] transaction","detail":"{read_only:false; response_revision:1125; number_of_response:1; }","duration":"547.29844ms","start":"2026-06-09T15:53:35.345343Z","end":"2026-06-09T15:53:35.892642Z","steps":["trace[1217887096] 'process raft request' (duration: 143.827164ms)","trace[1217887096] 'compare' (duration: 402.847616ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T15:53:35.892701Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:53:35.345315Z","time spent":"547.365082ms","remote":"127.0.0.1:43610","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":118,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T15:53:36.727408Z","caller":"traceutil/trace.go:171","msg":"trace[359612150] transaction","detail":"{read_only:false; response_revision:1126; number_of_response:1; }","duration":"182.654311ms","start":"2026-06-09T15:53:36.544711Z","end":"2026-06-09T15:53:36.727365Z","steps":["trace[359612150] 'process raft request' (duration: 182.071232ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T15:53:36.95475Z","caller":"traceutil/trace.go:171","msg":"trace[568432836] linearizableReadLoop","detail":"{readStateIndex:1173; appliedIndex:1172; }","duration":"121.954839ms","start":"2026-06-09T15:53:36.832778Z","end":"2026-06-09T15:53:36.954733Z","steps":["trace[568432836] 'read index received' (duration: 121.781683ms)","trace[568432836] 'applied index is now lower than readState.Index' (duration: 172.656µs)"],"step_count":2} {"level":"info","ts":"2026-06-09T15:53:36.954982Z","caller":"traceutil/trace.go:171","msg":"trace[1101479045] transaction","detail":"{read_only:false; response_revision:1127; number_of_response:1; }","duration":"143.755971ms","start":"2026-06-09T15:53:36.811219Z","end":"2026-06-09T15:53:36.954975Z","steps":["trace[1101479045] 'process raft request' (duration: 143.40918ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:53:36.955137Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.883067ms","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-09T15:53:36.955197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.417615ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-06-09T15:53:36.955207Z","caller":"traceutil/trace.go:171","msg":"trace[1259309784] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1127; }","duration":"121.98286ms","start":"2026-06-09T15:53:36.833209Z","end":"2026-06-09T15:53:36.955191Z","steps":["trace[1259309784] 'agreement among raft nodes before linearized reading' (duration: 121.772063ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T15:53:36.955225Z","caller":"traceutil/trace.go:171","msg":"trace[1847081343] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1127; }","duration":"122.492707ms","start":"2026-06-09T15:53:36.832726Z","end":"2026-06-09T15:53:36.955219Z","steps":["trace[1847081343] 'agreement among raft nodes before linearized reading' (duration: 122.382603ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:53:36.955151Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.547785ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-09T15:53:36.9553Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.737533ms","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-09T15:53:36.955316Z","caller":"traceutil/trace.go:171","msg":"trace[819707807] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1127; }","duration":"121.763323ms","start":"2026-06-09T15:53:36.833549Z","end":"2026-06-09T15:53:36.955312Z","steps":["trace[819707807] 'agreement among raft nodes before linearized reading' (duration: 121.722382ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T15:53:36.955296Z","caller":"traceutil/trace.go:171","msg":"trace[978226688] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:1127; }","duration":"105.762321ms","start":"2026-06-09T15:53:36.84951Z","end":"2026-06-09T15:53:36.955272Z","steps":["trace[978226688] 'agreement among raft nodes before linearized reading' (duration: 105.533853ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:53:37.229422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.334069ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-09T15:53:37.22969Z","caller":"traceutil/trace.go:171","msg":"trace[477685411] linearizableReadLoop","detail":"{readStateIndex:1176; appliedIndex:1173; }","duration":"152.92256ms","start":"2026-06-09T15:53:37.076748Z","end":"2026-06-09T15:53:37.229671Z","steps":["trace[477685411] 'read index received' (duration: 31.228609ms)","trace[477685411] 'applied index is now lower than readState.Index' (duration: 121.692761ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T15:53:37.229794Z","caller":"traceutil/trace.go:171","msg":"trace[1885786251] transaction","detail":"{read_only:false; response_revision:1130; number_of_response:1; }","duration":"266.377013ms","start":"2026-06-09T15:53:36.963405Z","end":"2026-06-09T15:53:37.229782Z","steps":["trace[1885786251] 'process raft request' (duration: 266.225228ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T15:53:37.229732Z","caller":"traceutil/trace.go:171","msg":"trace[1898801334] transaction","detail":"{read_only:false; response_revision:1128; number_of_response:1; }","duration":"266.353452ms","start":"2026-06-09T15:53:36.96331Z","end":"2026-06-09T15:53:37.229663Z","steps":["trace[1898801334] 'process raft request' (duration: 144.680182ms)","trace[1898801334] 'compare' (duration: 121.208605ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T15:53:37.229973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.334085ms","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-09T15:53:37.229782Z","caller":"traceutil/trace.go:171","msg":"trace[842371638] transaction","detail":"{read_only:false; response_revision:1129; number_of_response:1; }","duration":"266.361251ms","start":"2026-06-09T15:53:36.963383Z","end":"2026-06-09T15:53:37.229744Z","steps":["trace[842371638] 'process raft request' (duration: 266.189446ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T15:53:37.230063Z","caller":"traceutil/trace.go:171","msg":"trace[1294552156] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/; range_end:/registry/apiregistration.k8s.io/apiservices0; response_count:0; response_revision:1130; }","duration":"127.46877ms","start":"2026-06-09T15:53:37.102561Z","end":"2026-06-09T15:53:37.23003Z","steps":["trace[1294552156] 'agreement among raft nodes before linearized reading' (duration: 127.317135ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:53:37.23032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.560731ms","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-09T15:53:37.23043Z","caller":"traceutil/trace.go:171","msg":"trace[963553283] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1130; }","duration":"153.746897ms","start":"2026-06-09T15:53:37.076664Z","end":"2026-06-09T15:53:37.230411Z","steps":["trace[963553283] 'agreement among raft nodes before linearized reading' (duration: 153.434687ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:53:37.646814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.130806ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-09T15:53:37.647236Z","caller":"traceutil/trace.go:171","msg":"trace[406486180] transaction","detail":"{read_only:false; response_revision:1132; number_of_response:1; }","duration":"320.887131ms","start":"2026-06-09T15:53:37.326317Z","end":"2026-06-09T15:53:37.647204Z","steps":["trace[406486180] 'process raft request' (duration: 320.676374ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T15:53:37.64733Z","caller":"traceutil/trace.go:171","msg":"trace[31465863] transaction","detail":"{read_only:false; response_revision:1131; number_of_response:1; }","duration":"412.222901ms","start":"2026-06-09T15:53:37.235075Z","end":"2026-06-09T15:53:37.647298Z","steps":["trace[31465863] 'process raft request' (duration: 137.482036ms)","trace[31465863] 'compare' (duration: 273.97216ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T15:53:37.647355Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:53:37.326291Z","time spent":"321.004885ms","remote":"127.0.0.1:43780","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T15:53:37.647495Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:53:37.235046Z","time spent":"412.356276ms","remote":"127.0.0.1:43780","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T15:53:39.221713Z","caller":"traceutil/trace.go:171","msg":"trace[1535226600] linearizableReadLoop","detail":"{readStateIndex:1179; appliedIndex:1178; }","duration":"260.076867ms","start":"2026-06-09T15:53:38.961607Z","end":"2026-06-09T15:53:39.221683Z","steps":["trace[1535226600] 'read index received' (duration: 259.87679ms)","trace[1535226600] 'applied index is now lower than readState.Index' (duration: 199.167µs)"],"step_count":2} {"level":"info","ts":"2026-06-09T15:53:39.22183Z","caller":"traceutil/trace.go:171","msg":"trace[472507718] transaction","detail":"{read_only:false; response_revision:1133; number_of_response:1; }","duration":"487.381503ms","start":"2026-06-09T15:53:38.734413Z","end":"2026-06-09T15:53:39.221795Z","steps":["trace[472507718] 'process raft request' (duration: 487.097804ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:53:39.221944Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.316935ms","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-09T15:53:39.22198Z","caller":"traceutil/trace.go:171","msg":"trace[2003264258] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1133; }","duration":"260.429088ms","start":"2026-06-09T15:53:38.96154Z","end":"2026-06-09T15:53:39.221969Z","steps":["trace[2003264258] 'agreement among raft nodes before linearized reading' (duration: 260.246322ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:53:39.222006Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:53:38.734385Z","time spent":"487.527578ms","remote":"127.0.0.1:43780","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T15:53:55.650714Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:53:55.33323Z","time spent":"317.479352ms","remote":"127.0.0.1:43610","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-06-09T15:53:56.445368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.690252ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-09T15:53:56.445529Z","caller":"traceutil/trace.go:171","msg":"trace[780396611] transaction","detail":"{read_only:false; response_revision:1236; number_of_response:1; }","duration":"791.397602ms","start":"2026-06-09T15:53:55.654118Z","end":"2026-06-09T15:53:56.445515Z","steps":["trace[780396611] 'process raft request' (duration: 791.346121ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T15:53:56.445538Z","caller":"traceutil/trace.go:171","msg":"trace[1490465978] transaction","detail":"{read_only:false; response_revision:1235; number_of_response:1; }","duration":"1.103694358s","start":"2026-06-09T15:53:55.341815Z","end":"2026-06-09T15:53:56.44551Z","steps":["trace[1490465978] 'process raft request' (duration: 976.7837ms)","trace[1490465978] 'compare' (duration: 126.364651ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T15:53:56.445577Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:53:55.654098Z","time spent":"791.455785ms","remote":"127.0.0.1:43610","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":118,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T15:53:56.445715Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:53:55.341797Z","time spent":"1.103802492s","remote":"127.0.0.1:43780","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T15:53:56.445774Z","caller":"traceutil/trace.go:171","msg":"trace[1369769980] linearizableReadLoop","detail":"{readStateIndex:1287; appliedIndex:1285; }","duration":"1.064994844s","start":"2026-06-09T15:53:55.380769Z","end":"2026-06-09T15:53:56.445764Z","steps":["trace[1369769980] 'read index received' (duration: 269.827821ms)","trace[1369769980] 'applied index is now lower than readState.Index' (duration: 795.166273ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T15:53:56.445995Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.065224233s","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-09T15:53:56.446015Z","caller":"traceutil/trace.go:171","msg":"trace[1989173631] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1236; }","duration":"1.065339446s","start":"2026-06-09T15:53:55.38067Z","end":"2026-06-09T15:53:56.44601Z","steps":["trace[1989173631] 'agreement among raft nodes before linearized reading' (duration: 1.065177571s)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:53:56.446032Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:53:55.38065Z","time spent":"1.065378557s","remote":"127.0.0.1:43780","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-09T15:53:56.446097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.059343244s","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-09T15:53:56.446131Z","caller":"traceutil/trace.go:171","msg":"trace[172854424] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1236; }","duration":"1.059428216s","start":"2026-06-09T15:53:55.386695Z","end":"2026-06-09T15:53:56.446123Z","steps":["trace[172854424] 'agreement among raft nodes before linearized reading' (duration: 1.059287381s)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:53:56.446152Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:53:55.386679Z","time spent":"1.059469058s","remote":"127.0.0.1:43780","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-09T15:53:56.446243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"706.780854ms","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-09T15:53:56.446269Z","caller":"traceutil/trace.go:171","msg":"trace[767495999] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1236; }","duration":"706.853335ms","start":"2026-06-09T15:53:55.739409Z","end":"2026-06-09T15:53:56.446263Z","steps":["trace[767495999] 'agreement among raft nodes before linearized reading' (duration: 706.785703ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:53:56.446292Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:53:55.73939Z","time spent":"706.896887ms","remote":"127.0.0.1:43780","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-09T15:53:56.446335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.041946845s","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-09T15:53:56.446359Z","caller":"traceutil/trace.go:171","msg":"trace[1072104113] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1236; }","duration":"1.041992395s","start":"2026-06-09T15:53:55.404361Z","end":"2026-06-09T15:53:56.446354Z","steps":["trace[1072104113] 'agreement among raft nodes before linearized reading' (duration: 1.041930563s)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:53:56.446374Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:53:55.404353Z","time spent":"1.042017436s","remote":"127.0.0.1:43780","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-09T15:53:56.44645Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.042696498s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-06-09T15:53:56.446459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"891.412207ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T15:53:56.446474Z","caller":"traceutil/trace.go:171","msg":"trace[21438364] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1236; }","duration":"891.464148ms","start":"2026-06-09T15:53:55.555005Z","end":"2026-06-09T15:53:56.446469Z","steps":["trace[21438364] 'agreement among raft nodes before linearized reading' (duration: 891.439997ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T15:53:56.446474Z","caller":"traceutil/trace.go:171","msg":"trace[1812846778] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1236; }","duration":"1.04276809s","start":"2026-06-09T15:53:55.403699Z","end":"2026-06-09T15:53:56.446467Z","steps":["trace[1812846778] 'agreement among raft nodes before linearized reading' (duration: 1.042704598s)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:53:56.446488Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:53:55.554982Z","time spent":"891.50276ms","remote":"127.0.0.1:43598","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-09T15:53:56.446492Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:53:55.403675Z","time spent":"1.042813382s","remote":"127.0.0.1:43780","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-09T15:53:56.553004Z","caller":"traceutil/trace.go:171","msg":"trace[883877977] linearizableReadLoop","detail":"{readStateIndex:1292; appliedIndex:1288; }","duration":"100.212441ms","start":"2026-06-09T15:53:56.452757Z","end":"2026-06-09T15:53:56.552969Z","steps":["trace[883877977] 'read index received' (duration: 16.521031ms)","trace[883877977] 'applied index is now lower than readState.Index' (duration: 83.689949ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T15:53:56.553554Z","caller":"traceutil/trace.go:171","msg":"trace[1292535276] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1241; }","duration":"103.946411ms","start":"2026-06-09T15:53:56.449589Z","end":"2026-06-09T15:53:56.553536Z","steps":["trace[1292535276] 'agreement among raft nodes before linearized reading' (duration: 103.90982ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T15:53:56.55359Z","caller":"traceutil/trace.go:171","msg":"trace[282065729] transaction","detail":"{read_only:false; response_revision:1241; number_of_response:1; }","duration":"100.122418ms","start":"2026-06-09T15:53:56.453439Z","end":"2026-06-09T15:53:56.553561Z","steps":["trace[282065729] 'process raft request' (duration: 91.588653ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:53:56.553653Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.861921ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-06-09T15:53:56.553767Z","caller":"traceutil/trace.go:171","msg":"trace[1898585705] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:1241; }","duration":"100.995066ms","start":"2026-06-09T15:53:56.452752Z","end":"2026-06-09T15:53:56.553747Z","steps":["trace[1898585705] 'agreement among raft nodes before linearized reading' (duration: 100.746548ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T15:54:08.55795Z","caller":"traceutil/trace.go:171","msg":"trace[916291901] transaction","detail":"{read_only:false; response_revision:1275; number_of_response:1; }","duration":"113.685614ms","start":"2026-06-09T15:54:08.444221Z","end":"2026-06-09T15:54:08.557906Z","steps":["trace[916291901] 'process raft request' (duration: 113.081404ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:54:08.993576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.499836ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-09T15:54:08.993691Z","caller":"traceutil/trace.go:171","msg":"trace[521813086] linearizableReadLoop","detail":"{readStateIndex:1330; appliedIndex:1329; }","duration":"403.131316ms","start":"2026-06-09T15:54:08.590542Z","end":"2026-06-09T15:54:08.993673Z","steps":["trace[521813086] 'read index received' (duration: 140.404853ms)","trace[521813086] 'applied index is now lower than readState.Index' (duration: 262.725263ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T15:54:08.993824Z","caller":"traceutil/trace.go:171","msg":"trace[72260030] transaction","detail":"{read_only:false; response_revision:1276; number_of_response:1; }","duration":"429.241784ms","start":"2026-06-09T15:54:08.564565Z","end":"2026-06-09T15:54:08.993807Z","steps":["trace[72260030] 'process raft request' (duration: 166.437299ms)","trace[72260030] 'compare' (duration: 262.34228ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T15:54:08.993901Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:54:08.564542Z","time spent":"429.323617ms","remote":"127.0.0.1:43780","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T15:54:08.994154Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.617843ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-06-09T15:54:08.994192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.907539ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-09T15:54:08.994197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.004768ms","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-09T15:54:08.994233Z","caller":"traceutil/trace.go:171","msg":"trace[87210407] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1276; }","duration":"329.765967ms","start":"2026-06-09T15:54:08.664448Z","end":"2026-06-09T15:54:08.994214Z","steps":["trace[87210407] 'agreement among raft nodes before linearized reading' (duration: 329.489648ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:54:08.994208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"403.648422ms","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-09T15:54:08.994284Z","caller":"traceutil/trace.go:171","msg":"trace[1721950594] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:1276; }","duration":"216.066324ms","start":"2026-06-09T15:54:08.778196Z","end":"2026-06-09T15:54:08.994262Z","steps":["trace[1721950594] 'agreement among raft nodes before linearized reading' (duration: 215.847217ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:54:08.994294Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:54:08.664426Z","time spent":"329.85954ms","remote":"127.0.0.1:43780","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-09T15:54:08.994294Z","caller":"traceutil/trace.go:171","msg":"trace[975714741] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1276; }","duration":"233.233785ms","start":"2026-06-09T15:54:08.761039Z","end":"2026-06-09T15:54:08.994273Z","steps":["trace[975714741] 'agreement among raft nodes before linearized reading' (duration: 232.908095ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T15:54:08.994316Z","caller":"traceutil/trace.go:171","msg":"trace[136720760] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1276; }","duration":"403.829058ms","start":"2026-06-09T15:54:08.590467Z","end":"2026-06-09T15:54:08.994297Z","steps":["trace[136720760] 'agreement among raft nodes before linearized reading' (duration: 403.493127ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:54:08.99436Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:54:08.59044Z","time spent":"403.911701ms","remote":"127.0.0.1:43780","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-09T15:54:08.994435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.737797ms","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-09T15:54:08.994476Z","caller":"traceutil/trace.go:171","msg":"trace[1813223541] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1276; }","duration":"273.84194ms","start":"2026-06-09T15:54:08.720622Z","end":"2026-06-09T15:54:08.994464Z","steps":["trace[1813223541] 'agreement among raft nodes before linearized reading' (duration: 273.691195ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:54:08.994603Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.482264ms","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-09T15:54:08.994663Z","caller":"traceutil/trace.go:171","msg":"trace[2027834677] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1276; }","duration":"299.588898ms","start":"2026-06-09T15:54:08.695056Z","end":"2026-06-09T15:54:08.994645Z","steps":["trace[2027834677] 'agreement among raft nodes before linearized reading' (duration: 299.35352ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T15:54:09.339961Z","caller":"traceutil/trace.go:171","msg":"trace[758779137] transaction","detail":"{read_only:false; response_revision:1277; number_of_response:1; }","duration":"341.127773ms","start":"2026-06-09T15:54:08.998804Z","end":"2026-06-09T15:54:09.339931Z","steps":["trace[758779137] 'process raft request' (duration: 296.085766ms)","trace[758779137] 'compare' (duration: 44.689476ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T15:54:09.340079Z","caller":"traceutil/trace.go:171","msg":"trace[1852382764] transaction","detail":"{read_only:false; response_revision:1278; number_of_response:1; }","duration":"341.232176ms","start":"2026-06-09T15:54:08.998814Z","end":"2026-06-09T15:54:09.340047Z","steps":["trace[1852382764] 'process raft request' (duration: 341.007339ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:54:09.340135Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:54:08.998783Z","time spent":"341.267407ms","remote":"127.0.0.1:43780","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T15:54:09.340231Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:54:08.998794Z","time spent":"341.35629ms","remote":"127.0.0.1:43780","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T15:54:09.770415Z","caller":"traceutil/trace.go:171","msg":"trace[1480464818] transaction","detail":"{read_only:false; response_revision:1279; number_of_response:1; }","duration":"769.972854ms","start":"2026-06-09T15:54:09.000411Z","end":"2026-06-09T15:54:09.770384Z","steps":["trace[1480464818] 'process raft request' (duration: 768.749285ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:54:09.770562Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:54:09.000401Z","time spent":"770.090448ms","remote":"127.0.0.1:43780","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T15:54:09.77076Z","caller":"traceutil/trace.go:171","msg":"trace[2013638641] transaction","detail":"{read_only:false; response_revision:1281; number_of_response:1; }","duration":"768.884269ms","start":"2026-06-09T15:54:09.001863Z","end":"2026-06-09T15:54:09.770747Z","steps":["trace[2013638641] 'process raft request' (duration: 768.756815ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T15:54:09.770792Z","caller":"traceutil/trace.go:171","msg":"trace[342623255] linearizableReadLoop","detail":"{readStateIndex:1335; appliedIndex:1332; }","duration":"450.007162ms","start":"2026-06-09T15:54:09.320697Z","end":"2026-06-09T15:54:09.770704Z","steps":["trace[342623255] 'read index received' (duration: 448.435591ms)","trace[342623255] 'applied index is now lower than readState.Index' (duration: 1.570661ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T15:54:09.770839Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:54:09.001853Z","time spent":"768.951711ms","remote":"127.0.0.1:43780","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T15:54:09.770775Z","caller":"traceutil/trace.go:171","msg":"trace[224847052] transaction","detail":"{read_only:false; response_revision:1280; number_of_response:1; }","duration":"770.243983ms","start":"2026-06-09T15:54:09.000494Z","end":"2026-06-09T15:54:09.770738Z","steps":["trace[224847052] 'process raft request' (duration: 769.85202ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:54:09.770966Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.878122ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-09T15:54:09.770967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"450.211758ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T15:54:09.77106Z","caller":"traceutil/trace.go:171","msg":"trace[1179393271] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:1281; }","duration":"450.400814ms","start":"2026-06-09T15:54:09.320639Z","end":"2026-06-09T15:54:09.77104Z","steps":["trace[1179393271] 'agreement among raft nodes before linearized reading' (duration: 450.214188ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:54:09.771104Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:54:09.320618Z","time spent":"450.475007ms","remote":"127.0.0.1:57546","response type":"/etcdserverpb.KV/Range","request count":0,"request size":114,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true "} {"level":"info","ts":"2026-06-09T15:54:09.771007Z","caller":"traceutil/trace.go:171","msg":"trace[1172027552] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1281; }","duration":"203.969115ms","start":"2026-06-09T15:54:09.567027Z","end":"2026-06-09T15:54:09.770996Z","steps":["trace[1172027552] 'agreement among raft nodes before linearized reading' (duration: 203.868852ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:54:09.771214Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:54:09.00047Z","time spent":"770.518132ms","remote":"127.0.0.1:43780","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T15:54:11.384815Z","caller":"traceutil/trace.go:171","msg":"trace[1719123839] transaction","detail":"{read_only:false; response_revision:1282; number_of_response:1; }","duration":"384.460535ms","start":"2026-06-09T15:54:11.000335Z","end":"2026-06-09T15:54:11.384796Z","steps":["trace[1719123839] 'process raft request' (duration: 384.3292ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:54:11.385518Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:54:11.000307Z","time spent":"385.139507ms","remote":"127.0.0.1:43780","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T15:54:12.683407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"822.495992ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-06-09T15:54:12.683864Z","caller":"traceutil/trace.go:171","msg":"trace[914782154] linearizableReadLoop","detail":"{readStateIndex:1337; appliedIndex:1335; }","duration":"1.339958421s","start":"2026-06-09T15:54:11.343879Z","end":"2026-06-09T15:54:12.683837Z","steps":["trace[914782154] 'read index received' (duration: 40.76618ms)","trace[914782154] 'applied index is now lower than readState.Index' (duration: 1.299190681s)"],"step_count":2} {"level":"info","ts":"2026-06-09T15:54:12.684017Z","caller":"traceutil/trace.go:171","msg":"trace[146112086] transaction","detail":"{read_only:false; response_revision:1283; number_of_response:1; }","duration":"1.315895718s","start":"2026-06-09T15:54:11.368106Z","end":"2026-06-09T15:54:12.684002Z","steps":["trace[146112086] 'process raft request' (duration: 1.315428453s)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:54:12.684157Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:54:11.368086Z","time spent":"1.315985531s","remote":"127.0.0.1:43780","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T15:54:13.268029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.505944ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T15:54:13.268116Z","caller":"traceutil/trace.go:171","msg":"trace[266664414] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1283; }","duration":"233.603537ms","start":"2026-06-09T15:54:13.034487Z","end":"2026-06-09T15:54:13.268091Z","steps":["trace[266664414] 'range keys from in-memory index tree' (duration: 233.448533ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:54:13.268112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.710291533s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-09T15:54:13.268174Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.493054602s","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-09T15:54:13.268252Z","caller":"traceutil/trace.go:171","msg":"trace[1351452180] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1283; }","duration":"1.493153425s","start":"2026-06-09T15:54:11.775076Z","end":"2026-06-09T15:54:13.268229Z","steps":["trace[1351452180] 'agreement among raft nodes before linearized reading' (duration: 909.466047ms)","trace[1351452180] 'range keys from in-memory index tree' (duration: 583.44423ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T15:54:13.268381Z","caller":"traceutil/trace.go:171","msg":"trace[345536011] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1283; }","duration":"1.710398557s","start":"2026-06-09T15:54:11.557766Z","end":"2026-06-09T15:54:13.268164Z","steps":["trace[345536011] 'agreement among raft nodes before linearized reading' (duration: 1.126797271s)","trace[345536011] 'range keys from in-memory index tree' (duration: 583.503252ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T15:54:13.268424Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:54:11.557751Z","time spent":"1.710665035s","remote":"127.0.0.1:43598","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-09T15:54:13.268303Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:54:11.775072Z","time spent":"1.493220947s","remote":"127.0.0.1:43780","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-09T15:54:13.267915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"320.966715ms","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":"warn","ts":"2026-06-09T15:54:13.26861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.49361028s","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-09T15:54:13.268636Z","caller":"traceutil/trace.go:171","msg":"trace[871537145] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:1283; }","duration":"321.7541ms","start":"2026-06-09T15:54:12.946861Z","end":"2026-06-09T15:54:13.268615Z","steps":["trace[871537145] 'count revisions from in-memory index tree' (duration: 320.80713ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T15:54:13.268641Z","caller":"traceutil/trace.go:171","msg":"trace[1388989674] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1283; }","duration":"1.493661731s","start":"2026-06-09T15:54:11.774968Z","end":"2026-06-09T15:54:13.26863Z","steps":["trace[1388989674] 'agreement among raft nodes before linearized reading' (duration: 909.5877ms)","trace[1388989674] 'range keys from in-memory index tree' (duration: 583.967357ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T15:54:13.268672Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:54:11.774955Z","time spent":"1.493708133s","remote":"127.0.0.1:43780","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-09T15:54:13.268683Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:54:12.946816Z","time spent":"321.852714ms","remote":"127.0.0.1:43662","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":5,"response size":31,"request content":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true "} {"level":"warn","ts":"2026-06-09T15:54:13.268564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.924661852s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-06-09T15:54:13.268816Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.924814547s","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-09T15:54:13.268826Z","caller":"traceutil/trace.go:171","msg":"trace[1885049954] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1283; }","duration":"1.924995072s","start":"2026-06-09T15:54:11.343817Z","end":"2026-06-09T15:54:13.268812Z","steps":["trace[1885049954] 'agreement among raft nodes before linearized reading' (duration: 1.340600812s)","trace[1885049954] 'range keys from in-memory index tree' (duration: 584.006068ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T15:54:13.268842Z","caller":"traceutil/trace.go:171","msg":"trace[678972496] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1283; }","duration":"1.924861048s","start":"2026-06-09T15:54:11.343972Z","end":"2026-06-09T15:54:13.268833Z","steps":["trace[678972496] 'agreement among raft nodes before linearized reading' (duration: 1.340475818s)","trace[678972496] 'range keys from in-memory index tree' (duration: 584.319918ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T15:54:13.268843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.49299789s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-06-09T15:54:13.26886Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:54:11.343793Z","time spent":"1.925057445s","remote":"127.0.0.1:43780","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-09T15:54:13.268869Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:54:11.343932Z","time spent":"1.924929131s","remote":"127.0.0.1:43780","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-09T15:54:13.268905Z","caller":"traceutil/trace.go:171","msg":"trace[1064090977] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1283; }","duration":"1.493069052s","start":"2026-06-09T15:54:11.775815Z","end":"2026-06-09T15:54:13.268884Z","steps":["trace[1064090977] 'agreement among raft nodes before linearized reading' (duration: 908.715632ms)","trace[1064090977] 'range keys from in-memory index tree' (duration: 584.169803ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T15:54:13.268952Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:54:11.775812Z","time spent":"1.493127644s","remote":"127.0.0.1:43780","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-09T15:54:13.534987Z","caller":"traceutil/trace.go:171","msg":"trace[1988041483] transaction","detail":"{read_only:false; response_revision:1284; number_of_response:1; }","duration":"261.451953ms","start":"2026-06-09T15:54:13.27351Z","end":"2026-06-09T15:54:13.534962Z","steps":["trace[1988041483] 'process raft request' (duration: 261.215265ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T15:54:13.539846Z","caller":"traceutil/trace.go:171","msg":"trace[1183178718] transaction","detail":"{read_only:false; response_revision:1285; number_of_response:1; }","duration":"265.513933ms","start":"2026-06-09T15:54:13.274307Z","end":"2026-06-09T15:54:13.539821Z","steps":["trace[1183178718] 'process raft request' (duration: 265.265955ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T15:54:13.539873Z","caller":"traceutil/trace.go:171","msg":"trace[827564034] transaction","detail":"{read_only:false; response_revision:1286; number_of_response:1; }","duration":"265.320357ms","start":"2026-06-09T15:54:13.274529Z","end":"2026-06-09T15:54:13.539849Z","steps":["trace[827564034] 'process raft request' (duration: 265.180772ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T15:54:13.539925Z","caller":"traceutil/trace.go:171","msg":"trace[62670002] linearizableReadLoop","detail":"{readStateIndex:1343; appliedIndex:1338; }","duration":"209.758841ms","start":"2026-06-09T15:54:13.330153Z","end":"2026-06-09T15:54:13.539912Z","steps":["trace[62670002] 'read index received' (duration: 204.491722ms)","trace[62670002] 'applied index is now lower than readState.Index' (duration: 5.266509ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T15:54:13.540002Z","caller":"traceutil/trace.go:171","msg":"trace[281526419] transaction","detail":"{read_only:false; response_revision:1287; number_of_response:1; }","duration":"265.13635ms","start":"2026-06-09T15:54:13.274858Z","end":"2026-06-09T15:54:13.539994Z","steps":["trace[281526419] 'process raft request' (duration: 264.897943ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T15:54:13.539996Z","caller":"traceutil/trace.go:171","msg":"trace[1571990971] transaction","detail":"{read_only:false; response_revision:1288; number_of_response:1; }","duration":"264.726098ms","start":"2026-06-09T15:54:13.275157Z","end":"2026-06-09T15:54:13.539883Z","steps":["trace[1571990971] 'process raft request' (duration: 264.635895ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:54:13.540164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.050916ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-09T15:54:13.540204Z","caller":"traceutil/trace.go:171","msg":"trace[1707400759] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:1289; }","duration":"119.144899ms","start":"2026-06-09T15:54:13.421049Z","end":"2026-06-09T15:54:13.540194Z","steps":["trace[1707400759] 'agreement among raft nodes before linearized reading' (duration: 119.025725ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T15:54:13.540345Z","caller":"traceutil/trace.go:171","msg":"trace[1010751632] transaction","detail":"{read_only:false; response_revision:1289; number_of_response:1; }","duration":"111.016707ms","start":"2026-06-09T15:54:13.429291Z","end":"2026-06-09T15:54:13.540307Z","steps":["trace[1010751632] 'process raft request' (duration: 110.544152ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:54:13.540616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.447453ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T15:54:13.540651Z","caller":"traceutil/trace.go:171","msg":"trace[1119573803] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:1289; }","duration":"210.535576ms","start":"2026-06-09T15:54:13.330108Z","end":"2026-06-09T15:54:13.540644Z","steps":["trace[1119573803] 'agreement among raft nodes before linearized reading' (duration: 209.904026ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:54:18.058208Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8620627102956010103,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-09T15:54:18.559003Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8620627102956010103,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-09T15:54:18.849414Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.293634422s","expected-duration":"1s"} {"level":"info","ts":"2026-06-09T15:54:18.851198Z","caller":"traceutil/trace.go:171","msg":"trace[1396254566] transaction","detail":"{read_only:false; response_revision:1324; number_of_response:1; }","duration":"1.295136781s","start":"2026-06-09T15:54:17.555632Z","end":"2026-06-09T15:54:18.850769Z","steps":["trace[1396254566] 'process raft request' (duration: 1.294893573s)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:54:18.851558Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:54:17.555596Z","time spent":"1.295687018s","remote":"127.0.0.1:43780","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T15:54:19.567575Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000109285s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-06-09T15:54:19.567684Z","caller":"traceutil/trace.go:171","msg":"trace[431908320] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.00025475s","start":"2026-06-09T15:54:17.567406Z","end":"2026-06-09T15:54:19.567661Z","steps":["trace[431908320] 'agreement among raft nodes before linearized reading' (duration: 2.000115825s)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:54:19.567727Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:54:17.567401Z","time spent":"2.000318192s","remote":"127.0.0.1:43598","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/06/09 15:54:19 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"info","ts":"2026-06-09T15:54:19.740061Z","caller":"traceutil/trace.go:171","msg":"trace[952241783] transaction","detail":"{read_only:false; response_revision:1325; number_of_response:1; }","duration":"2.182540758s","start":"2026-06-09T15:54:17.557486Z","end":"2026-06-09T15:54:19.740027Z","steps":["trace[952241783] 'process raft request' (duration: 2.139260387s)","trace[952241783] 'compare' (duration: 43.040193ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T15:54:19.740251Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:54:17.55747Z","time spent":"2.182679993s","remote":"127.0.0.1:43780","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T15:54:19.740284Z","caller":"traceutil/trace.go:171","msg":"trace[720430817] linearizableReadLoop","detail":"{readStateIndex:1382; appliedIndex:1379; }","duration":"2.182679123s","start":"2026-06-09T15:54:17.55758Z","end":"2026-06-09T15:54:19.740259Z","steps":["trace[720430817] 'read index received' (duration: 1.292555997s)","trace[720430817] 'applied index is now lower than readState.Index' (duration: 890.122106ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T15:54:19.740406Z","caller":"traceutil/trace.go:171","msg":"trace[471700412] transaction","detail":"{read_only:false; response_revision:1326; number_of_response:1; }","duration":"2.176784583s","start":"2026-06-09T15:54:17.563611Z","end":"2026-06-09T15:54:19.740396Z","steps":["trace[471700412] 'process raft request' (duration: 2.176340469s)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:54:19.740508Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:54:17.563597Z","time spent":"2.176838945s","remote":"127.0.0.1:43780","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T15:54:19.740559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.182977793s","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-09T15:54:19.740616Z","caller":"traceutil/trace.go:171","msg":"trace[1783268486] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1327; }","duration":"2.183083036s","start":"2026-06-09T15:54:17.557518Z","end":"2026-06-09T15:54:19.740601Z","steps":["trace[1783268486] 'agreement among raft nodes before linearized reading' (duration: 2.182941731s)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:54:19.740648Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:54:17.557494Z","time spent":"2.183148068s","remote":"127.0.0.1:43780","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-09T15:54:19.740682Z","caller":"traceutil/trace.go:171","msg":"trace[9500239] transaction","detail":"{read_only:false; response_revision:1327; number_of_response:1; }","duration":"1.044965282s","start":"2026-06-09T15:54:18.695704Z","end":"2026-06-09T15:54:19.740669Z","steps":["trace[9500239] 'process raft request' (duration: 1.044475846s)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:54:19.740724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.1769924s","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-09T15:54:19.740794Z","caller":"traceutil/trace.go:171","msg":"trace[571113625] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1327; }","duration":"2.177093903s","start":"2026-06-09T15:54:17.563683Z","end":"2026-06-09T15:54:19.740777Z","steps":["trace[571113625] 'agreement among raft nodes before linearized reading' (duration: 2.176901397s)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:54:19.740806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.856729ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T15:54:19.74089Z","caller":"traceutil/trace.go:171","msg":"trace[93712422] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:1327; }","duration":"188.984343ms","start":"2026-06-09T15:54:19.551894Z","end":"2026-06-09T15:54:19.740878Z","steps":["trace[93712422] 'agreement among raft nodes before linearized reading' (duration: 188.88085ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:54:19.740902Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:54:17.563667Z","time spent":"2.177214477s","remote":"127.0.0.1:43780","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-09T15:54:19.740923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"709.427059ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T15:54:19.74096Z","caller":"traceutil/trace.go:171","msg":"trace[2103459849] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1327; }","duration":"709.491991ms","start":"2026-06-09T15:54:19.031462Z","end":"2026-06-09T15:54:19.740953Z","steps":["trace[2103459849] 'agreement among raft nodes before linearized reading' (duration: 709.441119ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:54:19.740976Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:54:19.031445Z","time spent":"709.528051ms","remote":"127.0.0.1:43598","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-09T15:54:19.741092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.174721157s","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-09T15:54:19.74074Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:54:18.69568Z","time spent":"1.045031023s","remote":"127.0.0.1:43780","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T15:54:19.741149Z","caller":"traceutil/trace.go:171","msg":"trace[286818063] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1327; }","duration":"2.174791749s","start":"2026-06-09T15:54:17.566343Z","end":"2026-06-09T15:54:19.741135Z","steps":["trace[286818063] 'agreement among raft nodes before linearized reading' (duration: 2.174658734s)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:54:19.741199Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:54:17.566335Z","time spent":"2.174852411s","remote":"127.0.0.1:43780","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-09T15:54:19.741104Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.091832ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T15:54:19.74125Z","caller":"traceutil/trace.go:171","msg":"trace[1788255290] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1327; }","duration":"173.275138ms","start":"2026-06-09T15:54:19.567968Z","end":"2026-06-09T15:54:19.741243Z","steps":["trace[1788255290] 'agreement among raft nodes before linearized reading' (duration: 173.109633ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:54:21.650687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"648.416948ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-06-09T15:54:21.650823Z","caller":"traceutil/trace.go:171","msg":"trace[1532331767] linearizableReadLoop","detail":"{readStateIndex:1388; appliedIndex:1387; }","duration":"794.779052ms","start":"2026-06-09T15:54:20.856005Z","end":"2026-06-09T15:54:21.650784Z","steps":["trace[1532331767] 'read index received' (duration: 145.537788ms)","trace[1532331767] 'applied index is now lower than readState.Index' (duration: 649.239294ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T15:54:21.651159Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"795.138963ms","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-09T15:54:21.651237Z","caller":"traceutil/trace.go:171","msg":"trace[1816047876] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1331; }","duration":"795.226646ms","start":"2026-06-09T15:54:20.855994Z","end":"2026-06-09T15:54:21.65122Z","steps":["trace[1816047876] 'agreement among raft nodes before linearized reading' (duration: 795.001259ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:54:21.651233Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"585.106643ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-09T15:54:21.651287Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:54:20.855951Z","time spent":"795.321919ms","remote":"127.0.0.1:43780","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-09T15:54:21.651322Z","caller":"traceutil/trace.go:171","msg":"trace[1287083841] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:1331; }","duration":"585.209737ms","start":"2026-06-09T15:54:21.06609Z","end":"2026-06-09T15:54:21.6513Z","steps":["trace[1287083841] 'agreement among raft nodes before linearized reading' (duration: 585.070812ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:54:21.651405Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:54:21.066063Z","time spent":"585.32513ms","remote":"127.0.0.1:57508","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"info","ts":"2026-06-09T15:54:22.032651Z","caller":"traceutil/trace.go:171","msg":"trace[738801065] linearizableReadLoop","detail":"{readStateIndex:1389; appliedIndex:1388; }","duration":"285.409222ms","start":"2026-06-09T15:54:21.74722Z","end":"2026-06-09T15:54:22.03263Z","steps":["trace[738801065] 'read index received' (duration: 285.377961ms)","trace[738801065] 'applied index is now lower than readState.Index' (duration: 30.201µs)"],"step_count":2} {"level":"info","ts":"2026-06-09T15:54:22.032782Z","caller":"traceutil/trace.go:171","msg":"trace[1020997745] transaction","detail":"{read_only:false; response_revision:1332; number_of_response:1; }","duration":"370.801445ms","start":"2026-06-09T15:54:21.66197Z","end":"2026-06-09T15:54:22.032772Z","steps":["trace[1020997745] 'process raft request' (duration: 370.526826ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:54:22.032883Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:54:21.661953Z","time spent":"370.855347ms","remote":"127.0.0.1:43780","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T15:54:22.033051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.810705ms","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-09T15:54:22.03316Z","caller":"traceutil/trace.go:171","msg":"trace[2036862272] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1332; }","duration":"285.96385ms","start":"2026-06-09T15:54:21.747177Z","end":"2026-06-09T15:54:22.033141Z","steps":["trace[2036862272] 'agreement among raft nodes before linearized reading' (duration: 285.67352ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T15:54:22.135133Z","caller":"traceutil/trace.go:171","msg":"trace[171437992] linearizableReadLoop","detail":"{readStateIndex:1390; appliedIndex:1389; }","duration":"102.406761ms","start":"2026-06-09T15:54:22.032706Z","end":"2026-06-09T15:54:22.135113Z","steps":["trace[171437992] 'read index received' (duration: 75.832067ms)","trace[171437992] 'applied index is now lower than readState.Index' (duration: 26.573883ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T15:54:22.135278Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"362.663095ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:474"} {"level":"info","ts":"2026-06-09T15:54:22.135306Z","caller":"traceutil/trace.go:171","msg":"trace[48685664] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1333; }","duration":"362.726376ms","start":"2026-06-09T15:54:21.772571Z","end":"2026-06-09T15:54:22.135297Z","steps":["trace[48685664] 'agreement among raft nodes before linearized reading' (duration: 362.612513ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:54:22.135342Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:54:21.77256Z","time spent":"362.775279ms","remote":"127.0.0.1:43780","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":498,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-06-09T15:54:22.135378Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.136085ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-06-09T15:54:22.135397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.978098ms","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-09T15:54:22.135459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"331.962378ms","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-09T15:54:22.135487Z","caller":"traceutil/trace.go:171","msg":"trace[504080683] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1333; }","duration":"313.113412ms","start":"2026-06-09T15:54:21.822354Z","end":"2026-06-09T15:54:22.135468Z","steps":["trace[504080683] 'agreement among raft nodes before linearized reading' (duration: 312.854104ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T15:54:22.135514Z","caller":"traceutil/trace.go:171","msg":"trace[443959003] transaction","detail":"{read_only:false; response_revision:1333; number_of_response:1; }","duration":"358.48246ms","start":"2026-06-09T15:54:21.777019Z","end":"2026-06-09T15:54:22.135501Z","steps":["trace[443959003] 'process raft request' (duration: 331.590906ms)","trace[443959003] 'compare' (duration: 26.405428ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T15:54:22.135533Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:54:21.82234Z","time spent":"313.185165ms","remote":"127.0.0.1:43780","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-09T15:54:22.135613Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:54:21.776995Z","time spent":"358.557293ms","remote":"127.0.0.1:43780","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T15:54:22.135515Z","caller":"traceutil/trace.go:171","msg":"trace[1325283224] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1333; }","duration":"332.052871ms","start":"2026-06-09T15:54:21.803447Z","end":"2026-06-09T15:54:22.1355Z","steps":["trace[1325283224] 'agreement among raft nodes before linearized reading' (duration: 331.924467ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:54:22.135685Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:54:21.80343Z","time spent":"332.243828ms","remote":"127.0.0.1:43780","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-09T15:54:22.135464Z","caller":"traceutil/trace.go:171","msg":"trace[1128202312] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1333; }","duration":"309.271949ms","start":"2026-06-09T15:54:21.826173Z","end":"2026-06-09T15:54:22.135445Z","steps":["trace[1128202312] 'agreement among raft nodes before linearized reading' (duration: 308.99846ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:54:22.135748Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:54:21.82616Z","time spent":"309.581519ms","remote":"127.0.0.1:43780","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-09T15:54:22.155665Z","caller":"traceutil/trace.go:171","msg":"trace[1350319823] transaction","detail":"{read_only:false; response_revision:1334; number_of_response:1; }","duration":"119.546882ms","start":"2026-06-09T15:54:22.036095Z","end":"2026-06-09T15:54:22.155642Z","steps":["trace[1350319823] 'process raft request' (duration: 119.446029ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T15:54:22.30731Z","caller":"traceutil/trace.go:171","msg":"trace[1360155091] transaction","detail":"{read_only:false; response_revision:1335; number_of_response:1; }","duration":"167.910817ms","start":"2026-06-09T15:54:22.139368Z","end":"2026-06-09T15:54:22.307279Z","steps":["trace[1360155091] 'process raft request' (duration: 110.254463ms)","trace[1360155091] 'compare' (duration: 57.457267ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T15:54:22.307511Z","caller":"traceutil/trace.go:171","msg":"trace[1566447816] transaction","detail":"{read_only:false; response_revision:1336; number_of_response:1; }","duration":"168.086471ms","start":"2026-06-09T15:54:22.139404Z","end":"2026-06-09T15:54:22.30749Z","steps":["trace[1566447816] 'process raft request' (duration: 167.816913ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T15:54:22.307678Z","caller":"traceutil/trace.go:171","msg":"trace[23966383] transaction","detail":"{read_only:false; response_revision:1337; number_of_response:1; }","duration":"167.965198ms","start":"2026-06-09T15:54:22.139691Z","end":"2026-06-09T15:54:22.307656Z","steps":["trace[23966383] 'process raft request' (duration: 167.73758ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T15:54:22.307839Z","caller":"traceutil/trace.go:171","msg":"trace[413761857] transaction","detail":"{read_only:false; response_revision:1338; number_of_response:1; }","duration":"167.567725ms","start":"2026-06-09T15:54:22.140264Z","end":"2026-06-09T15:54:22.307831Z","steps":["trace[413761857] 'process raft request' (duration: 167.351778ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T15:54:22.307858Z","caller":"traceutil/trace.go:171","msg":"trace[1117576268] transaction","detail":"{read_only:false; response_revision:1339; number_of_response:1; }","duration":"125.355458ms","start":"2026-06-09T15:54:22.182484Z","end":"2026-06-09T15:54:22.307839Z","steps":["trace[1117576268] 'process raft request' (duration: 125.279196ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T15:54:23.261426Z","caller":"traceutil/trace.go:171","msg":"trace[1096207240] transaction","detail":"{read_only:false; response_revision:1340; number_of_response:1; }","duration":"293.820402ms","start":"2026-06-09T15:54:22.967585Z","end":"2026-06-09T15:54:23.261405Z","steps":["trace[1096207240] 'process raft request' (duration: 293.683968ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:54:24.184034Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8620627102956010139,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-09T15:54:24.422143Z","caller":"traceutil/trace.go:171","msg":"trace[1085186865] transaction","detail":"{read_only:false; response_revision:1342; number_of_response:1; }","duration":"739.004959ms","start":"2026-06-09T15:54:23.683116Z","end":"2026-06-09T15:54:24.422121Z","steps":["trace[1085186865] 'process raft request' (duration: 738.851354ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:54:24.422258Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:54:23.683099Z","time spent":"739.109353ms","remote":"127.0.0.1:43780","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":494,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-09T15:54:24.43152Z","caller":"traceutil/trace.go:171","msg":"trace[1585313435] linearizableReadLoop","detail":"{readStateIndex:1400; appliedIndex:1398; }","duration":"748.338709ms","start":"2026-06-09T15:54:23.683166Z","end":"2026-06-09T15:54:24.431504Z","steps":["trace[1585313435] 'read index received' (duration: 738.737461ms)","trace[1585313435] 'applied index is now lower than readState.Index' (duration: 9.600378ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T15:54:24.431741Z","caller":"traceutil/trace.go:171","msg":"trace[210106046] transaction","detail":"{read_only:false; response_revision:1343; number_of_response:1; }","duration":"291.612112ms","start":"2026-06-09T15:54:24.140118Z","end":"2026-06-09T15:54:24.43173Z","steps":["trace[210106046] 'process raft request' (duration: 291.25471ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T15:54:24.431861Z","caller":"traceutil/trace.go:171","msg":"trace[494395257] transaction","detail":"{read_only:false; response_revision:1344; number_of_response:1; }","duration":"135.682551ms","start":"2026-06-09T15:54:24.296172Z","end":"2026-06-09T15:54:24.431855Z","steps":["trace[494395257] 'process raft request' (duration: 135.300348ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:54:24.432056Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"748.878996ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:1 size:112976"} {"level":"info","ts":"2026-06-09T15:54:24.432081Z","caller":"traceutil/trace.go:171","msg":"trace[1783172533] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:1; response_revision:1344; }","duration":"748.926778ms","start":"2026-06-09T15:54:23.683147Z","end":"2026-06-09T15:54:24.432073Z","steps":["trace[1783172533] 'agreement among raft nodes before linearized reading' (duration: 748.794593ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:54:24.432102Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:54:23.68314Z","time spent":"748.956179ms","remote":"127.0.0.1:43634","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":1,"response size":113000,"request content":"key:\"/registry/ranges/serviceips\" "} {"level":"warn","ts":"2026-06-09T15:54:24.442178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.341233ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-06-09T15:54:24.442194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"405.350927ms","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-09T15:54:24.442244Z","caller":"traceutil/trace.go:171","msg":"trace[1097731176] range","detail":"{range_begin:/registry/csidrivers/; range_end:/registry/csidrivers0; response_count:0; response_revision:1345; }","duration":"221.448387ms","start":"2026-06-09T15:54:24.22078Z","end":"2026-06-09T15:54:24.442228Z","steps":["trace[1097731176] 'agreement among raft nodes before linearized reading' (duration: 221.310533ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:54:24.442308Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.268086ms","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-09T15:54:24.442336Z","caller":"traceutil/trace.go:171","msg":"trace[1801691779] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1345; }","duration":"280.296307ms","start":"2026-06-09T15:54:24.162034Z","end":"2026-06-09T15:54:24.442331Z","steps":["trace[1801691779] 'agreement among raft nodes before linearized reading' (duration: 280.235365ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:54:24.442444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.135622ms","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-09T15:54:24.442551Z","caller":"traceutil/trace.go:171","msg":"trace[510203379] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1345; }","duration":"130.294998ms","start":"2026-06-09T15:54:24.312235Z","end":"2026-06-09T15:54:24.44253Z","steps":["trace[510203379] 'agreement among raft nodes before linearized reading' (duration: 129.834643ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:54:24.442613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.467875ms","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-09T15:54:24.442651Z","caller":"traceutil/trace.go:171","msg":"trace[806337383] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1345; }","duration":"131.538567ms","start":"2026-06-09T15:54:24.311105Z","end":"2026-06-09T15:54:24.442643Z","steps":["trace[806337383] 'agreement among raft nodes before linearized reading' (duration: 131.372412ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T15:54:24.442253Z","caller":"traceutil/trace.go:171","msg":"trace[336732924] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1345; }","duration":"405.4542ms","start":"2026-06-09T15:54:24.036784Z","end":"2026-06-09T15:54:24.442238Z","steps":["trace[336732924] 'agreement among raft nodes before linearized reading' (duration: 405.265414ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:54:24.442826Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:54:24.036766Z","time spent":"406.051749ms","remote":"127.0.0.1:43780","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-09T15:54:24.443012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.692686ms","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-09T15:54:24.443087Z","caller":"traceutil/trace.go:171","msg":"trace[393992401] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1345; }","duration":"128.788379ms","start":"2026-06-09T15:54:24.314288Z","end":"2026-06-09T15:54:24.443076Z","steps":["trace[393992401] 'agreement among raft nodes before linearized reading' (duration: 128.518881ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T15:54:24.697236Z","caller":"traceutil/trace.go:171","msg":"trace[867431971] transaction","detail":"{read_only:false; response_revision:1346; number_of_response:1; }","duration":"262.121933ms","start":"2026-06-09T15:54:24.43509Z","end":"2026-06-09T15:54:24.697212Z","steps":["trace[867431971] 'process raft request' (duration: 258.59884ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T15:54:24.703044Z","caller":"traceutil/trace.go:171","msg":"trace[303560276] transaction","detail":"{read_only:false; response_revision:1347; number_of_response:1; }","duration":"256.428441ms","start":"2026-06-09T15:54:24.446593Z","end":"2026-06-09T15:54:24.703021Z","steps":["trace[303560276] 'process raft request' (duration: 256.239105ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T15:54:24.703419Z","caller":"traceutil/trace.go:171","msg":"trace[233165766] transaction","detail":"{read_only:false; response_revision:1348; number_of_response:1; }","duration":"256.763662ms","start":"2026-06-09T15:54:24.446635Z","end":"2026-06-09T15:54:24.703398Z","steps":["trace[233165766] 'process raft request' (duration: 256.352509ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T15:54:24.703902Z","caller":"traceutil/trace.go:171","msg":"trace[1698728159] transaction","detail":"{read_only:false; response_revision:1349; number_of_response:1; }","duration":"257.209106ms","start":"2026-06-09T15:54:24.446662Z","end":"2026-06-09T15:54:24.703872Z","steps":["trace[1698728159] 'process raft request' (duration: 256.655509ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T15:54:24.704097Z","caller":"traceutil/trace.go:171","msg":"trace[1901236381] transaction","detail":"{read_only:false; response_revision:1350; number_of_response:1; }","duration":"257.284748ms","start":"2026-06-09T15:54:24.446802Z","end":"2026-06-09T15:54:24.704086Z","steps":["trace[1901236381] 'process raft request' (duration: 256.871695ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T15:54:24.704594Z","caller":"traceutil/trace.go:171","msg":"trace[1035625106] transaction","detail":"{read_only:false; response_revision:1352; number_of_response:1; }","duration":"255.980557ms","start":"2026-06-09T15:54:24.448585Z","end":"2026-06-09T15:54:24.704566Z","steps":["trace[1035625106] 'process raft request' (duration: 255.840752ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T15:54:24.704549Z","caller":"traceutil/trace.go:171","msg":"trace[1523483992] transaction","detail":"{read_only:false; response_revision:1351; number_of_response:1; }","duration":"257.174745ms","start":"2026-06-09T15:54:24.447314Z","end":"2026-06-09T15:54:24.704489Z","steps":["trace[1523483992] 'process raft request' (duration: 256.477623ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:54:24.70488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.200004ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T15:54:24.704925Z","caller":"traceutil/trace.go:171","msg":"trace[254697584] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:1352; }","duration":"256.278426ms","start":"2026-06-09T15:54:24.448633Z","end":"2026-06-09T15:54:24.704911Z","steps":["trace[254697584] 'agreement among raft nodes before linearized reading' (duration: 256.170472ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T15:54:24.704738Z","caller":"traceutil/trace.go:171","msg":"trace[114516559] linearizableReadLoop","detail":"{readStateIndex:1409; appliedIndex:1402; }","duration":"256.06099ms","start":"2026-06-09T15:54:24.448659Z","end":"2026-06-09T15:54:24.70472Z","steps":["trace[114516559] 'read index received' (duration: 245.040725ms)","trace[114516559] 'applied index is now lower than readState.Index' (duration: 11.010484ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T15:54:24.705365Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.666998ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T15:54:24.705406Z","caller":"traceutil/trace.go:171","msg":"trace[786720353] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1352; }","duration":"148.707669ms","start":"2026-06-09T15:54:24.556688Z","end":"2026-06-09T15:54:24.705396Z","steps":["trace[786720353] 'agreement among raft nodes before linearized reading' (duration: 148.650068ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:54:26.091079Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8620627102956010157,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-09T15:54:26.591359Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8620627102956010157,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-09T15:54:27.091997Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8620627102956010157,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-09T15:54:27.592556Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8620627102956010157,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-09T15:54:27.750117Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.414192475s","expected-duration":"1s"} {"level":"warn","ts":"2026-06-09T15:54:27.750421Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:54:25.335833Z","time spent":"2.414583417s","remote":"127.0.0.1:43610","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-06-09T15:54:28.398193Z","caller":"traceutil/trace.go:171","msg":"trace[1693658556] transaction","detail":"{read_only:false; response_revision:1353; number_of_response:1; }","duration":"1.960136352s","start":"2026-06-09T15:54:26.43799Z","end":"2026-06-09T15:54:28.398127Z","steps":["trace[1693658556] 'process raft request' (duration: 1.871343998s)","trace[1693658556] 'compare' (duration: 88.561406ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T15:54:28.398356Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:54:26.437967Z","time spent":"1.960308768s","remote":"127.0.0.1:43780","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T15:54:28.39819Z","caller":"traceutil/trace.go:171","msg":"trace[801838960] linearizableReadLoop","detail":"{readStateIndex:1411; appliedIndex:1409; }","duration":"2.808069902s","start":"2026-06-09T15:54:25.590092Z","end":"2026-06-09T15:54:28.398162Z","steps":["trace[801838960] 'read index received' (duration: 2.160190992s)","trace[801838960] 'applied index is now lower than readState.Index' (duration: 647.87749ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T15:54:28.399275Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.273611426s","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-09T15:54:28.399335Z","caller":"traceutil/trace.go:171","msg":"trace[545862701] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:1354; }","duration":"2.27371148s","start":"2026-06-09T15:54:26.125609Z","end":"2026-06-09T15:54:28.399321Z","steps":["trace[545862701] 'agreement among raft nodes before linearized reading' (duration: 2.273586676s)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:54:28.399311Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.809189679s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-09T15:54:28.399424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.808943203s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-09T15:54:28.39942Z","caller":"traceutil/trace.go:171","msg":"trace[1740604524] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:1354; }","duration":"2.809352614s","start":"2026-06-09T15:54:25.590048Z","end":"2026-06-09T15:54:28.3994Z","steps":["trace[1740604524] 'agreement among raft nodes before linearized reading' (duration: 2.808200477s)"],"step_count":1} {"level":"info","ts":"2026-06-09T15:54:28.399476Z","caller":"traceutil/trace.go:171","msg":"trace[693877254] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:1354; }","duration":"1.809030716s","start":"2026-06-09T15:54:26.590436Z","end":"2026-06-09T15:54:28.399467Z","steps":["trace[693877254] 'agreement among raft nodes before linearized reading' (duration: 1.808955944s)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:54:28.399551Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:54:26.590417Z","time spent":"1.809114039s","remote":"127.0.0.1:43860","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":17,"response size":31,"request content":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true "} {"level":"warn","ts":"2026-06-09T15:54:28.399567Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:54:25.590025Z","time spent":"2.809481668s","remote":"127.0.0.1:43830","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":29,"request content":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true "} {"level":"warn","ts":"2026-06-09T15:54:28.399585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.690080584s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-06-09T15:54:28.399657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.690328572s","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-09T15:54:28.39972Z","caller":"traceutil/trace.go:171","msg":"trace[1318634976] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1354; }","duration":"1.69027531s","start":"2026-06-09T15:54:26.709412Z","end":"2026-06-09T15:54:28.399688Z","steps":["trace[1318634976] 'agreement among raft nodes before linearized reading' (duration: 1.689872457s)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:54:28.399776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.843422312s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-09T15:54:28.399797Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:54:26.709392Z","time spent":"1.690389133s","remote":"127.0.0.1:43780","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-09T15:54:28.399826Z","caller":"traceutil/trace.go:171","msg":"trace[848045476] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1354; }","duration":"1.843508994s","start":"2026-06-09T15:54:26.556306Z","end":"2026-06-09T15:54:28.399815Z","steps":["trace[848045476] 'agreement among raft nodes before linearized reading' (duration: 1.843439362s)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:54:28.399835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.690560319s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-06-09T15:54:28.399864Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:54:26.556283Z","time spent":"1.843573757s","remote":"127.0.0.1:43598","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-09T15:54:28.399868Z","caller":"traceutil/trace.go:171","msg":"trace[1457694233] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1354; }","duration":"1.690612671s","start":"2026-06-09T15:54:26.709247Z","end":"2026-06-09T15:54:28.399859Z","steps":["trace[1457694233] 'agreement among raft nodes before linearized reading' (duration: 1.690517408s)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:54:28.399912Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:54:26.709235Z","time spent":"1.690666672s","remote":"127.0.0.1:43780","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-09T15:54:28.399529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.691906102s","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-09T15:54:28.400008Z","caller":"traceutil/trace.go:171","msg":"trace[2058918479] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1354; }","duration":"1.692437249s","start":"2026-06-09T15:54:26.707561Z","end":"2026-06-09T15:54:28.399998Z","steps":["trace[2058918479] 'agreement among raft nodes before linearized reading' (duration: 1.691792888s)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:54:28.400046Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:54:26.70754Z","time spent":"1.692496041s","remote":"127.0.0.1:43780","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-09T15:54:28.400105Z","caller":"traceutil/trace.go:171","msg":"trace[1812115702] transaction","detail":"{read_only:false; response_revision:1354; number_of_response:1; }","duration":"648.503921ms","start":"2026-06-09T15:54:27.751578Z","end":"2026-06-09T15:54:28.400082Z","steps":["trace[1812115702] 'process raft request' (duration: 646.513067ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:54:28.399371Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:54:26.125591Z","time spent":"2.273769502s","remote":"127.0.0.1:57598","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":1,"response size":31,"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-09T15:54:28.400265Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:54:27.75156Z","time spent":"648.603513ms","remote":"127.0.0.1:43610","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":118,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T15:54:28.400525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.204444ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T15:54:28.400584Z","caller":"traceutil/trace.go:171","msg":"trace[238870346] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:1354; }","duration":"340.305876ms","start":"2026-06-09T15:54:28.060264Z","end":"2026-06-09T15:54:28.40057Z","steps":["trace[238870346] 'agreement among raft nodes before linearized reading' (duration: 340.211613ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:54:28.40062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.087587632s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:474"} {"level":"warn","ts":"2026-06-09T15:54:28.400648Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.68994957s","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-09T15:54:28.40069Z","caller":"traceutil/trace.go:171","msg":"trace[1536802330] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1354; }","duration":"1.087698495s","start":"2026-06-09T15:54:27.31298Z","end":"2026-06-09T15:54:28.400679Z","steps":["trace[1536802330] 'agreement among raft nodes before linearized reading' (duration: 1.08755566s)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:54:28.400744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.59785073s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T15:54:28.400782Z","caller":"traceutil/trace.go:171","msg":"trace[617259322] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:1354; }","duration":"1.597932932s","start":"2026-06-09T15:54:26.802841Z","end":"2026-06-09T15:54:28.400774Z","steps":["trace[617259322] 'agreement among raft nodes before linearized reading' (duration: 1.59787608s)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:54:28.400819Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:54:26.802816Z","time spent":"1.597993354s","remote":"127.0.0.1:57538","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"info","ts":"2026-06-09T15:54:28.399734Z","caller":"traceutil/trace.go:171","msg":"trace[1985945259] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1354; }","duration":"1.690411904s","start":"2026-06-09T15:54:26.709297Z","end":"2026-06-09T15:54:28.399709Z","steps":["trace[1985945259] 'agreement among raft nodes before linearized reading' (duration: 1.69028334s)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:54:28.400979Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:54:26.709286Z","time spent":"1.691673005s","remote":"127.0.0.1:43780","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-09T15:54:28.400743Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:54:27.31296Z","time spent":"1.087767148s","remote":"127.0.0.1:43780","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":498,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "} {"level":"info","ts":"2026-06-09T15:54:28.400695Z","caller":"traceutil/trace.go:171","msg":"trace[1143664165] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1354; }","duration":"1.690037952s","start":"2026-06-09T15:54:26.710647Z","end":"2026-06-09T15:54:28.400685Z","steps":["trace[1143664165] 'agreement among raft nodes before linearized reading' (duration: 1.689857956s)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:54:28.401151Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:54:26.710628Z","time spent":"1.690510718s","remote":"127.0.0.1:43780","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-09T15:54:28.400629Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:54:28.060243Z","time spent":"340.371749ms","remote":"127.0.0.1:43686","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":0,"response size":29,"request content":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true "} {"level":"info","ts":"2026-06-09T15:54:30.054435Z","caller":"traceutil/trace.go:171","msg":"trace[803880334] linearizableReadLoop","detail":"{readStateIndex:1419; appliedIndex:1418; }","duration":"219.543156ms","start":"2026-06-09T15:54:29.834864Z","end":"2026-06-09T15:54:30.054407Z","steps":["trace[803880334] 'read index received' (duration: 219.35343ms)","trace[803880334] 'applied index is now lower than readState.Index' (duration: 188.386µs)"],"step_count":2} {"level":"info","ts":"2026-06-09T15:54:30.054544Z","caller":"traceutil/trace.go:171","msg":"trace[2020611318] transaction","detail":"{read_only:false; response_revision:1361; number_of_response:1; }","duration":"340.317687ms","start":"2026-06-09T15:54:29.714199Z","end":"2026-06-09T15:54:30.054517Z","steps":["trace[2020611318] 'process raft request' (duration: 339.976976ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:54:30.054765Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:54:29.714185Z","time spent":"340.500213ms","remote":"127.0.0.1:43780","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":494,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T15:54:30.054815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.759643ms","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-09T15:54:30.055048Z","caller":"traceutil/trace.go:171","msg":"trace[431681545] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:1361; }","duration":"220.140945ms","start":"2026-06-09T15:54:29.834806Z","end":"2026-06-09T15:54:30.054947Z","steps":["trace[431681545] 'agreement among raft nodes before linearized reading' (duration: 219.742372ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T15:54:30.082145Z","caller":"traceutil/trace.go:171","msg":"trace[1017410908] transaction","detail":"{read_only:false; response_revision:1362; number_of_response:1; }","duration":"137.966224ms","start":"2026-06-09T15:54:29.944158Z","end":"2026-06-09T15:54:30.082124Z","steps":["trace[1017410908] 'process raft request' (duration: 135.382241ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T15:54:36.681392Z","caller":"traceutil/trace.go:171","msg":"trace[173474039] transaction","detail":"{read_only:false; response_revision:1420; number_of_response:1; }","duration":"114.656844ms","start":"2026-06-09T15:54:36.566711Z","end":"2026-06-09T15:54:36.681368Z","steps":["trace[173474039] 'process raft request' (duration: 114.619913ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T15:54:36.68164Z","caller":"traceutil/trace.go:171","msg":"trace[1231694863] transaction","detail":"{read_only:false; response_revision:1419; number_of_response:1; }","duration":"114.995245ms","start":"2026-06-09T15:54:36.566618Z","end":"2026-06-09T15:54:36.681613Z","steps":["trace[1231694863] 'process raft request' (duration: 114.576491ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T15:54:37.402942Z","caller":"traceutil/trace.go:171","msg":"trace[1904544807] linearizableReadLoop","detail":"{readStateIndex:1481; appliedIndex:1480; }","duration":"169.535239ms","start":"2026-06-09T15:54:37.233367Z","end":"2026-06-09T15:54:37.402903Z","steps":["trace[1904544807] 'read index received' (duration: 169.301601ms)","trace[1904544807] 'applied index is now lower than readState.Index' (duration: 232.547µs)"],"step_count":2} {"level":"info","ts":"2026-06-09T15:54:37.403013Z","caller":"traceutil/trace.go:171","msg":"trace[1946393993] transaction","detail":"{read_only:false; response_revision:1421; number_of_response:1; }","duration":"324.88145ms","start":"2026-06-09T15:54:37.0781Z","end":"2026-06-09T15:54:37.402981Z","steps":["trace[1946393993] 'process raft request' (duration: 324.653553ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:54:37.40307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.671053ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-09T15:54:37.403112Z","caller":"traceutil/trace.go:171","msg":"trace[78681974] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/; range_end:/registry/mutatingwebhookconfigurations0; response_count:0; response_revision:1421; }","duration":"169.783436ms","start":"2026-06-09T15:54:37.233315Z","end":"2026-06-09T15:54:37.403098Z","steps":["trace[78681974] 'agreement among raft nodes before linearized reading' (duration: 169.688283ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:54:37.403175Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:54:37.07808Z","time spent":"325.016185ms","remote":"127.0.0.1:43780","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T15:54:38.302461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.356308ms","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:530"} {"level":"info","ts":"2026-06-09T15:54:38.30255Z","caller":"traceutil/trace.go:171","msg":"trace[621116733] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1421; }","duration":"106.482052ms","start":"2026-06-09T15:54:38.196045Z","end":"2026-06-09T15:54:38.302527Z","steps":["trace[621116733] 'range keys from in-memory index tree' (duration: 106.161372ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:54:38.302621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"746.998015ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T15:54:38.302706Z","caller":"traceutil/trace.go:171","msg":"trace[1963565792] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1421; }","duration":"747.220283ms","start":"2026-06-09T15:54:37.555468Z","end":"2026-06-09T15:54:38.302688Z","steps":["trace[1963565792] 'range keys from in-memory index tree' (duration: 746.907033ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:54:38.302754Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:54:37.555443Z","time spent":"747.302705ms","remote":"127.0.0.1:43598","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-09T15:54:43.753228Z","caller":"traceutil/trace.go:171","msg":"trace[163684996] transaction","detail":"{read_only:false; response_revision:1449; number_of_response:1; }","duration":"114.935013ms","start":"2026-06-09T15:54:43.638265Z","end":"2026-06-09T15:54:43.7532Z","steps":["trace[163684996] 'process raft request' (duration: 114.723407ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T15:54:44.766011Z","caller":"traceutil/trace.go:171","msg":"trace[1186586969] linearizableReadLoop","detail":"{readStateIndex:1514; appliedIndex:1513; }","duration":"130.265316ms","start":"2026-06-09T15:54:44.635722Z","end":"2026-06-09T15:54:44.765987Z","steps":["trace[1186586969] 'read index received' (duration: 90.658983ms)","trace[1186586969] 'applied index is now lower than readState.Index' (duration: 39.605063ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T15:54:44.766279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.535516ms","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-09T15:54:44.766327Z","caller":"traceutil/trace.go:171","msg":"trace[1561427009] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1453; }","duration":"130.618428ms","start":"2026-06-09T15:54:44.635694Z","end":"2026-06-09T15:54:44.766312Z","steps":["trace[1561427009] 'agreement among raft nodes before linearized reading' (duration: 130.432872ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T15:54:44.766544Z","caller":"traceutil/trace.go:171","msg":"trace[1330215318] transaction","detail":"{read_only:false; response_revision:1453; number_of_response:1; }","duration":"160.653623ms","start":"2026-06-09T15:54:44.605463Z","end":"2026-06-09T15:54:44.766116Z","steps":["trace[1330215318] 'process raft request' (duration: 121.014369ms)","trace[1330215318] 'compare' (duration: 39.392956ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T15:55:06.864944Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.211269ms","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-09T15:55:06.86505Z","caller":"traceutil/trace.go:171","msg":"trace[1153986403] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1554; }","duration":"149.373334ms","start":"2026-06-09T15:55:06.715648Z","end":"2026-06-09T15:55:06.865022Z","steps":["trace[1153986403] 'range keys from in-memory index tree' (duration: 148.972851ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T15:55:10.675593Z","caller":"traceutil/trace.go:171","msg":"trace[1992818192] transaction","detail":"{read_only:false; response_revision:1570; number_of_response:1; }","duration":"156.5052ms","start":"2026-06-09T15:55:10.519041Z","end":"2026-06-09T15:55:10.675547Z","steps":["trace[1992818192] 'process raft request' (duration: 156.323214ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:55:10.675708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.260488ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T15:55:10.675513Z","caller":"traceutil/trace.go:171","msg":"trace[1494999337] linearizableReadLoop","detail":"{readStateIndex:1636; appliedIndex:1635; }","duration":"120.06298ms","start":"2026-06-09T15:55:10.55543Z","end":"2026-06-09T15:55:10.675493Z","steps":["trace[1494999337] 'read index received' (duration: 119.957577ms)","trace[1494999337] 'applied index is now lower than readState.Index' (duration: 104.033µs)"],"step_count":2} {"level":"info","ts":"2026-06-09T15:55:10.67577Z","caller":"traceutil/trace.go:171","msg":"trace[83348704] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1570; }","duration":"120.363221ms","start":"2026-06-09T15:55:10.555395Z","end":"2026-06-09T15:55:10.675758Z","steps":["trace[83348704] 'agreement among raft nodes before linearized reading' (duration: 120.254237ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:55:10.691331Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.58495ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:535"} {"level":"info","ts":"2026-06-09T15:55:10.691429Z","caller":"traceutil/trace.go:171","msg":"trace[219937272] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1571; }","duration":"121.719495ms","start":"2026-06-09T15:55:10.569687Z","end":"2026-06-09T15:55:10.691406Z","steps":["trace[219937272] 'agreement among raft nodes before linearized reading' (duration: 121.394174ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T15:55:12.589934Z","caller":"traceutil/trace.go:171","msg":"trace[129055029] transaction","detail":"{read_only:false; response_revision:1579; number_of_response:1; }","duration":"108.975496ms","start":"2026-06-09T15:55:12.480932Z","end":"2026-06-09T15:55:12.589907Z","steps":["trace[129055029] 'process raft request' (duration: 108.781119ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:55:12.994961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.76164ms","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-09T15:55:12.995035Z","caller":"traceutil/trace.go:171","msg":"trace[1888881342] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1579; }","duration":"315.871693ms","start":"2026-06-09T15:55:12.679146Z","end":"2026-06-09T15:55:12.995018Z","steps":["trace[1888881342] 'range keys from in-memory index tree' (duration: 315.577663ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:55:12.995084Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:55:12.679129Z","time spent":"315.947535ms","remote":"127.0.0.1:43780","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-09T15:55:12.995398Z","caller":"traceutil/trace.go:171","msg":"trace[1037621971] transaction","detail":"{read_only:false; response_revision:1580; number_of_response:1; }","duration":"296.049541ms","start":"2026-06-09T15:55:12.699318Z","end":"2026-06-09T15:55:12.995367Z","steps":["trace[1037621971] 'process raft request' (duration: 295.821013ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T15:55:15.190941Z","caller":"traceutil/trace.go:171","msg":"trace[2052547989] linearizableReadLoop","detail":"{readStateIndex:1658; appliedIndex:1656; }","duration":"109.481312ms","start":"2026-06-09T15:55:15.081428Z","end":"2026-06-09T15:55:15.190909Z","steps":["trace[2052547989] 'read index received' (duration: 48.407873ms)","trace[2052547989] 'applied index is now lower than readState.Index' (duration: 61.072899ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T15:55:15.190994Z","caller":"traceutil/trace.go:171","msg":"trace[1995983142] transaction","detail":"{read_only:false; response_revision:1591; number_of_response:1; }","duration":"111.016473ms","start":"2026-06-09T15:55:15.079951Z","end":"2026-06-09T15:55:15.190968Z","steps":["trace[1995983142] 'process raft request' (duration: 110.852788ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:55:15.191102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.661168ms","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-09T15:55:15.191133Z","caller":"traceutil/trace.go:171","msg":"trace[1198665960] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1592; }","duration":"109.72754ms","start":"2026-06-09T15:55:15.081395Z","end":"2026-06-09T15:55:15.191122Z","steps":["trace[1198665960] 'agreement among raft nodes before linearized reading' (duration: 109.634137ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T15:55:15.191015Z","caller":"traceutil/trace.go:171","msg":"trace[1424176315] transaction","detail":"{read_only:false; response_revision:1592; number_of_response:1; }","duration":"108.270963ms","start":"2026-06-09T15:55:15.082739Z","end":"2026-06-09T15:55:15.19101Z","steps":["trace[1424176315] 'process raft request' (duration: 108.149329ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:55:19.300319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.053103ms","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-09T15:55:19.300428Z","caller":"traceutil/trace.go:171","msg":"trace[1391607840] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:1608; }","duration":"128.213019ms","start":"2026-06-09T15:55:19.172191Z","end":"2026-06-09T15:55:19.300404Z","steps":["trace[1391607840] 'count revisions from in-memory index tree' (duration: 127.883037ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:55:19.300831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.191469ms","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:530"} {"level":"info","ts":"2026-06-09T15:55:19.300921Z","caller":"traceutil/trace.go:171","msg":"trace[1072873968] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1608; }","duration":"111.367884ms","start":"2026-06-09T15:55:19.189531Z","end":"2026-06-09T15:55:19.300899Z","steps":["trace[1072873968] 'range keys from in-memory index tree' (duration: 110.507386ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T15:55:29.258832Z","caller":"traceutil/trace.go:171","msg":"trace[1109932203] transaction","detail":"{read_only:false; response_revision:1654; number_of_response:1; }","duration":"117.060972ms","start":"2026-06-09T15:55:29.141749Z","end":"2026-06-09T15:55:29.25881Z","steps":["trace[1109932203] 'process raft request' (duration: 116.922277ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T15:55:41.856211Z","caller":"traceutil/trace.go:171","msg":"trace[616968983] transaction","detail":"{read_only:false; response_revision:1714; number_of_response:1; }","duration":"187.863982ms","start":"2026-06-09T15:55:41.668308Z","end":"2026-06-09T15:55:41.856172Z","steps":["trace[616968983] 'process raft request' (duration: 103.064801ms)","trace[616968983] 'compare' (duration: 84.611885ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T15:55:41.856222Z","caller":"traceutil/trace.go:171","msg":"trace[2146806698] transaction","detail":"{read_only:false; response_revision:1715; number_of_response:1; }","duration":"186.789636ms","start":"2026-06-09T15:55:41.669403Z","end":"2026-06-09T15:55:41.856192Z","steps":["trace[2146806698] 'process raft request' (duration: 186.703664ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T15:55:42.844447Z","caller":"traceutil/trace.go:171","msg":"trace[413512061] transaction","detail":"{read_only:false; response_revision:1717; number_of_response:1; }","duration":"116.356659ms","start":"2026-06-09T15:55:42.72807Z","end":"2026-06-09T15:55:42.844427Z","steps":["trace[413512061] 'process raft request' (duration: 116.234495ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T15:55:50.056052Z","caller":"traceutil/trace.go:171","msg":"trace[1318945754] transaction","detail":"{read_only:false; response_revision:1752; number_of_response:1; }","duration":"119.876304ms","start":"2026-06-09T15:55:49.936158Z","end":"2026-06-09T15:55:50.056035Z","steps":["trace[1318945754] 'process raft request' (duration: 119.743719ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:55:50.955749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.975757ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-06-09T15:55:50.955829Z","caller":"traceutil/trace.go:171","msg":"trace[1668731993] linearizableReadLoop","detail":"{readStateIndex:1828; appliedIndex:1827; }","duration":"100.311041ms","start":"2026-06-09T15:55:50.855506Z","end":"2026-06-09T15:55:50.955817Z","steps":["trace[1668731993] 'read index received' (duration: 50.922µs)","trace[1668731993] 'applied index is now lower than readState.Index' (duration: 100.259099ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T15:55:50.955941Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.427845ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:535"} {"level":"info","ts":"2026-06-09T15:55:50.95596Z","caller":"traceutil/trace.go:171","msg":"trace[238382477] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1753; }","duration":"100.495977ms","start":"2026-06-09T15:55:50.855456Z","end":"2026-06-09T15:55:50.955952Z","steps":["trace[238382477] 'agreement among raft nodes before linearized reading' (duration: 100.394594ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:55:51.841309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.683121ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-09T15:55:51.841424Z","caller":"traceutil/trace.go:171","msg":"trace[20406756] linearizableReadLoop","detail":"{readStateIndex:1831; appliedIndex:1830; }","duration":"233.809473ms","start":"2026-06-09T15:55:51.607598Z","end":"2026-06-09T15:55:51.841408Z","steps":["trace[20406756] 'read index received' (duration: 36.041µs)","trace[20406756] 'applied index is now lower than readState.Index' (duration: 233.772212ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T15:55:51.841509Z","caller":"traceutil/trace.go:171","msg":"trace[1228617892] transaction","detail":"{read_only:false; response_revision:1756; number_of_response:1; }","duration":"346.593664ms","start":"2026-06-09T15:55:51.494904Z","end":"2026-06-09T15:55:51.841498Z","steps":["trace[1228617892] 'process raft request' (duration: 80.622653ms)","trace[1228617892] 'compare' (duration: 265.437653ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T15:55:51.841568Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T15:55:51.49489Z","time spent":"346.645216ms","remote":"127.0.0.1:43780","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T15:55:51.841715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.904383ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-06-09T15:55:51.84176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.142104ms","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-09T15:55:51.841809Z","caller":"traceutil/trace.go:171","msg":"trace[785348893] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1756; }","duration":"233.068788ms","start":"2026-06-09T15:55:51.608717Z","end":"2026-06-09T15:55:51.841786Z","steps":["trace[785348893] 'agreement among raft nodes before linearized reading' (duration: 232.83217ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T15:55:51.841828Z","caller":"traceutil/trace.go:171","msg":"trace[867551175] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1756; }","duration":"234.207207ms","start":"2026-06-09T15:55:51.607585Z","end":"2026-06-09T15:55:51.841793Z","steps":["trace[867551175] 'agreement among raft nodes before linearized reading' (duration: 234.031711ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:55:51.841821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.786ms","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-09T15:55:51.841892Z","caller":"traceutil/trace.go:171","msg":"trace[1767130665] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1756; }","duration":"129.901804ms","start":"2026-06-09T15:55:51.711973Z","end":"2026-06-09T15:55:51.841874Z","steps":["trace[1767130665] 'agreement among raft nodes before linearized reading' (duration: 129.656026ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T15:55:52.033933Z","caller":"traceutil/trace.go:171","msg":"trace[585723590] transaction","detail":"{read_only:false; response_revision:1760; number_of_response:1; }","duration":"105.14806ms","start":"2026-06-09T15:55:51.928758Z","end":"2026-06-09T15:55:52.033906Z","steps":["trace[585723590] 'process raft request' (duration: 37.928528ms)","trace[585723590] 'compare' (duration: 66.895721ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T15:56:00.058389Z","caller":"traceutil/trace.go:171","msg":"trace[1165358493] transaction","detail":"{read_only:false; response_revision:1793; number_of_response:1; }","duration":"119.270225ms","start":"2026-06-09T15:55:59.939093Z","end":"2026-06-09T15:56:00.058363Z","steps":["trace[1165358493] 'process raft request' (duration: 119.097439ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T15:56:00.062098Z","caller":"traceutil/trace.go:171","msg":"trace[1372999936] transaction","detail":"{read_only:false; response_revision:1795; number_of_response:1; }","duration":"111.924462ms","start":"2026-06-09T15:55:59.950141Z","end":"2026-06-09T15:56:00.062065Z","steps":["trace[1372999936] 'process raft request' (duration: 111.872451ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T15:56:00.062153Z","caller":"traceutil/trace.go:171","msg":"trace[1226229460] transaction","detail":"{read_only:false; response_revision:1794; number_of_response:1; }","duration":"114.013551ms","start":"2026-06-09T15:55:59.948121Z","end":"2026-06-09T15:56:00.062134Z","steps":["trace[1226229460] 'process raft request' (duration: 113.729561ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T15:56:02.197234Z","caller":"traceutil/trace.go:171","msg":"trace[2074979046] transaction","detail":"{read_only:false; response_revision:1804; number_of_response:1; }","duration":"109.056311ms","start":"2026-06-09T15:56:02.088136Z","end":"2026-06-09T15:56:02.197193Z","steps":["trace[2074979046] 'process raft request' (duration: 65.156886ms)","trace[2074979046] 'compare' (duration: 43.696288ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T15:56:03.032151Z","caller":"traceutil/trace.go:171","msg":"trace[1755942499] transaction","detail":"{read_only:false; response_revision:1809; number_of_response:1; }","duration":"116.931973ms","start":"2026-06-09T15:56:02.915192Z","end":"2026-06-09T15:56:03.032124Z","steps":["trace[1755942499] 'process raft request' (duration: 116.755068ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T15:56:06.340098Z","caller":"traceutil/trace.go:171","msg":"trace[563817240] transaction","detail":"{read_only:false; response_revision:1825; number_of_response:1; }","duration":"100.019332ms","start":"2026-06-09T15:56:06.23976Z","end":"2026-06-09T15:56:06.33978Z","steps":["trace[563817240] 'process raft request' (duration: 46.631502ms)","trace[563817240] 'compare' (duration: 53.217024ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T15:58:29.410285Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.042287ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T15:58:29.410388Z","caller":"traceutil/trace.go:171","msg":"trace[1226987788] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:2497; }","duration":"118.192132ms","start":"2026-06-09T15:58:29.292174Z","end":"2026-06-09T15:58:29.410367Z","steps":["trace[1226987788] 'count revisions from in-memory index tree' (duration: 117.964805ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:58:29.410534Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.048617ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:473"} {"level":"warn","ts":"2026-06-09T15:58:29.410614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.592063ms","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-09T15:58:29.410611Z","caller":"traceutil/trace.go:171","msg":"trace[218505088] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2497; }","duration":"144.16891ms","start":"2026-06-09T15:58:29.266424Z","end":"2026-06-09T15:58:29.410592Z","steps":["trace[218505088] 'range keys from in-memory index tree' (duration: 143.876661ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T15:58:29.410645Z","caller":"traceutil/trace.go:171","msg":"trace[749375143] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2497; }","duration":"280.654736ms","start":"2026-06-09T15:58:29.129983Z","end":"2026-06-09T15:58:29.410637Z","steps":["trace[749375143] 'range keys from in-memory index tree' (duration: 280.47683ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:58:35.647576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.340082ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"warn","ts":"2026-06-09T15:58:35.647647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.785512ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-06-09T15:58:35.647674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.825707ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-06-09T15:58:35.647757Z","caller":"traceutil/trace.go:171","msg":"trace[1638759665] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2531; }","duration":"124.949258ms","start":"2026-06-09T15:58:35.522783Z","end":"2026-06-09T15:58:35.647732Z","steps":["trace[1638759665] 'range keys from in-memory index tree' (duration: 124.571925ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:58:35.647785Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.227528ms","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-09T15:58:35.647768Z","caller":"traceutil/trace.go:171","msg":"trace[14432110] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2531; }","duration":"126.965021ms","start":"2026-06-09T15:58:35.520782Z","end":"2026-06-09T15:58:35.647747Z","steps":["trace[14432110] 'range keys from in-memory index tree' (duration: 126.582209ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T15:58:35.647822Z","caller":"traceutil/trace.go:171","msg":"trace[1989078103] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2531; }","duration":"121.308961ms","start":"2026-06-09T15:58:35.526505Z","end":"2026-06-09T15:58:35.647814Z","steps":["trace[1989078103] 'range keys from in-memory index tree' (duration: 121.112705ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T15:58:35.64767Z","caller":"traceutil/trace.go:171","msg":"trace[1649260285] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2531; }","duration":"121.467186ms","start":"2026-06-09T15:58:35.526179Z","end":"2026-06-09T15:58:35.647646Z","steps":["trace[1649260285] 'range keys from in-memory index tree' (duration: 121.111895ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T15:58:35.648343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.814829ms","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-09T15:58:35.6484Z","caller":"traceutil/trace.go:171","msg":"trace[148232042] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:2531; }","duration":"122.901171ms","start":"2026-06-09T15:58:35.525485Z","end":"2026-06-09T15:58:35.648386Z","steps":["trace[148232042] 'range keys from in-memory index tree' (duration: 122.685405ms)"],"step_count":1}