{"level":"warn","ts":"2026-06-15T20:58:03.220161Z","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-15T20:58:03.22027Z","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-15T20:58:03.220338Z","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-15T20:58:03.220351Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.65:2380"]} {"level":"info","ts":"2026-06-15T20:58:03.22037Z","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-15T20:58:03.220986Z","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-15T20:58:03.221095Z","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-15T20:58:03.224839Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.519072ms"} {"level":"info","ts":"2026-06-15T20:58:03.229198Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"cf8c3a138c9a77a2","cluster-id":"c278183e1f634dff"} {"level":"info","ts":"2026-06-15T20:58:03.229282Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 switched to configuration voters=()"} {"level":"info","ts":"2026-06-15T20:58:03.229301Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 became follower at term 0"} {"level":"info","ts":"2026-06-15T20:58:03.229315Z","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-15T20:58:03.229323Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 became follower at term 1"} {"level":"info","ts":"2026-06-15T20:58:03.229358Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 switched to configuration voters=(14955392318228297634)"} {"level":"warn","ts":"2026-06-15T20:58:03.235684Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-15T20:58:03.237377Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-15T20:58:03.238844Z","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-15T20:58:03.240927Z","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-15T20:58:03.241051Z","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-15T20:58:03.241242Z","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-15T20:58:03.241253Z","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-15T20:58:03.241511Z","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-15T20:58:03.248453Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 switched to configuration voters=(14955392318228297634)"} {"level":"info","ts":"2026-06-15T20:58:03.252216Z","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-15T20:58:03.253583Z","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-15T20:58:03.25451Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.65:2380"} {"level":"info","ts":"2026-06-15T20:58:03.254545Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.65:2380"} {"level":"info","ts":"2026-06-15T20:58:03.257259Z","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-15T20:58:03.257299Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-15T20:58:04.130506Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 is starting a new election at term 1"} {"level":"info","ts":"2026-06-15T20:58:04.130592Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 became pre-candidate at term 1"} {"level":"info","ts":"2026-06-15T20:58:04.130622Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 received MsgPreVoteResp from cf8c3a138c9a77a2 at term 1"} {"level":"info","ts":"2026-06-15T20:58:04.130634Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 became candidate at term 2"} {"level":"info","ts":"2026-06-15T20:58:04.13064Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 received MsgVoteResp from cf8c3a138c9a77a2 at term 2"} {"level":"info","ts":"2026-06-15T20:58:04.130652Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 became leader at term 2"} {"level":"info","ts":"2026-06-15T20:58:04.130659Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: cf8c3a138c9a77a2 elected leader cf8c3a138c9a77a2 at term 2"} {"level":"info","ts":"2026-06-15T20:58:04.131619Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-15T20:58:04.132243Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-15T20:58:04.132236Z","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-15T20:58:04.132305Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-15T20:58:04.132945Z","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-15T20:58:04.13308Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-15T20:58:04.133093Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-15T20:58:04.133121Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-15T20:58:04.133246Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-15T20:58:04.136029Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-15T20:58:04.136569Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.65:2379"} {"level":"info","ts":"2026-06-15T20:58:21.744187Z","caller":"traceutil/trace.go:171","msg":"trace[1561085719] linearizableReadLoop","detail":"{readStateIndex:426; appliedIndex:425; }","duration":"149.671108ms","start":"2026-06-15T20:58:21.594493Z","end":"2026-06-15T20:58:21.744164Z","steps":["trace[1561085719] 'read index received' (duration: 149.428481ms)","trace[1561085719] 'applied index is now lower than readState.Index' (duration: 241.717µs)"],"step_count":2} {"level":"info","ts":"2026-06-15T20:58:21.74431Z","caller":"traceutil/trace.go:171","msg":"trace[27165773] transaction","detail":"{read_only:false; response_revision:415; number_of_response:1; }","duration":"214.816244ms","start":"2026-06-15T20:58:21.529422Z","end":"2026-06-15T20:58:21.744239Z","steps":["trace[27165773] 'process raft request' (duration: 214.614799ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:58:21.744427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.77672ms","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-15T20:58:21.744518Z","caller":"traceutil/trace.go:171","msg":"trace[118853177] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:415; }","duration":"149.935494ms","start":"2026-06-15T20:58:21.594558Z","end":"2026-06-15T20:58:21.744494Z","steps":["trace[118853177] 'agreement among raft nodes before linearized reading' (duration: 149.752189ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:58:21.744504Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.998216ms","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-15T20:58:21.744687Z","caller":"traceutil/trace.go:171","msg":"trace[1413393644] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:415; }","duration":"150.17199ms","start":"2026-06-15T20:58:21.59445Z","end":"2026-06-15T20:58:21.744622Z","steps":["trace[1413393644] 'agreement among raft nodes before linearized reading' (duration: 149.857072ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:58:22.594451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"427.890882ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-15T20:58:22.594671Z","caller":"traceutil/trace.go:171","msg":"trace[1935602793] linearizableReadLoop","detail":"{readStateIndex:428; appliedIndex:426; }","duration":"487.066263ms","start":"2026-06-15T20:58:22.107593Z","end":"2026-06-15T20:58:22.594659Z","steps":["trace[1935602793] 'read index received' (duration: 58.487432ms)","trace[1935602793] 'applied index is now lower than readState.Index' (duration: 428.577721ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T20:58:22.594727Z","caller":"traceutil/trace.go:171","msg":"trace[2087335676] transaction","detail":"{read_only:false; response_revision:416; number_of_response:1; }","duration":"847.003745ms","start":"2026-06-15T20:58:21.747715Z","end":"2026-06-15T20:58:22.594718Z","steps":["trace[2087335676] 'process raft request' (duration: 418.387564ms)","trace[2087335676] 'compare' (duration: 427.79758ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T20:58:22.594769Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:58:21.747666Z","time spent":"847.078827ms","remote":"127.0.0.1:47480","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-15T20:58:22.594961Z","caller":"traceutil/trace.go:171","msg":"trace[2075083661] transaction","detail":"{read_only:false; response_revision:417; number_of_response:1; }","duration":"846.610994ms","start":"2026-06-15T20:58:21.748312Z","end":"2026-06-15T20:58:22.594923Z","steps":["trace[2075083661] 'process raft request' (duration: 846.219024ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:58:22.595115Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:58:21.748304Z","time spent":"846.728537ms","remote":"127.0.0.1:47480","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-15T20:58:22.595103Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"487.476373ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T20:58:22.595215Z","caller":"traceutil/trace.go:171","msg":"trace[1658246985] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:417; }","duration":"487.613316ms","start":"2026-06-15T20:58:22.107584Z","end":"2026-06-15T20:58:22.595197Z","steps":["trace[1658246985] 'agreement among raft nodes before linearized reading' (duration: 487.454362ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:58:22.983065Z","caller":"traceutil/trace.go:171","msg":"trace[2091977776] linearizableReadLoop","detail":"{readStateIndex:429; appliedIndex:428; }","duration":"388.355111ms","start":"2026-06-15T20:58:22.594694Z","end":"2026-06-15T20:58:22.983049Z","steps":["trace[2091977776] 'read index received' (duration: 385.548488ms)","trace[2091977776] 'applied index is now lower than readState.Index' (duration: 2.806033ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T20:58:22.983192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"756.231812ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-06-15T20:58:22.983211Z","caller":"traceutil/trace.go:171","msg":"trace[1206425042] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:417; }","duration":"756.295023ms","start":"2026-06-15T20:58:22.226911Z","end":"2026-06-15T20:58:22.983206Z","steps":["trace[1206425042] 'agreement among raft nodes before linearized reading' (duration: 756.22219ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:58:22.983187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"694.126985ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-15T20:58:22.983267Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"385.804996ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/etcd-instance\" ","response":"range_response_count:1 size:5326"} {"level":"info","ts":"2026-06-15T20:58:22.983265Z","caller":"traceutil/trace.go:171","msg":"trace[575595656] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:417; }","duration":"694.251278ms","start":"2026-06-15T20:58:22.288996Z","end":"2026-06-15T20:58:22.983247Z","steps":["trace[575595656] 'agreement among raft nodes before linearized reading' (duration: 694.100023ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:58:22.983287Z","caller":"traceutil/trace.go:171","msg":"trace[505755424] range","detail":"{range_begin:/registry/pods/kube-system/etcd-instance; range_end:; response_count:1; response_revision:417; }","duration":"385.848887ms","start":"2026-06-15T20:58:22.597435Z","end":"2026-06-15T20:58:22.983283Z","steps":["trace[505755424] 'agreement among raft nodes before linearized reading' (duration: 385.817446ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:58:22.983306Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:58:22.597419Z","time spent":"385.881007ms","remote":"127.0.0.1:47394","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":1,"response size":5350,"request content":"key:\"/registry/pods/kube-system/etcd-instance\" "} {"level":"warn","ts":"2026-06-15T20:58:22.983323Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:58:22.288951Z","time spent":"694.363741ms","remote":"127.0.0.1:59494","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-15T20:58:22.983232Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:58:22.226894Z","time spent":"756.334235ms","remote":"127.0.0.1:47480","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-15T20:58:28.733852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.861733ms","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-15T20:58:28.733956Z","caller":"traceutil/trace.go:171","msg":"trace[280813268] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:439; }","duration":"112.022907ms","start":"2026-06-15T20:58:28.621907Z","end":"2026-06-15T20:58:28.73393Z","steps":["trace[280813268] 'agreement among raft nodes before linearized reading' (duration: 111.832872ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:58:28.85997Z","caller":"traceutil/trace.go:171","msg":"trace[1695902055] transaction","detail":"{read_only:false; response_revision:440; number_of_response:1; }","duration":"169.786232ms","start":"2026-06-15T20:58:28.690117Z","end":"2026-06-15T20:58:28.859903Z","steps":["trace[1695902055] 'process raft request' (duration: 115.090598ms)","trace[1695902055] 'compare' (duration: 54.448407ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T20:58:28.860032Z","caller":"traceutil/trace.go:171","msg":"trace[253871225] transaction","detail":"{read_only:false; response_revision:441; number_of_response:1; }","duration":"169.516894ms","start":"2026-06-15T20:58:28.690499Z","end":"2026-06-15T20:58:28.860016Z","steps":["trace[253871225] 'process raft request' (duration: 169.331389ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:58:28.860022Z","caller":"traceutil/trace.go:171","msg":"trace[1849683011] transaction","detail":"{read_only:false; response_revision:442; number_of_response:1; }","duration":"168.882807ms","start":"2026-06-15T20:58:28.691116Z","end":"2026-06-15T20:58:28.859999Z","steps":["trace[1849683011] 'process raft request' (duration: 168.770835ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:58:28.860313Z","caller":"traceutil/trace.go:171","msg":"trace[740290425] transaction","detail":"{read_only:false; response_revision:444; number_of_response:1; }","duration":"165.87178ms","start":"2026-06-15T20:58:28.694433Z","end":"2026-06-15T20:58:28.860305Z","steps":["trace[740290425] 'process raft request' (duration: 165.713406ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:58:28.860318Z","caller":"traceutil/trace.go:171","msg":"trace[1916259142] transaction","detail":"{read_only:false; response_revision:446; number_of_response:1; }","duration":"121.786091ms","start":"2026-06-15T20:58:28.738523Z","end":"2026-06-15T20:58:28.860309Z","steps":["trace[1916259142] 'process raft request' (duration: 121.75106ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:58:28.860418Z","caller":"traceutil/trace.go:171","msg":"trace[1942174770] transaction","detail":"{read_only:false; response_revision:443; number_of_response:1; }","duration":"166.536736ms","start":"2026-06-15T20:58:28.693873Z","end":"2026-06-15T20:58:28.86041Z","steps":["trace[1942174770] 'process raft request' (duration: 166.095605ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:58:28.860424Z","caller":"traceutil/trace.go:171","msg":"trace[1803514210] linearizableReadLoop","detail":"{readStateIndex:457; appliedIndex:452; }","duration":"123.187787ms","start":"2026-06-15T20:58:28.737227Z","end":"2026-06-15T20:58:28.860415Z","steps":["trace[1803514210] 'read index received' (duration: 68.095643ms)","trace[1803514210] 'applied index is now lower than readState.Index' (duration: 55.090804ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T20:58:28.860457Z","caller":"traceutil/trace.go:171","msg":"trace[819999398] transaction","detail":"{read_only:false; response_revision:445; number_of_response:1; }","duration":"122.025078ms","start":"2026-06-15T20:58:28.738418Z","end":"2026-06-15T20:58:28.860443Z","steps":["trace[819999398] 'process raft request' (duration: 121.824622ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:58:28.860541Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.314552ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-7c96b6546b-vbztv\" ","response":"range_response_count:1 size:4016"} {"level":"info","ts":"2026-06-15T20:58:28.860574Z","caller":"traceutil/trace.go:171","msg":"trace[1339498428] range","detail":"{range_begin:/registry/pods/kube-system/coredns-7c96b6546b-vbztv; range_end:; response_count:1; response_revision:446; }","duration":"123.395854ms","start":"2026-06-15T20:58:28.737164Z","end":"2026-06-15T20:58:28.86056Z","steps":["trace[1339498428] 'agreement among raft nodes before linearized reading' (duration: 123.315622ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:58:28.860659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.814017ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/coredns\" ","response":"range_response_count:1 size:4195"} {"level":"info","ts":"2026-06-15T20:58:28.86069Z","caller":"traceutil/trace.go:171","msg":"trace[542167993] range","detail":"{range_begin:/registry/deployments/kube-system/coredns; range_end:; response_count:1; response_revision:446; }","duration":"117.87339ms","start":"2026-06-15T20:58:28.742808Z","end":"2026-06-15T20:58:28.860682Z","steps":["trace[542167993] 'agreement among raft nodes before linearized reading' (duration: 117.816739ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:58:29.156424Z","caller":"traceutil/trace.go:171","msg":"trace[1790671072] linearizableReadLoop","detail":"{readStateIndex:476; appliedIndex:472; }","duration":"144.889783ms","start":"2026-06-15T20:58:29.011511Z","end":"2026-06-15T20:58:29.156401Z","steps":["trace[1790671072] 'read index received' (duration: 59.017208ms)","trace[1790671072] 'applied index is now lower than readState.Index' (duration: 85.871635ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T20:58:29.156602Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.065018ms","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-15T20:58:29.156574Z","caller":"traceutil/trace.go:171","msg":"trace[1947423334] transaction","detail":"{read_only:false; response_revision:462; number_of_response:1; }","duration":"148.026264ms","start":"2026-06-15T20:58:29.008498Z","end":"2026-06-15T20:58:29.156524Z","steps":["trace[1947423334] 'process raft request' (duration: 133.541747ms)","trace[1947423334] 'compare' (duration: 14.262612ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T20:58:29.156637Z","caller":"traceutil/trace.go:171","msg":"trace[2010903442] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:462; }","duration":"145.14339ms","start":"2026-06-15T20:58:29.011484Z","end":"2026-06-15T20:58:29.156628Z","steps":["trace[2010903442] 'agreement among raft nodes before linearized reading' (duration: 145.049377ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:58:29.326735Z","caller":"traceutil/trace.go:171","msg":"trace[737564699] transaction","detail":"{read_only:false; response_revision:465; number_of_response:1; }","duration":"102.724135ms","start":"2026-06-15T20:58:29.22398Z","end":"2026-06-15T20:58:29.326704Z","steps":["trace[737564699] 'process raft request' (duration: 97.93685ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:58:42.150706Z","caller":"traceutil/trace.go:171","msg":"trace[1620283229] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"351.053371ms","start":"2026-06-15T20:58:41.799626Z","end":"2026-06-15T20:58:42.15068Z","steps":["trace[1620283229] 'process raft request' (duration: 350.897837ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:58:42.150845Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:58:41.79961Z","time spent":"351.177334ms","remote":"127.0.0.1:47266","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-15T20:58:42.157424Z","caller":"traceutil/trace.go:171","msg":"trace[463967740] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"327.56831ms","start":"2026-06-15T20:58:41.829822Z","end":"2026-06-15T20:58:42.15739Z","steps":["trace[463967740] 'process raft request' (duration: 326.983845ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:58:42.15754Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:58:41.829815Z","time spent":"327.670332ms","remote":"127.0.0.1:47266","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-15T20:58:42.157906Z","caller":"traceutil/trace.go:171","msg":"trace[985036212] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"357.58299ms","start":"2026-06-15T20:58:41.800304Z","end":"2026-06-15T20:58:42.157887Z","steps":["trace[985036212] 'process raft request' (duration: 356.257916ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:58:42.157969Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:58:41.800274Z","time spent":"357.662823ms","remote":"127.0.0.1:47266","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-15T20:58:42.158142Z","caller":"traceutil/trace.go:171","msg":"trace[1921323231] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"357.719984ms","start":"2026-06-15T20:58:41.800411Z","end":"2026-06-15T20:58:42.158131Z","steps":["trace[1921323231] 'process raft request' (duration: 356.318128ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:58:42.158184Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:58:41.800405Z","time spent":"357.759825ms","remote":"127.0.0.1:47266","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-15T20:58:42.158233Z","caller":"traceutil/trace.go:171","msg":"trace[136199188] linearizableReadLoop","detail":"{readStateIndex:548; appliedIndex:545; }","duration":"328.558256ms","start":"2026-06-15T20:58:41.829625Z","end":"2026-06-15T20:58:42.158183Z","steps":["trace[136199188] 'read index received' (duration: 321.300126ms)","trace[136199188] 'applied index is now lower than readState.Index' (duration: 7.25715ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T20:58:42.158365Z","caller":"traceutil/trace.go:171","msg":"trace[1370109985] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"332.1908ms","start":"2026-06-15T20:58:41.826163Z","end":"2026-06-15T20:58:42.158354Z","steps":["trace[1370109985] 'process raft request' (duration: 330.603409ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:58:42.158492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.796372ms","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-15T20:58:42.158507Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:58:41.826142Z","time spent":"332.297593ms","remote":"127.0.0.1:47266","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-15T20:58:42.158543Z","caller":"traceutil/trace.go:171","msg":"trace[34193148] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:540; }","duration":"328.906765ms","start":"2026-06-15T20:58:41.829621Z","end":"2026-06-15T20:58:42.158527Z","steps":["trace[34193148] 'agreement among raft nodes before linearized reading' (duration: 328.70977ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:58:42.158615Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:58:41.829595Z","time spent":"329.008097ms","remote":"127.0.0.1:47480","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-15T20:58:42.158924Z","caller":"traceutil/trace.go:171","msg":"trace[2086498455] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"325.847436ms","start":"2026-06-15T20:58:41.833063Z","end":"2026-06-15T20:58:42.158911Z","steps":["trace[2086498455] 'process raft request' (duration: 323.820983ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:58:42.159004Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:58:41.833037Z","time spent":"325.917167ms","remote":"127.0.0.1:47266","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-15T20:58:42.159181Z","caller":"traceutil/trace.go:171","msg":"trace[1882732631] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"321.208644ms","start":"2026-06-15T20:58:41.837963Z","end":"2026-06-15T20:58:42.159171Z","steps":["trace[1882732631] 'process raft request' (duration: 318.975026ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:58:42.159228Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:58:41.83795Z","time spent":"321.253446ms","remote":"127.0.0.1:47266","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-15T20:58:42.159295Z","caller":"traceutil/trace.go:171","msg":"trace[963242891] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"316.329397ms","start":"2026-06-15T20:58:41.842959Z","end":"2026-06-15T20:58:42.159288Z","steps":["trace[963242891] 'process raft request' (duration: 314.028447ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:58:42.159331Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:58:41.842951Z","time spent":"316.363427ms","remote":"127.0.0.1:47266","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-15T20:58:42.159397Z","caller":"traceutil/trace.go:171","msg":"trace[2089719023] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"310.690049ms","start":"2026-06-15T20:58:41.848699Z","end":"2026-06-15T20:58:42.159389Z","steps":["trace[2089719023] 'process raft request' (duration: 308.369999ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:58:42.159631Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:58:41.848661Z","time spent":"310.755001ms","remote":"127.0.0.1:47266","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-15T20:58:42.159707Z","caller":"traceutil/trace.go:171","msg":"trace[2111301735] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"297.368813ms","start":"2026-06-15T20:58:41.862331Z","end":"2026-06-15T20:58:42.1597Z","steps":["trace[2111301735] 'process raft request' (duration: 294.846447ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:58:42.159767Z","caller":"traceutil/trace.go:171","msg":"trace[1013465651] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"278.273966ms","start":"2026-06-15T20:58:41.881485Z","end":"2026-06-15T20:58:42.159759Z","steps":["trace[1013465651] 'process raft request' (duration: 275.833952ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:58:42.159828Z","caller":"traceutil/trace.go:171","msg":"trace[1021380255] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"174.676928ms","start":"2026-06-15T20:58:41.985144Z","end":"2026-06-15T20:58:42.159821Z","steps":["trace[1021380255] 'process raft request' (duration: 172.87359ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:58:48.290575Z","caller":"traceutil/trace.go:171","msg":"trace[1989403881] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"193.940749ms","start":"2026-06-15T20:58:48.096592Z","end":"2026-06-15T20:58:48.290533Z","steps":["trace[1989403881] 'process raft request' (duration: 193.729464ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:58:48.454852Z","caller":"traceutil/trace.go:171","msg":"trace[1661640308] linearizableReadLoop","detail":"{readStateIndex:647; appliedIndex:646; }","duration":"156.612778ms","start":"2026-06-15T20:58:48.298206Z","end":"2026-06-15T20:58:48.454819Z","steps":["trace[1661640308] 'read index received' (duration: 154.443002ms)","trace[1661640308] 'applied index is now lower than readState.Index' (duration: 2.168266ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T20:58:48.455022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.790913ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T20:58:48.455063Z","caller":"traceutil/trace.go:171","msg":"trace[1196002001] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:626; }","duration":"156.900745ms","start":"2026-06-15T20:58:48.29815Z","end":"2026-06-15T20:58:48.45505Z","steps":["trace[1196002001] 'agreement among raft nodes before linearized reading' (duration: 156.794742ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:58:48.455261Z","caller":"traceutil/trace.go:171","msg":"trace[1271772188] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"228.738836ms","start":"2026-06-15T20:58:48.226313Z","end":"2026-06-15T20:58:48.455052Z","steps":["trace[1271772188] 'process raft request' (duration: 227.066673ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:58:48.471458Z","caller":"traceutil/trace.go:171","msg":"trace[1736393360] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"173.031045ms","start":"2026-06-15T20:58:48.298387Z","end":"2026-06-15T20:58:48.471418Z","steps":["trace[1736393360] 'process raft request' (duration: 172.611205ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:58:49.568382Z","caller":"traceutil/trace.go:171","msg":"trace[1098534932] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"605.805434ms","start":"2026-06-15T20:58:48.962544Z","end":"2026-06-15T20:58:49.568349Z","steps":["trace[1098534932] 'process raft request' (duration: 605.526047ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:58:49.568574Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:58:48.962528Z","time spent":"605.950308ms","remote":"127.0.0.1:47480","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-15T20:58:49.705348Z","caller":"traceutil/trace.go:171","msg":"trace[383617570] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"741.21508ms","start":"2026-06-15T20:58:48.964083Z","end":"2026-06-15T20:58:49.705298Z","steps":["trace[383617570] 'process raft request' (duration: 740.608334ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:58:49.705642Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:58:48.96407Z","time spent":"741.408045ms","remote":"127.0.0.1:47480","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-15T20:58:49.705915Z","caller":"traceutil/trace.go:171","msg":"trace[618327589] linearizableReadLoop","detail":"{readStateIndex:652; appliedIndex:649; }","duration":"416.061504ms","start":"2026-06-15T20:58:49.289822Z","end":"2026-06-15T20:58:49.705884Z","steps":["trace[618327589] 'read index received' (duration: 278.42047ms)","trace[618327589] 'applied index is now lower than readState.Index' (duration: 137.639474ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T20:58:49.706111Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"416.275709ms","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-15T20:58:49.706138Z","caller":"traceutil/trace.go:171","msg":"trace[1471351685] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"659.160504ms","start":"2026-06-15T20:58:49.046949Z","end":"2026-06-15T20:58:49.706109Z","steps":["trace[1471351685] 'process raft request' (duration: 658.164198ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:58:49.706161Z","caller":"traceutil/trace.go:171","msg":"trace[715701966] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:631; }","duration":"416.364082ms","start":"2026-06-15T20:58:49.289781Z","end":"2026-06-15T20:58:49.706145Z","steps":["trace[715701966] 'agreement among raft nodes before linearized reading' (duration: 416.230858ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:58:49.706207Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:58:49.289646Z","time spent":"416.548116ms","remote":"127.0.0.1:47480","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-15T20:58:49.706295Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:58:49.046911Z","time spent":"659.283967ms","remote":"127.0.0.1:47304","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036165,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T20:58:51.423994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.652800917s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-15T20:58:51.424304Z","caller":"traceutil/trace.go:171","msg":"trace[364156720] linearizableReadLoop","detail":"{readStateIndex:655; appliedIndex:652; }","duration":"1.134963872s","start":"2026-06-15T20:58:50.289321Z","end":"2026-06-15T20:58:51.424285Z","steps":["trace[364156720] 'read index received' (duration: 245.782069ms)","trace[364156720] 'applied index is now lower than readState.Index' (duration: 889.180753ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T20:58:51.424586Z","caller":"traceutil/trace.go:171","msg":"trace[829133227] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"1.712683267s","start":"2026-06-15T20:58:49.711887Z","end":"2026-06-15T20:58:51.42457Z","steps":["trace[829133227] 'process raft request' (duration: 59.188462ms)","trace[829133227] 'compare' (duration: 1.652054198s)"],"step_count":2} {"level":"warn","ts":"2026-06-15T20:58:51.42467Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:58:49.711868Z","time spent":"1.712764009s","remote":"127.0.0.1:47480","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-15T20:58:51.424915Z","caller":"traceutil/trace.go:171","msg":"trace[627117816] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"1.656977506s","start":"2026-06-15T20:58:49.767924Z","end":"2026-06-15T20:58:51.424902Z","steps":["trace[627117816] 'process raft request' (duration: 1.656211867s)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:58:51.424976Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:58:49.767883Z","time spent":"1.657068649s","remote":"127.0.0.1:47546","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":897,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-15T20:58:51.425188Z","caller":"traceutil/trace.go:171","msg":"trace[874325370] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"1.148903426s","start":"2026-06-15T20:58:50.276218Z","end":"2026-06-15T20:58:51.425121Z","steps":["trace[874325370] 'process raft request' (duration: 1.148005153s)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:58:51.425292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.1359672s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T20:58:51.42534Z","caller":"traceutil/trace.go:171","msg":"trace[1607188473] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:634; }","duration":"1.136052482s","start":"2026-06-15T20:58:50.289276Z","end":"2026-06-15T20:58:51.425328Z","steps":["trace[1607188473] 'agreement among raft nodes before linearized reading' (duration: 1.1359836s)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:58:51.425377Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:58:50.289256Z","time spent":"1.136113933s","remote":"127.0.0.1:59494","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-15T20:58:51.425431Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:58:50.276182Z","time spent":"1.149109582s","remote":"127.0.0.1:47480","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-15T20:58:51.425563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"949.641726ms","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-15T20:58:51.425604Z","caller":"traceutil/trace.go:171","msg":"trace[1788593545] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:634; }","duration":"949.714198ms","start":"2026-06-15T20:58:50.47588Z","end":"2026-06-15T20:58:51.425594Z","steps":["trace[1788593545] 'agreement among raft nodes before linearized reading' (duration: 949.646067ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:58:51.42564Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:58:50.475862Z","time spent":"949.77128ms","remote":"127.0.0.1:47480","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":"info","ts":"2026-06-15T20:58:51.815316Z","caller":"traceutil/trace.go:171","msg":"trace[1233793103] transaction","detail":"{read_only:false; response_revision:637; number_of_response:1; }","duration":"100.080646ms","start":"2026-06-15T20:58:51.715199Z","end":"2026-06-15T20:58:51.81528Z","steps":["trace[1233793103] 'process raft request' (duration: 99.86723ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:58:52.241173Z","caller":"traceutil/trace.go:171","msg":"trace[1481002334] transaction","detail":"{read_only:false; response_revision:641; number_of_response:1; }","duration":"115.119987ms","start":"2026-06-15T20:58:52.126023Z","end":"2026-06-15T20:58:52.241143Z","steps":["trace[1481002334] 'process raft request' (duration: 112.695084ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:58:53.073669Z","caller":"traceutil/trace.go:171","msg":"trace[2064743950] transaction","detail":"{read_only:false; response_revision:643; number_of_response:1; }","duration":"716.819486ms","start":"2026-06-15T20:58:52.356813Z","end":"2026-06-15T20:58:53.073633Z","steps":["trace[2064743950] 'process raft request' (duration: 716.59132ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:58:53.073912Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:58:52.35679Z","time spent":"717.02678ms","remote":"127.0.0.1:47296","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":700,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-15T20:58:53.250331Z","caller":"traceutil/trace.go:171","msg":"trace[1185815121] transaction","detail":"{read_only:false; response_revision:644; number_of_response:1; }","duration":"830.631278ms","start":"2026-06-15T20:58:52.419662Z","end":"2026-06-15T20:58:53.250293Z","steps":["trace[1185815121] 'process raft request' (duration: 829.597562ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:58:53.25051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.294664ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-mp28v\" ","response":"range_response_count:1 size:17243"} {"level":"warn","ts":"2026-06-15T20:58:53.250519Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:58:52.419641Z","time spent":"830.776342ms","remote":"127.0.0.1:47304","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036229,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T20:58:53.250576Z","caller":"traceutil/trace.go:171","msg":"trace[1022062996] range","detail":"{range_begin:/registry/pods/kube-system/cilium-mp28v; range_end:; response_count:1; response_revision:644; }","duration":"140.406617ms","start":"2026-06-15T20:58:53.110152Z","end":"2026-06-15T20:58:53.250559Z","steps":["trace[1022062996] 'agreement among raft nodes before linearized reading' (duration: 140.15149ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:58:53.250856Z","caller":"traceutil/trace.go:171","msg":"trace[1730557847] linearizableReadLoop","detail":"{readStateIndex:666; appliedIndex:665; }","duration":"139.994065ms","start":"2026-06-15T20:58:53.110203Z","end":"2026-06-15T20:58:53.250197Z","steps":["trace[1730557847] 'read index received' (duration: 138.748103ms)","trace[1730557847] 'applied index is now lower than readState.Index' (duration: 1.245032ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T20:58:53.640349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.354854ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-15T20:58:53.640721Z","caller":"traceutil/trace.go:171","msg":"trace[1456066035] linearizableReadLoop","detail":"{readStateIndex:668; appliedIndex:667; }","duration":"311.685356ms","start":"2026-06-15T20:58:53.329006Z","end":"2026-06-15T20:58:53.640691Z","steps":["trace[1456066035] 'read index received' (duration: 64.897211ms)","trace[1456066035] 'applied index is now lower than readState.Index' (duration: 246.785625ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T20:58:53.640889Z","caller":"traceutil/trace.go:171","msg":"trace[1231887780] transaction","detail":"{read_only:false; response_revision:646; number_of_response:1; }","duration":"325.012362ms","start":"2026-06-15T20:58:53.315805Z","end":"2026-06-15T20:58:53.640818Z","steps":["trace[1231887780] 'process raft request' (duration: 78.072493ms)","trace[1231887780] 'compare' (duration: 245.909223ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T20:58:53.640991Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.948163ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-15T20:58:53.641081Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:58:53.315766Z","time spent":"325.227929ms","remote":"127.0.0.1:47564","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1092,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-15T20:58:53.641095Z","caller":"traceutil/trace.go:171","msg":"trace[840195249] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:646; }","duration":"312.072547ms","start":"2026-06-15T20:58:53.328997Z","end":"2026-06-15T20:58:53.641069Z","steps":["trace[840195249] 'agreement among raft nodes before linearized reading' (duration: 311.817649ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:58:53.641106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.017456ms","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-15T20:58:53.641157Z","caller":"traceutil/trace.go:171","msg":"trace[993399731] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:646; }","duration":"203.104528ms","start":"2026-06-15T20:58:53.438038Z","end":"2026-06-15T20:58:53.641143Z","steps":["trace[993399731] 'agreement among raft nodes before linearized reading' (duration: 202.836191ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:58:53.641152Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:58:53.328938Z","time spent":"312.206339ms","remote":"127.0.0.1:59478","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-15T20:58:53.641242Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.636931ms","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-15T20:58:53.64128Z","caller":"traceutil/trace.go:171","msg":"trace[801694330] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:646; }","duration":"211.721952ms","start":"2026-06-15T20:58:53.429545Z","end":"2026-06-15T20:58:53.641267Z","steps":["trace[801694330] 'agreement among raft nodes before linearized reading' (duration: 211.320852ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:58:53.76293Z","caller":"traceutil/trace.go:171","msg":"trace[139421609] transaction","detail":"{read_only:false; response_revision:647; number_of_response:1; }","duration":"114.868881ms","start":"2026-06-15T20:58:53.64803Z","end":"2026-06-15T20:58:53.762899Z","steps":["trace[139421609] 'process raft request' (duration: 111.133583ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:58:53.763133Z","caller":"traceutil/trace.go:171","msg":"trace[1743690637] linearizableReadLoop","detail":"{readStateIndex:671; appliedIndex:668; }","duration":"109.558333ms","start":"2026-06-15T20:58:53.653534Z","end":"2026-06-15T20:58:53.763092Z","steps":["trace[1743690637] 'read index received' (duration: 105.58529ms)","trace[1743690637] 'applied index is now lower than readState.Index' (duration: 3.970733ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T20:58:53.762926Z","caller":"traceutil/trace.go:171","msg":"trace[783083687] transaction","detail":"{read_only:false; response_revision:648; number_of_response:1; }","duration":"114.808549ms","start":"2026-06-15T20:58:53.648106Z","end":"2026-06-15T20:58:53.762914Z","steps":["trace[783083687] 'process raft request' (duration: 114.726587ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:58:53.763236Z","caller":"traceutil/trace.go:171","msg":"trace[1122139758] transaction","detail":"{read_only:false; response_revision:649; number_of_response:1; }","duration":"113.112605ms","start":"2026-06-15T20:58:53.650111Z","end":"2026-06-15T20:58:53.763224Z","steps":["trace[1122139758] 'process raft request' (duration: 112.770576ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:58:53.763341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.789729ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/envoy-gateway-gateway-helm-certgen:envoy-gateway-system\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T20:58:53.763372Z","caller":"traceutil/trace.go:171","msg":"trace[1640551661] range","detail":"{range_begin:/registry/clusterrolebindings/envoy-gateway-gateway-helm-certgen:envoy-gateway-system; range_end:; response_count:0; response_revision:649; }","duration":"109.864021ms","start":"2026-06-15T20:58:53.653498Z","end":"2026-06-15T20:58:53.763362Z","steps":["trace[1640551661] 'agreement among raft nodes before linearized reading' (duration: 109.791279ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:58:56.938294Z","caller":"traceutil/trace.go:171","msg":"trace[2102277661] transaction","detail":"{read_only:false; response_revision:711; number_of_response:1; }","duration":"151.025322ms","start":"2026-06-15T20:58:56.787238Z","end":"2026-06-15T20:58:56.938264Z","steps":["trace[2102277661] 'process raft request' (duration: 150.809207ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:58:57.457889Z","caller":"traceutil/trace.go:171","msg":"trace[1047313911] transaction","detail":"{read_only:false; response_revision:724; number_of_response:1; }","duration":"147.393867ms","start":"2026-06-15T20:58:57.310471Z","end":"2026-06-15T20:58:57.457865Z","steps":["trace[1047313911] 'process raft request' (duration: 147.131791ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:59:03.946548Z","caller":"traceutil/trace.go:171","msg":"trace[887498747] transaction","detail":"{read_only:false; response_revision:775; number_of_response:1; }","duration":"130.430927ms","start":"2026-06-15T20:59:03.816043Z","end":"2026-06-15T20:59:03.946474Z","steps":["trace[887498747] 'process raft request' (duration: 90.843676ms)","trace[887498747] 'compare' (duration: 39.154979ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T20:59:03.946573Z","caller":"traceutil/trace.go:171","msg":"trace[1603994885] transaction","detail":"{read_only:false; response_revision:776; number_of_response:1; }","duration":"129.79258ms","start":"2026-06-15T20:59:03.816711Z","end":"2026-06-15T20:59:03.946504Z","steps":["trace[1603994885] 'process raft request' (duration: 129.434781ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:59:08.714427Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8620627240377148378,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-15T20:59:08.968309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"389.217514ms","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-15T20:59:08.968683Z","caller":"traceutil/trace.go:171","msg":"trace[127502455] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:809; }","duration":"389.611724ms","start":"2026-06-15T20:59:08.579042Z","end":"2026-06-15T20:59:08.968654Z","steps":["trace[127502455] 'range keys from in-memory index tree' (duration: 389.193014ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:59:08.968893Z","caller":"traceutil/trace.go:171","msg":"trace[455244106] linearizableReadLoop","detail":"{readStateIndex:837; appliedIndex:836; }","duration":"755.092883ms","start":"2026-06-15T20:59:08.213763Z","end":"2026-06-15T20:59:08.968856Z","steps":["trace[455244106] 'read index received' (duration: 752.28195ms)","trace[455244106] 'applied index is now lower than readState.Index' (duration: 2.806133ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T20:59:08.96906Z","caller":"traceutil/trace.go:171","msg":"trace[844605224] transaction","detail":"{read_only:false; response_revision:810; number_of_response:1; }","duration":"898.499217ms","start":"2026-06-15T20:59:08.070549Z","end":"2026-06-15T20:59:08.969048Z","steps":["trace[844605224] 'process raft request' (duration: 895.506819ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:59:08.9694Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"679.34911ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T20:59:08.969435Z","caller":"traceutil/trace.go:171","msg":"trace[2060318435] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:810; }","duration":"679.468942ms","start":"2026-06-15T20:59:08.289956Z","end":"2026-06-15T20:59:08.969425Z","steps":["trace[2060318435] 'agreement among raft nodes before linearized reading' (duration: 679.305448ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:59:08.969662Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:59:08.289923Z","time spent":"679.528534ms","remote":"127.0.0.1:59478","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-15T20:59:08.969714Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"755.917584ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-r85gq\" ","response":"range_response_count:1 size:3964"} {"level":"info","ts":"2026-06-15T20:59:08.970044Z","caller":"traceutil/trace.go:171","msg":"trace[1365687793] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-r85gq; range_end:; response_count:1; response_revision:810; }","duration":"756.082928ms","start":"2026-06-15T20:59:08.213666Z","end":"2026-06-15T20:59:08.969749Z","steps":["trace[1365687793] 'agreement among raft nodes before linearized reading' (duration: 755.598045ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:59:08.970099Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:59:08.213631Z","time spent":"756.453487ms","remote":"127.0.0.1:47394","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3988,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-r85gq\" "} {"level":"warn","ts":"2026-06-15T20:59:08.970166Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:59:08.070528Z","time spent":"898.560059ms","remote":"127.0.0.1:47480","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-15T20:59:09.087637Z","caller":"traceutil/trace.go:171","msg":"trace[575447238] transaction","detail":"{read_only:false; response_revision:811; number_of_response:1; }","duration":"108.969327ms","start":"2026-06-15T20:59:08.978629Z","end":"2026-06-15T20:59:09.087598Z","steps":["trace[575447238] 'process raft request' (duration: 108.701641ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:59:19.387145Z","caller":"traceutil/trace.go:171","msg":"trace[1649848502] transaction","detail":"{read_only:false; response_revision:928; number_of_response:1; }","duration":"135.607861ms","start":"2026-06-15T20:59:19.251503Z","end":"2026-06-15T20:59:19.387111Z","steps":["trace[1649848502] 'process raft request' (duration: 135.428436ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:59:40.317521Z","caller":"traceutil/trace.go:171","msg":"trace[1286980387] linearizableReadLoop","detail":"{readStateIndex:1039; appliedIndex:1038; }","duration":"106.370202ms","start":"2026-06-15T20:59:40.211123Z","end":"2026-06-15T20:59:40.317493Z","steps":["trace[1286980387] 'read index received' (duration: 106.182027ms)","trace[1286980387] 'applied index is now lower than readState.Index' (duration: 186.985µs)"],"step_count":2} {"level":"info","ts":"2026-06-15T20:59:40.317957Z","caller":"traceutil/trace.go:171","msg":"trace[1513159538] transaction","detail":"{read_only:false; response_revision:1006; number_of_response:1; }","duration":"173.543563ms","start":"2026-06-15T20:59:40.14435Z","end":"2026-06-15T20:59:40.317894Z","steps":["trace[1513159538] 'process raft request' (duration: 172.979398ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:59:40.318071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.936867ms","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-15T20:59:40.318118Z","caller":"traceutil/trace.go:171","msg":"trace[153918526] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1006; }","duration":"107.03105ms","start":"2026-06-15T20:59:40.211072Z","end":"2026-06-15T20:59:40.318103Z","steps":["trace[153918526] 'agreement among raft nodes before linearized reading' (duration: 106.871386ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:59:43.85544Z","caller":"traceutil/trace.go:171","msg":"trace[1443019513] transaction","detail":"{read_only:false; response_revision:1021; number_of_response:1; }","duration":"442.083049ms","start":"2026-06-15T20:59:43.413325Z","end":"2026-06-15T20:59:43.855408Z","steps":["trace[1443019513] 'process raft request' (duration: 441.867463ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:59:43.85565Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:59:43.413304Z","time spent":"442.234773ms","remote":"127.0.0.1:47480","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T20:59:48.510465Z","caller":"traceutil/trace.go:171","msg":"trace[1253742891] linearizableReadLoop","detail":"{readStateIndex:1074; appliedIndex:1073; }","duration":"100.314544ms","start":"2026-06-15T20:59:48.410121Z","end":"2026-06-15T20:59:48.510435Z","steps":["trace[1253742891] 'read index received' (duration: 67.297163ms)","trace[1253742891] 'applied index is now lower than readState.Index' (duration: 33.016141ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T20:59:48.510729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.56889ms","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-15T20:59:48.51078Z","caller":"traceutil/trace.go:171","msg":"trace[326857454] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1038; }","duration":"100.699504ms","start":"2026-06-15T20:59:48.410065Z","end":"2026-06-15T20:59:48.510765Z","steps":["trace[326857454] 'agreement among raft nodes before linearized reading' (duration: 100.488068ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:59:48.510679Z","caller":"traceutil/trace.go:171","msg":"trace[531265560] transaction","detail":"{read_only:false; response_revision:1038; number_of_response:1; }","duration":"101.739901ms","start":"2026-06-15T20:59:48.408778Z","end":"2026-06-15T20:59:48.510518Z","steps":["trace[531265560] 'process raft request' (duration: 68.617878ms)","trace[531265560] 'compare' (duration: 32.846286ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T21:00:28.81579Z","caller":"traceutil/trace.go:171","msg":"trace[528348028] transaction","detail":"{read_only:false; response_revision:1170; number_of_response:1; }","duration":"102.691615ms","start":"2026-06-15T21:00:28.713064Z","end":"2026-06-15T21:00:28.815756Z","steps":["trace[528348028] 'process raft request' (duration: 67.939841ms)","trace[528348028] 'compare' (duration: 34.445927ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T21:00:29.281045Z","caller":"traceutil/trace.go:171","msg":"trace[24683653] transaction","detail":"{read_only:false; response_revision:1172; number_of_response:1; }","duration":"111.945936ms","start":"2026-06-15T21:00:29.169059Z","end":"2026-06-15T21:00:29.281005Z","steps":["trace[24683653] 'process raft request' (duration: 111.778701ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T21:00:34.974049Z","caller":"traceutil/trace.go:171","msg":"trace[321300839] transaction","detail":"{read_only:false; response_revision:1190; number_of_response:1; }","duration":"127.173211ms","start":"2026-06-15T21:00:34.846852Z","end":"2026-06-15T21:00:34.974025Z","steps":["trace[321300839] 'process raft request' (duration: 126.488824ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T21:00:38.423016Z","caller":"traceutil/trace.go:171","msg":"trace[763868370] transaction","detail":"{read_only:false; response_revision:1200; number_of_response:1; }","duration":"144.361209ms","start":"2026-06-15T21:00:38.278616Z","end":"2026-06-15T21:00:38.422978Z","steps":["trace[763868370] 'process raft request' (duration: 144.163064ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T21:00:42.303803Z","caller":"traceutil/trace.go:171","msg":"trace[1986038469] transaction","detail":"{read_only:false; response_revision:1212; number_of_response:1; }","duration":"104.975534ms","start":"2026-06-15T21:00:42.198799Z","end":"2026-06-15T21:00:42.303774Z","steps":["trace[1986038469] 'process raft request' (duration: 104.80707ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T21:01:20.698239Z","caller":"traceutil/trace.go:171","msg":"trace[140063094] transaction","detail":"{read_only:false; response_revision:1338; number_of_response:1; }","duration":"121.286509ms","start":"2026-06-15T21:01:20.576912Z","end":"2026-06-15T21:01:20.698199Z","steps":["trace[140063094] 'process raft request' (duration: 120.857627ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T21:01:41.920678Z","caller":"traceutil/trace.go:171","msg":"trace[1651539231] linearizableReadLoop","detail":"{readStateIndex:1466; appliedIndex:1465; }","duration":"346.801572ms","start":"2026-06-15T21:01:41.573851Z","end":"2026-06-15T21:01:41.920653Z","steps":["trace[1651539231] 'read index received' (duration: 346.604906ms)","trace[1651539231] 'applied index is now lower than readState.Index' (duration: 195.636µs)"],"step_count":2} {"level":"info","ts":"2026-06-15T21:01:41.920738Z","caller":"traceutil/trace.go:171","msg":"trace[878744061] transaction","detail":"{read_only:false; response_revision:1408; number_of_response:1; }","duration":"429.857584ms","start":"2026-06-15T21:01:41.490845Z","end":"2026-06-15T21:01:41.920703Z","steps":["trace[878744061] 'process raft request' (duration: 429.662758ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T21:01:41.920876Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"347.004207ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-15T21:01:41.920908Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T21:01:41.490827Z","time spent":"429.985697ms","remote":"127.0.0.1:47480","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T21:01:41.920923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.649465ms","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-15T21:01:41.920913Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.328266ms","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-15T21:01:41.920961Z","caller":"traceutil/trace.go:171","msg":"trace[885052504] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1408; }","duration":"339.743267ms","start":"2026-06-15T21:01:41.581206Z","end":"2026-06-15T21:01:41.92095Z","steps":["trace[885052504] 'agreement among raft nodes before linearized reading' (duration: 339.594384ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T21:01:41.920972Z","caller":"traceutil/trace.go:171","msg":"trace[1789252203] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:1408; }","duration":"122.428269ms","start":"2026-06-15T21:01:41.798532Z","end":"2026-06-15T21:01:41.92096Z","steps":["trace[1789252203] 'agreement among raft nodes before linearized reading' (duration: 122.328966ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T21:01:41.920973Z","caller":"traceutil/trace.go:171","msg":"trace[757073606] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:1408; }","duration":"347.13699ms","start":"2026-06-15T21:01:41.573799Z","end":"2026-06-15T21:01:41.920936Z","steps":["trace[757073606] 'agreement among raft nodes before linearized reading' (duration: 346.999237ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T21:01:41.920998Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T21:01:41.581188Z","time spent":"339.802208ms","remote":"127.0.0.1:47480","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-15T21:01:41.921015Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T21:01:41.573777Z","time spent":"347.228822ms","remote":"127.0.0.1:47426","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-15T21:01:42.399354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.50656ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-15T21:01:42.399474Z","caller":"traceutil/trace.go:171","msg":"trace[1916232860] linearizableReadLoop","detail":"{readStateIndex:1467; appliedIndex:1466; }","duration":"109.652746ms","start":"2026-06-15T21:01:42.289804Z","end":"2026-06-15T21:01:42.399457Z","steps":["trace[1916232860] 'read index received' (duration: 38.071µs)","trace[1916232860] 'applied index is now lower than readState.Index' (duration: 109.613235ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T21:01:42.399645Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.81636ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T21:01:42.399792Z","caller":"traceutil/trace.go:171","msg":"trace[1528314388] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1409; }","duration":"110.011765ms","start":"2026-06-15T21:01:42.289754Z","end":"2026-06-15T21:01:42.399766Z","steps":["trace[1528314388] 'agreement among raft nodes before linearized reading' (duration: 109.761489ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T21:01:42.400258Z","caller":"traceutil/trace.go:171","msg":"trace[1783680686] transaction","detail":"{read_only:false; response_revision:1409; number_of_response:1; }","duration":"474.387534ms","start":"2026-06-15T21:01:41.92585Z","end":"2026-06-15T21:01:42.400237Z","steps":["trace[1783680686] 'process raft request' (duration: 274.401486ms)","trace[1783680686] 'compare' (duration: 198.377015ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T21:01:42.400343Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T21:01:41.925822Z","time spent":"474.480846ms","remote":"127.0.0.1:47480","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-15T21:01:54.090632Z","caller":"traceutil/trace.go:171","msg":"trace[442880584] transaction","detail":"{read_only:false; response_revision:1447; number_of_response:1; }","duration":"113.927597ms","start":"2026-06-15T21:01:53.976678Z","end":"2026-06-15T21:01:54.090606Z","steps":["trace[442880584] 'process raft request' (duration: 113.731712ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T21:02:07.501678Z","caller":"traceutil/trace.go:171","msg":"trace[1872991947] linearizableReadLoop","detail":"{readStateIndex:1556; appliedIndex:1555; }","duration":"161.67872ms","start":"2026-06-15T21:02:07.339979Z","end":"2026-06-15T21:02:07.501657Z","steps":["trace[1872991947] 'read index received' (duration: 161.509116ms)","trace[1872991947] 'applied index is now lower than readState.Index' (duration: 168.344µs)"],"step_count":2} {"level":"info","ts":"2026-06-15T21:02:07.501793Z","caller":"traceutil/trace.go:171","msg":"trace[941415192] transaction","detail":"{read_only:false; response_revision:1492; number_of_response:1; }","duration":"166.396244ms","start":"2026-06-15T21:02:07.33537Z","end":"2026-06-15T21:02:07.501766Z","steps":["trace[941415192] 'process raft request' (duration: 166.145617ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T21:02:07.501885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.892886ms","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-15T21:02:07.501934Z","caller":"traceutil/trace.go:171","msg":"trace[142147890] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1492; }","duration":"161.951727ms","start":"2026-06-15T21:02:07.339965Z","end":"2026-06-15T21:02:07.501917Z","steps":["trace[142147890] 'agreement among raft nodes before linearized reading' (duration: 161.798693ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T21:02:13.079327Z","caller":"traceutil/trace.go:171","msg":"trace[1879642416] transaction","detail":"{read_only:false; response_revision:1509; number_of_response:1; }","duration":"352.686265ms","start":"2026-06-15T21:02:12.726611Z","end":"2026-06-15T21:02:13.079297Z","steps":["trace[1879642416] 'process raft request' (duration: 323.502674ms)","trace[1879642416] 'compare' (duration: 29.032407ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T21:02:13.079466Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T21:02:12.726589Z","time spent":"352.808067ms","remote":"127.0.0.1:47480","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-15T21:02:13.798424Z","caller":"traceutil/trace.go:171","msg":"trace[1465560927] transaction","detail":"{read_only:false; response_revision:1511; number_of_response:1; }","duration":"272.919368ms","start":"2026-06-15T21:02:13.525474Z","end":"2026-06-15T21:02:13.798393Z","steps":["trace[1465560927] 'process raft request' (duration: 272.716853ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T21:02:13.799288Z","caller":"traceutil/trace.go:171","msg":"trace[1858419138] transaction","detail":"{read_only:false; response_revision:1512; number_of_response:1; }","duration":"271.652374ms","start":"2026-06-15T21:02:13.527603Z","end":"2026-06-15T21:02:13.799255Z","steps":["trace[1858419138] 'process raft request' (duration: 271.50366ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T21:02:29.21007Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.781716ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T21:02:29.210415Z","caller":"traceutil/trace.go:171","msg":"trace[301438584] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1561; }","duration":"288.181925ms","start":"2026-06-15T21:02:28.922214Z","end":"2026-06-15T21:02:29.210396Z","steps":["trace[301438584] 'range keys from in-memory index tree' (duration: 287.705204ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T21:02:46.416342Z","caller":"traceutil/trace.go:171","msg":"trace[1371366746] linearizableReadLoop","detail":"{readStateIndex:1740; appliedIndex:1739; }","duration":"362.748412ms","start":"2026-06-15T21:02:46.05357Z","end":"2026-06-15T21:02:46.416318Z","steps":["trace[1371366746] 'read index received' (duration: 362.586558ms)","trace[1371366746] 'applied index is now lower than readState.Index' (duration: 160.834µs)"],"step_count":2} {"level":"info","ts":"2026-06-15T21:02:46.416477Z","caller":"traceutil/trace.go:171","msg":"trace[123706205] transaction","detail":"{read_only:false; response_revision:1667; number_of_response:1; }","duration":"372.879127ms","start":"2026-06-15T21:02:46.043577Z","end":"2026-06-15T21:02:46.416456Z","steps":["trace[123706205] 'process raft request' (duration: 372.60693ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T21:02:46.416644Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T21:02:46.04356Z","time spent":"372.965528ms","remote":"127.0.0.1:47480","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T21:02:46.416677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"363.107071ms","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-15T21:02:46.416715Z","caller":"traceutil/trace.go:171","msg":"trace[2145245349] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1667; }","duration":"363.149742ms","start":"2026-06-15T21:02:46.053554Z","end":"2026-06-15T21:02:46.416703Z","steps":["trace[2145245349] 'agreement among raft nodes before linearized reading' (duration: 362.880605ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T21:02:46.416746Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T21:02:46.053495Z","time spent":"363.242925ms","remote":"127.0.0.1:47480","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-15T21:02:46.418509Z","caller":"traceutil/trace.go:171","msg":"trace[13551787] transaction","detail":"{read_only:false; response_revision:1668; number_of_response:1; }","duration":"364.749835ms","start":"2026-06-15T21:02:46.053741Z","end":"2026-06-15T21:02:46.418491Z","steps":["trace[13551787] 'process raft request' (duration: 364.586451ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T21:02:46.418605Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T21:02:46.053727Z","time spent":"364.832936ms","remote":"127.0.0.1:47480","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T21:02:46.418503Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.027612ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T21:02:46.418687Z","caller":"traceutil/trace.go:171","msg":"trace[1268121273] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1668; }","duration":"128.250148ms","start":"2026-06-15T21:02:46.290413Z","end":"2026-06-15T21:02:46.418664Z","steps":["trace[1268121273] 'agreement among raft nodes before linearized reading' (duration: 128.023172ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T21:03:04.441516Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.832543ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T21:03:04.441595Z","caller":"traceutil/trace.go:171","msg":"trace[188894783] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1747; }","duration":"151.960636ms","start":"2026-06-15T21:03:04.289616Z","end":"2026-06-15T21:03:04.441577Z","steps":["trace[188894783] 'range keys from in-memory index tree' (duration: 151.71561ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T21:03:05.319264Z","caller":"traceutil/trace.go:171","msg":"trace[126280563] linearizableReadLoop","detail":"{readStateIndex:1829; appliedIndex:1828; }","duration":"214.884573ms","start":"2026-06-15T21:03:05.104356Z","end":"2026-06-15T21:03:05.31924Z","steps":["trace[126280563] 'read index received' (duration: 214.784251ms)","trace[126280563] 'applied index is now lower than readState.Index' (duration: 99.232µs)"],"step_count":2} {"level":"warn","ts":"2026-06-15T21:03:05.319421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.045428ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T21:03:05.319454Z","caller":"traceutil/trace.go:171","msg":"trace[762201907] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:1752; }","duration":"215.13287ms","start":"2026-06-15T21:03:05.104311Z","end":"2026-06-15T21:03:05.319443Z","steps":["trace[762201907] 'agreement among raft nodes before linearized reading' (duration: 215.055828ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T21:03:05.319635Z","caller":"traceutil/trace.go:171","msg":"trace[1269230117] transaction","detail":"{read_only:false; response_revision:1752; number_of_response:1; }","duration":"280.379019ms","start":"2026-06-15T21:03:05.039219Z","end":"2026-06-15T21:03:05.319598Z","steps":["trace[1269230117] 'process raft request' (duration: 279.865205ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T21:03:05.553821Z","caller":"traceutil/trace.go:171","msg":"trace[1395048803] linearizableReadLoop","detail":"{readStateIndex:1830; appliedIndex:1829; }","duration":"100.069345ms","start":"2026-06-15T21:03:05.453728Z","end":"2026-06-15T21:03:05.553797Z","steps":["trace[1395048803] 'read index received' (duration: 59.359535ms)","trace[1395048803] 'applied index is now lower than readState.Index' (duration: 40.70839ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T21:03:05.553894Z","caller":"traceutil/trace.go:171","msg":"trace[1204877143] transaction","detail":"{read_only:false; response_revision:1753; number_of_response:1; }","duration":"190.010877ms","start":"2026-06-15T21:03:05.363848Z","end":"2026-06-15T21:03:05.553859Z","steps":["trace[1204877143] 'process raft request' (duration: 149.242975ms)","trace[1204877143] 'compare' (duration: 40.432632ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T21:03:05.554141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.392714ms","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-15T21:03:05.554175Z","caller":"traceutil/trace.go:171","msg":"trace[1683762343] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1753; }","duration":"100.469526ms","start":"2026-06-15T21:03:05.453698Z","end":"2026-06-15T21:03:05.554167Z","steps":["trace[1683762343] 'agreement among raft nodes before linearized reading' (duration: 100.188269ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T21:03:06.030693Z","caller":"traceutil/trace.go:171","msg":"trace[1401785388] transaction","detail":"{read_only:false; response_revision:1756; number_of_response:1; }","duration":"143.198168ms","start":"2026-06-15T21:03:05.887477Z","end":"2026-06-15T21:03:06.030675Z","steps":["trace[1401785388] 'process raft request' (duration: 143.103014ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T21:03:06.288849Z","caller":"traceutil/trace.go:171","msg":"trace[2090746934] linearizableReadLoop","detail":"{readStateIndex:1834; appliedIndex:1833; }","duration":"253.352405ms","start":"2026-06-15T21:03:06.035467Z","end":"2026-06-15T21:03:06.28882Z","steps":["trace[2090746934] 'read index received' (duration: 157.270654ms)","trace[2090746934] 'applied index is now lower than readState.Index' (duration: 96.080411ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T21:03:06.288859Z","caller":"traceutil/trace.go:171","msg":"trace[1402275297] transaction","detail":"{read_only:false; response_revision:1757; number_of_response:1; }","duration":"378.890752ms","start":"2026-06-15T21:03:05.909936Z","end":"2026-06-15T21:03:06.288827Z","steps":["trace[1402275297] 'process raft request' (duration: 282.784341ms)","trace[1402275297] 'compare' (duration: 95.853635ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T21:03:06.288994Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T21:03:05.909911Z","time spent":"379.019855ms","remote":"127.0.0.1:47296","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":788,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-15T21:03:06.289071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.566021ms","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-15T21:03:06.289113Z","caller":"traceutil/trace.go:171","msg":"trace[1227167781] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1757; }","duration":"253.636303ms","start":"2026-06-15T21:03:06.035462Z","end":"2026-06-15T21:03:06.289099Z","steps":["trace[1227167781] 'agreement among raft nodes before linearized reading' (duration: 253.444207ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T21:03:06.45557Z","caller":"traceutil/trace.go:171","msg":"trace[1217453940] linearizableReadLoop","detail":"{readStateIndex:1835; appliedIndex:1834; }","duration":"165.122578ms","start":"2026-06-15T21:03:06.290419Z","end":"2026-06-15T21:03:06.455542Z","steps":["trace[1217453940] 'read index received' (duration: 129.217814ms)","trace[1217453940] 'applied index is now lower than readState.Index' (duration: 35.903614ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T21:03:06.455626Z","caller":"traceutil/trace.go:171","msg":"trace[2124385994] transaction","detail":"{read_only:false; response_revision:1758; number_of_response:1; }","duration":"419.860789ms","start":"2026-06-15T21:03:06.035725Z","end":"2026-06-15T21:03:06.455586Z","steps":["trace[2124385994] 'process raft request' (duration: 383.939443ms)","trace[2124385994] 'compare' (duration: 35.756551ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T21:03:06.455711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.277213ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T21:03:06.455757Z","caller":"traceutil/trace.go:171","msg":"trace[718035797] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1758; }","duration":"165.364234ms","start":"2026-06-15T21:03:06.290383Z","end":"2026-06-15T21:03:06.455747Z","steps":["trace[718035797] 'agreement among raft nodes before linearized reading' (duration: 165.258781ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T21:03:06.455753Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T21:03:06.035698Z","time spent":"419.980592ms","remote":"127.0.0.1:47296","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":773,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-15T21:03:06.47346Z","caller":"traceutil/trace.go:171","msg":"trace[1408638780] transaction","detail":"{read_only:false; response_revision:1760; number_of_response:1; }","duration":"180.270142ms","start":"2026-06-15T21:03:06.29315Z","end":"2026-06-15T21:03:06.47342Z","steps":["trace[1408638780] 'process raft request' (duration: 180.135978ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T21:03:06.473487Z","caller":"traceutil/trace.go:171","msg":"trace[1053107480] transaction","detail":"{read_only:false; response_revision:1759; number_of_response:1; }","duration":"180.347695ms","start":"2026-06-15T21:03:06.293114Z","end":"2026-06-15T21:03:06.473462Z","steps":["trace[1053107480] 'process raft request' (duration: 180.081648ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T21:03:07.449146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.681832ms","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-15T21:03:07.449235Z","caller":"traceutil/trace.go:171","msg":"trace[460335636] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1765; }","duration":"125.825225ms","start":"2026-06-15T21:03:07.323391Z","end":"2026-06-15T21:03:07.449216Z","steps":["trace[460335636] 'range keys from in-memory index tree' (duration: 125.492917ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T21:03:16.99625Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8620627240377150872,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-15T21:03:17.247461Z","caller":"traceutil/trace.go:171","msg":"trace[1900189865] transaction","detail":"{read_only:false; response_revision:1833; number_of_response:1; }","duration":"755.726832ms","start":"2026-06-15T21:03:16.491713Z","end":"2026-06-15T21:03:17.24744Z","steps":["trace[1900189865] 'process raft request' (duration: 755.605069ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T21:03:17.247604Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T21:03:16.491686Z","time spent":"755.846206ms","remote":"127.0.0.1:47480","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":459,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T21:03:17.535804Z","caller":"traceutil/trace.go:171","msg":"trace[1259324566] linearizableReadLoop","detail":"{readStateIndex:1913; appliedIndex:1912; }","duration":"1.040614837s","start":"2026-06-15T21:03:16.495158Z","end":"2026-06-15T21:03:17.535773Z","steps":["trace[1259324566] 'read index received' (duration: 752.56291ms)","trace[1259324566] 'applied index is now lower than readState.Index' (duration: 288.049947ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T21:03:17.535976Z","caller":"traceutil/trace.go:171","msg":"trace[87922117] transaction","detail":"{read_only:false; response_revision:1834; number_of_response:1; }","duration":"717.061915ms","start":"2026-06-15T21:03:16.818866Z","end":"2026-06-15T21:03:17.535927Z","steps":["trace[87922117] 'process raft request' (duration: 632.311199ms)","trace[87922117] 'compare' (duration: 84.367386ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T21:03:17.536216Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T21:03:16.818849Z","time spent":"717.249551ms","remote":"127.0.0.1:47480","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-15T21:03:17.536232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.041044608s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:526"} {"level":"info","ts":"2026-06-15T21:03:17.536297Z","caller":"traceutil/trace.go:171","msg":"trace[1671568354] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1834; }","duration":"1.041149611s","start":"2026-06-15T21:03:16.495126Z","end":"2026-06-15T21:03:17.536275Z","steps":["trace[1671568354] 'agreement among raft nodes before linearized reading' (duration: 1.040819892s)"],"step_count":1} {"level":"warn","ts":"2026-06-15T21:03:17.536286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"522.537071ms","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":"warn","ts":"2026-06-15T21:03:17.53634Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T21:03:16.49511Z","time spent":"1.041218903s","remote":"127.0.0.1:47480","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":550,"request content":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" "} {"level":"info","ts":"2026-06-15T21:03:17.536351Z","caller":"traceutil/trace.go:171","msg":"trace[2102828206] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/; range_end:/registry/mutatingwebhookconfigurations0; response_count:0; response_revision:1834; }","duration":"522.652096ms","start":"2026-06-15T21:03:17.01368Z","end":"2026-06-15T21:03:17.536332Z","steps":["trace[2102828206] 'agreement among raft nodes before linearized reading' (duration: 522.540253ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T21:03:17.53635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"861.387482ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-06-15T21:03:17.536441Z","caller":"traceutil/trace.go:171","msg":"trace[649026107] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1834; }","duration":"861.581568ms","start":"2026-06-15T21:03:16.674839Z","end":"2026-06-15T21:03:17.536421Z","steps":["trace[649026107] 'agreement among raft nodes before linearized reading' (duration: 861.25091ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T21:03:17.536494Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T21:03:16.674819Z","time spent":"861.665649ms","remote":"127.0.0.1:47480","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":504,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-15T21:03:17.536538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"326.073777ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.65\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-06-15T21:03:17.53657Z","caller":"traceutil/trace.go:171","msg":"trace[1752804640] range","detail":"{range_begin:/registry/masterleases/199.204.45.65; range_end:; response_count:1; response_revision:1834; }","duration":"326.102157ms","start":"2026-06-15T21:03:17.210458Z","end":"2026-06-15T21:03:17.53656Z","steps":["trace[1752804640] 'agreement among raft nodes before linearized reading' (duration: 325.959044ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T21:03:17.536334Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.363443ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-15T21:03:17.5366Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T21:03:17.210419Z","time spent":"326.172379ms","remote":"127.0.0.1:47244","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.204.45.65\" "} {"level":"info","ts":"2026-06-15T21:03:17.536635Z","caller":"traceutil/trace.go:171","msg":"trace[322166961] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1834; }","duration":"246.719371ms","start":"2026-06-15T21:03:17.289891Z","end":"2026-06-15T21:03:17.53661Z","steps":["trace[322166961] 'agreement among raft nodes before linearized reading' (duration: 246.367453ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T21:03:17.536667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"803.25455ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-06-15T21:03:17.536686Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"759.203383ms","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-15T21:03:17.536707Z","caller":"traceutil/trace.go:171","msg":"trace[227424089] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1834; }","duration":"803.316121ms","start":"2026-06-15T21:03:16.733377Z","end":"2026-06-15T21:03:17.536693Z","steps":["trace[227424089] 'agreement among raft nodes before linearized reading' (duration: 803.218937ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T21:03:17.536728Z","caller":"traceutil/trace.go:171","msg":"trace[1391145216] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1834; }","duration":"759.281014ms","start":"2026-06-15T21:03:16.777435Z","end":"2026-06-15T21:03:17.536716Z","steps":["trace[1391145216] 'agreement among raft nodes before linearized reading' (duration: 759.15435ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T21:03:17.536752Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T21:03:16.733362Z","time spent":"803.380203ms","remote":"127.0.0.1:47480","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-15T21:03:17.53677Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T21:03:16.777411Z","time spent":"759.351026ms","remote":"127.0.0.1:47480","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-15T21:03:17.536393Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T21:03:17.013664Z","time spent":"522.718357ms","remote":"127.0.0.1:47728","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":1,"response size":31,"request content":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true "} {"level":"warn","ts":"2026-06-15T21:03:17.536951Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"538.789226ms","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-15T21:03:17.536993Z","caller":"traceutil/trace.go:171","msg":"trace[570724687] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:1834; }","duration":"538.833577ms","start":"2026-06-15T21:03:16.998147Z","end":"2026-06-15T21:03:17.536981Z","steps":["trace[570724687] 'agreement among raft nodes before linearized reading' (duration: 538.763555ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T21:03:17.537027Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T21:03:16.998093Z","time spent":"538.925299ms","remote":"127.0.0.1:47332","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":"warn","ts":"2026-06-15T21:04:03.921373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.289895ms","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-15T21:04:03.921439Z","caller":"traceutil/trace.go:171","msg":"trace[1293322290] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2048; }","duration":"142.406779ms","start":"2026-06-15T21:04:03.779019Z","end":"2026-06-15T21:04:03.921426Z","steps":["trace[1293322290] 'range keys from in-memory index tree' (duration: 142.176733ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T21:04:03.921507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.488281ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"warn","ts":"2026-06-15T21:04:03.921572Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.426422ms","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-15T21:04:03.921661Z","caller":"traceutil/trace.go:171","msg":"trace[753993132] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2048; }","duration":"144.563455ms","start":"2026-06-15T21:04:03.777078Z","end":"2026-06-15T21:04:03.921642Z","steps":["trace[753993132] 'range keys from in-memory index tree' (duration: 144.234937ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T21:04:03.921578Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.208482ms","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-15T21:04:03.921753Z","caller":"traceutil/trace.go:171","msg":"trace[1275481662] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2048; }","duration":"140.393327ms","start":"2026-06-15T21:04:03.781336Z","end":"2026-06-15T21:04:03.921729Z","steps":["trace[1275481662] 'range keys from in-memory index tree' (duration: 140.103918ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T21:04:03.921677Z","caller":"traceutil/trace.go:171","msg":"trace[1404350921] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2048; }","duration":"157.679386ms","start":"2026-06-15T21:04:03.76395Z","end":"2026-06-15T21:04:03.92163Z","steps":["trace[1404350921] 'range keys from in-memory index tree' (duration: 157.308336ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T21:04:04.047407Z","caller":"traceutil/trace.go:171","msg":"trace[575194869] transaction","detail":"{read_only:false; response_revision:2049; number_of_response:1; }","duration":"121.812022ms","start":"2026-06-15T21:04:03.92557Z","end":"2026-06-15T21:04:04.047382Z","steps":["trace[575194869] 'process raft request' (duration: 121.658168ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T21:04:04.070479Z","caller":"traceutil/trace.go:171","msg":"trace[1980418011] transaction","detail":"{read_only:false; response_revision:2051; number_of_response:1; }","duration":"144.342099ms","start":"2026-06-15T21:04:03.926104Z","end":"2026-06-15T21:04:04.070446Z","steps":["trace[1980418011] 'process raft request' (duration: 144.219066ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T21:04:04.070698Z","caller":"traceutil/trace.go:171","msg":"trace[1135458561] linearizableReadLoop","detail":"{readStateIndex:2142; appliedIndex:2137; }","duration":"102.631263ms","start":"2026-06-15T21:04:03.968054Z","end":"2026-06-15T21:04:04.070685Z","steps":["trace[1135458561] 'read index received' (duration: 79.170841ms)","trace[1135458561] 'applied index is now lower than readState.Index' (duration: 23.459662ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T21:04:04.070786Z","caller":"traceutil/trace.go:171","msg":"trace[1324228085] transaction","detail":"{read_only:false; response_revision:2052; number_of_response:1; }","duration":"144.609097ms","start":"2026-06-15T21:04:03.926155Z","end":"2026-06-15T21:04:04.070764Z","steps":["trace[1324228085] 'process raft request' (duration: 144.235517ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T21:04:04.070942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.845988ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-06-15T21:04:04.070981Z","caller":"traceutil/trace.go:171","msg":"trace[389648717] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2053; }","duration":"102.957801ms","start":"2026-06-15T21:04:03.968013Z","end":"2026-06-15T21:04:04.070971Z","steps":["trace[389648717] 'agreement among raft nodes before linearized reading' (duration: 102.763616ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T21:04:04.070954Z","caller":"traceutil/trace.go:171","msg":"trace[396612924] transaction","detail":"{read_only:false; response_revision:2053; number_of_response:1; }","duration":"144.254247ms","start":"2026-06-15T21:04:03.926666Z","end":"2026-06-15T21:04:04.070921Z","steps":["trace[396612924] 'process raft request' (duration: 143.954359ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T21:04:04.070503Z","caller":"traceutil/trace.go:171","msg":"trace[954727354] transaction","detail":"{read_only:false; response_revision:2050; number_of_response:1; }","duration":"144.358229ms","start":"2026-06-15T21:04:03.926097Z","end":"2026-06-15T21:04:04.070455Z","steps":["trace[954727354] 'process raft request' (duration: 143.795865ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T21:06:34.927988Z","caller":"traceutil/trace.go:171","msg":"trace[169922879] linearizableReadLoop","detail":"{readStateIndex:2859; appliedIndex:2858; }","duration":"135.6702ms","start":"2026-06-15T21:06:34.792281Z","end":"2026-06-15T21:06:34.927951Z","steps":["trace[169922879] 'read index received' (duration: 109.651001ms)","trace[169922879] 'applied index is now lower than readState.Index' (duration: 26.017889ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T21:06:34.928372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.227213ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:532"} {"level":"warn","ts":"2026-06-15T21:06:34.92853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.573944ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-06-15T21:06:34.928553Z","caller":"traceutil/trace.go:171","msg":"trace[1645053072] transaction","detail":"{read_only:false; response_revision:2740; number_of_response:1; }","duration":"141.928533ms","start":"2026-06-15T21:06:34.786525Z","end":"2026-06-15T21:06:34.928453Z","steps":["trace[1645053072] 'process raft request' (duration: 115.394431ms)","trace[1645053072] 'compare' (duration: 25.709521ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T21:06:34.928606Z","caller":"traceutil/trace.go:171","msg":"trace[673968165] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2740; }","duration":"141.696957ms","start":"2026-06-15T21:06:34.786896Z","end":"2026-06-15T21:06:34.928593Z","steps":["trace[673968165] 'agreement among raft nodes before linearized reading' (duration: 141.452721ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T21:06:34.928438Z","caller":"traceutil/trace.go:171","msg":"trace[870751664] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:2740; }","duration":"139.335815ms","start":"2026-06-15T21:06:34.789087Z","end":"2026-06-15T21:06:34.928423Z","steps":["trace[870751664] 'agreement among raft nodes before linearized reading' (duration: 139.16534ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T21:06:34.935099Z","caller":"traceutil/trace.go:171","msg":"trace[909857832] transaction","detail":"{read_only:false; response_revision:2741; number_of_response:1; }","duration":"139.966982ms","start":"2026-06-15T21:06:34.795122Z","end":"2026-06-15T21:06:34.935089Z","steps":["trace[909857832] 'process raft request' (duration: 139.88922ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T21:06:34.93532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.006005ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-06-15T21:06:34.935346Z","caller":"traceutil/trace.go:171","msg":"trace[720423935] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2741; }","duration":"142.055197ms","start":"2026-06-15T21:06:34.793284Z","end":"2026-06-15T21:06:34.935339Z","steps":["trace[720423935] 'agreement among raft nodes before linearized reading' (duration: 141.975834ms)"],"step_count":1}